builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1464625048.21 results: success (0) buildid: 20160530075640 builduid: 4593b5538f644b03bb5656e5eeeecd2e revision: 4dbe106594fa8197404081eb801cbd4b2a42d06b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.209801) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.210886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.211593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.228135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.228430) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 09:17:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.3M=0s 2016-05-30 09:17:29 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.359915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.360275) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014727 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.410244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:28.410647) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4dbe106594fa8197404081eb801cbd4b2a42d06b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4dbe106594fa8197404081eb801cbd4b2a42d06b --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 09:17:29,854 truncating revision to first 12 chars 2016-05-30 09:17:29,854 Setting DEBUG logging. 2016-05-30 09:17:29,854 attempt 1/10 2016-05-30 09:17:29,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4dbe106594fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 09:17:30,189 unpacking tar archive at: fx-team-4dbe106594fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:29.093967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:29.094338) ========= script_repo_revision: 4dbe106594fa8197404081eb801cbd4b2a42d06b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:29.094827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:29.095158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 09:17:29.105892) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-30 09:17:29.106215) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:17:30 INFO - MultiFileLogger online at 20160530 09:17:30 in /builds/slave/test 09:17:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:17:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:30 INFO - {'append_to_log': False, 09:17:30 INFO - 'base_work_dir': '/builds/slave/test', 09:17:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:17:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:30 INFO - 'branch': 'Fx-Team-Non-PGO', 09:17:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:30 INFO - 'config_files': ('talos/linux_config.py',), 09:17:30 INFO - 'default_actions': ('clobber', 09:17:30 INFO - 'read-buildbot-config', 09:17:30 INFO - 'download-and-extract', 09:17:30 INFO - 'populate-webroot', 09:17:30 INFO - 'create-virtualenv', 09:17:30 INFO - 'install', 09:17:30 INFO - 'run-tests'), 09:17:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:30 INFO - 'download_minidump_stackwalk': True, 09:17:30 INFO - 'download_symbols': 'ondemand', 09:17:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:30 INFO - 'installer_path': 'installer.exe', 09:17:30 INFO - 'log_level': 'info', 09:17:30 INFO - 'log_name': 'talos', 09:17:30 INFO - 'log_to_console': True, 09:17:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:17:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:17:30 INFO - 'opt_config_files': (), 09:17:30 INFO - 'pip_index': False, 09:17:30 INFO - 'sps_profile': False, 09:17:30 INFO - 'sps_profile_interval': 0, 09:17:30 INFO - 'suite': 'dromaeojs-e10s', 09:17:30 INFO - 'system_bits': '32', 09:17:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:30 INFO - 'title': 'talos-linux64-ix-034', 09:17:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:30 INFO - 'use_talos_json': True, 09:17:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:30 INFO - 'work_dir': 'build'} 09:17:30 INFO - ##### 09:17:30 INFO - ##### Running clobber step. 09:17:30 INFO - ##### 09:17:30 INFO - Running pre-action listener: _resource_record_pre_action 09:17:30 INFO - Running main action method: clobber 09:17:30 INFO - rmtree: /builds/slave/test/build 09:17:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:31 INFO - Running post-action listener: _resource_record_post_action 09:17:31 INFO - ##### 09:17:31 INFO - ##### Finished clobber step (success) 09:17:31 INFO - ##### 09:17:31 INFO - ##### 09:17:31 INFO - ##### Running read-buildbot-config step. 09:17:31 INFO - ##### 09:17:31 INFO - Running pre-action listener: _resource_record_pre_action 09:17:31 INFO - Running main action method: read_buildbot_config 09:17:31 INFO - Using buildbot properties: 09:17:31 INFO - { 09:17:31 INFO - "project": "", 09:17:31 INFO - "product": "firefox", 09:17:31 INFO - "script_repo_revision": "production", 09:17:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:17:31 INFO - "repository": "", 09:17:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:17:31 INFO - "buildid": "20160530075640", 09:17:31 INFO - "pgo_build": "False", 09:17:31 INFO - "basedir": "/builds/slave/test", 09:17:31 INFO - "buildnumber": 1351, 09:17:31 INFO - "slavename": "talos-linux64-ix-034", 09:17:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:17:31 INFO - "platform": "ubuntu64_hw", 09:17:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:17:31 INFO - "branch": "fx-team", 09:17:31 INFO - "repo_path": "integration/fx-team", 09:17:31 INFO - "revision": "4dbe106594fa8197404081eb801cbd4b2a42d06b", 09:17:31 INFO - "stage_platform": "linux64", 09:17:31 INFO - "builduid": "4593b5538f644b03bb5656e5eeeecd2e", 09:17:31 INFO - "slavebuilddir": "test" 09:17:31 INFO - } 09:17:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:17:31 INFO - Running post-action listener: _resource_record_post_action 09:17:31 INFO - ##### 09:17:31 INFO - ##### Finished read-buildbot-config step (success) 09:17:31 INFO - ##### 09:17:31 INFO - ##### 09:17:31 INFO - ##### Running download-and-extract step. 09:17:31 INFO - ##### 09:17:31 INFO - Running pre-action listener: _resource_record_pre_action 09:17:31 INFO - Running main action method: download_and_extract 09:17:31 INFO - mkdir: /builds/slave/test/build/tests 09:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:31 INFO - https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:17:32 INFO - Downloaded 1361 bytes. 09:17:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:17:32 INFO - Using the following test package requirements: 09:17:32 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:17:32 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:17:32 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:17:32 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:32 INFO - u'jsshell-linux-x86_64.zip'], 09:17:32 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:17:32 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:17:32 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:17:32 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:17:32 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:17:32 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:17:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:17: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')]} 09:17:32 INFO - https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:17:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:17:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:17:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:17:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:33 INFO - Downloaded 22838217 bytes. 09:17:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:17:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:17:34 INFO - Return code: 0 09:17:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:34 INFO - https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:35 INFO - Downloaded 22838217 bytes. 09:17:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:17:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:17:37 INFO - Return code: 0 09:17: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')]} 09:17:37 INFO - https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:17:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:17:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:17:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:17:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:17:38 INFO - Downloaded 10834055 bytes. 09:17:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:17:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:17:38 INFO - Return code: 0 09:17:38 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')]} 09:17:38 INFO - https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:17:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:17:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:17:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:17:39 INFO - Downloaded 55002237 bytes. 09:17:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:17:39 INFO - mkdir: /builds/slave/test/properties 09:17:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:17:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:17:39 INFO - Contents: 09:17:39 INFO - build_url:https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:17:40 INFO - Running post-action listener: _resource_record_post_action 09:17:40 INFO - Running post-action listener: set_extra_try_arguments 09:17:40 INFO - ##### 09:17:40 INFO - ##### Finished download-and-extract step (success) 09:17:40 INFO - ##### 09:17:40 INFO - ##### 09:17:40 INFO - ##### Running populate-webroot step. 09:17:40 INFO - ##### 09:17:40 INFO - Running pre-action listener: _resource_record_pre_action 09:17:40 INFO - Running main action method: populate_webroot 09:17:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:40 INFO - '--tppagecycles', 09:17:40 INFO - '7'], 09:17:40 INFO - 'tests': ['tsvgm']}}, 09:17:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:17:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:17:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:17:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:40 INFO - 'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:40 INFO - 'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['damp', 'tps']}, 09:17:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:40 INFO - 'tests': ['damp', 'tps']}, 09:17:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['dromaeo_dom']}, 09:17:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['a11yr', 09:17:40 INFO - 'ts_paint', 09:17:40 INFO - 'tpaint', 09:17:40 INFO - 'sessionrestore', 09:17:40 INFO - 'sessionrestore_no_auto_restore', 09:17:40 INFO - 'tabpaint']}, 09:17:40 INFO - 'other-e10s': {'tests': ['a11yr', 09:17:40 INFO - 'ts_paint', 09:17:40 INFO - 'tpaint', 09:17:40 INFO - 'sessionrestore', 09:17:40 INFO - 'sessionrestore_no_auto_restore', 09:17:40 INFO - 'tabpaint']}, 09:17:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:17:40 INFO - 'ts_paint', 09:17:40 INFO - 'tpaint', 09:17:40 INFO - 'sessionrestore', 09:17:40 INFO - 'sessionrestore_no_auto_restore', 09:17:40 INFO - 'tabpaint']}, 09:17:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:17:40 INFO - 'ts_paint', 09:17:40 INFO - 'tpaint', 09:17:40 INFO - 'sessionrestore', 09:17:40 INFO - 'sessionrestore_no_auto_restore', 09:17:40 INFO - 'tabpaint']}, 09:17:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['a11yr', 09:17:40 INFO - 'ts_paint', 09:17:40 INFO - 'tpaint', 09:17:40 INFO - 'sessionrestore', 09:17:40 INFO - 'sessionrestore_no_auto_restore', 09:17:40 INFO - 'tabpaint']}, 09:17:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['a11yr', 09:17:40 INFO - 'ts_paint', 09:17:40 INFO - 'tpaint', 09:17:40 INFO - 'sessionrestore', 09:17:40 INFO - 'sessionrestore_no_auto_restore', 09:17:40 INFO - 'tabpaint']}, 09:17:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['tsvgx', 09:17:40 INFO - 'tsvgr_opacity', 09:17:40 INFO - 'tart', 09:17:40 INFO - 'tscrollx', 09:17:40 INFO - 'cart']}, 09:17:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:17:40 INFO - 'tsvgr_opacity', 09:17:40 INFO - 'tart', 09:17:40 INFO - 'tscrollx', 09:17:40 INFO - 'cart']}, 09:17:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:40 INFO - 'talos_options': ['--disable-e10s'], 09:17:40 INFO - 'tests': ['tp5o']}, 09:17:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:40 INFO - 'tests': ['tp5o']}, 09:17:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:40 INFO - 'talos_options': ['--disable-e10s', 09:17:40 INFO - '--xperf_path', 09:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:40 INFO - 'tests': ['tp5n']}, 09:17:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:40 INFO - 'talos_options': ['--xperf_path', 09:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:40 INFO - 'tests': ['tp5n']}}, 09:17:40 INFO - 'talos.zip': {'path': '', 09:17:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:40 INFO - Running post-action listener: _resource_record_post_action 09:17:40 INFO - ##### 09:17:40 INFO - ##### Finished populate-webroot step (success) 09:17:40 INFO - ##### 09:17:40 INFO - ##### 09:17:40 INFO - ##### Running create-virtualenv step. 09:17:40 INFO - ##### 09:17:40 INFO - Running pre-action listener: _resource_record_pre_action 09:17:40 INFO - Running main action method: create_virtualenv 09:17:40 INFO - Creating virtualenv /builds/slave/test/build/venv 09:17:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:17:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:17:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:40 INFO - Using real prefix '/usr' 09:17:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:17:41 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:43 INFO - Installing pip.................done. 09:17:43 INFO - Return code: 0 09:17:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:17:43 INFO - Running command: ['/builds/slave/test/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/build 09:17:43 INFO - Copy/paste: /builds/slave/test/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 09:17:43 INFO - Using env: {'DISPLAY': ':0', 09:17:43 INFO - 'HOME': '/home/cltbld', 09:17:43 INFO - 'LANG': 'en_US.UTF-8', 09:17:43 INFO - 'LANGUAGE': 'en_US:en', 09:17:43 INFO - 'LOGNAME': 'cltbld', 09:17:43 INFO - 'MAIL': '/var/mail/cltbld', 09:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:43 INFO - 'MOZ_NO_REMOTE': '1', 09:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:43 INFO - 'NO_EM_RESTART': '1', 09:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:43 INFO - 'PWD': '/builds/slave/test', 09:17:43 INFO - 'SHELL': '/bin/bash', 09:17:43 INFO - 'SHLVL': '1', 09:17:43 INFO - 'TERM': 'linux', 09:17:43 INFO - 'TMOUT': '86400', 09:17:43 INFO - 'USER': 'cltbld', 09:17:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:43 INFO - '_': '/tools/buildbot/bin/python'} 09:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:43 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 09:17:43 INFO - Cleaning up... 09:17:43 INFO - Return code: 0 09:17:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:17:43 INFO - Running command: ['/builds/slave/test/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>=3.1.1'] in /builds/slave/test/build 09:17:43 INFO - Copy/paste: /builds/slave/test/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>=3.1.1 09:17:43 INFO - Using env: {'DISPLAY': ':0', 09:17:43 INFO - 'HOME': '/home/cltbld', 09:17:43 INFO - 'LANG': 'en_US.UTF-8', 09:17:43 INFO - 'LANGUAGE': 'en_US:en', 09:17:43 INFO - 'LOGNAME': 'cltbld', 09:17:43 INFO - 'MAIL': '/var/mail/cltbld', 09:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:43 INFO - 'MOZ_NO_REMOTE': '1', 09:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:43 INFO - 'NO_EM_RESTART': '1', 09:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:43 INFO - 'PWD': '/builds/slave/test', 09:17:43 INFO - 'SHELL': '/bin/bash', 09:17:43 INFO - 'SHLVL': '1', 09:17:43 INFO - 'TERM': 'linux', 09:17:43 INFO - 'TMOUT': '86400', 09:17:43 INFO - 'USER': 'cltbld', 09:17:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:43 INFO - '_': '/tools/buildbot/bin/python'} 09:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:43 INFO - Downloading/unpacking psutil>=3.1.1 09:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:45 INFO - Installing collected packages: psutil 09:17:45 INFO - Running setup.py install for psutil 09:17:45 INFO - building 'psutil._psutil_linux' extension 09:17:45 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 09:17:46 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 09:17:46 INFO - building 'psutil._psutil_posix' extension 09:17:46 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 09:17:46 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 09:17:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:46 INFO - Successfully installed psutil 09:17:46 INFO - Cleaning up... 09:17:46 INFO - Return code: 0 09:17:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:17:46 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')]} 09:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:46 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')]} 09:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:17:46 INFO - Running command: ['/builds/slave/test/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.3'] in /builds/slave/test/build 09:17:46 INFO - Copy/paste: /builds/slave/test/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.3 09:17:46 INFO - Using env: {'DISPLAY': ':0', 09:17:46 INFO - 'HOME': '/home/cltbld', 09:17:46 INFO - 'LANG': 'en_US.UTF-8', 09:17:46 INFO - 'LANGUAGE': 'en_US:en', 09:17:46 INFO - 'LOGNAME': 'cltbld', 09:17:46 INFO - 'MAIL': '/var/mail/cltbld', 09:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:46 INFO - 'MOZ_NO_REMOTE': '1', 09:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:46 INFO - 'NO_EM_RESTART': '1', 09:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:46 INFO - 'PWD': '/builds/slave/test', 09:17:46 INFO - 'SHELL': '/bin/bash', 09:17:46 INFO - 'SHLVL': '1', 09:17:46 INFO - 'TERM': 'linux', 09:17:46 INFO - 'TMOUT': '86400', 09:17:46 INFO - 'USER': 'cltbld', 09:17:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:46 INFO - '_': '/tools/buildbot/bin/python'} 09:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:17:46 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 09:17:46 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 09:17:46 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 09:17:46 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 09:17:46 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 09:17:46 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 09:17:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:17:48 INFO - Installing collected packages: mozsystemmonitor 09:17:48 INFO - Running setup.py install for mozsystemmonitor 09:17:48 INFO - Successfully installed mozsystemmonitor 09:17:48 INFO - Cleaning up... 09:17:48 INFO - Return code: 0 09:17:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:17:48 INFO - Running command: ['/builds/slave/test/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/build 09:17:48 INFO - Copy/paste: /builds/slave/test/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 09:17:48 INFO - Using env: {'DISPLAY': ':0', 09:17:48 INFO - 'HOME': '/home/cltbld', 09:17:48 INFO - 'LANG': 'en_US.UTF-8', 09:17:48 INFO - 'LANGUAGE': 'en_US:en', 09:17:48 INFO - 'LOGNAME': 'cltbld', 09:17:48 INFO - 'MAIL': '/var/mail/cltbld', 09:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:48 INFO - 'MOZ_NO_REMOTE': '1', 09:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:48 INFO - 'NO_EM_RESTART': '1', 09:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:48 INFO - 'PWD': '/builds/slave/test', 09:17:48 INFO - 'SHELL': '/bin/bash', 09:17:48 INFO - 'SHLVL': '1', 09:17:48 INFO - 'TERM': 'linux', 09:17:48 INFO - 'TMOUT': '86400', 09:17:48 INFO - 'USER': 'cltbld', 09:17:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:48 INFO - '_': '/tools/buildbot/bin/python'} 09:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:17:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:51 INFO - Downloading docopt-0.6.1.tar.gz 09:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:51 INFO - Running setup.py install for blobuploader 09:17:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:17:51 INFO - Running setup.py install for requests 09:17:52 INFO - Running setup.py install for docopt 09:17:52 INFO - Successfully installed blobuploader requests docopt 09:17:52 INFO - Cleaning up... 09:17:52 INFO - Return code: 0 09:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 09:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 09:17:52 INFO - Using env: {'DISPLAY': ':0', 09:17:52 INFO - 'HOME': '/home/cltbld', 09:17:52 INFO - 'LANG': 'en_US.UTF-8', 09:17:52 INFO - 'LANGUAGE': 'en_US:en', 09:17:52 INFO - 'LOGNAME': 'cltbld', 09:17:52 INFO - 'MAIL': '/var/mail/cltbld', 09:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:52 INFO - 'MOZ_NO_REMOTE': '1', 09:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:52 INFO - 'NO_EM_RESTART': '1', 09:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:52 INFO - 'PWD': '/builds/slave/test', 09:17:52 INFO - 'SHELL': '/bin/bash', 09:17:52 INFO - 'SHLVL': '1', 09:17:52 INFO - 'TERM': 'linux', 09:17:52 INFO - 'TMOUT': '86400', 09:17:52 INFO - 'USER': 'cltbld', 09:17:52 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:52 INFO - '_': '/tools/buildbot/bin/python'} 09:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:52 INFO - Running setup.py (path:/tmp/pip-1LFGeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:52 INFO - Running setup.py (path:/tmp/pip-I41_E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:52 INFO - Running setup.py (path:/tmp/pip-o5S0Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:52 INFO - Running setup.py (path:/tmp/pip-tt3RUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:52 INFO - Running setup.py (path:/tmp/pip-ViyiMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:52 INFO - Running setup.py (path:/tmp/pip-62SXO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:53 INFO - Running setup.py (path:/tmp/pip-Xo8zFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:53 INFO - Running setup.py (path:/tmp/pip-fQvDHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:53 INFO - Running setup.py (path:/tmp/pip-Efb6sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:53 INFO - Running setup.py (path:/tmp/pip-mtJIxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:53 INFO - Running setup.py (path:/tmp/pip-rqacmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:53 INFO - Running setup.py (path:/tmp/pip-lutzLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:53 INFO - Running setup.py (path:/tmp/pip-anIwcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:53 INFO - Running setup.py (path:/tmp/pip-dy1iky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:53 INFO - Running setup.py (path:/tmp/pip-AyPqgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:53 INFO - Running setup.py (path:/tmp/pip-ncn5_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:53 INFO - Running setup.py (path:/tmp/pip-jW50tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:53 INFO - Running setup.py install for manifestparser 09:17:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:17:53 INFO - Running setup.py install for mozcrash 09:17:53 INFO - Running setup.py install for mozdebug 09:17:54 INFO - Running setup.py install for mozdevice 09:17:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Running setup.py install for mozfile 09:17:54 INFO - Running setup.py install for mozhttpd 09:17:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Running setup.py install for mozinfo 09:17:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Running setup.py install for mozInstall 09:17:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Running setup.py install for mozleak 09:17:54 INFO - Running setup.py install for mozlog 09:17:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Running setup.py install for moznetwork 09:17:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:17:54 INFO - Running setup.py install for mozprocess 09:17:55 INFO - Running setup.py install for mozprofile 09:17:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:17:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:17:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:17:55 INFO - Running setup.py install for mozrunner 09:17:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:17:55 INFO - Running setup.py install for mozscreenshot 09:17:55 INFO - Running setup.py install for moztest 09:17:55 INFO - Running setup.py install for mozversion 09:17:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:17:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:55 INFO - Cleaning up... 09:17:55 INFO - Return code: 0 09:17:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17: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')]} 09:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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')]} 09:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 09:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 09:17:55 INFO - Using env: {'DISPLAY': ':0', 09:17:55 INFO - 'HOME': '/home/cltbld', 09:17:55 INFO - 'LANG': 'en_US.UTF-8', 09:17:55 INFO - 'LANGUAGE': 'en_US:en', 09:17:55 INFO - 'LOGNAME': 'cltbld', 09:17:55 INFO - 'MAIL': '/var/mail/cltbld', 09:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:55 INFO - 'MOZ_NO_REMOTE': '1', 09:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:55 INFO - 'NO_EM_RESTART': '1', 09:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:55 INFO - 'PWD': '/builds/slave/test', 09:17:55 INFO - 'SHELL': '/bin/bash', 09:17:55 INFO - 'SHLVL': '1', 09:17:55 INFO - 'TERM': 'linux', 09:17:55 INFO - 'TMOUT': '86400', 09:17:55 INFO - 'USER': 'cltbld', 09:17:55 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:55 INFO - '_': '/tools/buildbot/bin/python'} 09:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:55 INFO - Running setup.py (path:/tmp/pip-SeG8nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:55 INFO - Running setup.py (path:/tmp/pip-6gxwYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:55 INFO - Running setup.py (path:/tmp/pip-oy2Vzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:56 INFO - Running setup.py (path:/tmp/pip-rOJWhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:56 INFO - Running setup.py (path:/tmp/pip-c_vI7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:56 INFO - Running setup.py (path:/tmp/pip-sCG7o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:56 INFO - Running setup.py (path:/tmp/pip-pQJOZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:56 INFO - Running setup.py (path:/tmp/pip-NcSr26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:56 INFO - Running setup.py (path:/tmp/pip-Pj7EU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:56 INFO - Running setup.py (path:/tmp/pip-EWuLB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:56 INFO - Running setup.py (path:/tmp/pip-a1ZWSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:56 INFO - Running setup.py (path:/tmp/pip-xZUbfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:56 INFO - Running setup.py (path:/tmp/pip-nIj4uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:56 INFO - Running setup.py (path:/tmp/pip-Va6F2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:56 INFO - Running setup.py (path:/tmp/pip-LSqErB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:56 INFO - Running setup.py (path:/tmp/pip-MgH9G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:56 INFO - Running setup.py (path:/tmp/pip-hb89eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:17:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:59 INFO - Downloading blessings-1.6.tar.gz 09:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:59 INFO - Installing collected packages: blessings 09:17:59 INFO - Running setup.py install for blessings 09:17:59 INFO - Successfully installed blessings 09:17:59 INFO - Cleaning up... 09:17:59 INFO - Return code: 0 09:17:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:59 INFO - Reading from file tmpfile_stdout 09:17:59 INFO - Current package versions: 09:17:59 INFO - argparse == 1.2.1 09:17:59 INFO - blessings == 1.6 09:17:59 INFO - blobuploader == 1.2.4 09:17:59 INFO - docopt == 0.6.1 09:17:59 INFO - manifestparser == 1.1 09:17:59 INFO - mozInstall == 1.12 09:17:59 INFO - mozcrash == 0.17 09:17:59 INFO - mozdebug == 0.1 09:17:59 INFO - mozdevice == 0.48 09:17:59 INFO - mozfile == 1.2 09:17:59 INFO - mozhttpd == 0.7 09:17:59 INFO - mozinfo == 0.9 09:17:59 INFO - mozleak == 0.1 09:17:59 INFO - mozlog == 3.2 09:17:59 INFO - moznetwork == 0.27 09:17:59 INFO - mozprocess == 0.22 09:17:59 INFO - mozprofile == 0.28 09:17:59 INFO - mozrunner == 6.11 09:17:59 INFO - mozscreenshot == 0.1 09:17:59 INFO - mozsystemmonitor == 0.3 09:17:59 INFO - moztest == 0.7 09:17:59 INFO - mozversion == 1.4 09:17:59 INFO - psutil == 3.1.1 09:17:59 INFO - requests == 1.2.3 09:17:59 INFO - wsgiref == 0.1.2 09:17:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 09:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 09:17:59 INFO - Using env: {'DISPLAY': ':0', 09:17:59 INFO - 'HOME': '/home/cltbld', 09:17:59 INFO - 'LANG': 'en_US.UTF-8', 09:17:59 INFO - 'LANGUAGE': 'en_US:en', 09:17:59 INFO - 'LOGNAME': 'cltbld', 09:17:59 INFO - 'MAIL': '/var/mail/cltbld', 09:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:59 INFO - 'MOZ_NO_REMOTE': '1', 09:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:59 INFO - 'NO_EM_RESTART': '1', 09:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:59 INFO - 'PWD': '/builds/slave/test', 09:17:59 INFO - 'SHELL': '/bin/bash', 09:17:59 INFO - 'SHLVL': '1', 09:17:59 INFO - 'TERM': 'linux', 09:17:59 INFO - 'TMOUT': '86400', 09:17:59 INFO - 'USER': 'cltbld', 09:17:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:59 INFO - '_': '/tools/buildbot/bin/python'} 09:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:17:59 INFO - Cleaning up... 09:17:59 INFO - Return code: 0 09:17:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:17:59 INFO - Running command: ['/builds/slave/test/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/build 09:17:59 INFO - Copy/paste: /builds/slave/test/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 09:17:59 INFO - Using env: {'DISPLAY': ':0', 09:17:59 INFO - 'HOME': '/home/cltbld', 09:17:59 INFO - 'LANG': 'en_US.UTF-8', 09:17:59 INFO - 'LANGUAGE': 'en_US:en', 09:17:59 INFO - 'LOGNAME': 'cltbld', 09:17:59 INFO - 'MAIL': '/var/mail/cltbld', 09:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:59 INFO - 'MOZ_NO_REMOTE': '1', 09:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:59 INFO - 'NO_EM_RESTART': '1', 09:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:59 INFO - 'PWD': '/builds/slave/test', 09:17:59 INFO - 'SHELL': '/bin/bash', 09:17:59 INFO - 'SHLVL': '1', 09:17:59 INFO - 'TERM': 'linux', 09:17:59 INFO - 'TMOUT': '86400', 09:17:59 INFO - 'USER': 'cltbld', 09:17:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:59 INFO - '_': '/tools/buildbot/bin/python'} 09:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:00 INFO - Downloading/unpacking jsonschema 09:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:01 INFO - Downloading/unpacking functools32 (from jsonschema) 09:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:02 INFO - warning: no files found matching '*.txt' 09:18:02 INFO - no previously-included directories found matching 'build' 09:18:02 INFO - no previously-included directories found matching 'dist' 09:18:02 INFO - no previously-included directories found matching '.git*' 09:18:02 INFO - Installing collected packages: jsonschema, functools32 09:18:02 INFO - Running setup.py install for functools32 09:18:02 INFO - warning: no files found matching '*.txt' 09:18:02 INFO - no previously-included directories found matching 'build' 09:18:02 INFO - no previously-included directories found matching 'dist' 09:18:02 INFO - no previously-included directories found matching '.git*' 09:18:02 INFO - Successfully installed jsonschema functools32 09:18:02 INFO - Cleaning up... 09:18:02 INFO - Return code: 0 09:18:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ffe08737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:18:02 INFO - Running command: ['/builds/slave/test/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/build 09:18:02 INFO - Copy/paste: /builds/slave/test/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 09:18:02 INFO - Using env: {'DISPLAY': ':0', 09:18:02 INFO - 'HOME': '/home/cltbld', 09:18:02 INFO - 'LANG': 'en_US.UTF-8', 09:18:02 INFO - 'LANGUAGE': 'en_US:en', 09:18:02 INFO - 'LOGNAME': 'cltbld', 09:18:02 INFO - 'MAIL': '/var/mail/cltbld', 09:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:02 INFO - 'MOZ_NO_REMOTE': '1', 09:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:02 INFO - 'NO_EM_RESTART': '1', 09:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:02 INFO - 'PWD': '/builds/slave/test', 09:18:02 INFO - 'SHELL': '/bin/bash', 09:18:02 INFO - 'SHLVL': '1', 09:18:02 INFO - 'TERM': 'linux', 09:18:02 INFO - 'TMOUT': '86400', 09:18:02 INFO - 'USER': 'cltbld', 09:18:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:02 INFO - '_': '/tools/buildbot/bin/python'} 09:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:02 INFO - Downloading/unpacking flake8 09:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:18:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:18:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:18:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:18:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:18:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:18:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:18:05 INFO - no previously-included directories found matching 'docs/_build' 09:18:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:18:05 INFO - Running setup.py install for pep8 09:18:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:18:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:18:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:18:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:18:05 INFO - no previously-included directories found matching 'docs/_build' 09:18:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:18:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:18:05 INFO - Cleaning up... 09:18:05 INFO - Return code: 0 09:18:05 INFO - Running post-action listener: _resource_record_post_action 09:18:05 INFO - Running post-action listener: _start_resource_monitoring 09:18:05 INFO - Starting resource monitoring. 09:18:05 INFO - ##### 09:18:05 INFO - ##### Finished create-virtualenv step (success) 09:18:05 INFO - ##### 09:18:05 INFO - ##### 09:18:05 INFO - ##### Running install step. 09:18:05 INFO - ##### 09:18:05 INFO - Running pre-action listener: _resource_record_pre_action 09:18:05 INFO - Running main action method: install 09:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:05 INFO - Reading from file tmpfile_stdout 09:18:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:05 INFO - Reading from file tmpfile_stdout 09:18:05 INFO - Output received: 09:18:05 INFO - Usage: mozinstall [options] installer 09:18:05 INFO - Options: 09:18:05 INFO - -h, --help show this help message and exit 09:18:05 INFO - -d DEST, --destination=DEST 09:18:05 INFO - Directory to install application into. [default: 09:18:05 INFO - "/builds/slave/test"] 09:18:05 INFO - --app=APP Application being installed. [default: firefox] 09:18:05 INFO - mkdir: /builds/slave/test/build/application 09:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:18:21 INFO - Reading from file tmpfile_stdout 09:18:21 INFO - Output received: 09:18:21 INFO - /builds/slave/test/build/application/firefox/firefox 09:18:21 INFO - Running post-action listener: _resource_record_post_action 09:18:21 INFO - ##### 09:18:21 INFO - ##### Finished install step (success) 09:18:21 INFO - ##### 09:18:21 INFO - ##### 09:18:21 INFO - ##### Running run-tests step. 09:18:21 INFO - ##### 09:18:21 INFO - Running pre-action listener: _resource_record_pre_action 09:18:21 INFO - Running main action method: run_tests 09:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:18:21 INFO - Python 2.7.3 09:18:21 INFO - Return code: 0 09:18:21 INFO - grabbing minidump binary from tooltool 09:18:21 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')]} 09:18:21 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b9c0>, '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 0x291c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:18:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:18:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:18:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:18:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:18:21 INFO - Return code: 0 09:18:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:18:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:18:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:18:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:18:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:18:22 INFO - Return code: 0 09:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:18:22 INFO - Using env: {'DISPLAY': ':0', 09:18:22 INFO - 'HOME': '/home/cltbld', 09:18:22 INFO - 'LANG': 'en_US.UTF-8', 09:18:22 INFO - 'LANGUAGE': 'en_US:en', 09:18:22 INFO - 'LOGNAME': 'cltbld', 09:18:22 INFO - 'MAIL': '/var/mail/cltbld', 09:18:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:18:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:22 INFO - 'MOZ_NO_REMOTE': '1', 09:18:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:22 INFO - 'NO_EM_RESTART': '1', 09:18:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:22 INFO - 'PWD': '/builds/slave/test', 09:18:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:18:22 INFO - 'SHELL': '/bin/bash', 09:18:22 INFO - 'SHLVL': '1', 09:18:22 INFO - 'TERM': 'linux', 09:18:22 INFO - 'TMOUT': '86400', 09:18:22 INFO - 'USER': 'cltbld', 09:18:22 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837', 09:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:22 INFO - '_': '/tools/buildbot/bin/python'} 09:18:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:18:22 INFO - mozversion application_buildid: 20160530075640 09:18:22 INFO - mozversion application_changeset: 4dbe106594fa8197404081eb801cbd4b2a42d06b 09:18:22 INFO - mozversion application_display_name: Nightly 09:18:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:18:22 INFO - mozversion application_name: Firefox 09:18:22 INFO - mozversion application_remotingname: firefox 09:18:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:18:22 INFO - mozversion application_vendor: Mozilla 09:18:22 INFO - mozversion application_version: 49.0a1 09:18:22 INFO - mozversion platform_buildid: 20160530075640 09:18:22 INFO - mozversion platform_changeset: 4dbe106594fa8197404081eb801cbd4b2a42d06b 09:18:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:18:22 INFO - mozversion platform_version: 49.0a1 09:18:22 INFO - using testdate: 1464625102 09:18:22 INFO - actual date: 1464625102 09:18:22 INFO - starting webserver on 'localhost:49600' 09:18:22 INFO - SUITE-START | Running 2 tests 09:18:22 INFO - TEST-START | dromaeo_css 09:18:22 INFO - operating with platform_type : linux_ 09:18:22 INFO - Initialising browser for dromaeo_css test... 09:18:22 INFO - TEST-INFO | started process 18231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfyIio/profile http://localhost:49600/getInfo.html) 09:18:27 INFO - PROCESS | 18231 | __metrics Screen width/height:1600/1200 09:18:27 INFO - PROCESS | 18231 | colorDepth:24 09:18:27 INFO - PROCESS | 18231 | Browser inner width/height: 1024/697 09:18:27 INFO - PROCESS | 18231 | __metrics 09:18:28 ERROR - PROCESS | 18231 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:18:29 INFO - TEST-INFO | 18231: exit 0 09:18:29 INFO - Browser initialized. 09:18:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:18:29 INFO - TEST-INFO | started process 18349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfyIio/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:41 INFO - PROCESS | 18349 | RSS: Main: 167723008 09:18:41 INFO - PROCESS | 18349 | 09:19:30 INFO - PROCESS | 18349 | 1464625170725 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] 09:21:42 INFO - PROCESS | 18349 | Cycle 1(1): loaded http://localhost:49600/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49600/tests/dromaeo/cssquery-ext.html) 09:21:43 INFO - PROCESS | 18349 | RSS: Main: 171474944 09:21:43 INFO - PROCESS | 18349 | 09:24:45 INFO - PROCESS | 18349 | Cycle 1(1): loaded http://localhost:49600/tests/dromaeo/cssquery-ext.html (next: http://localhost:49600/tests/dromaeo/cssquery-jquery.html) 09:24:46 INFO - PROCESS | 18349 | RSS: Main: 169713664 09:24:46 INFO - PROCESS | 18349 | 09:27:48 INFO - PROCESS | 18349 | Cycle 1(1): loaded http://localhost:49600/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49600/tests/dromaeo/cssquery-mootools.html) 09:27:48 INFO - PROCESS | 18349 | RSS: Main: 171028480 09:27:48 INFO - PROCESS | 18349 | 09:30:50 INFO - PROCESS | 18349 | Cycle 1(1): loaded http://localhost:49600/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49600/tests/dromaeo/cssquery-prototype.html) 09:30:51 INFO - PROCESS | 18349 | RSS: Main: 168865792 09:30:51 INFO - PROCESS | 18349 | 09:33:53 INFO - PROCESS | 18349 | Cycle 1(1): loaded http://localhost:49600/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49600/tests/dromaeo/cssquery-yui.html) 09:33:54 INFO - PROCESS | 18349 | RSS: Main: 171098112 09:33:54 INFO - PROCESS | 18349 | 09:36:56 INFO - PROCESS | 18349 | Cycle 1(1): loaded http://localhost:49600/tests/dromaeo/cssquery-yui.html (next: http://localhost:49600/tests/dromaeo/cssquery-dojo.html) 09:36:57 INFO - PROCESS | 18349 | RSS: Main: 172052480 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - PROCESS | 18349 | __start_tp_report 09:36:57 INFO - PROCESS | 18349 | _x_x_mozilla_page_load 09:36:57 INFO - PROCESS | 18349 | _x_x_mozilla_page_load_details 09:36:57 INFO - PROCESS | 18349 | |i|pagename|runs| 09:36:57 INFO - PROCESS | 18349 | |0;dojo.html;2623.160588611644;2694.6227528146055;2705.5130076586206;2709.254954887406;2722.7685646720015;4669.463011753645;4701.059788042392;4709.740964246969;4785.5214478552125;4832.951670483294;4624.09830083134;4647.163510568096;4648.116857797017;4685.086408150412;4701.623870090384;4334.241507736149;4350.15172041452;4418.491873434548;4461.709988850731;4465.955340446587;4154.273002224613;4440.844570440036;4443.933340999887;4482.10357928414;4484.663650226246;4297.59172878576;4321.049369138785;4336.522982471925;4339.566043395666;4411.536788637179;4329.112531930947;4345.652347812167;4356.564343565649;4358.585934336233;4398.626116780078;4385.649148068179;4388.561143885618;4403.625691816167;4413.271810151321;4444.177827101964;4572.199865023607;4600.539946005406;4634.026854360588;4653.720776753372;4684.180268453007;5020.1214787412055;5059.139946209153;5062.898742025176;5067;5121.359830021247;5049.899002019975;5074.416442109168;5108.64239503235;5138.2806407103035;5157.432682404932;4647.070585882803;4689.10906927686;4696.929546056812;4728.078024785203;4729.006908549174;5194.766235519411;5222.276648705918;5231.973840130775;5236.869078272997;5288.153895376721;4908.165611845995;4950.356453661001;4982.427020892644;4984.90030199394;4987.391705989506;5073.985202959423;5088.389393272831;5097.847064588068;5112.309838171874;5158.690478571298;4944.505549445099;4967.428745694291;4994.22589498621;5035;5051.141305977919;4911.705297682151;4969.229769385751;4974.27872958419;5038.773255203525;5056.241563765465;4161.438205842233;4162.41726158338;4201.075763332062;4239.0885959518855;4252.107057517894;3646.6535679110443;3651.4705367722063;3680.650338217865;3681.8159092045826;3697.9630203698157;4334.393184954109;4340.218760623118;4393.7363758174615;4394.12117576486;4398.208322501916;4928.778204980785;5077;5100.413452452941;5126.231065340229;5135.897282054338;4414.404055452537;4414.668899832525;4416.646668266531;4435.667324950641;4466.0398014427055;4342;4534.36518887356;4534.59188673021;4536.72779633223;4578.65660075489;4763.642726795504;4793.95206047949;4796.112719146969;4815.3258543803195;4840.491748366371;5054.873628159326;5097;5118.334616499831;5119;5166.819161329336;4632.652551058752;4683.648726345469;4819.277108433763;4826;4843.07981483517;4885.218365061573;4893.461719210813;4956.909479914413;4959.082569724613;5011.4487406386;4985.401751789808;5008.899822003613;5013.749312534285;5020.949790502194;5022.84931452057;4813.518648135158;4839.080574690797;4843.757812109451;4864.246041863516;4934.210526315916;4752.287156926489;4905.730184839868;4921.212605983169;4927.039227350776;4954.603631709527;4893.951060489349;4902.436219834622;4911.066897289504;4924.359833221658;4937.9259311109645;4781.330613714153;4938.629602779878;4998.4501704813165;5016.297718319511;5022.74886255693;4863.975680121577;4905.386826646669;4906.313116163668;4908.828191013297;4953.182724850503 09:36:57 INFO - PROCESS | 18349 | |1;ext.html;545.740773132762;600.456586788956;603.8671492271701;616.0728104203175;629.6883042893768;37329;38012;38448.807755961214;38490.422643660364;38625;39442.60557394425;40037.39943900837;40097;40131.79934100333;40203.59796402035;7608.201138880421;7809.921900781004;7815.765527034198;7818.374530037612;7837.843243135162;7588.203238659944;7708.730194443196;7714.652840622158;7727.690892364299;7730.420218483609;7760.650770715331;7820.921790782077;7823.843523129534;7824.960875195616;7825.765227043198;7638.159802421729;7711.15177330496;7725.188855170182;7734.071911370644;7738.303552680286;7659.119201291867;7694.576798276093;7769.805754856117;7771.028621422322;7777.883331750028;29787;36639.450408243894;37165.442518362244;37172.25655486902;37427;2950.2034450698193;2999.145243605584;3122.266267427153;3152.921176970571;3205.294835136266;28863.42273154525;30143;30397.392052158833;31048.689513105033;31423.37153256922;3337.9666203337897;3417.976541929284;3459.135216195951;3460.9307813843584;3482.2861313430685;260001;266594.9999999981;266668;267841;269491;33101.66898330986;34013.149671257925;34126.146846329044;58918.70540647355;59817.40182598205;34939.30121397558;34981.30037399238;35162.82418587942;35243.64756352455;35385.29229415449;12756.298403587705;12883.677908052374;12945.935270323587;12979.935100324437;13009.674758131123;11025.558977640965;11052.226344155832;11117.444127793578;11159.888401116048;11173.329600224013;7983.281504664608;8001.839963200703;8067.959660201662;8105.392095592736;8130.59347032646;3178.666240044808;3192.808431494118;3231.4829627259523;3238.044776790852;3266.281418088017;951.3911096897991;975.1370037516849;979.3095867413457;1002.3534820041178;1018.6587493189717;27444;28199.15402537927;28262.71737282601;28563.857180713963;29684;933.8365785987424;1031.3502493429091;1031.8710161229847;1062.028244156588;1073.5115522437272;14665.92667036658;14674.706505869823;14684.29659766269;14936.775948360782;15084.773728394082;385711;388997;389159;390034;390974;48828.5117148824;49003;49200.50799491959;49243.26135107976;49386.50613493891;1215.604928398274;1245.0102168775663;1251.3242848861512;1256.974860502803;1270.3775150176348;26214;27489.31276718098;27646.44707105887;27824.44351112926;27862;43459.56540434682;43876.780616096716;43943.340849887914;44060;44164.55835441605;348189;348344;350119;350122;350885;25176.622350665122;25535.744642553338;25612.10357637474;25623.615645764956;25724;40975.29356037021;41531.169376611695;42012.3698144522;42411.363829541966;42619.36070959;34118.82940585281;36406.27187456289;36697.63302367049;37037;37134;35796.821015895795;35922.4611630831;35995;36350.63649363472;36449.271014579026;32228.35543289074;35278.118047048;35643;36169.63830361768;36324.818375907955;31318.373632527677;32030;32606.51090233696;32683.50974735333;32758.181045473102;25185.370365741004;25247.74752252454;25446.363840904127;25551.744482554936;25788.35529111787 09:36:57 INFO - PROCESS | 18349 | |2;jquery.html;356.365669108986;357.8139367528885;366.49423795162687;368.4786027770703;374.3617132788592;15547.53357399277;15797.526074217778;16668.416605418814;16701.33194672213;16724.74912876308;15508.689826203468;16735.16324183789;16744.497665070037;16747;16759.66480670386;4202.873913782584;4515.051839113774;4516.751578663188;4529.456465224178;4575.862724118265;4450.1767173073085;4508.752018638974;4547.226971414851;4558.883073646961;4674.883127921812;4636.09596128755;4657.976710116444;4661.137689527432;4667.789949452266;4683.180443422388;4636.698614590041;4646.070785842828;4653.208954477747;4655.837045703401;4761.452432970218;4569.177548041352;4590;4593.150267200579;4596.471405788344;4611.123886461562;19211.51971200717;19456.124474398686;20217.29239476626;20225.595488090305;20276.08757605911;1810.2849374497132;1861.7672790901138;1910.3313840155834;2040.6326861164985;2354.8108205356184;9267.814643707155;9288.489133097677;9296.814063718755;9450.621975120986;9482.525873706287;1758.1824451630052;1797.8112298208762;1809.7104463285812;1810.5021119192195;1850.7131394633852;50405.49594504045;62447.375526244614;63656.36343636551;67615.66192169057;71478;9308.720738377859;9402.247820174369;9730.61077556904;9780.41317520951;9918.851217231748;13461.865381346257;13478;13547.864521354857;13563.050586458854;13584.864151358557;7312.817179570553;7331.5234509757765;7419.85160296791;7499.137599176055;7522.6614802334025;7067;7088.220295767462;7138.857222855514;7188.964055179796;7241.058662373857;4137.1518838638;4153.6677065834665;4157.833686652561;4169.541350451448;4191.098913733562;1767.6111255523765;1769.7079981802858;1799.4781513360979;1807.9819201808077;1874.2487793443556;733.974310899116;824.2169938558394;893.1827377949104;975.5219942228399;983.1397527163732;14579.854201458062;15701.764473532907;15734.449294274646;17474.459906165906;17614;846.8645016797406;852.292597144381;859.1751918158512;911.9224865886474;973.5521660036321;9239.676611318571;9717.708468745948;9729.367591106555;9786.070323319273;9796.804063918682;428989;431606;433075;434076;436391;75727.62136189394;79674;79758;80827.59586202032;81412;915.3729695158837;941.3457646935451;954.0364232125464;961.7403301108661;981.7054883534911;15283.541493755205;15462.458813941457;15540.222988850739;15687.450939217073;16024.038557686576;34654.48018279778;35168.472472912414;36598.8170059148;36935.445968309956;36958.8152059238;44435;46594.76702616465;48896.51103489062;50387.496125038284;51285.230721539956;6778.457723382019;6902.378785909293;6974.766935985084;6980.546264492792;6991.2659170788365;9264.861027084464;9948.900510995087;9999.201182250456;10050;10151.7462063449;8724.69463568772;8775.517346546001;8944.642214311354;8986.68546600866;9101.544922753968;8709.520976346363;8820.735377938672;9167.541622918961;9224.308176886894;9298.674546390845;8441;9074.863877041718;9116.817663646558;9143.268538517035;9155.954220228856;6762.188537375547;6914.965425172842;6984.685689143899;7134.32223938725;7164.820879478055;6959.686814093479;8343.791405214919;8670.869936950825;8953.28373730113;9179.678711245075 09:36:57 INFO - PROCESS | 18349 | |3;mootools.html;1401.23632620222;1447.5367882277671;1532.09606332264;1739.4259894234904;1747.4408189379396;6663.400293973541;7196.244394338598;7232.855342893139;7659.195784442637;7671.808204794876;7368.5210461319975;7491.850162996737;7496;7530.096388433396;7591.5065520741255;2163.2320526213202;2210.248515504728;2211.369759618509;2211.513467037249;2217.2683014605223;2172.6958225848393;2189.2447105748493;2231.9665205021856;2232.8548644338066;2239.3505883293824;2167.2847960173185;2171.554831259596;2172.31572054803;2180.1388451561625;2198;2121.2999710095633;2131.019730923777;2135.028562004292;2138.689889965954;2146.3453646637768;2121.7666056733747;2135.241989093865;2164.2425151197112;2167.1548096242477;2172.750133734625;7528.435367347416;7611.6574754135645;7612.695492180306;7616.276453736941;7626.580538070404;4310.784460776948;4398.69209155356;4414.205443020255;4437.7781110944325;4451.99830038242;2834.957475637867;2879.9136025919256;2930.8094973826633;2935.8091724037868;2964.659064207622;905.6920646979993;959.2469911119738;959.5681943125552;962.0956301076965;978.33473238198;9996.450195239258;10188.235882308782;10195.643152489702;10256.794864102676;10269.537870795832;4069.654079403284;4115.8765237042935;4187.560306167869;4199.265128602482;4229.767362795076;8734.301255899512;8770.780730481789;8812.427192232484;8828.42615230008;8830.55847207637;4561.064981678748;4567.314902764612;4577.473590537064;4577.7482238477205;4577.977110114428;3548.3790336690977;3957.2876882161486;4105.527864295585;4107.753534787922;4153.1070819773895;3586.8923932282073;3639.9636003639625;3739.6821270191795;3775.8867233983024;3806.54321481424;1165.1261553834624;1185.964421067352;1187.8871507206802;1198.8501437320335;1217.0871846115413;621.7233331167587;738.6565247160096;753.9208383119803;845.7251393297203;895.3061377432412;5179.430262671103;5216.66091704038;5290.894182116336;5383.407825139231;5391.029614669319;855.4311382930406;870.8171284030298;885.9025507194203;909.5952301225891;933.6358820060182;3484.285721427101;3516.2967406518796;3545.6099829018785;3641.10792855752;3702.333579955634;9046.773830654287;9277.304202184729;9345.252379809599;9369.765755856022;9387.765305867408;9225.12361325673;9306.255499560155;9326.533673316308;9332.206762425134;9336.486493242937;7070.186928503288;7135.5005149640065;7137.1435427749;7256.274372562807;7260.891086633705;5277.920831187458;5299.390570084335;5324.680519168863;5350.357957045179;5454.836354909359;8642.956785216034;8669.349798764992;8714.782130446789;8754.91245087541;8780.517071561126;8251.876221856797;8658.740237792876;8668.436551624125;8736.519491428033;8807.427517211361;5937.435943585352;5981.312149102909;6135.969320153371;6470.191226096738;6652.268250492345;6950.65246737651;6983.580985140908;7000.964995174992;7020.894686579808;7027.824304392431;6207.286162091417;6249.6562689052535;6318.778842740482;6339.651319177489;6372.426481616677;6082;6212.223472065992;6260.593061450991;6282.465990390868;6373.6175829450385;6017.638941663514;6099.847503812262;6137.079438084323;6140.754369825157;6144.1398204250545;4489.820407183676;4516;4516.254817955132;4543;4557.430321209848;4647.140279048387;4658.045100754405;4661.930071049005;4747.620190384692;4753.548412900769 09:36:57 INFO - PROCESS | 18349 | |4;prototype.html;296.4057065583505;299.7886490024532;302.7910741588304;304.72574682785506;305.15472142166186;4902.0686069646745;4961.454240033593;4991.850244492671;5015.4421245165;5018.222175562789;4853.490383509734;4879.43886453058;4883.975580122104;4889.657723959324;4907.625864757864;3638.399664055434;3658.9085272868124;3801.7718936863876;3805.391137418014;3807.8857634271017;3761.266553022148;3791.374423220165;3798.2213646202463;3809.4857194278693;3818.4845045918864;3767.5871548169434;3778.8110594470304;3780.1494663700723;3787.280416720814;3793.639604237593;3595.658412450813;3794.146317078649;3795.886123416302;3798.582155962842;3804.980975095121;3290.5393244945726;3325.1354647791504;3329.9833500832583;3332.216929021678;3332.516785066152;4754.811297175706;4770.425759499357;4784.708128805203;4786.253017648533;4817.7591120444185;4316.3741257517795;4318.654507639413;4321.762303073329;4322.6325762309925;4332.891677708082;4995.525425084647;5113.258577506278;5123.180291153435;5131.435542090367;5143.408508021551;3515.91210219744;3547.929041419183;3575.3743094958277;3595.2449985503076;3597.748157628941;5308.362996440414;5365.463453654643;5377.623566350318;5385.488378604026;5408.56614523466;3583.7670551414076;3648.616895226016;3675.4854320395166;3677.191017976041;3684.7604905681046;3747.4004159334377;3751.643593858579;3754.9535503150846;3768.6231376862643;3787.753796003306;4245.660347172281;4261.893452663709;4271.572842715704;4278.422412974271;4308.806103725277;5020.196768517093;5174.948250517522;5179.922301165486;5205.412349233445;5231.3199284092825;1278.367208231931;1278.6355888571713;1290.806379043151;1299.909006369564;1303.1659737767836;775.7789030126387;802.8394321135796;802.9839403211903;811.7280710961894;813.8738495533202;4430.269005614037;4524.276115821453;4533.274676051882;4557.316402539579;4563.224251877189;5281.626777037998;5297.523222909879;5336.973315133399;5340.706261155674;5355.410904800468;4460.643148548108;4584.739196720929;4598.252663987663;4603.516630753723;4614.653900957442;2830.165101295123;2859.1422573227946;2866.3980564081776;2868.4653710264906;2868.6844447110802;5076.502431782633;5078.390593128848;5080.399674102646;5089.185730283137;5093.592512598983;5284.260203571503;5390;5393;5456.781728730885;5473.75368108436;5011.5489605935645;5014.6991180529285;5032.79868805251;5039.294498770175;5046.520580544842;5298.947010529845;5307.389650190277;5311.920321195263;5314.256004159343;5366.597505187205;5105.821296254613;5197.22041693749;5200.739963001911;5214.452482489284;5244.213367994831;4915.26271059344;5010.473900240422;5031.169856973705;5054.620903432184;5055.458085284024;3527.435610302442;3614.4578313253223;3620.6741393274733;3646.7994260314877;3660.798656073835;5143.279940808215;5320.255164277081;5335.78656853737;5351.277577526984;5375.489328513785;5154.278401023785;5165.708572856785;5178.352705911761;5181.404138523967;5197.324347834758;5164.664296820694;5175.2312512805465;5180.093483640423;5184.922226166535;5215.191645294985;4808.8797780055775;5086.160783470686;5100.826809833833;5112.846614601568;5128.974355128201;4989.351384320015;5074.340335756328;5206.687598744087;5217.686938783685;5228.947710522846;5092.592592592658;5101.7704203310195;5112.386513618241;5119.846404607868;5122.564582010571 09:36:57 INFO - PROCESS | 18349 | |5;yui.html;601.9518438524918;683.7470136049662;690.0127632418634;690.5580428525741;725.4595326481772;11886.881131188686;11932.284062956207;12214.877851221485;12330.630081097559;12480.251184928888;12226;12329.753404931897;12406.565770198045;12448.937755311234;12473.501059957613;621.2048577820375;766.9578173200472;782.2021538031205;798.2695833312512;798.5168972771477;793.0245797668871;793.3851265269404;801.1027649033091;803.056408719752;805.0379796143611;833.3583140981441;834.6452757578036;834.8789425533294;838.174398217755;838.9203025712578;823.7528741377563;826.3926014379426;829.1294141151767;829.7759604906671;831.2269589281965;605.8969975104243;611.3702886027398;612.0482649480057;612.1429998002787;612.8222815383533;12068.939655301756;12126.090543209295;12142.757144857052;12147.574834880737;12199.207051541622;12351.62945111639;12690.682732931658;12772.105952583323;12935.049877056472;12953.352332383343;9885.209183265322;9978.600855965753;10031.849522257173;10280.845787313196;10450.843237351446;3247.7564182686156;3312.271300313927;3319.153615827948;3341.665833416663;3383.1372999885116;49285.753571231915;49608.255876161886;49669.50330496721;51219;51412.99999999963;10194.643187488402;10293.279470437148;10299.17606591471;10306.433146176882;10443.477826108816;15454.227288635524;18543.258269669062;18584.070796460393;18623.06884655789;18650.626987460175;6557.672116394161;6639.136912201479;6712.194536655633;6864.897026544606;6928.272531384233;3512.7892326460496;3544.592371877267;3550.25444656625;3581.6776490116013;3653.85768239314;2860.6281183446017;2943.9705602943695;2962.3927094945484;2962.511185654386;2968.139239620529;515.8555604430766;539.554867234533;543.6221825831088;544.3930018029947;545.342861851468;497.6566169343142;533.4825219537042;545.4926917966329;580.8199458167896;597.3906615252419;7693.153753087156;7845.137034926153;8021.27808497238;8203.261706446448;8229.218224268685;507.20369020637247;573.1288441568792;605.5034871405493;609.3845216331537;612.0604871522193;3699.5930447650735;3732.346839303111;3756.2111956488898;3765.4728338032696;3936.8622098226424;54871.72564137154;55201.72399138059;55712;56083;56188.71905640527;50416.747916260916;50657.493425066015;50663.24005139926;50743.49256507387;51494.742526287126;45728.77135614301;46848.765756171;47050.76474617605;47450.76274618605;48420.5157948416;7637.159912409519;7703.458067334581;7793.61031948389;7820.413468989735;7912;31335.21661958469;31479.842600787764;31708.84145579257;32454.35091298208;32485.837570811993;38495.615043849204;40826.38760418655;40884.182316354105;41435.7928210357;42242.36636450517;8888.555572221234;9025.548722563713;9034.774130646787;9064.410813297114;9111.134442227978;10402.843957340798;10438.739031524272;10451.163906887583;10510;10562.577496900038;9354.438733676001;9492.145706886413;9518.524073796421;9618;9768.26737994639;9578.329516933747;9599.808003839744;9753.512324383895;9767.365121267096;10118;9362.251019918527;9623.422594644344;9874.061964113398;9926.454045027303;9964.60141594357;8283.37874659415;8351.415400921876;8795.692150774692;9650.227981761302;9672.806543869225;9528.285378596494;9578.808423831624;9602.807943841224;9629.32594718391;9634.951825240829 09:36:57 INFO - PROCESS | 18349 | __end_tp_report 09:36:57 INFO - PROCESS | 18349 | __start_cc_report 09:36:57 INFO - PROCESS | 18349 | _x_x_mozilla_cycle_collect,374 09:36:57 INFO - PROCESS | 18349 | __end_cc_report 09:36:57 INFO - PROCESS | 18349 | __startTimestamp1464626217113__endTimestamp 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - PROCESS | 18349 | ------- Summary: start ------- 09:36:57 INFO - PROCESS | 18349 | Number of tests: 6 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - PROCESS | 18349 | [#0] dojo.html Cycles:165 Average:4672.78 Median:4815.33 stddev:488.13 (10.1%) stddev-sans-first:462.38 09:36:57 INFO - PROCESS | 18349 | Values: 2623.2 2694.6 2705.5 2709.3 2722.8 4669.5 4701.1 4709.7 4785.5 4833.0 4624.1 4647.2 4648.1 4685.1 4701.6 4334.2 4350.2 4418.5 4461.7 4466.0 4154.3 4440.8 4443.9 4482.1 4484.7 4297.6 4321.0 4336.5 4339.6 4411.5 4329.1 4345.7 4356.6 4358.6 4398.6 4385.6 4388.6 4403.6 4413.3 4444.2 4572.2 4600.5 4634.0 4653.7 4684.2 5020.1 5059.1 5062.9 5067.0 5121.4 5049.9 5074.4 5108.6 5138.3 5157.4 4647.1 4689.1 4696.9 4728.1 4729.0 5194.8 5222.3 5232.0 5236.9 5288.2 4908.2 4950.4 4982.4 4984.9 4987.4 5074.0 5088.4 5097.8 5112.3 5158.7 4944.5 4967.4 4994.2 5035.0 5051.1 4911.7 4969.2 4974.3 5038.8 5056.2 4161.4 4162.4 4201.1 4239.1 4252.1 3646.7 3651.5 3680.7 3681.8 3698.0 4334.4 4340.2 4393.7 4394.1 4398.2 4928.8 5077.0 5100.4 5126.2 5135.9 4414.4 4414.7 4416.6 4435.7 4466.0 4342.0 4534.4 4534.6 4536.7 4578.7 4763.6 4794.0 4796.1 4815.3 4840.5 5054.9 5097.0 5118.3 5119.0 5166.8 4632.7 4683.6 4819.3 4826.0 4843.1 4885.2 4893.5 4956.9 4959.1 5011.4 4985.4 5008.9 5013.7 5020.9 5022.8 4813.5 4839.1 4843.8 4864.2 4934.2 4752.3 4905.7 4921.2 4927.0 4954.6 4894.0 4902.4 4911.1 4924.4 4937.9 4781.3 4938.6 4998.5 5016.3 5022.7 4864.0 4905.4 4906.3 4908.8 4953.2 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - PROCESS | 18349 | [#1] ext.html Cycles:180 Average:47463.97 Median:35260.88 stddev:89467.86 (253.7%) stddev-sans-first:89649.49 09:36:57 INFO - PROCESS | 18349 | Values: 545.7 600.5 603.9 616.1 629.7 37329.0 38012.0 38448.8 38490.4 38625.0 39442.6 40037.4 40097.0 40131.8 40203.6 7608.2 7809.9 7815.8 7818.4 7837.8 7588.2 7708.7 7714.7 7727.7 7730.4 7760.7 7820.9 7823.8 7825.0 7825.8 7638.2 7711.2 7725.2 7734.1 7738.3 7659.1 7694.6 7769.8 7771.0 7777.9 29787.0 36639.5 37165.4 37172.3 37427.0 2950.2 2999.1 3122.3 3152.9 3205.3 28863.4 30143.0 30397.4 31048.7 31423.4 3338.0 3418.0 3459.1 3460.9 3482.3 260001.0 266595.0 266668.0 267841.0 269491.0 33101.7 34013.1 34126.1 58918.7 59817.4 34939.3 34981.3 35162.8 35243.6 35385.3 12756.3 12883.7 12945.9 12979.9 13009.7 11025.6 11052.2 11117.4 11159.9 11173.3 7983.3 8001.8 8068.0 8105.4 8130.6 3178.7 3192.8 3231.5 3238.0 3266.3 951.4 975.1 979.3 1002.4 1018.7 27444.0 28199.2 28262.7 28563.9 29684.0 933.8 1031.4 1031.9 1062.0 1073.5 14665.9 14674.7 14684.3 14936.8 15084.8 385711.0 388997.0 389159.0 390034.0 390974.0 48828.5 49003.0 49200.5 49243.3 49386.5 1215.6 1245.0 1251.3 1257.0 1270.4 26214.0 27489.3 27646.4 27824.4 27862.0 43459.6 43876.8 43943.3 44060.0 44164.6 348189.0 348344.0 350119.0 350122.0 350885.0 25176.6 25535.7 25612.1 25623.6 25724.0 40975.3 41531.2 42012.4 42411.4 42619.4 34118.8 36406.3 36697.6 37037.0 37134.0 35796.8 35922.5 35995.0 36350.6 36449.3 32228.4 35278.1 35643.0 36169.6 36324.8 31318.4 32030.0 32606.5 32683.5 32758.2 25185.4 25247.7 25446.4 25551.7 25788.4 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - PROCESS | 18349 | [#2] jquery.html Cycles:180 Average:24888.22 Median:4671.34 stddev:71240.51 (1525.1%) stddev-sans-first:71416.54 09:36:57 INFO - PROCESS | 18349 | Values: 356.4 357.8 366.5 368.5 374.4 15547.5 15797.5 16668.4 16701.3 16724.7 15508.7 16735.2 16744.5 16747.0 16759.7 4202.9 4515.1 4516.8 4529.5 4575.9 4450.2 4508.8 4547.2 4558.9 4674.9 4636.1 4658.0 4661.1 4667.8 4683.2 4636.7 4646.1 4653.2 4655.8 4761.5 4569.2 4590.0 4593.2 4596.5 4611.1 19211.5 19456.1 20217.3 20225.6 20276.1 1810.3 1861.8 1910.3 2040.6 2354.8 9267.8 9288.5 9296.8 9450.6 9482.5 1758.2 1797.8 1809.7 1810.5 1850.7 50405.5 62447.4 63656.4 67615.7 71478.0 9308.7 9402.2 9730.6 9780.4 9918.9 13461.9 13478.0 13547.9 13563.1 13584.9 7312.8 7331.5 7419.9 7499.1 7522.7 7067.0 7088.2 7138.9 7189.0 7241.1 4137.2 4153.7 4157.8 4169.5 4191.1 1767.6 1769.7 1799.5 1808.0 1874.2 734.0 824.2 893.2 975.5 983.1 14579.9 15701.8 15734.4 17474.5 17614.0 846.9 852.3 859.2 911.9 973.6 9239.7 9717.7 9729.4 9786.1 9796.8 428989.0 431606.0 433075.0 434076.0 436391.0 75727.6 79674.0 79758.0 80827.6 81412.0 915.4 941.3 954.0 961.7 981.7 15283.5 15462.5 15540.2 15687.5 16024.0 34654.5 35168.5 36598.8 36935.4 36958.8 44435.0 46594.8 48896.5 50387.5 51285.2 6778.5 6902.4 6974.8 6980.5 6991.3 9264.9 9948.9 9999.2 10050.0 10151.7 8724.7 8775.5 8944.6 8986.7 9101.5 8709.5 8820.7 9167.5 9224.3 9298.7 8441.0 9074.9 9116.8 9143.3 9156.0 6762.2 6915.0 6984.7 7134.3 7164.8 6959.7 8343.8 8670.9 8953.3 9179.7 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - PROCESS | 18349 | [#3] mootools.html Cycles:180 Average:4993.18 Median:5366.88 stddev:2728.58 (50.8%) stddev-sans-first:2722.88 09:36:57 INFO - PROCESS | 18349 | Values: 1401.2 1447.5 1532.1 1739.4 1747.4 6663.4 7196.2 7232.9 7659.2 7671.8 7368.5 7491.9 7496.0 7530.1 7591.5 2163.2 2210.2 2211.4 2211.5 2217.3 2172.7 2189.2 2232.0 2232.9 2239.4 2167.3 2171.6 2172.3 2180.1 2198.0 2121.3 2131.0 2135.0 2138.7 2146.3 2121.8 2135.2 2164.2 2167.2 2172.8 7528.4 7611.7 7612.7 7616.3 7626.6 4310.8 4398.7 4414.2 4437.8 4452.0 2835.0 2879.9 2930.8 2935.8 2964.7 905.7 959.2 959.6 962.1 978.3 9996.5 10188.2 10195.6 10256.8 10269.5 4069.7 4115.9 4187.6 4199.3 4229.8 8734.3 8770.8 8812.4 8828.4 8830.6 4561.1 4567.3 4577.5 4577.7 4578.0 3548.4 3957.3 4105.5 4107.8 4153.1 3586.9 3640.0 3739.7 3775.9 3806.5 1165.1 1186.0 1187.9 1198.9 1217.1 621.7 738.7 753.9 845.7 895.3 5179.4 5216.7 5290.9 5383.4 5391.0 855.4 870.8 885.9 909.6 933.6 3484.3 3516.3 3545.6 3641.1 3702.3 9046.8 9277.3 9345.3 9369.8 9387.8 9225.1 9306.3 9326.5 9332.2 9336.5 7070.2 7135.5 7137.1 7256.3 7260.9 5277.9 5299.4 5324.7 5350.4 5454.8 8643.0 8669.3 8714.8 8754.9 8780.5 8251.9 8658.7 8668.4 8736.5 8807.4 5937.4 5981.3 6136.0 6470.2 6652.3 6950.7 6983.6 7001.0 7020.9 7027.8 6207.3 6249.7 6318.8 6339.7 6372.4 6082.0 6212.2 6260.6 6282.5 6373.6 6017.6 6099.8 6137.1 6140.8 6144.1 4489.8 4516.0 4516.3 4543.0 4557.4 4647.1 4658.0 4661.9 4747.6 4753.5 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - PROCESS | 18349 | [#4] prototype.html Cycles:180 Average:4265.00 Median:4904.85 stddev:1263.05 (25.8%) stddev-sans-first:1230.97 09:36:57 INFO - PROCESS | 18349 | Values: 296.4 299.8 302.8 304.7 305.2 4902.1 4961.5 4991.9 5015.4 5018.2 4853.5 4879.4 4884.0 4889.7 4907.6 3638.4 3658.9 3801.8 3805.4 3807.9 3761.3 3791.4 3798.2 3809.5 3818.5 3767.6 3778.8 3780.1 3787.3 3793.6 3595.7 3794.1 3795.9 3798.6 3805.0 3290.5 3325.1 3330.0 3332.2 3332.5 4754.8 4770.4 4784.7 4786.3 4817.8 4316.4 4318.7 4321.8 4322.6 4332.9 4995.5 5113.3 5123.2 5131.4 5143.4 3515.9 3547.9 3575.4 3595.2 3597.7 5308.4 5365.5 5377.6 5385.5 5408.6 3583.8 3648.6 3675.5 3677.2 3684.8 3747.4 3751.6 3755.0 3768.6 3787.8 4245.7 4261.9 4271.6 4278.4 4308.8 5020.2 5174.9 5179.9 5205.4 5231.3 1278.4 1278.6 1290.8 1299.9 1303.2 775.8 802.8 803.0 811.7 813.9 4430.3 4524.3 4533.3 4557.3 4563.2 5281.6 5297.5 5337.0 5340.7 5355.4 4460.6 4584.7 4598.3 4603.5 4614.7 2830.2 2859.1 2866.4 2868.5 2868.7 5076.5 5078.4 5080.4 5089.2 5093.6 5284.3 5390.0 5393.0 5456.8 5473.8 5011.5 5014.7 5032.8 5039.3 5046.5 5298.9 5307.4 5311.9 5314.3 5366.6 5105.8 5197.2 5200.7 5214.5 5244.2 4915.3 5010.5 5031.2 5054.6 5055.5 3527.4 3614.5 3620.7 3646.8 3660.8 5143.3 5320.3 5335.8 5351.3 5375.5 5154.3 5165.7 5178.4 5181.4 5197.3 5164.7 5175.2 5180.1 5184.9 5215.2 4808.9 5086.2 5100.8 5112.8 5129.0 4989.4 5074.3 5206.7 5217.7 5228.9 5092.6 5101.8 5112.4 5119.8 5122.6 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - PROCESS | 18349 | [#5] yui.html Cycles:180 Average:13156.81 Median:544.87 stddev:15747.54 (2890.2%) stddev-sans-first:15763.49 09:36:57 INFO - PROCESS | 18349 | Values: 602.0 683.7 690.0 690.6 725.5 11886.9 11932.3 12214.9 12330.6 12480.3 12226.0 12329.8 12406.6 12448.9 12473.5 621.2 767.0 782.2 798.3 798.5 793.0 793.4 801.1 803.1 805.0 833.4 834.6 834.9 838.2 838.9 823.8 826.4 829.1 829.8 831.2 605.9 611.4 612.0 612.1 612.8 12068.9 12126.1 12142.8 12147.6 12199.2 12351.6 12690.7 12772.1 12935.0 12953.4 9885.2 9978.6 10031.8 10280.8 10450.8 3247.8 3312.3 3319.2 3341.7 3383.1 49285.8 49608.3 49669.5 51219.0 51413.0 10194.6 10293.3 10299.2 10306.4 10443.5 15454.2 18543.3 18584.1 18623.1 18650.6 6557.7 6639.1 6712.2 6864.9 6928.3 3512.8 3544.6 3550.3 3581.7 3653.9 2860.6 2944.0 2962.4 2962.5 2968.1 515.9 539.6 543.6 544.4 545.3 497.7 533.5 545.5 580.8 597.4 7693.2 7845.1 8021.3 8203.3 8229.2 507.2 573.1 605.5 609.4 612.1 3699.6 3732.3 3756.2 3765.5 3936.9 54871.7 55201.7 55712.0 56083.0 56188.7 50416.7 50657.5 50663.2 50743.5 51494.7 45728.8 46848.8 47050.8 47450.8 48420.5 7637.2 7703.5 7793.6 7820.4 7912.0 31335.2 31479.8 31708.8 32454.4 32485.8 38495.6 40826.4 40884.2 41435.8 42242.4 8888.6 9025.5 9034.8 9064.4 9111.1 10402.8 10438.7 10451.2 10510.0 10562.6 9354.4 9492.1 9518.5 9618.0 9768.3 9578.3 9599.8 9753.5 9767.4 10118.0 9362.3 9623.4 9874.1 9926.5 9964.6 8283.4 8351.4 8795.7 9650.2 9672.8 9528.3 9578.8 9602.8 9629.3 9635.0 09:36:57 INFO - PROCESS | 18349 | -------- Summary: end -------- 09:36:57 INFO - PROCESS | 18349 | 09:36:57 INFO - TEST-INFO | 18349: exit 0 09:36:57 INFO - TEST-OK | dromaeo_css | took 1115036ms 09:36:57 INFO - TEST-START | kraken 09:36:57 INFO - operating with platform_type : linux_ 09:36:57 INFO - Initialising browser for kraken test... 09:36:57 INFO - TEST-INFO | started process 18582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC8F4Re/profile http://localhost:49600/getInfo.html) 09:37:02 INFO - PROCESS | 18582 | __metrics Screen width/height:1600/1200 09:37:02 INFO - PROCESS | 18582 | colorDepth:24 09:37:02 INFO - PROCESS | 18582 | Browser inner width/height: 1024/697 09:37:02 INFO - PROCESS | 18582 | __metrics 09:37:03 ERROR - PROCESS | 18582 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:37:04 INFO - TEST-INFO | 18582: exit 0 09:37:04 INFO - Browser initialized. 09:37:04 INFO - Running cycle 1/1 for kraken test... 09:37:04 INFO - TEST-INFO | started process 18703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC8F4Re/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:16 INFO - PROCESS | 18703 | RSS: Main: 168034304 09:37:16 INFO - PROCESS | 18703 | 09:37:18 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49600/tests/kraken/driver.html?testName=audio-beat-detection) 09:37:19 INFO - PROCESS | 18703 | RSS: Main: 172486656 09:37:19 INFO - PROCESS | 18703 | 09:37:22 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49600/tests/kraken/driver.html?testName=audio-dft) 09:37:23 INFO - PROCESS | 18703 | RSS: Main: 171945984 09:37:23 INFO - PROCESS | 18703 | 09:37:26 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49600/tests/kraken/driver.html?testName=audio-fft) 09:37:26 INFO - PROCESS | 18703 | RSS: Main: 168169472 09:37:26 INFO - PROCESS | 18703 | 09:37:28 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49600/tests/kraken/driver.html?testName=audio-oscillator) 09:37:29 INFO - PROCESS | 18703 | RSS: Main: 168562688 09:37:29 INFO - PROCESS | 18703 | 09:37:31 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49600/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:37:32 INFO - PROCESS | 18703 | RSS: Main: 169021440 09:37:32 INFO - PROCESS | 18703 | 09:37:35 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49600/tests/kraken/driver.html?testName=imaging-darkroom) 09:37:36 INFO - PROCESS | 18703 | RSS: Main: 169287680 09:37:36 INFO - PROCESS | 18703 | 09:37:39 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49600/tests/kraken/driver.html?testName=imaging-desaturate) 09:37:40 INFO - PROCESS | 18703 | RSS: Main: 167157760 09:37:40 INFO - PROCESS | 18703 | 09:37:43 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49600/tests/kraken/driver.html?testName=json-parse-financial) 09:37:44 INFO - PROCESS | 18703 | RSS: Main: 167612416 09:37:44 INFO - PROCESS | 18703 | 09:37:45 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49600/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:46 INFO - PROCESS | 18703 | RSS: Main: 168214528 09:37:46 INFO - PROCESS | 18703 | 09:37:48 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49600/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:48 INFO - PROCESS | 18703 | RSS: Main: 168198144 09:37:48 INFO - PROCESS | 18703 | 09:37:51 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49600/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:51 INFO - PROCESS | 18703 | RSS: Main: 168759296 09:37:51 INFO - PROCESS | 18703 | 09:37:54 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:55 INFO - PROCESS | 18703 | RSS: Main: 168861696 09:37:55 INFO - PROCESS | 18703 | 09:37:58 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:37:58 INFO - PROCESS | 18703 | RSS: Main: 168796160 09:37:58 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | Cycle 1(1): loaded http://localhost:49600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49600/tests/kraken/driver.html?testName=ai-astar) 09:38:00 INFO - PROCESS | 18703 | RSS: Main: 169553920 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | __start_tp_report 09:38:00 INFO - PROCESS | 18703 | _x_x_mozilla_page_load 09:38:00 INFO - PROCESS | 18703 | _x_x_mozilla_page_load_details 09:38:00 INFO - PROCESS | 18703 | |i|pagename|runs| 09:38:00 INFO - PROCESS | 18703 | |0;ai-astar;117;110;116;113;114;113;114;116;114;117 09:38:00 INFO - PROCESS | 18703 | |1;audio-beat-detection;171;130;152;181;130;162;160;134;193;128 09:38:00 INFO - PROCESS | 18703 | |2;audio-dft;163;163;165;176;164;163;165;163;162;163 09:38:00 INFO - PROCESS | 18703 | |3;audio-fft;76;75;76;164;78;77;75;75;163;77 09:38:00 INFO - PROCESS | 18703 | |4;audio-oscillator;84;87;146;84;84;84;133;85;84;137 09:38:00 INFO - PROCESS | 18703 | |5;imaging-gaussian-blur;117;118;117;118;117;118;120;118;117;119 09:38:00 INFO - PROCESS | 18703 | |6;imaging-darkroom;147;149;147;148;148;148;147;148;148;148 09:38:00 INFO - PROCESS | 18703 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;95 09:38:00 INFO - PROCESS | 18703 | |8;json-parse-financial;64;65;63;63;66;64;70;62;63;62 09:38:00 INFO - PROCESS | 18703 | |9;json-stringify-tinderbox;65;65;65;66;67;66;65;65;67;66 09:38:00 INFO - PROCESS | 18703 | |10;stanford-crypto-aes;82;84;82;85;90;84;86;90;109;85 09:38:00 INFO - PROCESS | 18703 | |11;stanford-crypto-ccm;133;144;147;133;137;149;131;136;155;152 09:38:00 INFO - PROCESS | 18703 | |12;stanford-crypto-pbkdf2;173;173;173;180;173;170;175;175;171;173 09:38:00 INFO - PROCESS | 18703 | |13;stanford-crypto-sha256-iterative;66;68;67;67;68;66;67;67;70;66 09:38:00 INFO - PROCESS | 18703 | __end_tp_report 09:38:00 INFO - PROCESS | 18703 | __start_cc_report 09:38:00 INFO - PROCESS | 18703 | _x_x_mozilla_cycle_collect,937 09:38:00 INFO - PROCESS | 18703 | __end_cc_report 09:38:00 INFO - PROCESS | 18703 | __startTimestamp1464626280863__endTimestamp 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | ------- Summary: start ------- 09:38:00 INFO - PROCESS | 18703 | Number of tests: 14 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.17 (1.9%) stddev-sans-first:2.09 09:38:00 INFO - PROCESS | 18703 | Values: 117.0 110.0 116.0 113.0 114.0 113.0 114.0 116.0 114.0 117.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:161.00 stddev:23.26 (14.4%) stddev-sans-first:23.86 09:38:00 INFO - PROCESS | 18703 | Values: 171.0 130.0 152.0 181.0 130.0 162.0 160.0 134.0 193.0 128.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:4.08 (2.5%) stddev-sans-first:4.28 09:38:00 INFO - PROCESS | 18703 | Values: 163.0 163.0 165.0 176.0 164.0 163.0 165.0 163.0 162.0 163.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:36.85 (48.5%) stddev-sans-first:38.54 09:38:00 INFO - PROCESS | 18703 | Values: 76.0 75.0 76.0 164.0 78.0 77.0 75.0 75.0 163.0 77.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:84.00 stddev:26.33 (31.4%) stddev-sans-first:27.22 09:38:00 INFO - PROCESS | 18703 | Values: 84.0 87.0 146.0 84.0 84.0 84.0 133.0 85.0 84.0 137.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 09:38:00 INFO - PROCESS | 18703 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 120.0 118.0 117.0 119.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 09:38:00 INFO - PROCESS | 18703 | Values: 147.0 149.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 148.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:38:00 INFO - PROCESS | 18703 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:2.39 (3.7%) stddev-sans-first:2.54 09:38:00 INFO - PROCESS | 18703 | Values: 64.0 65.0 63.0 63.0 66.0 64.0 70.0 62.0 63.0 62.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 09:38:00 INFO - PROCESS | 18703 | Values: 65.0 65.0 65.0 66.0 67.0 66.0 65.0 65.0 67.0 66.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:85.00 stddev:7.99 (9.4%) stddev-sans-first:8.20 09:38:00 INFO - PROCESS | 18703 | Values: 82.0 84.0 82.0 85.0 90.0 84.0 86.0 90.0 109.0 85.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:145.50 stddev:8.76 (6.0%) stddev-sans-first:8.70 09:38:00 INFO - PROCESS | 18703 | Values: 133.0 144.0 147.0 133.0 137.0 149.0 131.0 136.0 155.0 152.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.00 stddev:2.72 (1.6%) stddev-sans-first:2.87 09:38:00 INFO - PROCESS | 18703 | Values: 173.0 173.0 173.0 180.0 173.0 170.0 175.0 175.0 171.0 173.0 09:38:00 INFO - PROCESS | 18703 | 09:38:00 INFO - PROCESS | 18703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 09:38:00 INFO - PROCESS | 18703 | Values: 66.0 68.0 67.0 67.0 68.0 66.0 67.0 67.0 70.0 66.0 09:38:00 INFO - PROCESS | 18703 | -------- Summary: end -------- 09:38:00 INFO - PROCESS | 18703 | 09:38:01 INFO - TEST-INFO | 18703: exit 0 09:38:02 INFO - TEST-OK | kraken | took 64140ms 09:38:02 INFO - SUITE-END | took 1179s 09:38:02 INFO - Completed test suite (00:19:39) 09:38:02 INFO - javascript benchmark 09:38:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6172.438510367575, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.160588611644, 2694.6227528146055, 2705.5130076586206, 2709.254954887406, 2722.7685646720015, 4669.463011753645, 4701.059788042392, 4709.740964246969, 4785.5214478552125, 4832.951670483294, 4624.09830083134, 4647.163510568096, 4648.116857797017, 4685.086408150412, 4701.623870090384, 4334.241507736149, 4350.15172041452, 4418.491873434548, 4461.709988850731, 4465.955340446587, 4154.273002224613, 4440.844570440036, 4443.933340999887, 4482.10357928414, 4484.663650226246, 4297.59172878576, 4321.049369138785, 4336.522982471925, 4339.566043395666, 4411.536788637179, 4329.112531930947, 4345.652347812167, 4356.564343565649, 4358.585934336233, 4398.626116780078, 4385.649148068179, 4388.561143885618, 4403.625691816167, 4413.271810151321, 4444.177827101964, 4572.199865023607, 4600.539946005406, 4634.026854360588, 4653.720776753372, 4684.180268453007, 5020.1214787412055, 5059.139946209153, 5062.898742025176, 5067.0, 5121.359830021247, 5049.899002019975, 5074.416442109168, 5108.64239503235, 5138.2806407103035, 5157.432682404932, 4647.070585882803, 4689.10906927686, 4696.929546056812, 4728.078024785203, 4729.006908549174, 5194.766235519411, 5222.276648705918, 5231.973840130775, 5236.869078272997, 5288.153895376721, 4908.165611845995, 4950.356453661001, 4982.427020892644, 4984.90030199394, 4987.391705989506, 5073.985202959423, 5088.389393272831, 5097.847064588068, 5112.309838171874, 5158.690478571298, 4944.505549445099, 4967.428745694291, 4994.22589498621, 5035.0, 5051.141305977919, 4911.705297682151, 4969.229769385751, 4974.27872958419, 5038.773255203525, 5056.241563765465, 4161.438205842233, 4162.41726158338, 4201.075763332062, 4239.0885959518855, 4252.107057517894, 3646.6535679110443, 3651.4705367722063, 3680.650338217865, 3681.8159092045826, 3697.9630203698157, 4334.393184954109, 4340.218760623118, 4393.7363758174615, 4394.12117576486, 4398.208322501916, 4928.778204980785, 5077.0, 5100.413452452941, 5126.231065340229, 5135.897282054338, 4414.404055452537, 4414.668899832525, 4416.646668266531, 4435.667324950641, 4466.0398014427055, 4342.0, 4534.36518887356, 4534.59188673021, 4536.72779633223, 4578.65660075489, 4763.642726795504, 4793.95206047949, 4796.112719146969, 4815.3258543803195, 4840.491748366371, 5054.873628159326, 5097.0, 5118.334616499831, 5119.0, 5166.819161329336, 4632.652551058752, 4683.648726345469, 4819.277108433763, 4826.0, 4843.07981483517, 4885.218365061573, 4893.461719210813, 4956.909479914413, 4959.082569724613, 5011.4487406386, 4985.401751789808, 5008.899822003613, 5013.749312534285, 5020.949790502194, 5022.84931452057, 4813.518648135158, 4839.080574690797, 4843.757812109451, 4864.246041863516, 4934.210526315916, 4752.287156926489, 4905.730184839868, 4921.212605983169, 4927.039227350776, 4954.603631709527, 4893.951060489349, 4902.436219834622, 4911.066897289504, 4924.359833221658, 4937.9259311109645, 4781.330613714153, 4938.629602779878, 4998.4501704813165, 5016.297718319511, 5022.74886255693, 4863.975680121577, 4905.386826646669, 4906.313116163668, 4908.828191013297, 4953.182724850503], "value": 4642.102173206189, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.740773132762, 600.456586788956, 603.8671492271701, 616.0728104203175, 629.6883042893768, 37329.0, 38012.0, 38448.807755961214, 38490.422643660364, 38625.0, 39442.60557394425, 40037.39943900837, 40097.0, 40131.79934100333, 40203.59796402035, 7608.201138880421, 7809.921900781004, 7815.765527034198, 7818.374530037612, 7837.843243135162, 7588.203238659944, 7708.730194443196, 7714.652840622158, 7727.690892364299, 7730.420218483609, 7760.650770715331, 7820.921790782077, 7823.843523129534, 7824.960875195616, 7825.765227043198, 7638.159802421729, 7711.15177330496, 7725.188855170182, 7734.071911370644, 7738.303552680286, 7659.119201291867, 7694.576798276093, 7769.805754856117, 7771.028621422322, 7777.883331750028, 29787.0, 36639.450408243894, 37165.442518362244, 37172.25655486902, 37427.0, 2950.2034450698193, 2999.145243605584, 3122.266267427153, 3152.921176970571, 3205.294835136266, 28863.42273154525, 30143.0, 30397.392052158833, 31048.689513105033, 31423.37153256922, 3337.9666203337897, 3417.976541929284, 3459.135216195951, 3460.9307813843584, 3482.2861313430685, 260001.0, 266594.9999999981, 266668.0, 267841.0, 269491.0, 33101.66898330986, 34013.149671257925, 34126.146846329044, 58918.70540647355, 59817.40182598205, 34939.30121397558, 34981.30037399238, 35162.82418587942, 35243.64756352455, 35385.29229415449, 12756.298403587705, 12883.677908052374, 12945.935270323587, 12979.935100324437, 13009.674758131123, 11025.558977640965, 11052.226344155832, 11117.444127793578, 11159.888401116048, 11173.329600224013, 7983.281504664608, 8001.839963200703, 8067.959660201662, 8105.392095592736, 8130.59347032646, 3178.666240044808, 3192.808431494118, 3231.4829627259523, 3238.044776790852, 3266.281418088017, 951.3911096897991, 975.1370037516849, 979.3095867413457, 1002.3534820041178, 1018.6587493189717, 27444.0, 28199.15402537927, 28262.71737282601, 28563.857180713963, 29684.0, 933.8365785987424, 1031.3502493429091, 1031.8710161229847, 1062.028244156588, 1073.5115522437272, 14665.92667036658, 14674.706505869823, 14684.29659766269, 14936.775948360782, 15084.773728394082, 385711.0, 388997.0, 389159.0, 390034.0, 390974.0, 48828.5117148824, 49003.0, 49200.50799491959, 49243.26135107976, 49386.50613493891, 1215.604928398274, 1245.0102168775663, 1251.3242848861512, 1256.974860502803, 1270.3775150176348, 26214.0, 27489.31276718098, 27646.44707105887, 27824.44351112926, 27862.0, 43459.56540434682, 43876.780616096716, 43943.340849887914, 44060.0, 44164.55835441605, 348189.0, 348344.0, 350119.0, 350122.0, 350885.0, 25176.622350665122, 25535.744642553338, 25612.10357637474, 25623.615645764956, 25724.0, 40975.29356037021, 41531.169376611695, 42012.3698144522, 42411.363829541966, 42619.36070959, 34118.82940585281, 36406.27187456289, 36697.63302367049, 37037.0, 37134.0, 35796.821015895795, 35922.4611630831, 35995.0, 36350.63649363472, 36449.271014579026, 32228.35543289074, 35278.118047048, 35643.0, 36169.63830361768, 36324.818375907955, 31318.373632527677, 32030.0, 32606.51090233696, 32683.50974735333, 32758.181045473102, 25185.370365741004, 25247.74752252454, 25446.363840904127, 25551.744482554936, 25788.35529111787], "value": 16564.517438341856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.365669108986, 357.8139367528885, 366.49423795162687, 368.4786027770703, 374.3617132788592, 15547.53357399277, 15797.526074217778, 16668.416605418814, 16701.33194672213, 16724.74912876308, 15508.689826203468, 16735.16324183789, 16744.497665070037, 16747.0, 16759.66480670386, 4202.873913782584, 4515.051839113774, 4516.751578663188, 4529.456465224178, 4575.862724118265, 4450.1767173073085, 4508.752018638974, 4547.226971414851, 4558.883073646961, 4674.883127921812, 4636.09596128755, 4657.976710116444, 4661.137689527432, 4667.789949452266, 4683.180443422388, 4636.698614590041, 4646.070785842828, 4653.208954477747, 4655.837045703401, 4761.452432970218, 4569.177548041352, 4590.0, 4593.150267200579, 4596.471405788344, 4611.123886461562, 19211.51971200717, 19456.124474398686, 20217.29239476626, 20225.595488090305, 20276.08757605911, 1810.2849374497132, 1861.7672790901138, 1910.3313840155834, 2040.6326861164985, 2354.8108205356184, 9267.814643707155, 9288.489133097677, 9296.814063718755, 9450.621975120986, 9482.525873706287, 1758.1824451630052, 1797.8112298208762, 1809.7104463285812, 1810.5021119192195, 1850.7131394633852, 50405.49594504045, 62447.375526244614, 63656.36343636551, 67615.66192169057, 71478.0, 9308.720738377859, 9402.247820174369, 9730.61077556904, 9780.41317520951, 9918.851217231748, 13461.865381346257, 13478.0, 13547.864521354857, 13563.050586458854, 13584.864151358557, 7312.817179570553, 7331.5234509757765, 7419.85160296791, 7499.137599176055, 7522.6614802334025, 7067.0, 7088.220295767462, 7138.857222855514, 7188.964055179796, 7241.058662373857, 4137.1518838638, 4153.6677065834665, 4157.833686652561, 4169.541350451448, 4191.098913733562, 1767.6111255523765, 1769.7079981802858, 1799.4781513360979, 1807.9819201808077, 1874.2487793443556, 733.974310899116, 824.2169938558394, 893.1827377949104, 975.5219942228399, 983.1397527163732, 14579.854201458062, 15701.764473532907, 15734.449294274646, 17474.459906165906, 17614.0, 846.8645016797406, 852.292597144381, 859.1751918158512, 911.9224865886474, 973.5521660036321, 9239.676611318571, 9717.708468745948, 9729.367591106555, 9786.070323319273, 9796.804063918682, 428989.0, 431606.0, 433075.0, 434076.0, 436391.0, 75727.62136189394, 79674.0, 79758.0, 80827.59586202032, 81412.0, 915.3729695158837, 941.3457646935451, 954.0364232125464, 961.7403301108661, 981.7054883534911, 15283.541493755205, 15462.458813941457, 15540.222988850739, 15687.450939217073, 16024.038557686576, 34654.48018279778, 35168.472472912414, 36598.8170059148, 36935.445968309956, 36958.8152059238, 44435.0, 46594.76702616465, 48896.51103489062, 50387.496125038284, 51285.230721539956, 6778.457723382019, 6902.378785909293, 6974.766935985084, 6980.546264492792, 6991.2659170788365, 9264.861027084464, 9948.900510995087, 9999.201182250456, 10050.0, 10151.7462063449, 8724.69463568772, 8775.517346546001, 8944.642214311354, 8986.68546600866, 9101.544922753968, 8709.520976346363, 8820.735377938672, 9167.541622918961, 9224.308176886894, 9298.674546390845, 8441.0, 9074.863877041718, 9116.817663646558, 9143.268538517035, 9155.954220228856, 6762.188537375547, 6914.965425172842, 6984.685689143899, 7134.32223938725, 7164.820879478055, 6959.686814093479, 8343.791405214919, 8670.869936950825, 8953.28373730113, 9179.678711245075], "value": 7815.069934359986, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.23632620222, 1447.5367882277671, 1532.09606332264, 1739.4259894234904, 1747.4408189379396, 6663.400293973541, 7196.244394338598, 7232.855342893139, 7659.195784442637, 7671.808204794876, 7368.5210461319975, 7491.850162996737, 7496.0, 7530.096388433396, 7591.5065520741255, 2163.2320526213202, 2210.248515504728, 2211.369759618509, 2211.513467037249, 2217.2683014605223, 2172.6958225848393, 2189.2447105748493, 2231.9665205021856, 2232.8548644338066, 2239.3505883293824, 2167.2847960173185, 2171.554831259596, 2172.31572054803, 2180.1388451561625, 2198.0, 2121.2999710095633, 2131.019730923777, 2135.028562004292, 2138.689889965954, 2146.3453646637768, 2121.7666056733747, 2135.241989093865, 2164.2425151197112, 2167.1548096242477, 2172.750133734625, 7528.435367347416, 7611.6574754135645, 7612.695492180306, 7616.276453736941, 7626.580538070404, 4310.784460776948, 4398.69209155356, 4414.205443020255, 4437.7781110944325, 4451.99830038242, 2834.957475637867, 2879.9136025919256, 2930.8094973826633, 2935.8091724037868, 2964.659064207622, 905.6920646979993, 959.2469911119738, 959.5681943125552, 962.0956301076965, 978.33473238198, 9996.450195239258, 10188.235882308782, 10195.643152489702, 10256.794864102676, 10269.537870795832, 4069.654079403284, 4115.8765237042935, 4187.560306167869, 4199.265128602482, 4229.767362795076, 8734.301255899512, 8770.780730481789, 8812.427192232484, 8828.42615230008, 8830.55847207637, 4561.064981678748, 4567.314902764612, 4577.473590537064, 4577.7482238477205, 4577.977110114428, 3548.3790336690977, 3957.2876882161486, 4105.527864295585, 4107.753534787922, 4153.1070819773895, 3586.8923932282073, 3639.9636003639625, 3739.6821270191795, 3775.8867233983024, 3806.54321481424, 1165.1261553834624, 1185.964421067352, 1187.8871507206802, 1198.8501437320335, 1217.0871846115413, 621.7233331167587, 738.6565247160096, 753.9208383119803, 845.7251393297203, 895.3061377432412, 5179.430262671103, 5216.66091704038, 5290.894182116336, 5383.407825139231, 5391.029614669319, 855.4311382930406, 870.8171284030298, 885.9025507194203, 909.5952301225891, 933.6358820060182, 3484.285721427101, 3516.2967406518796, 3545.6099829018785, 3641.10792855752, 3702.333579955634, 9046.773830654287, 9277.304202184729, 9345.252379809599, 9369.765755856022, 9387.765305867408, 9225.12361325673, 9306.255499560155, 9326.533673316308, 9332.206762425134, 9336.486493242937, 7070.186928503288, 7135.5005149640065, 7137.1435427749, 7256.274372562807, 7260.891086633705, 5277.920831187458, 5299.390570084335, 5324.680519168863, 5350.357957045179, 5454.836354909359, 8642.956785216034, 8669.349798764992, 8714.782130446789, 8754.91245087541, 8780.517071561126, 8251.876221856797, 8658.740237792876, 8668.436551624125, 8736.519491428033, 8807.427517211361, 5937.435943585352, 5981.312149102909, 6135.969320153371, 6470.191226096738, 6652.268250492345, 6950.65246737651, 6983.580985140908, 7000.964995174992, 7020.894686579808, 7027.824304392431, 6207.286162091417, 6249.6562689052535, 6318.778842740482, 6339.651319177489, 6372.426481616677, 6082.0, 6212.223472065992, 6260.593061450991, 6282.465990390868, 6373.6175829450385, 6017.638941663514, 6099.847503812262, 6137.079438084323, 6140.754369825157, 6144.1398204250545, 4489.820407183676, 4516.0, 4516.254817955132, 4543.0, 4557.430321209848, 4647.140279048387, 4658.045100754405, 4661.930071049005, 4747.620190384692, 4753.548412900769], "value": 4064.4446916530906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.4057065583505, 299.7886490024532, 302.7910741588304, 304.72574682785506, 305.15472142166186, 4902.0686069646745, 4961.454240033593, 4991.850244492671, 5015.4421245165, 5018.222175562789, 4853.490383509734, 4879.43886453058, 4883.975580122104, 4889.657723959324, 4907.625864757864, 3638.399664055434, 3658.9085272868124, 3801.7718936863876, 3805.391137418014, 3807.8857634271017, 3761.266553022148, 3791.374423220165, 3798.2213646202463, 3809.4857194278693, 3818.4845045918864, 3767.5871548169434, 3778.8110594470304, 3780.1494663700723, 3787.280416720814, 3793.639604237593, 3595.658412450813, 3794.146317078649, 3795.886123416302, 3798.582155962842, 3804.980975095121, 3290.5393244945726, 3325.1354647791504, 3329.9833500832583, 3332.216929021678, 3332.516785066152, 4754.811297175706, 4770.425759499357, 4784.708128805203, 4786.253017648533, 4817.7591120444185, 4316.3741257517795, 4318.654507639413, 4321.762303073329, 4322.6325762309925, 4332.891677708082, 4995.525425084647, 5113.258577506278, 5123.180291153435, 5131.435542090367, 5143.408508021551, 3515.91210219744, 3547.929041419183, 3575.3743094958277, 3595.2449985503076, 3597.748157628941, 5308.362996440414, 5365.463453654643, 5377.623566350318, 5385.488378604026, 5408.56614523466, 3583.7670551414076, 3648.616895226016, 3675.4854320395166, 3677.191017976041, 3684.7604905681046, 3747.4004159334377, 3751.643593858579, 3754.9535503150846, 3768.6231376862643, 3787.753796003306, 4245.660347172281, 4261.893452663709, 4271.572842715704, 4278.422412974271, 4308.806103725277, 5020.196768517093, 5174.948250517522, 5179.922301165486, 5205.412349233445, 5231.3199284092825, 1278.367208231931, 1278.6355888571713, 1290.806379043151, 1299.909006369564, 1303.1659737767836, 775.7789030126387, 802.8394321135796, 802.9839403211903, 811.7280710961894, 813.8738495533202, 4430.269005614037, 4524.276115821453, 4533.274676051882, 4557.316402539579, 4563.224251877189, 5281.626777037998, 5297.523222909879, 5336.973315133399, 5340.706261155674, 5355.410904800468, 4460.643148548108, 4584.739196720929, 4598.252663987663, 4603.516630753723, 4614.653900957442, 2830.165101295123, 2859.1422573227946, 2866.3980564081776, 2868.4653710264906, 2868.6844447110802, 5076.502431782633, 5078.390593128848, 5080.399674102646, 5089.185730283137, 5093.592512598983, 5284.260203571503, 5390.0, 5393.0, 5456.781728730885, 5473.75368108436, 5011.5489605935645, 5014.6991180529285, 5032.79868805251, 5039.294498770175, 5046.520580544842, 5298.947010529845, 5307.389650190277, 5311.920321195263, 5314.256004159343, 5366.597505187205, 5105.821296254613, 5197.22041693749, 5200.739963001911, 5214.452482489284, 5244.213367994831, 4915.26271059344, 5010.473900240422, 5031.169856973705, 5054.620903432184, 5055.458085284024, 3527.435610302442, 3614.4578313253223, 3620.6741393274733, 3646.7994260314877, 3660.798656073835, 5143.279940808215, 5320.255164277081, 5335.78656853737, 5351.277577526984, 5375.489328513785, 5154.278401023785, 5165.708572856785, 5178.352705911761, 5181.404138523967, 5197.324347834758, 5164.664296820694, 5175.2312512805465, 5180.093483640423, 5184.922226166535, 5215.191645294985, 4808.8797780055775, 5086.160783470686, 5100.826809833833, 5112.846614601568, 5128.974355128201, 4989.351384320015, 5074.340335756328, 5206.687598744087, 5217.686938783685, 5228.947710522846, 5092.592592592658, 5101.7704203310195, 5112.386513618241, 5119.846404607868, 5122.564582010571], "value": 3857.758243657779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.9518438524918, 683.7470136049662, 690.0127632418634, 690.5580428525741, 725.4595326481772, 11886.881131188686, 11932.284062956207, 12214.877851221485, 12330.630081097559, 12480.251184928888, 12226.0, 12329.753404931897, 12406.565770198045, 12448.937755311234, 12473.501059957613, 621.2048577820375, 766.9578173200472, 782.2021538031205, 798.2695833312512, 798.5168972771477, 793.0245797668871, 793.3851265269404, 801.1027649033091, 803.056408719752, 805.0379796143611, 833.3583140981441, 834.6452757578036, 834.8789425533294, 838.174398217755, 838.9203025712578, 823.7528741377563, 826.3926014379426, 829.1294141151767, 829.7759604906671, 831.2269589281965, 605.8969975104243, 611.3702886027398, 612.0482649480057, 612.1429998002787, 612.8222815383533, 12068.939655301756, 12126.090543209295, 12142.757144857052, 12147.574834880737, 12199.207051541622, 12351.62945111639, 12690.682732931658, 12772.105952583323, 12935.049877056472, 12953.352332383343, 9885.209183265322, 9978.600855965753, 10031.849522257173, 10280.845787313196, 10450.843237351446, 3247.7564182686156, 3312.271300313927, 3319.153615827948, 3341.665833416663, 3383.1372999885116, 49285.753571231915, 49608.255876161886, 49669.50330496721, 51219.0, 51412.99999999963, 10194.643187488402, 10293.279470437148, 10299.17606591471, 10306.433146176882, 10443.477826108816, 15454.227288635524, 18543.258269669062, 18584.070796460393, 18623.06884655789, 18650.626987460175, 6557.672116394161, 6639.136912201479, 6712.194536655633, 6864.897026544606, 6928.272531384233, 3512.7892326460496, 3544.592371877267, 3550.25444656625, 3581.6776490116013, 3653.85768239314, 2860.6281183446017, 2943.9705602943695, 2962.3927094945484, 2962.511185654386, 2968.139239620529, 515.8555604430766, 539.554867234533, 543.6221825831088, 544.3930018029947, 545.342861851468, 497.6566169343142, 533.4825219537042, 545.4926917966329, 580.8199458167896, 597.3906615252419, 7693.153753087156, 7845.137034926153, 8021.27808497238, 8203.261706446448, 8229.218224268685, 507.20369020637247, 573.1288441568792, 605.5034871405493, 609.3845216331537, 612.0604871522193, 3699.5930447650735, 3732.346839303111, 3756.2111956488898, 3765.4728338032696, 3936.8622098226424, 54871.72564137154, 55201.72399138059, 55712.0, 56083.0, 56188.71905640527, 50416.747916260916, 50657.493425066015, 50663.24005139926, 50743.49256507387, 51494.742526287126, 45728.77135614301, 46848.765756171, 47050.76474617605, 47450.76274618605, 48420.5157948416, 7637.159912409519, 7703.458067334581, 7793.61031948389, 7820.413468989735, 7912.0, 31335.21661958469, 31479.842600787764, 31708.84145579257, 32454.35091298208, 32485.837570811993, 38495.615043849204, 40826.38760418655, 40884.182316354105, 41435.7928210357, 42242.36636450517, 8888.555572221234, 9025.548722563713, 9034.774130646787, 9064.410813297114, 9111.134442227978, 10402.843957340798, 10438.739031524272, 10451.163906887583, 10510.0, 10562.577496900038, 9354.438733676001, 9492.145706886413, 9518.524073796421, 9618.0, 9768.26737994639, 9578.329516933747, 9599.808003839744, 9753.512324383895, 9767.365121267096, 10118.0, 9362.251019918527, 9623.422594644344, 9874.061964113398, 9926.454045027303, 9964.60141594357, 8283.37874659415, 8351.415400921876, 8795.692150774692, 9650.227981761302, 9672.806543869225, 9528.285378596494, 9578.808423831624, 9602.807943841224, 9629.32594718391, 9634.951825240829], "value": 5868.558698190355, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 116.0, 113.0, 114.0, 113.0, 114.0, 116.0, 114.0, 117.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 130.0, 152.0, 181.0, 130.0, 162.0, 160.0, 134.0, 193.0, 128.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 176.0, 164.0, 163.0, 165.0, 163.0, 162.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 164.0, 78.0, 77.0, 75.0, 75.0, 163.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 146.0, 84.0, 84.0, 84.0, 133.0, 85.0, 84.0, 137.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 120.0, 118.0, 117.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 63.0, 66.0, 64.0, 70.0, 62.0, 63.0, 62.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 65.0, 65.0, 67.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 82.0, 85.0, 90.0, 84.0, 86.0, 90.0, 109.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 144.0, 147.0, 133.0, 137.0, 149.0, 131.0, 136.0, 155.0, 152.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 173.0, 180.0, 173.0, 170.0, 175.0, 175.0, 171.0, 173.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 70.0, 66.0], "value": 67.2, "unit": "score"}]}]} 09:38:02 INFO - Return code: 0 09:38:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:38:02 ERROR - # TBPL SUCCESS # 09:38:02 INFO - Running post-action listener: _resource_record_post_action 09:38:02 INFO - ##### 09:38:02 INFO - ##### Finished run-tests step (success) 09:38:02 INFO - ##### 09:38:02 INFO - Running post-run listener: _resource_record_post_run 09:38:02 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539131904; Read time: 12; Write time: 651204 09:38:02 INFO - TinderboxPrint: CPU usage
13.4% 09:38:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:38:02 INFO - TinderboxPrint: I/O write bytes / time
539,131,904 / 651,204 09:38:02 INFO - TinderboxPrint: CPU idle
8,266.5 (86.5%) 09:38:02 INFO - TinderboxPrint: CPU user
1,227.8 (12.9%) 09:38:02 INFO - TinderboxPrint: Swap in / out
0 / 0 09:38:02 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 242102272; Read time: 0; Write time: 386420 09:38:02 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297029632; Read time: 12; Write time: 264784 09:38:03 INFO - Running post-run listener: _upload_blobber_files 09:38:03 INFO - Blob upload gear active. 09:38:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:38:03 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:38:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:38:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:04 INFO - (blobuploader) - INFO - Done attempting. 09:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:38:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:05 INFO - (blobuploader) - INFO - Done attempting. 09:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:09 INFO - (blobuploader) - INFO - Done attempting. 09:38:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:09 INFO - Return code: 0 09:38:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58bc68f5d75c96930aa77159f45648f7c9d09bb52a742695615db0853a3589564ed7870972019bc5a59e56d4f05f1cc30c2b97f6a2f889d7663c77aa718be417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03e2170d49d2057f4f396cb6bc73e232eb4289cb724f2180f97fb9fc317bfb46c595459bf62ce11423072c5f0f53e9e18e20e5b11be192fbfddf631a74384fb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be7e4e9a03ca3ad61da7c17a172ba3651e1c5dfbb708081423e8ac38683bb2542e90a5ce5ec852953b0be6ffa8a35b479cc13ecabbd23212e62e8aa5924106f9"} 09:38:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:09 INFO - Contents: 09:38:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58bc68f5d75c96930aa77159f45648f7c9d09bb52a742695615db0853a3589564ed7870972019bc5a59e56d4f05f1cc30c2b97f6a2f889d7663c77aa718be417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03e2170d49d2057f4f396cb6bc73e232eb4289cb724f2180f97fb9fc317bfb46c595459bf62ce11423072c5f0f53e9e18e20e5b11be192fbfddf631a74384fb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be7e4e9a03ca3ad61da7c17a172ba3651e1c5dfbb708081423e8ac38683bb2542e90a5ce5ec852953b0be6ffa8a35b479cc13ecabbd23212e62e8aa5924106f9"} 09:38:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:09 INFO - Copying logs to upload dir... 09:38:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.167203 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-30 09:38:08.287826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 09:38:08.290879) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58bc68f5d75c96930aa77159f45648f7c9d09bb52a742695615db0853a3589564ed7870972019bc5a59e56d4f05f1cc30c2b97f6a2f889d7663c77aa718be417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03e2170d49d2057f4f396cb6bc73e232eb4289cb724f2180f97fb9fc317bfb46c595459bf62ce11423072c5f0f53e9e18e20e5b11be192fbfddf631a74384fb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be7e4e9a03ca3ad61da7c17a172ba3651e1c5dfbb708081423e8ac38683bb2542e90a5ce5ec852953b0be6ffa8a35b479cc13ecabbd23212e62e8aa5924106f9"} build_url:https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/F0m44pQFRdOivvPk1NmceA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58bc68f5d75c96930aa77159f45648f7c9d09bb52a742695615db0853a3589564ed7870972019bc5a59e56d4f05f1cc30c2b97f6a2f889d7663c77aa718be417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03e2170d49d2057f4f396cb6bc73e232eb4289cb724f2180f97fb9fc317bfb46c595459bf62ce11423072c5f0f53e9e18e20e5b11be192fbfddf631a74384fb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be7e4e9a03ca3ad61da7c17a172ba3651e1c5dfbb708081423e8ac38683bb2542e90a5ce5ec852953b0be6ffa8a35b479cc13ecabbd23212e62e8aa5924106f9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 09:38:08.320714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:38:08.321304) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1464625048.868811-919278837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:38:08.402277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 09:38:08.402613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 09:38:08.403131) ========= ========= Total master_lag: 0.18 =========