builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1459576405.84 results: success (0) buildid: 20160401201148 builduid: 67fa0a0a4660417f9abb412e638a65fe revision: 7c164deed2231846aceaf869fa251d1ce8052d01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:25.842236) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:25.842663) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:25.842952) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.17 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.021317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.021592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.256257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.256550) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009680 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.384183) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.384464) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.384783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.385054) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 22:53:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.5M=0s 2016-04-01 22:53:26 (96.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169915 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.607462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.607773) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.159342 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:26.792466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 22:53:26.792789) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7c164deed2231846aceaf869fa251d1ce8052d01 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7c164deed2231846aceaf869fa251d1ce8052d01 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 22:53:27,117 truncating revision to first 12 chars 2016-04-01 22:53:27,117 Setting DEBUG logging. 2016-04-01 22:53:27,117 attempt 1/10 2016-04-01 22:53:27,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7c164deed223?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 22:53:27,712 unpacking tar archive at: mozilla-aurora-7c164deed223/testing/mozharness/ program finished with exit code 0 elapsedTime=1.255285 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 22:53:28.092171) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:28.092511) ========= echo 7c164deed2231846aceaf869fa251d1ce8052d01 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7c164deed2231846aceaf869fa251d1ce8052d01'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7c164deed2231846aceaf869fa251d1ce8052d01 program finished with exit code 0 elapsedTime=0.004920 script_repo_revision: '7c164deed2231846aceaf869fa251d1ce8052d01' ========= master_lag: 0.15 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:28.248904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:28.252223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 22:53:28.489120) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-04-01 22:53:28.489536) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:28 INFO - MultiFileLogger online at 20160401 22:53:28 in /builds/slave/test-pgo 22:53:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:53:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:53:28 INFO - {'append_to_log': False, 22:53:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:53:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:53:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:53:28 INFO - 'branch': 'Mozilla-Aurora', 22:53:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:28 INFO - 'config_files': ('talos/linux_config.py',), 22:53:28 INFO - 'default_actions': ('clobber', 22:53:28 INFO - 'read-buildbot-config', 22:53:28 INFO - 'download-and-extract', 22:53:28 INFO - 'populate-webroot', 22:53:28 INFO - 'create-virtualenv', 22:53:28 INFO - 'install', 22:53:28 INFO - 'run-tests'), 22:53:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:28 INFO - 'download_minidump_stackwalk': True, 22:53:28 INFO - 'download_symbols': 'ondemand', 22:53:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:28 INFO - 'installer_path': 'installer.exe', 22:53:28 INFO - 'log_level': 'info', 22:53:28 INFO - 'log_name': 'talos', 22:53:28 INFO - 'log_to_console': True, 22:53:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:28 INFO - 'opt_config_files': (), 22:53:28 INFO - 'pip_index': False, 22:53:28 INFO - 'sps_profile': False, 22:53:28 INFO - 'sps_profile_interval': 0, 22:53:28 INFO - 'suite': 'dromaeojs-e10s', 22:53:28 INFO - 'system_bits': '32', 22:53:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:28 INFO - 'title': 'talos-linux64-ix-041', 22:53:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:28 INFO - 'use_talos_json': True, 22:53:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:53:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:28 INFO - 'work_dir': 'build'} 22:53:28 INFO - ##### 22:53:28 INFO - ##### Running clobber step. 22:53:28 INFO - ##### 22:53:28 INFO - Running pre-action listener: _resource_record_pre_action 22:53:28 INFO - Running main action method: clobber 22:53:28 INFO - rmtree: /builds/slave/test-pgo/build 22:53:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:53:29 INFO - Running post-action listener: _resource_record_post_action 22:53:29 INFO - ##### 22:53:29 INFO - ##### Running read-buildbot-config step. 22:53:29 INFO - ##### 22:53:29 INFO - Running pre-action listener: _resource_record_pre_action 22:53:29 INFO - Running main action method: read_buildbot_config 22:53:29 INFO - Using buildbot properties: 22:53:29 INFO - { 22:53:29 INFO - "project": "", 22:53:29 INFO - "product": "firefox", 22:53:29 INFO - "script_repo_revision": "production", 22:53:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 22:53:29 INFO - "repository": "", 22:53:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 22:53:29 INFO - "buildid": "20160401201148", 22:53:29 INFO - "pgo_build": "True", 22:53:29 INFO - "basedir": "/builds/slave/test-pgo", 22:53:29 INFO - "buildnumber": 225, 22:53:29 INFO - "slavename": "talos-linux64-ix-041", 22:53:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:53:29 INFO - "platform": "ubuntu64_hw", 22:53:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:53:29 INFO - "branch": "mozilla-aurora", 22:53:29 INFO - "repo_path": "releases/mozilla-aurora", 22:53:29 INFO - "revision": "7c164deed2231846aceaf869fa251d1ce8052d01", 22:53:29 INFO - "stage_platform": "linux64-pgo", 22:53:29 INFO - "builduid": "67fa0a0a4660417f9abb412e638a65fe", 22:53:29 INFO - "slavebuilddir": "test" 22:53:29 INFO - } 22:53:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 22:53:29 INFO - Running post-action listener: _resource_record_post_action 22:53:29 INFO - ##### 22:53:29 INFO - ##### Running download-and-extract step. 22:53:29 INFO - ##### 22:53:29 INFO - Running pre-action listener: _resource_record_pre_action 22:53:29 INFO - Running main action method: download_and_extract 22:53:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:29 INFO - https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:53:32 INFO - Downloaded 1448 bytes. 22:53:32 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:53:32 INFO - Using the following test package requirements: 22:53:32 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:53:32 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:32 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:53:32 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'jsshell-linux-x86_64.zip'], 22:53:32 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:32 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:53:32 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:53:32 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:53:32 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:32 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:53:32 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:32 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:32 INFO - https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:53:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:53:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:39 INFO - Downloaded 23344398 bytes. 22:53:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:53:40 INFO - Return code: 0 22:53:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:53: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')]} 22:53:40 INFO - https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:54 INFO - Downloaded 23344398 bytes. 22:53:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:53:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:53:55 INFO - Return code: 0 22:53: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')]} 22:53:55 INFO - https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:53:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:53:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:53:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:53:57 INFO - Downloaded 10845161 bytes. 22:53:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:53:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:53:57 INFO - Return code: 0 22:53: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')]} 22:53:57 INFO - https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:53:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:53:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:53:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:54:20 INFO - Downloaded 60557231 bytes. 22:54:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:54:20 INFO - mkdir: /builds/slave/test-pgo/properties 22:54:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:54:20 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:54:20 INFO - Contents: 22:54:20 INFO - build_url:https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:54:23 INFO - Running post-action listener: _resource_record_post_action 22:54:23 INFO - Running post-action listener: set_extra_try_arguments 22:54:23 INFO - ##### 22:54:23 INFO - ##### Running populate-webroot step. 22:54:23 INFO - ##### 22:54:23 INFO - Running pre-action listener: _resource_record_pre_action 22:54:23 INFO - Running main action method: populate_webroot 22:54:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:23 INFO - '--tppagecycles', 22:54:23 INFO - '7'], 22:54:23 INFO - 'tests': ['tsvgm']}}, 22:54:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:54:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:54:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:54:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:23 INFO - 'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:23 INFO - 'tests': ['damp', 'tps']}, 22:54:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:23 INFO - 'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['damp', 'tps']}, 22:54:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:54:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:54:23 INFO - 'other': {'tests': ['a11yr', 22:54:23 INFO - 'ts_paint', 22:54:23 INFO - 'tpaint', 22:54:23 INFO - 'sessionrestore', 22:54:23 INFO - 'sessionrestore_no_auto_restore', 22:54:23 INFO - 'tabpaint']}, 22:54:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['a11yr', 22:54:23 INFO - 'ts_paint', 22:54:23 INFO - 'tpaint', 22:54:23 INFO - 'sessionrestore', 22:54:23 INFO - 'sessionrestore_no_auto_restore', 22:54:23 INFO - 'tabpaint']}, 22:54:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['a11yr', 22:54:23 INFO - 'ts_paint', 22:54:23 INFO - 'tpaint', 22:54:23 INFO - 'sessionrestore', 22:54:23 INFO - 'sessionrestore_no_auto_restore', 22:54:23 INFO - 'tabpaint']}, 22:54:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['a11yr', 22:54:23 INFO - 'ts_paint', 22:54:23 INFO - 'tpaint', 22:54:23 INFO - 'sessionrestore', 22:54:23 INFO - 'sessionrestore_no_auto_restore', 22:54:23 INFO - 'tabpaint']}, 22:54:23 INFO - 'other_l64': {'tests': ['a11yr', 22:54:23 INFO - 'ts_paint', 22:54:23 INFO - 'tpaint', 22:54:23 INFO - 'sessionrestore', 22:54:23 INFO - 'sessionrestore_no_auto_restore', 22:54:23 INFO - 'tabpaint']}, 22:54:23 INFO - 'other_nol64': {'tests': ['a11yr', 22:54:23 INFO - 'ts_paint', 22:54:23 INFO - 'tpaint', 22:54:23 INFO - 'sessionrestore', 22:54:23 INFO - 'sessionrestore_no_auto_restore', 22:54:23 INFO - 'tabpaint']}, 22:54:23 INFO - 'svgr': {'tests': ['tsvgx', 22:54:23 INFO - 'tsvgr_opacity', 22:54:23 INFO - 'tart', 22:54:23 INFO - 'tscrollx', 22:54:23 INFO - 'cart']}, 22:54:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['tsvgx', 22:54:23 INFO - 'tsvgr_opacity', 22:54:23 INFO - 'tart', 22:54:23 INFO - 'tscrollx', 22:54:23 INFO - 'cart']}, 22:54:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:23 INFO - 'tests': ['tp5o']}, 22:54:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:23 INFO - 'talos_options': ['--e10s'], 22:54:23 INFO - 'tests': ['tp5o']}, 22:54:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:23 INFO - 'talos_options': ['--xperf_path', 22:54:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:23 INFO - 'tests': ['tp5n']}, 22:54:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:23 INFO - 'talos_options': ['--e10s', 22:54:23 INFO - '--xperf_path', 22:54:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:23 INFO - 'tests': ['tp5n']}}, 22:54:23 INFO - 'talos.zip': {'path': '', 22:54:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:23 INFO - Running post-action listener: _resource_record_post_action 22:54:23 INFO - ##### 22:54:23 INFO - ##### Running create-virtualenv step. 22:54:23 INFO - ##### 22:54:23 INFO - Running pre-action listener: _resource_record_pre_action 22:54:23 INFO - Running main action method: create_virtualenv 22:54:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:54:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:54:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:54:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:23 INFO - Using real prefix '/usr' 22:54:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:54:23 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:25 INFO - Installing pip.................done. 22:54:25 INFO - Return code: 0 22:54:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:54:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:54:25 INFO - Using env: {'DISPLAY': ':0', 22:54:25 INFO - 'HOME': '/home/cltbld', 22:54:25 INFO - 'LANG': 'en_US.UTF-8', 22:54:25 INFO - 'LANGUAGE': 'en_US:en', 22:54:25 INFO - 'LOGNAME': 'cltbld', 22:54:25 INFO - 'MAIL': '/var/mail/cltbld', 22:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:25 INFO - 'MOZ_NO_REMOTE': '1', 22:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:25 INFO - 'NO_EM_RESTART': '1', 22:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:25 INFO - 'SHELL': '/bin/bash', 22:54:25 INFO - 'SHLVL': '1', 22:54:25 INFO - 'TERM': 'linux', 22:54:25 INFO - 'TMOUT': '86400', 22:54:25 INFO - 'USER': 'cltbld', 22:54:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:25 INFO - '_': '/tools/buildbot/bin/python'} 22:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:54:25 INFO - Cleaning up... 22:54:25 INFO - Return code: 0 22:54:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:54:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:54:25 INFO - Using env: {'DISPLAY': ':0', 22:54:25 INFO - 'HOME': '/home/cltbld', 22:54:25 INFO - 'LANG': 'en_US.UTF-8', 22:54:25 INFO - 'LANGUAGE': 'en_US:en', 22:54:25 INFO - 'LOGNAME': 'cltbld', 22:54:25 INFO - 'MAIL': '/var/mail/cltbld', 22:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:25 INFO - 'MOZ_NO_REMOTE': '1', 22:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:25 INFO - 'NO_EM_RESTART': '1', 22:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:25 INFO - 'SHELL': '/bin/bash', 22:54:25 INFO - 'SHLVL': '1', 22:54:25 INFO - 'TERM': 'linux', 22:54:25 INFO - 'TMOUT': '86400', 22:54:25 INFO - 'USER': 'cltbld', 22:54:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:25 INFO - '_': '/tools/buildbot/bin/python'} 22:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:26 INFO - Downloading/unpacking psutil>=0.7.1 22:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:54:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:37 INFO - Installing collected packages: psutil 22:54:37 INFO - Running setup.py install for psutil 22:54:37 INFO - building 'psutil._psutil_linux' extension 22:54:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:54:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:54:37 INFO - building 'psutil._psutil_posix' extension 22:54:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:54:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:54:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:37 INFO - Successfully installed psutil 22:54:37 INFO - Cleaning up... 22:54:37 INFO - Return code: 0 22:54:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:54:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:54:37 INFO - Using env: {'DISPLAY': ':0', 22:54:37 INFO - 'HOME': '/home/cltbld', 22:54:37 INFO - 'LANG': 'en_US.UTF-8', 22:54:37 INFO - 'LANGUAGE': 'en_US:en', 22:54:37 INFO - 'LOGNAME': 'cltbld', 22:54:37 INFO - 'MAIL': '/var/mail/cltbld', 22:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:37 INFO - 'MOZ_NO_REMOTE': '1', 22:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:37 INFO - 'NO_EM_RESTART': '1', 22:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:37 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:37 INFO - 'SHELL': '/bin/bash', 22:54:37 INFO - 'SHLVL': '1', 22:54:37 INFO - 'TERM': 'linux', 22:54:37 INFO - 'TMOUT': '86400', 22:54:37 INFO - 'USER': 'cltbld', 22:54:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:37 INFO - '_': '/tools/buildbot/bin/python'} 22:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:54:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:54:47 INFO - Installing collected packages: mozsystemmonitor 22:54:47 INFO - Running setup.py install for mozsystemmonitor 22:54:47 INFO - Successfully installed mozsystemmonitor 22:54:47 INFO - Cleaning up... 22:54:47 INFO - Return code: 0 22:54:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:54:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:54:47 INFO - Using env: {'DISPLAY': ':0', 22:54:47 INFO - 'HOME': '/home/cltbld', 22:54:47 INFO - 'LANG': 'en_US.UTF-8', 22:54:47 INFO - 'LANGUAGE': 'en_US:en', 22:54:47 INFO - 'LOGNAME': 'cltbld', 22:54:47 INFO - 'MAIL': '/var/mail/cltbld', 22:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:47 INFO - 'MOZ_NO_REMOTE': '1', 22:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:47 INFO - 'NO_EM_RESTART': '1', 22:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:47 INFO - 'SHELL': '/bin/bash', 22:54:47 INFO - 'SHLVL': '1', 22:54:47 INFO - 'TERM': 'linux', 22:54:47 INFO - 'TMOUT': '86400', 22:54:47 INFO - 'USER': 'cltbld', 22:54:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:47 INFO - '_': '/tools/buildbot/bin/python'} 22:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:51 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:54:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:52 INFO - Downloading docopt-0.6.1.tar.gz 22:54:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:52 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:52 INFO - Running setup.py install for blobuploader 22:54:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:54:52 INFO - Running setup.py install for requests 22:54:53 INFO - Running setup.py install for docopt 22:54:53 INFO - Successfully installed blobuploader requests docopt 22:54:53 INFO - Cleaning up... 22:54:53 INFO - Return code: 0 22:54:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:54:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:54:53 INFO - Using env: {'DISPLAY': ':0', 22:54:53 INFO - 'HOME': '/home/cltbld', 22:54:53 INFO - 'LANG': 'en_US.UTF-8', 22:54:53 INFO - 'LANGUAGE': 'en_US:en', 22:54:53 INFO - 'LOGNAME': 'cltbld', 22:54:53 INFO - 'MAIL': '/var/mail/cltbld', 22:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:53 INFO - 'MOZ_NO_REMOTE': '1', 22:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:53 INFO - 'NO_EM_RESTART': '1', 22:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:53 INFO - 'SHELL': '/bin/bash', 22:54:53 INFO - 'SHLVL': '1', 22:54:53 INFO - 'TERM': 'linux', 22:54:53 INFO - 'TMOUT': '86400', 22:54:53 INFO - 'USER': 'cltbld', 22:54:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:53 INFO - '_': '/tools/buildbot/bin/python'} 22:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:53 INFO - Running setup.py (path:/tmp/pip-WKEr3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:53 INFO - Running setup.py (path:/tmp/pip-IQ6Dbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:53 INFO - Running setup.py (path:/tmp/pip-_05XPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:53 INFO - Running setup.py (path:/tmp/pip-B3LSDc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:53 INFO - Running setup.py (path:/tmp/pip-6GbDkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:53 INFO - Running setup.py (path:/tmp/pip-Adyr9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:53 INFO - Running setup.py (path:/tmp/pip-BxKUqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:53 INFO - Running setup.py (path:/tmp/pip-jx_28k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:54 INFO - Running setup.py (path:/tmp/pip-a3u2IW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:54 INFO - Running setup.py (path:/tmp/pip-yFBETo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:54 INFO - Running setup.py (path:/tmp/pip-mRHr32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:54 INFO - Running setup.py (path:/tmp/pip-1_2XV6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:54 INFO - Running setup.py (path:/tmp/pip-owz87x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:54 INFO - Running setup.py (path:/tmp/pip-5VEzwc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:54 INFO - Running setup.py (path:/tmp/pip-6GjYbQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:54 INFO - Running setup.py (path:/tmp/pip-94dYU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:54 INFO - Running setup.py (path:/tmp/pip-xPhV_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:54 INFO - Running setup.py install for manifestparser 22:54:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:54:54 INFO - Running setup.py install for mozcrash 22:54:54 INFO - Running setup.py install for mozdebug 22:54:54 INFO - Running setup.py install for mozdevice 22:54:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozfile 22:54:55 INFO - Running setup.py install for mozhttpd 22:54:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozinfo 22:54:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozInstall 22:54:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozleak 22:54:55 INFO - Running setup.py install for mozlog 22:54:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for moznetwork 22:54:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozprocess 22:54:55 INFO - Running setup.py install for mozprofile 22:54:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:54:56 INFO - Running setup.py install for mozrunner 22:54:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:54:56 INFO - Running setup.py install for mozscreenshot 22:54:56 INFO - Running setup.py install for moztest 22:54:56 INFO - Running setup.py install for mozversion 22:54:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:54:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:56 INFO - Cleaning up... 22:54:56 INFO - Return code: 0 22:54:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:54:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:54:56 INFO - Using env: {'DISPLAY': ':0', 22:54:56 INFO - 'HOME': '/home/cltbld', 22:54:56 INFO - 'LANG': 'en_US.UTF-8', 22:54:56 INFO - 'LANGUAGE': 'en_US:en', 22:54:56 INFO - 'LOGNAME': 'cltbld', 22:54:56 INFO - 'MAIL': '/var/mail/cltbld', 22:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:56 INFO - 'MOZ_NO_REMOTE': '1', 22:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:56 INFO - 'NO_EM_RESTART': '1', 22:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:56 INFO - 'SHELL': '/bin/bash', 22:54:56 INFO - 'SHLVL': '1', 22:54:56 INFO - 'TERM': 'linux', 22:54:56 INFO - 'TMOUT': '86400', 22:54:56 INFO - 'USER': 'cltbld', 22:54:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:56 INFO - '_': '/tools/buildbot/bin/python'} 22:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:56 INFO - Running setup.py (path:/tmp/pip-gq1jwx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:56 INFO - Running setup.py (path:/tmp/pip-PdOqBb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:56 INFO - Running setup.py (path:/tmp/pip-vNVbh1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:56 INFO - Running setup.py (path:/tmp/pip-3lNutX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:56 INFO - Running setup.py (path:/tmp/pip-H1IjSC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:57 INFO - Running setup.py (path:/tmp/pip-FeLOo_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:57 INFO - Running setup.py (path:/tmp/pip-P6Xdyi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:57 INFO - Running setup.py (path:/tmp/pip-NOD9_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:57 INFO - Running setup.py (path:/tmp/pip-znfvyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:57 INFO - Running setup.py (path:/tmp/pip-6XFUxQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:57 INFO - Running setup.py (path:/tmp/pip-W9esmP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:57 INFO - Running setup.py (path:/tmp/pip-xfjGCq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:57 INFO - Running setup.py (path:/tmp/pip-OeWkUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:57 INFO - Running setup.py (path:/tmp/pip-HHgRa7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:57 INFO - Running setup.py (path:/tmp/pip-7oT4X9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:57 INFO - Running setup.py (path:/tmp/pip-YD75AN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:57 INFO - Running setup.py (path:/tmp/pip-87FfV2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:54:57 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:57 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:54:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:55:03 INFO - Downloading blessings-1.6.tar.gz 22:55:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:55:03 INFO - Installing collected packages: blessings 22:55:03 INFO - Running setup.py install for blessings 22:55:03 INFO - Successfully installed blessings 22:55:03 INFO - Cleaning up... 22:55:03 INFO - Return code: 0 22:55:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:55:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:55:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:04 INFO - Reading from file tmpfile_stdout 22:55:04 INFO - Current package versions: 22:55:04 INFO - argparse == 1.2.1 22:55:04 INFO - blessings == 1.6 22:55:04 INFO - blobuploader == 1.2.4 22:55:04 INFO - docopt == 0.6.1 22:55:04 INFO - manifestparser == 1.1 22:55:04 INFO - mozInstall == 1.12 22:55:04 INFO - mozcrash == 0.17 22:55:04 INFO - mozdebug == 0.1 22:55:04 INFO - mozdevice == 0.48 22:55:04 INFO - mozfile == 1.2 22:55:04 INFO - mozhttpd == 0.7 22:55:04 INFO - mozinfo == 0.9 22:55:04 INFO - mozleak == 0.1 22:55:04 INFO - mozlog == 3.1 22:55:04 INFO - moznetwork == 0.27 22:55:04 INFO - mozprocess == 0.22 22:55:04 INFO - mozprofile == 0.28 22:55:04 INFO - mozrunner == 6.11 22:55:04 INFO - mozscreenshot == 0.1 22:55:04 INFO - mozsystemmonitor == 0.0 22:55:04 INFO - moztest == 0.7 22:55:04 INFO - mozversion == 1.4 22:55:04 INFO - psutil == 3.1.1 22:55:04 INFO - requests == 1.2.3 22:55:04 INFO - wsgiref == 0.1.2 22:55:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:55:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:55:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:55:04 INFO - Using env: {'DISPLAY': ':0', 22:55:04 INFO - 'HOME': '/home/cltbld', 22:55:04 INFO - 'LANG': 'en_US.UTF-8', 22:55:04 INFO - 'LANGUAGE': 'en_US:en', 22:55:04 INFO - 'LOGNAME': 'cltbld', 22:55:04 INFO - 'MAIL': '/var/mail/cltbld', 22:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:04 INFO - 'MOZ_NO_REMOTE': '1', 22:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:04 INFO - 'NO_EM_RESTART': '1', 22:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:04 INFO - 'SHELL': '/bin/bash', 22:55:04 INFO - 'SHLVL': '1', 22:55:04 INFO - 'TERM': 'linux', 22:55:04 INFO - 'TMOUT': '86400', 22:55:04 INFO - 'USER': 'cltbld', 22:55:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:04 INFO - '_': '/tools/buildbot/bin/python'} 22:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:55:04 INFO - Cleaning up... 22:55:04 INFO - Return code: 0 22:55:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:55:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:55:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:55:04 INFO - Using env: {'DISPLAY': ':0', 22:55:04 INFO - 'HOME': '/home/cltbld', 22:55:04 INFO - 'LANG': 'en_US.UTF-8', 22:55:04 INFO - 'LANGUAGE': 'en_US:en', 22:55:04 INFO - 'LOGNAME': 'cltbld', 22:55:04 INFO - 'MAIL': '/var/mail/cltbld', 22:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:04 INFO - 'MOZ_NO_REMOTE': '1', 22:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:04 INFO - 'NO_EM_RESTART': '1', 22:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:04 INFO - 'SHELL': '/bin/bash', 22:55:04 INFO - 'SHLVL': '1', 22:55:04 INFO - 'TERM': 'linux', 22:55:04 INFO - 'TMOUT': '86400', 22:55:04 INFO - 'USER': 'cltbld', 22:55:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:04 INFO - '_': '/tools/buildbot/bin/python'} 22:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:04 INFO - Downloading/unpacking jsonschema 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:55:10 INFO - Downloading/unpacking functools32 (from jsonschema) 22:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:10 INFO - Downloading functools32-3.2.3-2.tar.gz 22:55:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:55:11 INFO - warning: no files found matching '*.txt' 22:55:11 INFO - no previously-included directories found matching 'build' 22:55:11 INFO - no previously-included directories found matching 'dist' 22:55:11 INFO - no previously-included directories found matching '.git*' 22:55:11 INFO - Installing collected packages: jsonschema, functools32 22:55:11 INFO - Running setup.py install for functools32 22:55:11 INFO - warning: no files found matching '*.txt' 22:55:11 INFO - no previously-included directories found matching 'build' 22:55:11 INFO - no previously-included directories found matching 'dist' 22:55:11 INFO - no previously-included directories found matching '.git*' 22:55:11 INFO - Successfully installed jsonschema functools32 22:55:11 INFO - Cleaning up... 22:55:11 INFO - Return code: 0 22:55:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fd7add10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:55:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:55:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:55:11 INFO - Using env: {'DISPLAY': ':0', 22:55:11 INFO - 'HOME': '/home/cltbld', 22:55:11 INFO - 'LANG': 'en_US.UTF-8', 22:55:11 INFO - 'LANGUAGE': 'en_US:en', 22:55:11 INFO - 'LOGNAME': 'cltbld', 22:55:11 INFO - 'MAIL': '/var/mail/cltbld', 22:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:11 INFO - 'MOZ_NO_REMOTE': '1', 22:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:11 INFO - 'NO_EM_RESTART': '1', 22:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:11 INFO - 'SHELL': '/bin/bash', 22:55:11 INFO - 'SHLVL': '1', 22:55:11 INFO - 'TERM': 'linux', 22:55:11 INFO - 'TMOUT': '86400', 22:55:11 INFO - 'USER': 'cltbld', 22:55:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:11 INFO - '_': '/tools/buildbot/bin/python'} 22:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:11 INFO - Downloading/unpacking flake8 22:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:55:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:55:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:55:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:17 INFO - no previously-included directories found matching 'docs/_build' 22:55:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:55:17 INFO - Running setup.py install for pep8 22:55:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:17 INFO - no previously-included directories found matching 'docs/_build' 22:55:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:55:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:55:17 INFO - Cleaning up... 22:55:17 INFO - Return code: 0 22:55:17 INFO - Running post-action listener: _resource_record_post_action 22:55:17 INFO - Running post-action listener: _start_resource_monitoring 22:55:17 INFO - Starting resource monitoring. 22:55:17 INFO - ##### 22:55:17 INFO - ##### Running install step. 22:55:17 INFO - ##### 22:55:17 INFO - Running pre-action listener: _resource_record_pre_action 22:55:17 INFO - Running main action method: install 22:55:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:55:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:17 INFO - Reading from file tmpfile_stdout 22:55:17 INFO - Detecting whether we're running mozinstall >=1.0... 22:55:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:55:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:55:17 INFO - Reading from file tmpfile_stdout 22:55:17 INFO - Output received: 22:55:17 INFO - Usage: mozinstall [options] installer 22:55:17 INFO - Options: 22:55:17 INFO - -h, --help show this help message and exit 22:55:17 INFO - -d DEST, --destination=DEST 22:55:17 INFO - Directory to install application into. [default: 22:55:17 INFO - "/builds/slave/test-pgo"] 22:55:17 INFO - --app=APP Application being installed. [default: firefox] 22:55:17 INFO - mkdir: /builds/slave/test-pgo/build/application 22:55:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:55:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:55:33 INFO - Reading from file tmpfile_stdout 22:55:33 INFO - Output received: 22:55:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:55:33 INFO - Running post-action listener: _resource_record_post_action 22:55:33 INFO - ##### 22:55:33 INFO - ##### Running run-tests step. 22:55:33 INFO - ##### 22:55:33 INFO - Running pre-action listener: _resource_record_pre_action 22:55:33 INFO - Running main action method: run_tests 22:55:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:55:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:55:33 INFO - Python 2.7.3 22:55:33 INFO - Return code: 0 22:55:33 INFO - grabbing minidump binary from tooltool 22:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:33 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 0x1378920>, '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 0x1379820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1379cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:55:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:55:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:55:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:55:33 INFO - Return code: 0 22:55:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:55:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:55:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:55:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:55:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:55:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:55:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:55:34 INFO - Return code: 0 22:55:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:55:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:55:34 INFO - Using env: {'DISPLAY': ':0', 22:55:34 INFO - 'HOME': '/home/cltbld', 22:55:34 INFO - 'LANG': 'en_US.UTF-8', 22:55:34 INFO - 'LANGUAGE': 'en_US:en', 22:55:34 INFO - 'LOGNAME': 'cltbld', 22:55:34 INFO - 'MAIL': '/var/mail/cltbld', 22:55:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:55:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:34 INFO - 'MOZ_NO_REMOTE': '1', 22:55:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:55:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:34 INFO - 'NO_EM_RESTART': '1', 22:55:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:55:34 INFO - 'SHELL': '/bin/bash', 22:55:34 INFO - 'SHLVL': '1', 22:55:34 INFO - 'TERM': 'linux', 22:55:34 INFO - 'TMOUT': '86400', 22:55:34 INFO - 'USER': 'cltbld', 22:55:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572', 22:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:34 INFO - '_': '/tools/buildbot/bin/python'} 22:55:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:55:34 INFO - mozversion application_buildid: 20160401201148 22:55:34 INFO - mozversion application_changeset: 7c164deed2231846aceaf869fa251d1ce8052d01 22:55:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:55:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:55:34 INFO - mozversion application_name: Firefox 22:55:34 INFO - mozversion application_remotingname: firefox-dev 22:55:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:55:34 INFO - mozversion application_vendor: Mozilla 22:55:34 INFO - mozversion application_version: 47.0a2 22:55:34 INFO - mozversion platform_buildid: 20160401201148 22:55:34 INFO - mozversion platform_changeset: 7c164deed2231846aceaf869fa251d1ce8052d01 22:55:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:55:34 INFO - mozversion platform_version: 47.0a2 22:55:34 INFO - using testdate: 1459576534 22:55:34 INFO - actual date: 1459576534 22:55:34 INFO - starting webserver on 'localhost:60969' 22:55:34 INFO - SUITE-START | Running 2 tests 22:55:34 INFO - TEST-START | dromaeo_css 22:55:34 INFO - operating with platform_type : linux_ 22:55:34 INFO - Initialising browser for dromaeo_css test... 22:55:34 INFO - TEST-INFO | started process 26553 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVyLOnx/profile http://localhost:60969/getInfo.html) 22:55:37 INFO - PROCESS | 26553 | 22:55:37 INFO - PROCESS | 26553 | (process:26630): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:55:38 INFO - PROCESS | 26553 | __metrics Screen width/height:1600/1200 22:55:38 INFO - PROCESS | 26553 | colorDepth:24 22:55:38 INFO - PROCESS | 26553 | Browser inner width/height: 1024/697 22:55:38 INFO - PROCESS | 26553 | __metrics 22:55:39 ERROR - PROCESS | 26553 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:55:40 INFO - TEST-INFO | 26553: exit 0 22:55:40 INFO - Browser initialized. 22:55:40 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:40 INFO - TEST-INFO | started process 26681 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVyLOnx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:42 INFO - PROCESS | 26681 | 22:55:42 INFO - PROCESS | 26681 | (process:26749): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:55:52 INFO - PROCESS | 26681 | RSS: Main: 151658496 22:55:52 INFO - PROCESS | 26681 | 22:56:41 INFO - PROCESS | 26681 | 1459576601596 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:58:49 INFO - PROCESS | 26681 | Cycle 1(1): loaded http://localhost:60969/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60969/tests/dromaeo/cssquery-ext.html) 22:58:50 INFO - PROCESS | 26681 | RSS: Main: 154697728 22:58:50 INFO - PROCESS | 26681 | 23:01:52 INFO - PROCESS | 26681 | Cycle 1(1): loaded http://localhost:60969/tests/dromaeo/cssquery-ext.html (next: http://localhost:60969/tests/dromaeo/cssquery-jquery.html) 23:01:53 INFO - PROCESS | 26681 | RSS: Main: 153882624 23:01:53 INFO - PROCESS | 26681 | 23:04:54 INFO - PROCESS | 26681 | Cycle 1(1): loaded http://localhost:60969/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60969/tests/dromaeo/cssquery-mootools.html) 23:04:55 INFO - PROCESS | 26681 | RSS: Main: 153669632 23:04:55 INFO - PROCESS | 26681 | 23:07:57 INFO - PROCESS | 26681 | Cycle 1(1): loaded http://localhost:60969/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60969/tests/dromaeo/cssquery-prototype.html) 23:07:57 INFO - PROCESS | 26681 | RSS: Main: 152825856 23:07:57 INFO - PROCESS | 26681 | 23:11:00 INFO - PROCESS | 26681 | Cycle 1(1): loaded http://localhost:60969/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60969/tests/dromaeo/cssquery-yui.html) 23:11:00 INFO - PROCESS | 26681 | RSS: Main: 154132480 23:11:00 INFO - PROCESS | 26681 | 23:14:02 INFO - PROCESS | 26681 | Cycle 1(1): loaded http://localhost:60969/tests/dromaeo/cssquery-yui.html (next: http://localhost:60969/tests/dromaeo/cssquery-dojo.html) 23:14:03 INFO - PROCESS | 26681 | RSS: Main: 155705344 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - PROCESS | 26681 | __start_tp_report 23:14:03 INFO - PROCESS | 26681 | _x_x_mozilla_page_load 23:14:03 INFO - PROCESS | 26681 | _x_x_mozilla_page_load_details 23:14:03 INFO - PROCESS | 26681 | |i|pagename|runs| 23:14:03 INFO - PROCESS | 26681 | |0;dojo.html;3307.9834600826994;3384.187794929218;3386.3904497190497;3431.691147796698;3433.8798142065034;5506.944930550693;5522.696251706155;5530.695811730363;5531.806386776464;5549.694766787825;5508.614396992212;5520.365158006821;5525.226468294442;5532.972335138329;5561.499465048145;5045.899082018375;5071.112555302826;5116.1814109742445;5135.8202462913805;5146.3309769729885;4975.0547395994645;5104.77028533715;5107.7701503432245;5144.742762861861;5181.922271165917;5023.095842748304;5063.46833582474;5085.415177254626;5146.716930568836;5186.818461353853;5163.7676304566385;5179.922301165486;5187.118189907687;5187.844364669066;5187.922181167285;4923.48303428142;4969.0807200668;5162.767675454614;5172.818951336722;5195.558377537914;5362;5390.757415916293;5396.83809485716;5418.187271909206;5419.187121931703;5937.970310148465;5963.970180149072;5995.820125396245;5998.40015998401;6001.979663457223;5958.285005799288;6023.066424704178;6047.395260473917;6075.2405949256345;6083.17877086592;5530.529904958124;5565.554755619541;5582.581306402036;5601.327840659106;5622.044252477089;5984.491318237911;6117.938820611737;6130.724117414727;6134;6135.509159267248;5879.794207202813;5955.196048533393;5971.104334349795;5975.970120149458;5994.310654274727;5996.640201587918;6007.609505382136;6022.849428764316;6028.457438830526;6045.516358691294;5807.216025836458;5955.791547295824;5998.190244316961;6011.939880601226;6012.338642749294;5913.231279933581;5932.3177834548715;5958.225430694069;5980.521558275327;6018.398160183947;4536.500984891659;4539.477960034572;4552.2488789350045;4559.110973360229;4585.037142200175;3987.5613682494904;4067.7355971861734;4104;4117.1765646870745;4136.8138433770555;5522.337319521683;5613.90528846871;5671.347795003628;5692.402297758758;5714.171445140514;5936.28764548257;5941.049432090845;5971.79098731551;5972.5520585955355;5995.550333724901;5537.972310138504;5633.830985070373;5641.774329026875;5645.915311270334;5656.236408084938;5105.030044291572;5201.45384734605;5256.894862102737;5271.604629652791;5299.205119232146;6169.475594574422;6186.133941248228;6204.13142160098;6215.098810672517;6216.067589861466;5888.705564721832;6045.183900173596;6050.122732203894;6053.939460605337;6063.060225665029;6137.131844484677;6253;6253.343398943228;6254.874902502015;6256.7810126645345;5874.412558744091;5890.852728681646;5918.3489816121055;5923.496502797138;5954.821355359346;5887.116932460165;5993.730282137401;6007.609505382136;6012.278526576664;6016.969915150396;5812.796552120655;5874.706264686834;5884;5890.7054647266605;5911.231539899957;5867.823965281048;5877.676727780014;5887.793927212527;5904.704764761831;5912;5619.100943848965;5766.106253530709;5812.041013232769;5821.912671310019;5857.4435428634215;5843.94156058434;5886.940350736909;5902.291724993029;5916.526677865674;5918.378570250062;5757.625754325955;5768.596198266249;5780.21967034445;5782.913256301074;5792.594518383673 23:14:03 INFO - PROCESS | 26681 | |1;ext.html;544.7140251368032;545.4027839515732;568.7241687781425;585.002570617098;619.2228752915091;31565.526517102233;41133.38299925496;41228;41252.793736031315;41342.37986430206;43525;43654.345184822174;43808.56191438084;43958.340624890574;44072.118557628906;8654.17785310396;8754.299656027535;8817.691380801672;8840.894888138982;8888.155625215593;8786.560671966376;8948.597313120892;9018.954905225464;9033.548322583878;9159.633614655406;9064.728058158265;9146.77133071672;9167.908320916773;9169.128932751411;9219.400738951947;9084.046175151647;9088.636454541811;9129.406588571721;9151.86272205914;9165.404248723846;9026.503542305236;9121.726348209564;9135.771605709844;9174.036726143791;9200.81598368029;43425.56574434247;43786.34320485163;43862.12275754467;43868.78065609652;43904.3414348785;3737.9439308410397;3775.962240377616;3817.580066192744;3837.539495260559;4031.5162180538523;31555.526667100014;31776;32131.51802722961;32176.356472870644;32879.178020549436;4243.830246790125;4279.122779830159;4279.40088387626;4318.632916202127;4359.912801743979;310167;313993;314831;315601;315980;49875.25187122196;50198.24702629464;72481.27518724851;74216;74235;49129.50870491249;49408.25887611689;49557;49649.75175124101;49706.50293497091;16426.260818263207;16576.502704918872;16599.336026559045;16629.6674066518;16656.33374665024;12794.42425090873;12836.679083022998;12837.807432888514;12915.160514566523;12921.289329086803;16611.91694041522;16712;16802.747958780627;16806.495805125865;16919.154042297836;6313.684315784192;6461.8061458156335;6541.5093867960095;6649.63427011519;6718.66406679664;1025.6666583360438;1032.6850310655173;1108.4014632098576;1140.00819287219;1186.0096819156101;29967.850160749058;30509.237269068006;30898.382032359226;30949.381012379625;31052.378952420826;1129.305477131558;1156.115571587736;1193.2601786892183;1215.8115492098739;1255.6798016505916;15812.525624231292;15951;16023;16123.11322877253;16388.590285242964;334208;550709;556295;924798;940364;64536;65115;65477.34522654808;65799.34200658028;66030.33969660338;1467.5670677150267;1500.3923411018554;1531.923403829804;1548.1253092002758;1552.534239728077;31802.52296215605;32008;32254.516182256815;32509.837450812596;33025.83487082549;52239.21641175461;52674.47325526696;52730;52827;53028;315430;318924;320410;320442;321091;35292;35428.29143417066;35553;35787.28425431529;35948.82025589855;46578.301325480825;47226.76386618045;47284.52715472939;48146.51853481561;48263.75868120637;39894.40158397568;39927.003649817976;40364.59635403608;40646;40842.387364188966;39367.606323936394;39680;40218.7264730352;40612.79693601631;41142.79428602838;39867.2026559473;40276;40299.3955090668;40637.39043914403;40665.186696265315;34218.82890585531;34949.548091861056;34979.47530786989;35527.46708799422;35602;27013;28012;28033.719662803112;28049.71950280471;28110.156695299174 23:14:03 INFO - PROCESS | 26681 | |2;jquery.html;370.8034741586959;393.10176247275;398.54133870035673;399.2872722190889;403.70932928291637;14863.256837158153;15280.312385942632;17879.55301117471;18631;18680.719789203155;17392.56518587036;17605.207765650546;17658.117094145306;17730.82269177308;18710.25158993642;5474.39781624021;5637.069883469223;5646.096624540074;5659.151127330892;5676.687782171979;5407;5616.045272303718;5626.606137570372;5639.210510528529;5699.145128230757;5596.888062238752;5601.579881508903;5601.691906945116;5608;5637.8590535236535;5326.627136100475;5546.556275497971;5587.38538760736;5600.411956744565;5637.661740295595;5028.321176641143;5030.597552195853;5041.344625198701;5060.924086138711;5061.468545802712;21641.35075947724;21646.675299870516;21867.562648746934;22141.557168856532;22298.665520017214;2341.098677009347;2356.7289761677457;2396.7962723168553;2442;2448.4490989527394;13643.317834108355;13734.519291824738;13760.587182384445;13797.379117939718;13974.091684040606;1871.2421469304954;1949.6393167264102;1993.1628715939341;1997.3009446693686;2010.5576773109892;66004;66107.66946165287;66664.66667666679;66748.66625666889;66904.33095669029;9655.903440965641;9965.850512242323;10155.695329140137;10197.796044079078;10322.587096516205;14384.928075359556;14478;14493.565193044225;14604.561863144123;14623.488177913934;7032.753853615099;7365.189829118793;7369.189389167187;7808.375329973588;8009.31920786728;7667.156612772591;7679.155292917774;7687.077550693953;7729.574873382018;7796.688132474751;4294.420253265832;4303.462067241595;4307.117041006586;4330.2638551446325;4339.978300108479;1791.641671665672;1835.128314050815;1877.4461533847548;1879.4079864842531;1907.2929727893459;919.6413398774483;962.0187408842941;1011.6762635956424;1023.0792286941812;1032.7624646331235;15678.843211567966;17063.31746730142;17268.481945541655;17555.473335799947;17588.824111758975;947.7962238118838;952.1620973543238;956.4596003258137;1019.0268293779571;1019.261035749076;7139.678714457862;10162.745931351776;10171.949140254252;10292.073713365833;10316.896831031743;464505;467477;474030;478564;485772;49634.255486167734;60890.391096089355;64827;77116.61441692755;78961.60519197368;1012.291396022787;1022.1260821997234;1026.707388394304;1061.3260579532052;1065.9520321585546;15977.8402215981;16008.679826403173;16226.432074877323;16237.18814059316;16509.504714858573;36256.27487450289;36348;36589;36905.44641830429;37266.62733372632;49950;52022;52509.474905250456;53020.73489632527;53082.2037669443;8002.479838810459;8471.32229421657;8516.70191543293;8577.185167409087;8971.641134354553;12576.685582860502;13456.596302110953;13549;13720;13757;11109.666709998713;11505.194636375709;11673;11727.88272117302;11795.882041179479;11211.271267367594;11287;11456.026237769884;11973.341466219441;12193.878061219275;11801.70495737579;11845.289282643069;11859.16985810985;12039.879601204226;12071.939640302093;8706.434081784664;8803.911960880308;8841.16008979146;8902.821943561223;8967.058458861986;11160.274582152135;11455.140864435034;11544.711382215512;11589.536418543164;11663.766724665289 23:14:03 INFO - PROCESS | 26681 | |3;mootools.html;1597.5526852481305;1638.5166375919102;1892.9588726200595;1943.1547276934543;1982.6332128556219;7531;7985.600719964008;8388.790280242996;8547.487150770958;8575.056743758189;8164.06113296971;8255.793605159874;8334.666613335474;8336.04135524415;8360.958195209016;2434.8052155827536;2447.6206188040883;2450.705915290159;2461.79074778644;2471.7775400213977;2428.1986944308424;2452.2520631207476;2465.6917885264343;2470.3330100872754;2476.2571228631427;2428.1501474483875;2463.2363967170236;2515.7987361011164;2516.1570873757314;2529.9620505692337;2464.4824586836785;2464.581021226396;2473.727889932106;2523.709773376067;2530.165045534969;2445.7065152181854;2449.9020039198413;2453.815963802722;2467.6545283660303;2469.32093674241;8389.244967952913;8431.367647426407;8437.535935523543;8444.535550544717;8493.193146651058;5189.403218629868;5283.418823929364;5324.387695415038;5331.893362132774;5335.253064570963;3191.2021994501374;3209;3263.543103965447;3274.754393420503;3298.455754800455;1002.7944271424341;2034.7151398804178;2058.8455865810124;2109.7784732603163;2118.05746442833;11608.187426880122;11623.07015438763;11695.532178712841;11742.412879356083;11748.236364636272;4359.80380882861;4544.613707834805;4563.840265590688;4603.631709463235;4635.539804961426;9553.856692149624;9612.086851749073;9648.228141748643;9662.951685241529;9685.757856053655;5284.07528682479;5299.072662284085;5312.362516498045;5322.520973112439;5340.572754179734;4762;4768.427788665383;4833.419989601271;4859.271109333628;4938.604911607063;3779.093017675738;3807.428885667117;3820.56063552695;3845.730798844054;3854.421836724514;1200.8739082396398;1207.7946749052683;1209.4436559182698;1210.1226610707167;1220.871808460099;1457.5918742751835;1463.9194844283666;1474.6903150338549;1477.8152730908637;1496.177102593591;8068.314193293636;8084.1107478177355;8110.553919534483;8121.79695507617;8124.7562573122905;530.6736357140331;539.099703495164;540.8810061786401;549.4038967719989;549.5685886579016;6259.499240060784;6273.592216505913;6315.652639104894;6355.9830427132365;6438;10049.598016079275;10313.84529232062;10328.225383096147;10357.17142628603;10386.169106471463;9872.753181170385;10110.443925584164;10119.139873110867;10140.797184056277;10215.387076775418;7932.365410767125;7938.047434308036;7994.960025199837;8016.038075430869;8037;7488.663010164447;7656.923430765621;7720.3051725344985;7721.498102623312;7767.106782719833;8869.423487473294;8930.508822014592;9023.097690230925;9033.322500812334;9306.581203845979;9118.863217051618;9338.11287927673;9446;9513.429194248367;9536.332456727963;6562.278149403657;7415.666295016845;7522.210167932507;7588.962055189689;7796.376289896908;7976.441649084509;7985;8024.358051355995;8050.597470126588;8107.4324797263625;7145.089363221962;7348.816279593053;7367.079115110611;7458.888116678363;7543.585102819397;7113.253108423748;7139.2503787101605;7195.02867112954;7247.057882475245;7278.871774874903;7525.510841795266;7554.773356799305;7571.772846814604;7688.577128258;7698.92215089899;6637.834054148491;6771.864562708817;6810.42111420515;6826.897596536155;6840.726370945106;6967.8606427870145;7051.435885129074;7098.964505177441;7108.46686498525;7148.678309475982 23:14:03 INFO - PROCESS | 26681 | |4;prototype.html;356.63266835159794;357.1535460957529;365.37338464533303;365.8097789149642;369.3573182662168;6364.363563643639;6427.871442571146;6468.417842394184;6473.805785826421;6479.805605831821;6240.4071613196675;6282.780102696406;6294.339094395092;6301.40136687014;6335.809925702225;4650.86047418578;4767.1657459944545;4803.159447096761;4815.109204797106;4855.223164293714;4834.347363105989;4849.296851956464;4856.174450343432;4861.611071114302;4865.391826021747;4782.33047373368;4811.06184294061;4821.710697358169;4822.156122678535;4839.540243676845;4837.685550439245;4843.491433399495;4851.660383773137;4851.927221091686;4853.927191092136;4234.957650423487;4240.342746874239;4243.299855523835;4247.660187185018;4248.532661407274;5986.8503287417725;6082.118092876508;6098.54260930432;6099.84750381244;6101.694915254219;5595.356533998561;5605.299337582802;5616.663000219959;5622.775088996435;5625.634333768292;6666.433353164987;6666.966665166643;6704.463642908556;6709.094272273278;6734.595924244561;4536.432945881765;4588.0365123324145;4603.884902877421;4608.654350923661;4610.3315019322345;6979.860402791966;7055.788326350218;7066.505344625878;7084.787456376265;7084.893726594105;4609.239475486507;4755.310479980383;4757.048590281957;4767.046590681877;4776.188048031843;4801.063792560417;4817.325574419584;4834.734089625104;4843.878903027453;4848.3454733610515;5562.082256427725;5585.106382978704;5643.689597072201;5649.209110724501;5658.405867383948;6773.8983915241315;6791.351372964449;6801.9319806801295;6811.761588344483;6835.521513494008;1689.864810815132;1720.329071662053;1721.8106008339073;1723.9741403878702;1725.6980028494963;1083.3391631105019;1103.7516558774212;1109.1847492093304;1111.360967443723;1128.4019469681082;6390.9360906391275;6417.903731444032;6427.453666438311;6432.77485288022;6438.581492202992;6907.75822846208;6962.373386395248;6964.7562335319035;6980.581165130108;6986.196587392414;6222.751089956351;6322.430981211713;6424.38968298011;6559.24568674599;6564.704588293538;3771.5097037384962;3807.9238415232094;3832.2527107214382;3838.808059597065;3843.7309388342546;7339.669714862737;7392.223816499298;7395.556266623912;7397.778066658009;7401.703931842773;7129;7228.638568071576;7247.565146091251;7263.7288474516745;7272.236415176436;7004.894926576106;7405.1484079330485;7406.962965185139;7438.888416673754;7460.813479662943;6985.057017302599;6986.091808064919;7001.684924178526;7011.509194356346;7081;6933.2026816916705;6968;6972.616506092214;6974.546654467444;6984.16190057176;7391.445641576795;7404.481686281909;7413.925860741324;7415.629218539159;7429.925700742923;4573.314002899591;4743.525647435229;4768.427788665383;4789.880252993703;4801.9039619208115;6965;6986.510944233854;6994.860102798018;7009.614471204132;7016.719331226694;6703.664816759045;6800.693968771516;6802.319768023158;6807.3873351398615;6812.386885180357;6735.797926062226;6741.764038258638;6748.9876518522615;6764.526483146329;6782.898256526058;6546.967265163644;6672.299408562225;6802.081718968074;6803.863922721617;6812.557183783237;6830.7609233676585;6845.0759147514445;6851.3491218334175;6891.207511136284;6899.344562266577;6676.332366763285;6731.663416829237;6746.392824645805;6750.493712971449;6758.7296508139125 23:14:03 INFO - PROCESS | 26681 | |5;yui.html;795.8766391209365;877.3595275448922;881.4534988307247;892.3218354050921;916.9358144929857;13226.867731322684;13465.663358416045;13470.057096003284;13481.056326057156;13531.864681353183;14025.088369255991;14087.084339517924;14095.436182552712;14103.435862565486;14123.78814317786;749.4791120171483;902.9232515236213;928.3640706116332;930.0792215706435;930.3580529434702;899.7345782994032;900.545224661545;908.5593487158723;909.6816114359954;910.6812615584558;971.1647982734878;975.7511834482198;977.4233202410576;978.0268632710463;978.5694294510429;970.2189737261466;971.1017308989157;971.4851128901694;974.2985050763439;975.3465178330536;727.6252729844134;729.6898818002328;731.3673672273445;732.1251104929611;733.600187897597;13695.726085478234;13897;13932.651683707887;13940.024198306122;13960.790588141084;13052.412641431063;13249.602511924657;13320.467181312735;13396.933015334958;13522.256275904821;11709.121815863844;11754.11844111695;11757.470913808898;11760.529578816837;11823.940880295544;3932.292187406266;3932.5870783567884;3949.8878494447135;3956.208758248362;3979.2041591681777;54188.45811541873;54463.72768136134;54605.726971365286;54697;55335.723321383535;11245.775084498264;11268.21122521432;11341.206115571831;11365.374904380173;11607.30356178632;20763.37709868676;20811.1675532977;20952;21011.15955361799;21097.472563185736;8323.583820808935;8458.788530286669;8539.957300213584;8617.526036068077;8807.559622019002;4905.190643543847;4913.70517768935;4921.901561968741;5037.773300201499;5054.772535235923;3397.5413319202084;3489.197484578561;3508.2281897982402;3516.894493165209;3523;612.0757655939564;627.9434850863444;637.5823835387829;639.2393052267787;641.6727468990848;602.3163709190013;635.5900444213456;638.7061951502361;661.7187695229508;672.2705864137367;7489.28851759082;7556.886646700304;7634.885476717854;7667.578283194478;7691.961540192263;506.5390494649851;626.8464226264595;636.0935666674969;645.9595231824906;657.9703913323912;3585.713142948558;3590.6409359064405;3636.8545258189374;3708.2398108388256;3805.980970095132;59580;60959;61205;61235.693821531495;61353;55249.44750552523;55561.722191388784;56258.15612765812;56551.43448565544;57421;50186.498135018184;50437.747811260706;50820.74589627028;50834.491655083715;50890.745546272774;7148.463865210234;7148.499605027599;7170.569765814068;7246.818829529304;7325.743598974011;38223.42664860085;38411.80794096012;38806.41790373203;38821.641242556376;40120;46135.53864461312;49117.2632410507;49305.75347123241;49649.75175124101;49958.75020624873;9779.902200977898;10114.443705595968;10253.436061016715;10363.170946324126;10385.324953877975;10847.837282440612;10873.68757235795;10993.110652373774;11046;11076.501557429774;9982.900170998197;10040.14658754014;10301.433421161608;10312.071913527818;10373.740656483647;9932.453715045742;10025.448600327052;10137.543810528396;10169;10238.692839214835;9656.109584692935;9850.507474626384;9894.604215831287;9956.2532810041;10042.28012833967;8713.912860871564;8723.78190545216;8727.781805454915;9021.458712477272;9032.14194651507;8486.405951583576;8892.688755893512;8908.643654254016;8919.152680495343;8995.95502022512 23:14:03 INFO - PROCESS | 26681 | __end_tp_report 23:14:03 INFO - PROCESS | 26681 | __start_cc_report 23:14:03 INFO - PROCESS | 26681 | _x_x_mozilla_cycle_collect,341 23:14:03 INFO - PROCESS | 26681 | __end_cc_report 23:14:03 INFO - PROCESS | 26681 | __startTimestamp1459577642999__endTimestamp 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - PROCESS | 26681 | ------- Summary: start ------- 23:14:03 INFO - PROCESS | 26681 | Number of tests: 6 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - PROCESS | 26681 | [#0] dojo.html Cycles:165 Average:5565.37 Median:5807.22 stddev:616.39 (10.6%) stddev-sans-first:592.29 23:14:03 INFO - PROCESS | 26681 | Values: 3308.0 3384.2 3386.4 3431.7 3433.9 5506.9 5522.7 5530.7 5531.8 5549.7 5508.6 5520.4 5525.2 5533.0 5561.5 5045.9 5071.1 5116.2 5135.8 5146.3 4975.1 5104.8 5107.8 5144.7 5181.9 5023.1 5063.5 5085.4 5146.7 5186.8 5163.8 5179.9 5187.1 5187.8 5187.9 4923.5 4969.1 5162.8 5172.8 5195.6 5362.0 5390.8 5396.8 5418.2 5419.2 5938.0 5964.0 5995.8 5998.4 6002.0 5958.3 6023.1 6047.4 6075.2 6083.2 5530.5 5565.6 5582.6 5601.3 5622.0 5984.5 6117.9 6130.7 6134.0 6135.5 5879.8 5955.2 5971.1 5976.0 5994.3 5996.6 6007.6 6022.8 6028.5 6045.5 5807.2 5955.8 5998.2 6011.9 6012.3 5913.2 5932.3 5958.2 5980.5 6018.4 4536.5 4539.5 4552.2 4559.1 4585.0 3987.6 4067.7 4104.0 4117.2 4136.8 5522.3 5613.9 5671.3 5692.4 5714.2 5936.3 5941.0 5971.8 5972.6 5995.6 5538.0 5633.8 5641.8 5645.9 5656.2 5105.0 5201.5 5256.9 5271.6 5299.2 6169.5 6186.1 6204.1 6215.1 6216.1 5888.7 6045.2 6050.1 6053.9 6063.1 6137.1 6253.0 6253.3 6254.9 6256.8 5874.4 5890.9 5918.3 5923.5 5954.8 5887.1 5993.7 6007.6 6012.3 6017.0 5812.8 5874.7 5884.0 5890.7 5911.2 5867.8 5877.7 5887.8 5904.7 5912.0 5619.1 5766.1 5812.0 5821.9 5857.4 5843.9 5886.9 5902.3 5916.5 5918.4 5757.6 5768.6 5780.2 5782.9 5792.6 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - PROCESS | 26681 | [#1] ext.html Cycles:180 Average:59494.74 Median:40488.70 stddev:129460.81 (319.7%) stddev-sans-first:129748.32 23:14:03 INFO - PROCESS | 26681 | Values: 544.7 545.4 568.7 585.0 619.2 31565.5 41133.4 41228.0 41252.8 41342.4 43525.0 43654.3 43808.6 43958.3 44072.1 8654.2 8754.3 8817.7 8840.9 8888.2 8786.6 8948.6 9019.0 9033.5 9159.6 9064.7 9146.8 9167.9 9169.1 9219.4 9084.0 9088.6 9129.4 9151.9 9165.4 9026.5 9121.7 9135.8 9174.0 9200.8 43425.6 43786.3 43862.1 43868.8 43904.3 3737.9 3776.0 3817.6 3837.5 4031.5 31555.5 31776.0 32131.5 32176.4 32879.2 4243.8 4279.1 4279.4 4318.6 4359.9 310167.0 313993.0 314831.0 315601.0 315980.0 49875.3 50198.2 72481.3 74216.0 74235.0 49129.5 49408.3 49557.0 49649.8 49706.5 16426.3 16576.5 16599.3 16629.7 16656.3 12794.4 12836.7 12837.8 12915.2 12921.3 16611.9 16712.0 16802.7 16806.5 16919.2 6313.7 6461.8 6541.5 6649.6 6718.7 1025.7 1032.7 1108.4 1140.0 1186.0 29967.9 30509.2 30898.4 30949.4 31052.4 1129.3 1156.1 1193.3 1215.8 1255.7 15812.5 15951.0 16023.0 16123.1 16388.6 334208.0 550709.0 556295.0 924798.0 940364.0 64536.0 65115.0 65477.3 65799.3 66030.3 1467.6 1500.4 1531.9 1548.1 1552.5 31802.5 32008.0 32254.5 32509.8 33025.8 52239.2 52674.5 52730.0 52827.0 53028.0 315430.0 318924.0 320410.0 320442.0 321091.0 35292.0 35428.3 35553.0 35787.3 35948.8 46578.3 47226.8 47284.5 48146.5 48263.8 39894.4 39927.0 40364.6 40646.0 40842.4 39367.6 39680.0 40218.7 40612.8 41142.8 39867.2 40276.0 40299.4 40637.4 40665.2 34218.8 34949.5 34979.5 35527.5 35602.0 27013.0 28012.0 28033.7 28049.7 28110.2 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - PROCESS | 26681 | [#2] jquery.html Cycles:180 Average:26876.80 Median:2445.22 stddev:77532.82 (3170.8%) stddev-sans-first:77724.78 23:14:03 INFO - PROCESS | 26681 | Values: 370.8 393.1 398.5 399.3 403.7 14863.3 15280.3 17879.6 18631.0 18680.7 17392.6 17605.2 17658.1 17730.8 18710.3 5474.4 5637.1 5646.1 5659.2 5676.7 5407.0 5616.0 5626.6 5639.2 5699.1 5596.9 5601.6 5601.7 5608.0 5637.9 5326.6 5546.6 5587.4 5600.4 5637.7 5028.3 5030.6 5041.3 5060.9 5061.5 21641.4 21646.7 21867.6 22141.6 22298.7 2341.1 2356.7 2396.8 2442.0 2448.4 13643.3 13734.5 13760.6 13797.4 13974.1 1871.2 1949.6 1993.2 1997.3 2010.6 66004.0 66107.7 66664.7 66748.7 66904.3 9655.9 9965.9 10155.7 10197.8 10322.6 14384.9 14478.0 14493.6 14604.6 14623.5 7032.8 7365.2 7369.2 7808.4 8009.3 7667.2 7679.2 7687.1 7729.6 7796.7 4294.4 4303.5 4307.1 4330.3 4340.0 1791.6 1835.1 1877.4 1879.4 1907.3 919.6 962.0 1011.7 1023.1 1032.8 15678.8 17063.3 17268.5 17555.5 17588.8 947.8 952.2 956.5 1019.0 1019.3 7139.7 10162.7 10171.9 10292.1 10316.9 464505.0 467477.0 474030.0 478564.0 485772.0 49634.3 60890.4 64827.0 77116.6 78961.6 1012.3 1022.1 1026.7 1061.3 1066.0 15977.8 16008.7 16226.4 16237.2 16509.5 36256.3 36348.0 36589.0 36905.4 37266.6 49950.0 52022.0 52509.5 53020.7 53082.2 8002.5 8471.3 8516.7 8577.2 8971.6 12576.7 13456.6 13549.0 13720.0 13757.0 11109.7 11505.2 11673.0 11727.9 11795.9 11211.3 11287.0 11456.0 11973.3 12193.9 11801.7 11845.3 11859.2 12039.9 12071.9 8706.4 8803.9 8841.2 8902.8 8967.1 11160.3 11455.1 11544.7 11589.5 11663.8 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - PROCESS | 26681 | [#3] mootools.html Cycles:180 Average:5913.11 Median:539.99 stddev:3034.66 (562.0%) stddev-sans-first:3025.84 23:14:03 INFO - PROCESS | 26681 | Values: 1597.6 1638.5 1893.0 1943.2 1982.6 7531.0 7985.6 8388.8 8547.5 8575.1 8164.1 8255.8 8334.7 8336.0 8361.0 2434.8 2447.6 2450.7 2461.8 2471.8 2428.2 2452.3 2465.7 2470.3 2476.3 2428.2 2463.2 2515.8 2516.2 2530.0 2464.5 2464.6 2473.7 2523.7 2530.2 2445.7 2449.9 2453.8 2467.7 2469.3 8389.2 8431.4 8437.5 8444.5 8493.2 5189.4 5283.4 5324.4 5331.9 5335.3 3191.2 3209.0 3263.5 3274.8 3298.5 1002.8 2034.7 2058.8 2109.8 2118.1 11608.2 11623.1 11695.5 11742.4 11748.2 4359.8 4544.6 4563.8 4603.6 4635.5 9553.9 9612.1 9648.2 9663.0 9685.8 5284.1 5299.1 5312.4 5322.5 5340.6 4762.0 4768.4 4833.4 4859.3 4938.6 3779.1 3807.4 3820.6 3845.7 3854.4 1200.9 1207.8 1209.4 1210.1 1220.9 1457.6 1463.9 1474.7 1477.8 1496.2 8068.3 8084.1 8110.6 8121.8 8124.8 530.7 539.1 540.9 549.4 549.6 6259.5 6273.6 6315.7 6356.0 6438.0 10049.6 10313.8 10328.2 10357.2 10386.2 9872.8 10110.4 10119.1 10140.8 10215.4 7932.4 7938.0 7995.0 8016.0 8037.0 7488.7 7656.9 7720.3 7721.5 7767.1 8869.4 8930.5 9023.1 9033.3 9306.6 9118.9 9338.1 9446.0 9513.4 9536.3 6562.3 7415.7 7522.2 7589.0 7796.4 7976.4 7985.0 8024.4 8050.6 8107.4 7145.1 7348.8 7367.1 7458.9 7543.6 7113.3 7139.3 7195.0 7247.1 7278.9 7525.5 7554.8 7571.8 7688.6 7698.9 6637.8 6771.9 6810.4 6826.9 6840.7 6967.9 7051.4 7099.0 7108.5 7148.7 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - PROCESS | 26681 | [#4] prototype.html Cycles:180 Average:5667.52 Median:6425.92 stddev:1732.04 (27.0%) stddev-sans-first:1690.40 23:14:03 INFO - PROCESS | 26681 | Values: 356.6 357.2 365.4 365.8 369.4 6364.4 6427.9 6468.4 6473.8 6479.8 6240.4 6282.8 6294.3 6301.4 6335.8 4650.9 4767.2 4803.2 4815.1 4855.2 4834.3 4849.3 4856.2 4861.6 4865.4 4782.3 4811.1 4821.7 4822.2 4839.5 4837.7 4843.5 4851.7 4851.9 4853.9 4235.0 4240.3 4243.3 4247.7 4248.5 5986.9 6082.1 6098.5 6099.8 6101.7 5595.4 5605.3 5616.7 5622.8 5625.6 6666.4 6667.0 6704.5 6709.1 6734.6 4536.4 4588.0 4603.9 4608.7 4610.3 6979.9 7055.8 7066.5 7084.8 7084.9 4609.2 4755.3 4757.0 4767.0 4776.2 4801.1 4817.3 4834.7 4843.9 4848.3 5562.1 5585.1 5643.7 5649.2 5658.4 6773.9 6791.4 6801.9 6811.8 6835.5 1689.9 1720.3 1721.8 1724.0 1725.7 1083.3 1103.8 1109.2 1111.4 1128.4 6390.9 6417.9 6427.5 6432.8 6438.6 6907.8 6962.4 6964.8 6980.6 6986.2 6222.8 6322.4 6424.4 6559.2 6564.7 3771.5 3807.9 3832.3 3838.8 3843.7 7339.7 7392.2 7395.6 7397.8 7401.7 7129.0 7228.6 7247.6 7263.7 7272.2 7004.9 7405.1 7407.0 7438.9 7460.8 6985.1 6986.1 7001.7 7011.5 7081.0 6933.2 6968.0 6972.6 6974.5 6984.2 7391.4 7404.5 7413.9 7415.6 7429.9 4573.3 4743.5 4768.4 4789.9 4801.9 6965.0 6986.5 6994.9 7009.6 7016.7 6703.7 6800.7 6802.3 6807.4 6812.4 6735.8 6741.8 6749.0 6764.5 6782.9 6547.0 6672.3 6802.1 6803.9 6812.6 6830.8 6845.1 6851.3 6891.2 6899.3 6676.3 6731.7 6746.4 6750.5 6758.7 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - PROCESS | 26681 | [#5] yui.html Cycles:180 Average:14570.27 Median:54534.73 stddev:17581.37 (32.2%) stddev-sans-first:17600.26 23:14:03 INFO - PROCESS | 26681 | Values: 795.9 877.4 881.5 892.3 916.9 13226.9 13465.7 13470.1 13481.1 13531.9 14025.1 14087.1 14095.4 14103.4 14123.8 749.5 902.9 928.4 930.1 930.4 899.7 900.5 908.6 909.7 910.7 971.2 975.8 977.4 978.0 978.6 970.2 971.1 971.5 974.3 975.3 727.6 729.7 731.4 732.1 733.6 13695.7 13897.0 13932.7 13940.0 13960.8 13052.4 13249.6 13320.5 13396.9 13522.3 11709.1 11754.1 11757.5 11760.5 11823.9 3932.3 3932.6 3949.9 3956.2 3979.2 54188.5 54463.7 54605.7 54697.0 55335.7 11245.8 11268.2 11341.2 11365.4 11607.3 20763.4 20811.2 20952.0 21011.2 21097.5 8323.6 8458.8 8540.0 8617.5 8807.6 4905.2 4913.7 4921.9 5037.8 5054.8 3397.5 3489.2 3508.2 3516.9 3523.0 612.1 627.9 637.6 639.2 641.7 602.3 635.6 638.7 661.7 672.3 7489.3 7556.9 7634.9 7667.6 7692.0 506.5 626.8 636.1 646.0 658.0 3585.7 3590.6 3636.9 3708.2 3806.0 59580.0 60959.0 61205.0 61235.7 61353.0 55249.4 55561.7 56258.2 56551.4 57421.0 50186.5 50437.7 50820.7 50834.5 50890.7 7148.5 7148.5 7170.6 7246.8 7325.7 38223.4 38411.8 38806.4 38821.6 40120.0 46135.5 49117.3 49305.8 49649.8 49958.8 9779.9 10114.4 10253.4 10363.2 10385.3 10847.8 10873.7 10993.1 11046.0 11076.5 9982.9 10040.1 10301.4 10312.1 10373.7 9932.5 10025.4 10137.5 10169.0 10238.7 9656.1 9850.5 9894.6 9956.3 10042.3 8713.9 8723.8 8727.8 9021.5 9032.1 8486.4 8892.7 8908.6 8919.2 8996.0 23:14:03 INFO - PROCESS | 26681 | -------- Summary: end -------- 23:14:03 INFO - PROCESS | 26681 | 23:14:03 INFO - TEST-INFO | 26681: exit 0 23:14:03 INFO - TEST-OK | dromaeo_css | took 1109381ms 23:14:03 INFO - TEST-START | kraken 23:14:03 INFO - operating with platform_type : linux_ 23:14:03 INFO - Initialising browser for kraken test... 23:14:03 INFO - TEST-INFO | started process 26927 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7sZBSV/profile http://localhost:60969/getInfo.html) 23:14:07 INFO - PROCESS | 26927 | 23:14:07 INFO - PROCESS | 26927 | (process:27003): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:14:08 INFO - PROCESS | 26927 | __metrics Screen width/height:1600/1200 23:14:08 INFO - PROCESS | 26927 | colorDepth:24 23:14:08 INFO - PROCESS | 26927 | Browser inner width/height: 1024/697 23:14:08 INFO - PROCESS | 26927 | __metrics 23:14:08 ERROR - PROCESS | 26927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:14:09 INFO - TEST-INFO | 26927: exit 0 23:14:09 INFO - Browser initialized. 23:14:09 INFO - Running cycle 1/1 for kraken test... 23:14:09 INFO - TEST-INFO | started process 27054 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7sZBSV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:11 INFO - PROCESS | 27054 | 23:14:11 INFO - PROCESS | 27054 | (process:27122): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:14:21 INFO - PROCESS | 27054 | RSS: Main: 151683072 23:14:21 INFO - PROCESS | 27054 | 23:14:23 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60969/tests/kraken/driver.html?testName=audio-beat-detection) 23:14:24 INFO - PROCESS | 27054 | RSS: Main: 155844608 23:14:24 INFO - PROCESS | 27054 | 23:14:27 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60969/tests/kraken/driver.html?testName=audio-dft) 23:14:27 INFO - PROCESS | 27054 | RSS: Main: 156151808 23:14:27 INFO - PROCESS | 27054 | 23:14:30 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60969/tests/kraken/driver.html?testName=audio-fft) 23:14:31 INFO - PROCESS | 27054 | RSS: Main: 156545024 23:14:31 INFO - PROCESS | 27054 | 23:14:33 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60969/tests/kraken/driver.html?testName=audio-oscillator) 23:14:33 INFO - PROCESS | 27054 | RSS: Main: 156487680 23:14:33 INFO - PROCESS | 27054 | 23:14:36 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60969/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:36 INFO - PROCESS | 27054 | RSS: Main: 156737536 23:14:36 INFO - PROCESS | 27054 | 23:14:39 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60969/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:40 INFO - PROCESS | 27054 | RSS: Main: 156553216 23:14:40 INFO - PROCESS | 27054 | 23:14:43 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60969/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:44 INFO - PROCESS | 27054 | RSS: Main: 156672000 23:14:44 INFO - PROCESS | 27054 | 23:14:47 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60969/tests/kraken/driver.html?testName=json-parse-financial) 23:14:47 INFO - PROCESS | 27054 | RSS: Main: 156774400 23:14:47 INFO - PROCESS | 27054 | 23:14:49 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60969/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:50 INFO - PROCESS | 27054 | RSS: Main: 156823552 23:14:50 INFO - PROCESS | 27054 | 23:14:51 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60969/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:52 INFO - PROCESS | 27054 | RSS: Main: 156610560 23:14:52 INFO - PROCESS | 27054 | 23:14:54 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60969/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:55 INFO - PROCESS | 27054 | RSS: Main: 156819456 23:14:55 INFO - PROCESS | 27054 | 23:14:57 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:58 INFO - PROCESS | 27054 | RSS: Main: 157585408 23:14:58 INFO - PROCESS | 27054 | 23:15:00 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:15:01 INFO - PROCESS | 27054 | RSS: Main: 157532160 23:15:01 INFO - PROCESS | 27054 | 23:15:02 INFO - PROCESS | 27054 | Cycle 1(1): loaded http://localhost:60969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60969/tests/kraken/driver.html?testName=ai-astar) 23:15:03 INFO - PROCESS | 27054 | RSS: Main: 158670848 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | __start_tp_report 23:15:03 INFO - PROCESS | 27054 | _x_x_mozilla_page_load 23:15:03 INFO - PROCESS | 27054 | _x_x_mozilla_page_load_details 23:15:03 INFO - PROCESS | 27054 | |i|pagename|runs| 23:15:03 INFO - PROCESS | 27054 | |0;ai-astar;113;105;111;109;110;122;110;111;110;111 23:15:03 INFO - PROCESS | 27054 | |1;audio-beat-detection;155;125;153;163;130;163;154;131;175;128 23:15:03 INFO - PROCESS | 27054 | |2;audio-dft;163;161;164;162;161;165;160;161;163;162 23:15:03 INFO - PROCESS | 27054 | |3;audio-fft;76;76;76;162;75;78;73;76;159;76 23:15:03 INFO - PROCESS | 27054 | |4;audio-oscillator;97;94;139;94;98;97;159;93;94;142 23:15:03 INFO - PROCESS | 27054 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;118;117;117 23:15:03 INFO - PROCESS | 27054 | |6;imaging-darkroom;148;146;151;146;147;147;147;146;147;147 23:15:03 INFO - PROCESS | 27054 | |7;imaging-desaturate;97;97;96;95;96;96;96;96;96;96 23:15:03 INFO - PROCESS | 27054 | |8;json-parse-financial;57;56;58;56;55;55;56;64;54;57 23:15:03 INFO - PROCESS | 27054 | |9;json-stringify-tinderbox;65;66;65;64;64;65;65;66;66;65 23:15:03 INFO - PROCESS | 27054 | |10;stanford-crypto-aes;77;79;80;81;78;78;83;78;80;80 23:15:03 INFO - PROCESS | 27054 | |11;stanford-crypto-ccm;116;114;116;112;113;118;114;117;122;113 23:15:03 INFO - PROCESS | 27054 | |12;stanford-crypto-pbkdf2;146;144;156;147;135;137;147;140;142;156 23:15:03 INFO - PROCESS | 27054 | |13;stanford-crypto-sha256-iterative;68;67;72;65;67;64;64;70;65;82 23:15:03 INFO - PROCESS | 27054 | __end_tp_report 23:15:03 INFO - PROCESS | 27054 | __start_cc_report 23:15:03 INFO - PROCESS | 27054 | _x_x_mozilla_cycle_collect,859 23:15:03 INFO - PROCESS | 27054 | __end_cc_report 23:15:03 INFO - PROCESS | 27054 | __startTimestamp1459577703101__endTimestamp 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | ------- Summary: start ------- 23:15:03 INFO - PROCESS | 27054 | Number of tests: 14 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.32 (3.9%) stddev-sans-first:4.53 23:15:03 INFO - PROCESS | 27054 | Values: 113.0 105.0 111.0 109.0 110.0 122.0 110.0 111.0 110.0 111.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:154.50 stddev:17.73 (11.5%) stddev-sans-first:18.61 23:15:03 INFO - PROCESS | 27054 | Values: 155.0 125.0 153.0 163.0 130.0 163.0 154.0 131.0 175.0 128.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.55 (1.0%) stddev-sans-first:1.62 23:15:03 INFO - PROCESS | 27054 | Values: 163.0 161.0 164.0 162.0 161.0 165.0 160.0 161.0 163.0 162.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:35.76 (47.1%) stddev-sans-first:37.42 23:15:03 INFO - PROCESS | 27054 | Values: 76.0 76.0 76.0 162.0 75.0 78.0 73.0 76.0 159.0 76.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:94.00 stddev:25.39 (27.0%) stddev-sans-first:26.44 23:15:03 INFO - PROCESS | 27054 | Values: 97.0 94.0 139.0 94.0 98.0 97.0 159.0 93.0 94.0 142.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:15:03 INFO - PROCESS | 27054 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.48 (1.0%) stddev-sans-first:1.54 23:15:03 INFO - PROCESS | 27054 | Values: 148.0 146.0 151.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 23:15:03 INFO - PROCESS | 27054 | Values: 97.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:2.78 (4.9%) stddev-sans-first:2.95 23:15:03 INFO - PROCESS | 27054 | Values: 57.0 56.0 58.0 56.0 55.0 55.0 56.0 64.0 54.0 57.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 23:15:03 INFO - PROCESS | 27054 | Values: 65.0 66.0 65.0 64.0 64.0 65.0 65.0 66.0 66.0 65.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:1.78 (2.2%) stddev-sans-first:1.66 23:15:03 INFO - PROCESS | 27054 | Values: 77.0 79.0 80.0 81.0 78.0 78.0 83.0 78.0 80.0 80.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:116.00 stddev:2.99 (2.6%) stddev-sans-first:3.17 23:15:03 INFO - PROCESS | 27054 | Values: 116.0 114.0 116.0 112.0 113.0 118.0 114.0 117.0 122.0 113.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:146.50 stddev:7.07 (4.8%) stddev-sans-first:7.49 23:15:03 INFO - PROCESS | 27054 | Values: 146.0 144.0 156.0 147.0 135.0 137.0 147.0 140.0 142.0 156.0 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - PROCESS | 27054 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.50 stddev:5.44 (8.1%) stddev-sans-first:5.77 23:15:03 INFO - PROCESS | 27054 | Values: 68.0 67.0 72.0 65.0 67.0 64.0 64.0 70.0 65.0 82.0 23:15:03 INFO - PROCESS | 27054 | -------- Summary: end -------- 23:15:03 INFO - PROCESS | 27054 | 23:15:03 INFO - TEST-INFO | 27054: exit 0 23:15:04 INFO - TEST-OK | kraken | took 60295ms 23:15:04 INFO - SUITE-END | took 1169s 23:15:04 INFO - Completed test suite (00:19:29) 23:15:04 INFO - javascript benchmark 23:15:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3307.9834600826994, 3384.187794929218, 3386.3904497190497, 3431.691147796698, 3433.8798142065034, 5506.944930550693, 5522.696251706155, 5530.695811730363, 5531.806386776464, 5549.694766787825, 5508.614396992212, 5520.365158006821, 5525.226468294442, 5532.972335138329, 5561.499465048145, 5045.899082018375, 5071.112555302826, 5116.1814109742445, 5135.8202462913805, 5146.3309769729885, 4975.0547395994645, 5104.77028533715, 5107.7701503432245, 5144.742762861861, 5181.922271165917, 5023.095842748304, 5063.46833582474, 5085.415177254626, 5146.716930568836, 5186.818461353853, 5163.7676304566385, 5179.922301165486, 5187.118189907687, 5187.844364669066, 5187.922181167285, 4923.48303428142, 4969.0807200668, 5162.767675454614, 5172.818951336722, 5195.558377537914, 5362.0, 5390.757415916293, 5396.83809485716, 5418.187271909206, 5419.187121931703, 5937.970310148465, 5963.970180149072, 5995.820125396245, 5998.40015998401, 6001.979663457223, 5958.285005799288, 6023.066424704178, 6047.395260473917, 6075.2405949256345, 6083.17877086592, 5530.529904958124, 5565.554755619541, 5582.581306402036, 5601.327840659106, 5622.044252477089, 5984.491318237911, 6117.938820611737, 6130.724117414727, 6134.0, 6135.509159267248, 5879.794207202813, 5955.196048533393, 5971.104334349795, 5975.970120149458, 5994.310654274727, 5996.640201587918, 6007.609505382136, 6022.849428764316, 6028.457438830526, 6045.516358691294, 5807.216025836458, 5955.791547295824, 5998.190244316961, 6011.939880601226, 6012.338642749294, 5913.231279933581, 5932.3177834548715, 5958.225430694069, 5980.521558275327, 6018.398160183947, 4536.500984891659, 4539.477960034572, 4552.2488789350045, 4559.110973360229, 4585.037142200175, 3987.5613682494904, 4067.7355971861734, 4104.0, 4117.1765646870745, 4136.8138433770555, 5522.337319521683, 5613.90528846871, 5671.347795003628, 5692.402297758758, 5714.171445140514, 5936.28764548257, 5941.049432090845, 5971.79098731551, 5972.5520585955355, 5995.550333724901, 5537.972310138504, 5633.830985070373, 5641.774329026875, 5645.915311270334, 5656.236408084938, 5105.030044291572, 5201.45384734605, 5256.894862102737, 5271.604629652791, 5299.205119232146, 6169.475594574422, 6186.133941248228, 6204.13142160098, 6215.098810672517, 6216.067589861466, 5888.705564721832, 6045.183900173596, 6050.122732203894, 6053.939460605337, 6063.060225665029, 6137.131844484677, 6253.0, 6253.343398943228, 6254.874902502015, 6256.7810126645345, 5874.412558744091, 5890.852728681646, 5918.3489816121055, 5923.496502797138, 5954.821355359346, 5887.116932460165, 5993.730282137401, 6007.609505382136, 6012.278526576664, 6016.969915150396, 5812.796552120655, 5874.706264686834, 5884.0, 5890.7054647266605, 5911.231539899957, 5867.823965281048, 5877.676727780014, 5887.793927212527, 5904.704764761831, 5912.0, 5619.100943848965, 5766.106253530709, 5812.041013232769, 5821.912671310019, 5857.4435428634215, 5843.94156058434, 5886.940350736909, 5902.291724993029, 5916.526677865674, 5918.378570250062, 5757.625754325955, 5768.596198266249, 5780.21967034445, 5782.913256301074, 5792.594518383673], "unit": "score", "name": "dojo.html", "value": 5525.565981343876}, {"lowerIsBetter": false, "replicates": [544.7140251368032, 545.4027839515732, 568.7241687781425, 585.002570617098, 619.2228752915091, 31565.526517102233, 41133.38299925496, 41228.0, 41252.793736031315, 41342.37986430206, 43525.0, 43654.345184822174, 43808.56191438084, 43958.340624890574, 44072.118557628906, 8654.17785310396, 8754.299656027535, 8817.691380801672, 8840.894888138982, 8888.155625215593, 8786.560671966376, 8948.597313120892, 9018.954905225464, 9033.548322583878, 9159.633614655406, 9064.728058158265, 9146.77133071672, 9167.908320916773, 9169.128932751411, 9219.400738951947, 9084.046175151647, 9088.636454541811, 9129.406588571721, 9151.86272205914, 9165.404248723846, 9026.503542305236, 9121.726348209564, 9135.771605709844, 9174.036726143791, 9200.81598368029, 43425.56574434247, 43786.34320485163, 43862.12275754467, 43868.78065609652, 43904.3414348785, 3737.9439308410397, 3775.962240377616, 3817.580066192744, 3837.539495260559, 4031.5162180538523, 31555.526667100014, 31776.0, 32131.51802722961, 32176.356472870644, 32879.178020549436, 4243.830246790125, 4279.122779830159, 4279.40088387626, 4318.632916202127, 4359.912801743979, 310167.0, 313993.0, 314831.0, 315601.0, 315980.0, 49875.25187122196, 50198.24702629464, 72481.27518724851, 74216.0, 74235.0, 49129.50870491249, 49408.25887611689, 49557.0, 49649.75175124101, 49706.50293497091, 16426.260818263207, 16576.502704918872, 16599.336026559045, 16629.6674066518, 16656.33374665024, 12794.42425090873, 12836.679083022998, 12837.807432888514, 12915.160514566523, 12921.289329086803, 16611.91694041522, 16712.0, 16802.747958780627, 16806.495805125865, 16919.154042297836, 6313.684315784192, 6461.8061458156335, 6541.5093867960095, 6649.63427011519, 6718.66406679664, 1025.6666583360438, 1032.6850310655173, 1108.4014632098576, 1140.00819287219, 1186.0096819156101, 29967.850160749058, 30509.237269068006, 30898.382032359226, 30949.381012379625, 31052.378952420826, 1129.305477131558, 1156.115571587736, 1193.2601786892183, 1215.8115492098739, 1255.6798016505916, 15812.525624231292, 15951.0, 16023.0, 16123.11322877253, 16388.590285242964, 334208.0, 550709.0, 556295.0, 924798.0, 940364.0, 64536.0, 65115.0, 65477.34522654808, 65799.34200658028, 66030.33969660338, 1467.5670677150267, 1500.3923411018554, 1531.923403829804, 1548.1253092002758, 1552.534239728077, 31802.52296215605, 32008.0, 32254.516182256815, 32509.837450812596, 33025.83487082549, 52239.21641175461, 52674.47325526696, 52730.0, 52827.0, 53028.0, 315430.0, 318924.0, 320410.0, 320442.0, 321091.0, 35292.0, 35428.29143417066, 35553.0, 35787.28425431529, 35948.82025589855, 46578.301325480825, 47226.76386618045, 47284.52715472939, 48146.51853481561, 48263.75868120637, 39894.40158397568, 39927.003649817976, 40364.59635403608, 40646.0, 40842.387364188966, 39367.606323936394, 39680.0, 40218.7264730352, 40612.79693601631, 41142.79428602838, 39867.2026559473, 40276.0, 40299.3955090668, 40637.39043914403, 40665.186696265315, 34218.82890585531, 34949.548091861056, 34979.47530786989, 35527.46708799422, 35602.0, 27013.0, 28012.0, 28033.719662803112, 28049.71950280471, 28110.156695299174], "unit": "score", "name": "ext.html", "value": 20086.220874107454}, {"lowerIsBetter": false, "replicates": [370.8034741586959, 393.10176247275, 398.54133870035673, 399.2872722190889, 403.70932928291637, 14863.256837158153, 15280.312385942632, 17879.55301117471, 18631.0, 18680.719789203155, 17392.56518587036, 17605.207765650546, 17658.117094145306, 17730.82269177308, 18710.25158993642, 5474.39781624021, 5637.069883469223, 5646.096624540074, 5659.151127330892, 5676.687782171979, 5407.0, 5616.045272303718, 5626.606137570372, 5639.210510528529, 5699.145128230757, 5596.888062238752, 5601.579881508903, 5601.691906945116, 5608.0, 5637.8590535236535, 5326.627136100475, 5546.556275497971, 5587.38538760736, 5600.411956744565, 5637.661740295595, 5028.321176641143, 5030.597552195853, 5041.344625198701, 5060.924086138711, 5061.468545802712, 21641.35075947724, 21646.675299870516, 21867.562648746934, 22141.557168856532, 22298.665520017214, 2341.098677009347, 2356.7289761677457, 2396.7962723168553, 2442.0, 2448.4490989527394, 13643.317834108355, 13734.519291824738, 13760.587182384445, 13797.379117939718, 13974.091684040606, 1871.2421469304954, 1949.6393167264102, 1993.1628715939341, 1997.3009446693686, 2010.5576773109892, 66004.0, 66107.66946165287, 66664.66667666679, 66748.66625666889, 66904.33095669029, 9655.903440965641, 9965.850512242323, 10155.695329140137, 10197.796044079078, 10322.587096516205, 14384.928075359556, 14478.0, 14493.565193044225, 14604.561863144123, 14623.488177913934, 7032.753853615099, 7365.189829118793, 7369.189389167187, 7808.375329973588, 8009.31920786728, 7667.156612772591, 7679.155292917774, 7687.077550693953, 7729.574873382018, 7796.688132474751, 4294.420253265832, 4303.462067241595, 4307.117041006586, 4330.2638551446325, 4339.978300108479, 1791.641671665672, 1835.128314050815, 1877.4461533847548, 1879.4079864842531, 1907.2929727893459, 919.6413398774483, 962.0187408842941, 1011.6762635956424, 1023.0792286941812, 1032.7624646331235, 15678.843211567966, 17063.31746730142, 17268.481945541655, 17555.473335799947, 17588.824111758975, 947.7962238118838, 952.1620973543238, 956.4596003258137, 1019.0268293779571, 1019.261035749076, 7139.678714457862, 10162.745931351776, 10171.949140254252, 10292.073713365833, 10316.896831031743, 464505.0, 467477.0, 474030.0, 478564.0, 485772.0, 49634.255486167734, 60890.391096089355, 64827.0, 77116.61441692755, 78961.60519197368, 1012.291396022787, 1022.1260821997234, 1026.707388394304, 1061.3260579532052, 1065.9520321585546, 15977.8402215981, 16008.679826403173, 16226.432074877323, 16237.18814059316, 16509.504714858573, 36256.27487450289, 36348.0, 36589.0, 36905.44641830429, 37266.62733372632, 49950.0, 52022.0, 52509.474905250456, 53020.73489632527, 53082.2037669443, 8002.479838810459, 8471.32229421657, 8516.70191543293, 8577.185167409087, 8971.641134354553, 12576.685582860502, 13456.596302110953, 13549.0, 13720.0, 13757.0, 11109.666709998713, 11505.194636375709, 11673.0, 11727.88272117302, 11795.882041179479, 11211.271267367594, 11287.0, 11456.026237769884, 11973.341466219441, 12193.878061219275, 11801.70495737579, 11845.289282643069, 11859.16985810985, 12039.879601204226, 12071.939640302093, 8706.434081784664, 8803.911960880308, 8841.16008979146, 8902.821943561223, 8967.058458861986, 11160.274582152135, 11455.140864435034, 11544.711382215512, 11589.536418543164, 11663.766724665289], "unit": "score", "name": "jquery.html", "value": 8829.511134768938}, {"lowerIsBetter": false, "replicates": [1597.5526852481305, 1638.5166375919102, 1892.9588726200595, 1943.1547276934543, 1982.6332128556219, 7531.0, 7985.600719964008, 8388.790280242996, 8547.487150770958, 8575.056743758189, 8164.06113296971, 8255.793605159874, 8334.666613335474, 8336.04135524415, 8360.958195209016, 2434.8052155827536, 2447.6206188040883, 2450.705915290159, 2461.79074778644, 2471.7775400213977, 2428.1986944308424, 2452.2520631207476, 2465.6917885264343, 2470.3330100872754, 2476.2571228631427, 2428.1501474483875, 2463.2363967170236, 2515.7987361011164, 2516.1570873757314, 2529.9620505692337, 2464.4824586836785, 2464.581021226396, 2473.727889932106, 2523.709773376067, 2530.165045534969, 2445.7065152181854, 2449.9020039198413, 2453.815963802722, 2467.6545283660303, 2469.32093674241, 8389.244967952913, 8431.367647426407, 8437.535935523543, 8444.535550544717, 8493.193146651058, 5189.403218629868, 5283.418823929364, 5324.387695415038, 5331.893362132774, 5335.253064570963, 3191.2021994501374, 3209.0, 3263.543103965447, 3274.754393420503, 3298.455754800455, 1002.7944271424341, 2034.7151398804178, 2058.8455865810124, 2109.7784732603163, 2118.05746442833, 11608.187426880122, 11623.07015438763, 11695.532178712841, 11742.412879356083, 11748.236364636272, 4359.80380882861, 4544.613707834805, 4563.840265590688, 4603.631709463235, 4635.539804961426, 9553.856692149624, 9612.086851749073, 9648.228141748643, 9662.951685241529, 9685.757856053655, 5284.07528682479, 5299.072662284085, 5312.362516498045, 5322.520973112439, 5340.572754179734, 4762.0, 4768.427788665383, 4833.419989601271, 4859.271109333628, 4938.604911607063, 3779.093017675738, 3807.428885667117, 3820.56063552695, 3845.730798844054, 3854.421836724514, 1200.8739082396398, 1207.7946749052683, 1209.4436559182698, 1210.1226610707167, 1220.871808460099, 1457.5918742751835, 1463.9194844283666, 1474.6903150338549, 1477.8152730908637, 1496.177102593591, 8068.314193293636, 8084.1107478177355, 8110.553919534483, 8121.79695507617, 8124.7562573122905, 530.6736357140331, 539.099703495164, 540.8810061786401, 549.4038967719989, 549.5685886579016, 6259.499240060784, 6273.592216505913, 6315.652639104894, 6355.9830427132365, 6438.0, 10049.598016079275, 10313.84529232062, 10328.225383096147, 10357.17142628603, 10386.169106471463, 9872.753181170385, 10110.443925584164, 10119.139873110867, 10140.797184056277, 10215.387076775418, 7932.365410767125, 7938.047434308036, 7994.960025199837, 8016.038075430869, 8037.0, 7488.663010164447, 7656.923430765621, 7720.3051725344985, 7721.498102623312, 7767.106782719833, 8869.423487473294, 8930.508822014592, 9023.097690230925, 9033.322500812334, 9306.581203845979, 9118.863217051618, 9338.11287927673, 9446.0, 9513.429194248367, 9536.332456727963, 6562.278149403657, 7415.666295016845, 7522.210167932507, 7588.962055189689, 7796.376289896908, 7976.441649084509, 7985.0, 8024.358051355995, 8050.597470126588, 8107.4324797263625, 7145.089363221962, 7348.816279593053, 7367.079115110611, 7458.888116678363, 7543.585102819397, 7113.253108423748, 7139.2503787101605, 7195.02867112954, 7247.057882475245, 7278.871774874903, 7525.510841795266, 7554.773356799305, 7571.772846814604, 7688.577128258, 7698.92215089899, 6637.834054148491, 6771.864562708817, 6810.42111420515, 6826.897596536155, 6840.726370945106, 6967.8606427870145, 7051.435885129074, 7098.964505177441, 7108.46686498525, 7148.678309475982], "unit": "score", "name": "mootools.html", "value": 4846.023833781297}, {"lowerIsBetter": false, "replicates": [356.63266835159794, 357.1535460957529, 365.37338464533303, 365.8097789149642, 369.3573182662168, 6364.363563643639, 6427.871442571146, 6468.417842394184, 6473.805785826421, 6479.805605831821, 6240.4071613196675, 6282.780102696406, 6294.339094395092, 6301.40136687014, 6335.809925702225, 4650.86047418578, 4767.1657459944545, 4803.159447096761, 4815.109204797106, 4855.223164293714, 4834.347363105989, 4849.296851956464, 4856.174450343432, 4861.611071114302, 4865.391826021747, 4782.33047373368, 4811.06184294061, 4821.710697358169, 4822.156122678535, 4839.540243676845, 4837.685550439245, 4843.491433399495, 4851.660383773137, 4851.927221091686, 4853.927191092136, 4234.957650423487, 4240.342746874239, 4243.299855523835, 4247.660187185018, 4248.532661407274, 5986.8503287417725, 6082.118092876508, 6098.54260930432, 6099.84750381244, 6101.694915254219, 5595.356533998561, 5605.299337582802, 5616.663000219959, 5622.775088996435, 5625.634333768292, 6666.433353164987, 6666.966665166643, 6704.463642908556, 6709.094272273278, 6734.595924244561, 4536.432945881765, 4588.0365123324145, 4603.884902877421, 4608.654350923661, 4610.3315019322345, 6979.860402791966, 7055.788326350218, 7066.505344625878, 7084.787456376265, 7084.893726594105, 4609.239475486507, 4755.310479980383, 4757.048590281957, 4767.046590681877, 4776.188048031843, 4801.063792560417, 4817.325574419584, 4834.734089625104, 4843.878903027453, 4848.3454733610515, 5562.082256427725, 5585.106382978704, 5643.689597072201, 5649.209110724501, 5658.405867383948, 6773.8983915241315, 6791.351372964449, 6801.9319806801295, 6811.761588344483, 6835.521513494008, 1689.864810815132, 1720.329071662053, 1721.8106008339073, 1723.9741403878702, 1725.6980028494963, 1083.3391631105019, 1103.7516558774212, 1109.1847492093304, 1111.360967443723, 1128.4019469681082, 6390.9360906391275, 6417.903731444032, 6427.453666438311, 6432.77485288022, 6438.581492202992, 6907.75822846208, 6962.373386395248, 6964.7562335319035, 6980.581165130108, 6986.196587392414, 6222.751089956351, 6322.430981211713, 6424.38968298011, 6559.24568674599, 6564.704588293538, 3771.5097037384962, 3807.9238415232094, 3832.2527107214382, 3838.808059597065, 3843.7309388342546, 7339.669714862737, 7392.223816499298, 7395.556266623912, 7397.778066658009, 7401.703931842773, 7129.0, 7228.638568071576, 7247.565146091251, 7263.7288474516745, 7272.236415176436, 7004.894926576106, 7405.1484079330485, 7406.962965185139, 7438.888416673754, 7460.813479662943, 6985.057017302599, 6986.091808064919, 7001.684924178526, 7011.509194356346, 7081.0, 6933.2026816916705, 6968.0, 6972.616506092214, 6974.546654467444, 6984.16190057176, 7391.445641576795, 7404.481686281909, 7413.925860741324, 7415.629218539159, 7429.925700742923, 4573.314002899591, 4743.525647435229, 4768.427788665383, 4789.880252993703, 4801.9039619208115, 6965.0, 6986.510944233854, 6994.860102798018, 7009.614471204132, 7016.719331226694, 6703.664816759045, 6800.693968771516, 6802.319768023158, 6807.3873351398615, 6812.386885180357, 6735.797926062226, 6741.764038258638, 6748.9876518522615, 6764.526483146329, 6782.898256526058, 6546.967265163644, 6672.299408562225, 6802.081718968074, 6803.863922721617, 6812.557183783237, 6830.7609233676585, 6845.0759147514445, 6851.3491218334175, 6891.207511136284, 6899.344562266577, 6676.332366763285, 6731.663416829237, 6746.392824645805, 6750.493712971449, 6758.7296508139125], "unit": "score", "name": "prototype.html", "value": 5103.91145506877}, {"lowerIsBetter": false, "replicates": [795.8766391209365, 877.3595275448922, 881.4534988307247, 892.3218354050921, 916.9358144929857, 13226.867731322684, 13465.663358416045, 13470.057096003284, 13481.056326057156, 13531.864681353183, 14025.088369255991, 14087.084339517924, 14095.436182552712, 14103.435862565486, 14123.78814317786, 749.4791120171483, 902.9232515236213, 928.3640706116332, 930.0792215706435, 930.3580529434702, 899.7345782994032, 900.545224661545, 908.5593487158723, 909.6816114359954, 910.6812615584558, 971.1647982734878, 975.7511834482198, 977.4233202410576, 978.0268632710463, 978.5694294510429, 970.2189737261466, 971.1017308989157, 971.4851128901694, 974.2985050763439, 975.3465178330536, 727.6252729844134, 729.6898818002328, 731.3673672273445, 732.1251104929611, 733.600187897597, 13695.726085478234, 13897.0, 13932.651683707887, 13940.024198306122, 13960.790588141084, 13052.412641431063, 13249.602511924657, 13320.467181312735, 13396.933015334958, 13522.256275904821, 11709.121815863844, 11754.11844111695, 11757.470913808898, 11760.529578816837, 11823.940880295544, 3932.292187406266, 3932.5870783567884, 3949.8878494447135, 3956.208758248362, 3979.2041591681777, 54188.45811541873, 54463.72768136134, 54605.726971365286, 54697.0, 55335.723321383535, 11245.775084498264, 11268.21122521432, 11341.206115571831, 11365.374904380173, 11607.30356178632, 20763.37709868676, 20811.1675532977, 20952.0, 21011.15955361799, 21097.472563185736, 8323.583820808935, 8458.788530286669, 8539.957300213584, 8617.526036068077, 8807.559622019002, 4905.190643543847, 4913.70517768935, 4921.901561968741, 5037.773300201499, 5054.772535235923, 3397.5413319202084, 3489.197484578561, 3508.2281897982402, 3516.894493165209, 3523.0, 612.0757655939564, 627.9434850863444, 637.5823835387829, 639.2393052267787, 641.6727468990848, 602.3163709190013, 635.5900444213456, 638.7061951502361, 661.7187695229508, 672.2705864137367, 7489.28851759082, 7556.886646700304, 7634.885476717854, 7667.578283194478, 7691.961540192263, 506.5390494649851, 626.8464226264595, 636.0935666674969, 645.9595231824906, 657.9703913323912, 3585.713142948558, 3590.6409359064405, 3636.8545258189374, 3708.2398108388256, 3805.980970095132, 59580.0, 60959.0, 61205.0, 61235.693821531495, 61353.0, 55249.44750552523, 55561.722191388784, 56258.15612765812, 56551.43448565544, 57421.0, 50186.498135018184, 50437.747811260706, 50820.74589627028, 50834.491655083715, 50890.745546272774, 7148.463865210234, 7148.499605027599, 7170.569765814068, 7246.818829529304, 7325.743598974011, 38223.42664860085, 38411.80794096012, 38806.41790373203, 38821.641242556376, 40120.0, 46135.53864461312, 49117.2632410507, 49305.75347123241, 49649.75175124101, 49958.75020624873, 9779.902200977898, 10114.443705595968, 10253.436061016715, 10363.170946324126, 10385.324953877975, 10847.837282440612, 10873.68757235795, 10993.110652373774, 11046.0, 11076.501557429774, 9982.900170998197, 10040.14658754014, 10301.433421161608, 10312.071913527818, 10373.740656483647, 9932.453715045742, 10025.448600327052, 10137.543810528396, 10169.0, 10238.692839214835, 9656.109584692935, 9850.507474626384, 9894.604215831287, 9956.2532810041, 10042.28012833967, 8713.912860871564, 8723.78190545216, 8727.781805454915, 9021.458712477272, 9032.14194651507, 8486.405951583576, 8892.688755893512, 8908.643654254016, 8919.152680495343, 8995.95502022512], "unit": "score", "name": "yui.html", "value": 6536.542292569066}], "name": "dromaeo_css", "value": 7356.097126570733}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 111.0, 109.0, 110.0, 122.0, 110.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 153.0, 163.0, 130.0, 163.0, 154.0, 131.0, 175.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 164.0, 162.0, 161.0, 165.0, 160.0, 161.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 76.0, 162.0, 75.0, 78.0, 73.0, 76.0, 159.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.7}, {"lowerIsBetter": true, "replicates": [97.0, 94.0, 139.0, 94.0, 98.0, 97.0, 159.0, 93.0, 94.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 151.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 58.0, 56.0, 55.0, 55.0, 56.0, 64.0, 54.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 64.0, 64.0, 65.0, 65.0, 66.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 80.0, 81.0, 78.0, 78.0, 83.0, 78.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [116.0, 114.0, 116.0, 112.0, 113.0, 118.0, 114.0, 117.0, 122.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 156.0, 147.0, 135.0, 137.0, 147.0, 140.0, 142.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 72.0, 65.0, 67.0, 64.0, 64.0, 70.0, 65.0, 82.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1515.3000000000002}]} 23:15:04 INFO - Return code: 0 23:15:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:15:04 ERROR - # TBPL SUCCESS # 23:15:04 INFO - Running post-action listener: _resource_record_post_action 23:15:04 INFO - Running post-run listener: _resource_record_post_run 23:15:05 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 286720; Write bytes: 248102912; Read time: 300; Write time: 166560 23:15:05 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 6090752; Read time: 0; Write time: 1276 23:15:05 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 286720; Write bytes: 242012160; Read time: 300; Write time: 165284 23:15:05 INFO - Running post-run listener: _upload_blobber_files 23:15:05 INFO - Blob upload gear active. 23:15:05 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:15:05 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:15:05 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:15:05 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:15:05 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:15:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:15:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:06 INFO - (blobuploader) - INFO - Done attempting. 23:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:07 INFO - (blobuploader) - INFO - Done attempting. 23:15:07 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:07 INFO - Return code: 0 23:15:07 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:15:07 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/758a17069b80b3f20d0a3ad2ddd1e26679c567ed833bb5e57c8a8559bacbaa130bdbcf712dee351d7546ec592efb05603ca1ea5e8e5cd932963958e071b2a91b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e54dc2d5a9630260af7912f0a408085c31ebda1561c3d350f78d48ddc822c5b55fc4a05926ffa639cb83af703cf5433cab8ac7dab3ed7e105e2d1b5d36604a25"} 23:15:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:15:07 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:15:07 INFO - Contents: 23:15:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/758a17069b80b3f20d0a3ad2ddd1e26679c567ed833bb5e57c8a8559bacbaa130bdbcf712dee351d7546ec592efb05603ca1ea5e8e5cd932963958e071b2a91b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e54dc2d5a9630260af7912f0a408085c31ebda1561c3d350f78d48ddc822c5b55fc4a05926ffa639cb83af703cf5433cab8ac7dab3ed7e105e2d1b5d36604a25"} 23:15:07 INFO - Running post-run listener: copy_logs_to_upload_dir 23:15:07 INFO - Copying logs to upload dir... 23:15:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:15:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1298.872964 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-04-01 23:15:07.408265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 23:15:07.411689) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/758a17069b80b3f20d0a3ad2ddd1e26679c567ed833bb5e57c8a8559bacbaa130bdbcf712dee351d7546ec592efb05603ca1ea5e8e5cd932963958e071b2a91b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e54dc2d5a9630260af7912f0a408085c31ebda1561c3d350f78d48ddc822c5b55fc4a05926ffa639cb83af703cf5433cab8ac7dab3ed7e105e2d1b5d36604a25"} build_url:https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/VPAqQ7jPTcCdY5_7QmH4Ew/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/758a17069b80b3f20d0a3ad2ddd1e26679c567ed833bb5e57c8a8559bacbaa130bdbcf712dee351d7546ec592efb05603ca1ea5e8e5cd932963958e071b2a91b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e54dc2d5a9630260af7912f0a408085c31ebda1561c3d350f78d48ddc822c5b55fc4a05926ffa639cb83af703cf5433cab8ac7dab3ed7e105e2d1b5d36604a25"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 23:15:07.437188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 23:15:07.437527) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1459576253.922001-1463813572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004806 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 23:15:07.519293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 23:15:07.519607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 23:15:07.519913) ========= ========= Total master_lag: 0.70 =========