builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1464672797.7 results: success (0) buildid: 20160530220544 builduid: 5b78fc2cdf304c03a52fd75c184bf2f3 revision: 11bba688023eb241c9b1c8c460a53d3679ae41f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.697344) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.698724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.699011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.715195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.715513) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 22:33:18-- 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% 230M=0s 2016-05-30 22:33:18 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.800573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.800893) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018464 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.850074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:17.850390) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11bba688023eb241c9b1c8c460a53d3679ae41f0 --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 11bba688023eb241c9b1c8c460a53d3679ae41f0 --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=516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 22:33:18,417 truncating revision to first 12 chars 2016-05-30 22:33:18,417 Setting DEBUG logging. 2016-05-30 22:33:18,417 attempt 1/10 2016-05-30 22:33:18,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11bba688023e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 22:33:18,722 unpacking tar archive at: fx-team-11bba688023e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632159 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:18.496273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:18.496608) ========= script_repo_revision: 11bba688023eb241c9b1c8c460a53d3679ae41f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:18.497020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:18.497297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 22:33:18.507619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-30 22:33:18.508019) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:33:19 INFO - MultiFileLogger online at 20160530 22:33:19 in /builds/slave/test 22:33:19 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 22:33:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:33:19 INFO - {'append_to_log': False, 22:33:19 INFO - 'base_work_dir': '/builds/slave/test', 22:33:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:33:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:33:19 INFO - 'branch': 'Fx-Team-Non-PGO', 22:33:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:33:19 INFO - 'config_files': ('talos/linux_config.py',), 22:33:19 INFO - 'default_actions': ('clobber', 22:33:19 INFO - 'read-buildbot-config', 22:33:19 INFO - 'download-and-extract', 22:33:19 INFO - 'populate-webroot', 22:33:19 INFO - 'create-virtualenv', 22:33:19 INFO - 'install', 22:33:19 INFO - 'run-tests'), 22:33:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:33:19 INFO - 'download_minidump_stackwalk': True, 22:33:19 INFO - 'download_symbols': 'ondemand', 22:33:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:33:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:33:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:33:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:33:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:33:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:33:19 INFO - 'installer_path': 'installer.exe', 22:33:19 INFO - 'log_level': 'info', 22:33:19 INFO - 'log_name': 'talos', 22:33:19 INFO - 'log_to_console': True, 22:33:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:33:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:33:19 INFO - 'opt_config_files': (), 22:33:19 INFO - 'pip_index': False, 22:33:19 INFO - 'sps_profile': False, 22:33:19 INFO - 'sps_profile_interval': 0, 22:33:19 INFO - 'suite': 'dromaeojs-e10s', 22:33:19 INFO - 'system_bits': '32', 22:33:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:33:19 INFO - 'title': 'talos-linux64-ix-061', 22:33:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:33:19 INFO - 'use_talos_json': True, 22:33:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:33:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:33:19 INFO - 'work_dir': 'build'} 22:33:19 INFO - ##### 22:33:19 INFO - ##### Running clobber step. 22:33:19 INFO - ##### 22:33:19 INFO - Running pre-action listener: _resource_record_pre_action 22:33:19 INFO - Running main action method: clobber 22:33:19 INFO - rmtree: /builds/slave/test/build 22:33:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:33:20 INFO - Running post-action listener: _resource_record_post_action 22:33:20 INFO - ##### 22:33:20 INFO - ##### Finished clobber step (success) 22:33:20 INFO - ##### 22:33:20 INFO - ##### 22:33:20 INFO - ##### Running read-buildbot-config step. 22:33:20 INFO - ##### 22:33:20 INFO - Running pre-action listener: _resource_record_pre_action 22:33:20 INFO - Running main action method: read_buildbot_config 22:33:20 INFO - Using buildbot properties: 22:33:20 INFO - { 22:33:20 INFO - "project": "", 22:33:20 INFO - "product": "firefox", 22:33:20 INFO - "script_repo_revision": "production", 22:33:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:33:20 INFO - "repository": "", 22:33:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:33:20 INFO - "buildid": "20160530220544", 22:33:20 INFO - "pgo_build": "False", 22:33:20 INFO - "basedir": "/builds/slave/test", 22:33:20 INFO - "buildnumber": 1325, 22:33:20 INFO - "slavename": "talos-linux64-ix-061", 22:33:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:33:20 INFO - "platform": "ubuntu64_hw", 22:33:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:33:20 INFO - "branch": "fx-team", 22:33:20 INFO - "repo_path": "integration/fx-team", 22:33:20 INFO - "revision": "11bba688023eb241c9b1c8c460a53d3679ae41f0", 22:33:20 INFO - "stage_platform": "linux64", 22:33:20 INFO - "builduid": "5b78fc2cdf304c03a52fd75c184bf2f3", 22:33:20 INFO - "slavebuilddir": "test" 22:33:20 INFO - } 22:33:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:33:20 INFO - Running post-action listener: _resource_record_post_action 22:33:20 INFO - ##### 22:33:20 INFO - ##### Finished read-buildbot-config step (success) 22:33:20 INFO - ##### 22:33:20 INFO - ##### 22:33:20 INFO - ##### Running download-and-extract step. 22:33:20 INFO - ##### 22:33:20 INFO - Running pre-action listener: _resource_record_pre_action 22:33:20 INFO - Running main action method: download_and_extract 22:33:20 INFO - mkdir: /builds/slave/test/build/tests 22:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:20 INFO - https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:33:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:33:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:33:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:21 INFO - Downloaded 1361 bytes. 22:33:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:33:21 INFO - Using the following test package requirements: 22:33:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:33:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:33:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:33:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:21 INFO - u'jsshell-linux-x86_64.zip'], 22:33:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:33:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:33:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:33:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:33:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:33:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:33:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:33: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')]} 22:33:21 INFO - https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:33:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:33:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:33:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:22 INFO - Downloaded 22837967 bytes. 22:33:22 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'] 22:33:22 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 22:33:24 INFO - Return code: 0 22:33:24 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 22:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:24 INFO - https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:33:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:33:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:33:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:28 INFO - Downloaded 22837967 bytes. 22:33:28 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'] 22:33:28 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 22:33:30 INFO - Return code: 0 22:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:30 INFO - https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:33:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:33:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:33:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:31 INFO - Downloaded 10834055 bytes. 22:33:31 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'] 22:33:31 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 22:33:31 INFO - Return code: 0 22:33: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')]} 22:33:31 INFO - https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:33:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:33:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:33:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMdak1UFROGFbAec2AVheg/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 22:33:40 INFO - Downloaded 54998722 bytes. 22:33:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:33:40 INFO - mkdir: /builds/slave/test/properties 22:33:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:33:40 INFO - Writing to file /builds/slave/test/properties/build_url 22:33:40 INFO - Contents: 22:33:40 INFO - build_url:https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:33:40 INFO - Running post-action listener: _resource_record_post_action 22:33:40 INFO - Running post-action listener: set_extra_try_arguments 22:33:40 INFO - ##### 22:33:40 INFO - ##### Finished download-and-extract step (success) 22:33:40 INFO - ##### 22:33:40 INFO - ##### 22:33:40 INFO - ##### Running populate-webroot step. 22:33:40 INFO - ##### 22:33:40 INFO - Running pre-action listener: _resource_record_pre_action 22:33:40 INFO - Running main action method: populate_webroot 22:33:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:33:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:33:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:33:40 INFO - '--tppagecycles', 22:33:40 INFO - '7'], 22:33:40 INFO - 'tests': ['tsvgm']}}, 22:33:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:33:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:33:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:33:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:33:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:40 INFO - 'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:33:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:33:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:40 INFO - 'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['damp', 'tps']}, 22:33:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:40 INFO - 'tests': ['damp', 'tps']}, 22:33:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['dromaeo_dom']}, 22:33:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:33:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['a11yr', 22:33:40 INFO - 'ts_paint', 22:33:40 INFO - 'tpaint', 22:33:40 INFO - 'sessionrestore', 22:33:40 INFO - 'sessionrestore_no_auto_restore', 22:33:40 INFO - 'tabpaint']}, 22:33:40 INFO - 'other-e10s': {'tests': ['a11yr', 22:33:40 INFO - 'ts_paint', 22:33:40 INFO - 'tpaint', 22:33:40 INFO - 'sessionrestore', 22:33:40 INFO - 'sessionrestore_no_auto_restore', 22:33:40 INFO - 'tabpaint']}, 22:33:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:33:40 INFO - 'ts_paint', 22:33:40 INFO - 'tpaint', 22:33:40 INFO - 'sessionrestore', 22:33:40 INFO - 'sessionrestore_no_auto_restore', 22:33:40 INFO - 'tabpaint']}, 22:33:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:33:40 INFO - 'ts_paint', 22:33:40 INFO - 'tpaint', 22:33:40 INFO - 'sessionrestore', 22:33:40 INFO - 'sessionrestore_no_auto_restore', 22:33:40 INFO - 'tabpaint']}, 22:33:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['a11yr', 22:33:40 INFO - 'ts_paint', 22:33:40 INFO - 'tpaint', 22:33:40 INFO - 'sessionrestore', 22:33:40 INFO - 'sessionrestore_no_auto_restore', 22:33:40 INFO - 'tabpaint']}, 22:33:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['a11yr', 22:33:40 INFO - 'ts_paint', 22:33:40 INFO - 'tpaint', 22:33:40 INFO - 'sessionrestore', 22:33:40 INFO - 'sessionrestore_no_auto_restore', 22:33:40 INFO - 'tabpaint']}, 22:33:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['tsvgx', 22:33:40 INFO - 'tsvgr_opacity', 22:33:40 INFO - 'tart', 22:33:40 INFO - 'tscrollx', 22:33:40 INFO - 'cart']}, 22:33:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:33:40 INFO - 'tsvgr_opacity', 22:33:40 INFO - 'tart', 22:33:40 INFO - 'tscrollx', 22:33:40 INFO - 'cart']}, 22:33:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:40 INFO - 'talos_options': ['--disable-e10s'], 22:33:40 INFO - 'tests': ['tp5o']}, 22:33:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:40 INFO - 'tests': ['tp5o']}, 22:33:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:40 INFO - 'talos_options': ['--disable-e10s', 22:33:40 INFO - '--xperf_path', 22:33:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:33:40 INFO - 'tests': ['tp5n']}, 22:33:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:40 INFO - 'talos_options': ['--xperf_path', 22:33:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:33:40 INFO - 'tests': ['tp5n']}}, 22:33:40 INFO - 'talos.zip': {'path': '', 22:33:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:33:40 INFO - Running post-action listener: _resource_record_post_action 22:33:40 INFO - ##### 22:33:40 INFO - ##### Finished populate-webroot step (success) 22:33:40 INFO - ##### 22:33:40 INFO - ##### 22:33:40 INFO - ##### Running create-virtualenv step. 22:33:40 INFO - ##### 22:33:40 INFO - Running pre-action listener: _resource_record_pre_action 22:33:40 INFO - Running main action method: create_virtualenv 22:33:40 INFO - Creating virtualenv /builds/slave/test/build/venv 22:33: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 22:33:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:33:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:33:41 INFO - Using real prefix '/usr' 22:33:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:33:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:33:43 INFO - Installing pip.................done. 22:33:43 INFO - Return code: 0 22:33:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:33: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 22:33: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 22:33:43 INFO - Using env: {'DISPLAY': ':0', 22:33:43 INFO - 'HOME': '/home/cltbld', 22:33:43 INFO - 'LANG': 'en_US.UTF-8', 22:33:43 INFO - 'LANGUAGE': 'en_US:en', 22:33:43 INFO - 'LOGNAME': 'cltbld', 22:33:43 INFO - 'MAIL': '/var/mail/cltbld', 22:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:43 INFO - 'MOZ_NO_REMOTE': '1', 22:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:43 INFO - 'NO_EM_RESTART': '1', 22:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:43 INFO - 'PWD': '/builds/slave/test', 22:33:43 INFO - 'SHELL': '/bin/bash', 22:33:43 INFO - 'SHLVL': '1', 22:33:43 INFO - 'TERM': 'linux', 22:33:43 INFO - 'TMOUT': '86400', 22:33:43 INFO - 'USER': 'cltbld', 22:33:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:43 INFO - '_': '/tools/buildbot/bin/python'} 22:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33: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 22:33:43 INFO - Cleaning up... 22:33:43 INFO - Return code: 0 22:33:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:33: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 22:33: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 22:33:43 INFO - Using env: {'DISPLAY': ':0', 22:33:43 INFO - 'HOME': '/home/cltbld', 22:33:43 INFO - 'LANG': 'en_US.UTF-8', 22:33:43 INFO - 'LANGUAGE': 'en_US:en', 22:33:43 INFO - 'LOGNAME': 'cltbld', 22:33:43 INFO - 'MAIL': '/var/mail/cltbld', 22:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:43 INFO - 'MOZ_NO_REMOTE': '1', 22:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:43 INFO - 'NO_EM_RESTART': '1', 22:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:43 INFO - 'PWD': '/builds/slave/test', 22:33:43 INFO - 'SHELL': '/bin/bash', 22:33:43 INFO - 'SHLVL': '1', 22:33:43 INFO - 'TERM': 'linux', 22:33:43 INFO - 'TMOUT': '86400', 22:33:43 INFO - 'USER': 'cltbld', 22:33:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:43 INFO - '_': '/tools/buildbot/bin/python'} 22:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:43 INFO - Downloading/unpacking psutil>=3.1.1 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:33:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:46 INFO - Installing collected packages: psutil 22:33:46 INFO - Running setup.py install for psutil 22:33:46 INFO - building 'psutil._psutil_linux' extension 22:33:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:33: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 22:33:46 INFO - building 'psutil._psutil_posix' extension 22:33: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 22:33: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 22:33:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:46 INFO - Successfully installed psutil 22:33:46 INFO - Cleaning up... 22:33:46 INFO - Return code: 0 22:33:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:33: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 22:33: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 22:33:46 INFO - Using env: {'DISPLAY': ':0', 22:33:46 INFO - 'HOME': '/home/cltbld', 22:33:46 INFO - 'LANG': 'en_US.UTF-8', 22:33:46 INFO - 'LANGUAGE': 'en_US:en', 22:33:46 INFO - 'LOGNAME': 'cltbld', 22:33:46 INFO - 'MAIL': '/var/mail/cltbld', 22:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:46 INFO - 'MOZ_NO_REMOTE': '1', 22:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:46 INFO - 'NO_EM_RESTART': '1', 22:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:46 INFO - 'PWD': '/builds/slave/test', 22:33:46 INFO - 'SHELL': '/bin/bash', 22:33:46 INFO - 'SHLVL': '1', 22:33:46 INFO - 'TERM': 'linux', 22:33:46 INFO - 'TMOUT': '86400', 22:33:46 INFO - 'USER': 'cltbld', 22:33:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:46 INFO - '_': '/tools/buildbot/bin/python'} 22:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:33:48 INFO - Installing collected packages: mozsystemmonitor 22:33:48 INFO - Running setup.py install for mozsystemmonitor 22:33:48 INFO - Successfully installed mozsystemmonitor 22:33:48 INFO - Cleaning up... 22:33:48 INFO - Return code: 0 22:33:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:33: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 22:33: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 22:33:48 INFO - Using env: {'DISPLAY': ':0', 22:33:48 INFO - 'HOME': '/home/cltbld', 22:33:48 INFO - 'LANG': 'en_US.UTF-8', 22:33:48 INFO - 'LANGUAGE': 'en_US:en', 22:33:48 INFO - 'LOGNAME': 'cltbld', 22:33:48 INFO - 'MAIL': '/var/mail/cltbld', 22:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:48 INFO - 'MOZ_NO_REMOTE': '1', 22:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:48 INFO - 'NO_EM_RESTART': '1', 22:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:48 INFO - 'PWD': '/builds/slave/test', 22:33:48 INFO - 'SHELL': '/bin/bash', 22:33:48 INFO - 'SHLVL': '1', 22:33:48 INFO - 'TERM': 'linux', 22:33:48 INFO - 'TMOUT': '86400', 22:33:48 INFO - 'USER': 'cltbld', 22:33:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:48 INFO - '_': '/tools/buildbot/bin/python'} 22:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:49 INFO - Downloading/unpacking blobuploader==1.2.4 22:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:51 INFO - Downloading blobuploader-1.2.4.tar.gz 22:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:33:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:33:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:51 INFO - Downloading docopt-0.6.1.tar.gz 22:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:33:51 INFO - Installing collected packages: blobuploader, requests, docopt 22:33:51 INFO - Running setup.py install for blobuploader 22:33:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:33:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:33:51 INFO - Running setup.py install for requests 22:33:52 INFO - Running setup.py install for docopt 22:33:52 INFO - Successfully installed blobuploader requests docopt 22:33:52 INFO - Cleaning up... 22:33:52 INFO - Return code: 0 22:33:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:33: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 22:33: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 22:33:52 INFO - Using env: {'DISPLAY': ':0', 22:33:52 INFO - 'HOME': '/home/cltbld', 22:33:52 INFO - 'LANG': 'en_US.UTF-8', 22:33:52 INFO - 'LANGUAGE': 'en_US:en', 22:33:52 INFO - 'LOGNAME': 'cltbld', 22:33:52 INFO - 'MAIL': '/var/mail/cltbld', 22:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:52 INFO - 'MOZ_NO_REMOTE': '1', 22:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:52 INFO - 'NO_EM_RESTART': '1', 22:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:52 INFO - 'PWD': '/builds/slave/test', 22:33:52 INFO - 'SHELL': '/bin/bash', 22:33:52 INFO - 'SHLVL': '1', 22:33:52 INFO - 'TERM': 'linux', 22:33:52 INFO - 'TMOUT': '86400', 22:33:52 INFO - 'USER': 'cltbld', 22:33:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:52 INFO - '_': '/tools/buildbot/bin/python'} 22:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:52 INFO - Running setup.py (path:/tmp/pip-c4jlUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:52 INFO - Running setup.py (path:/tmp/pip-bPZcLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:52 INFO - Running setup.py (path:/tmp/pip-ro0bNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:52 INFO - Running setup.py (path:/tmp/pip-YkLTY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:52 INFO - Running setup.py (path:/tmp/pip-xs8hjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:52 INFO - Running setup.py (path:/tmp/pip-c53vYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:53 INFO - Running setup.py (path:/tmp/pip-gNA7bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:53 INFO - Running setup.py (path:/tmp/pip-aN1H_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:53 INFO - Running setup.py (path:/tmp/pip-xG3yWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:53 INFO - Running setup.py (path:/tmp/pip-faDWtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:53 INFO - Running setup.py (path:/tmp/pip-N9VM7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:53 INFO - Running setup.py (path:/tmp/pip-avW_xE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:53 INFO - Running setup.py (path:/tmp/pip-OE5kcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:53 INFO - Running setup.py (path:/tmp/pip-xGMMtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:53 INFO - Running setup.py (path:/tmp/pip-igqzSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:53 INFO - Running setup.py (path:/tmp/pip-maUnig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:53 INFO - Running setup.py (path:/tmp/pip-30EnDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:33:53 INFO - Running setup.py install for manifestparser 22:33:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:33:53 INFO - Running setup.py install for mozcrash 22:33:54 INFO - Running setup.py install for mozdebug 22:33:54 INFO - Running setup.py install for mozdevice 22:33:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Running setup.py install for mozfile 22:33:54 INFO - Running setup.py install for mozhttpd 22:33:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Running setup.py install for mozinfo 22:33:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Running setup.py install for mozInstall 22:33:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Running setup.py install for mozleak 22:33:54 INFO - Running setup.py install for mozlog 22:33:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Running setup.py install for moznetwork 22:33:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:33:54 INFO - Running setup.py install for mozprocess 22:33:55 INFO - Running setup.py install for mozprofile 22:33:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:33:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:33:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:33:55 INFO - Running setup.py install for mozrunner 22:33:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:33:55 INFO - Running setup.py install for mozscreenshot 22:33:55 INFO - Running setup.py install for moztest 22:33:55 INFO - Running setup.py install for mozversion 22:33:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:33:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:33:55 INFO - Cleaning up... 22:33:55 INFO - Return code: 0 22:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:33: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 22:33: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 22:33:55 INFO - Using env: {'DISPLAY': ':0', 22:33:55 INFO - 'HOME': '/home/cltbld', 22:33:55 INFO - 'LANG': 'en_US.UTF-8', 22:33:55 INFO - 'LANGUAGE': 'en_US:en', 22:33:55 INFO - 'LOGNAME': 'cltbld', 22:33:55 INFO - 'MAIL': '/var/mail/cltbld', 22:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:55 INFO - 'MOZ_NO_REMOTE': '1', 22:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:55 INFO - 'NO_EM_RESTART': '1', 22:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:55 INFO - 'PWD': '/builds/slave/test', 22:33:55 INFO - 'SHELL': '/bin/bash', 22:33:55 INFO - 'SHLVL': '1', 22:33:55 INFO - 'TERM': 'linux', 22:33:55 INFO - 'TMOUT': '86400', 22:33:55 INFO - 'USER': 'cltbld', 22:33:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:55 INFO - '_': '/tools/buildbot/bin/python'} 22:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:55 INFO - Running setup.py (path:/tmp/pip-Fk87B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33: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)) 22:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:55 INFO - Running setup.py (path:/tmp/pip-61vx8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:56 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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:56 INFO - Running setup.py (path:/tmp/pip-NvrIWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:56 INFO - Running setup.py (path:/tmp/pip-a4qejB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:56 INFO - Running setup.py (path:/tmp/pip-eGJPAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:56 INFO - Running setup.py (path:/tmp/pip-RikPda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:56 INFO - Running setup.py (path:/tmp/pip-6idL5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:56 INFO - Running setup.py (path:/tmp/pip-a7Crmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:56 INFO - Running setup.py (path:/tmp/pip-x4S9D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:56 INFO - Running setup.py (path:/tmp/pip-ttkDGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:56 INFO - Running setup.py (path:/tmp/pip-pkyYOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:56 INFO - Running setup.py (path:/tmp/pip-MYxqkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:56 INFO - Running setup.py (path:/tmp/pip-sWOQdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:56 INFO - Running setup.py (path:/tmp/pip-5gGmFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:56 INFO - Running setup.py (path:/tmp/pip-3YRwl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33: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)) 22:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:56 INFO - Running setup.py (path:/tmp/pip-75XldE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:57 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)) 22:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:57 INFO - Running setup.py (path:/tmp/pip-XfiVyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:58 INFO - Downloading blessings-1.6.tar.gz 22:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:33:59 INFO - Installing collected packages: blessings 22:33:59 INFO - Running setup.py install for blessings 22:33:59 INFO - Successfully installed blessings 22:33:59 INFO - Cleaning up... 22:33:59 INFO - Return code: 0 22:33:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:59 INFO - Reading from file tmpfile_stdout 22:33:59 INFO - Current package versions: 22:33:59 INFO - argparse == 1.2.1 22:33:59 INFO - blessings == 1.6 22:33:59 INFO - blobuploader == 1.2.4 22:33:59 INFO - docopt == 0.6.1 22:33:59 INFO - manifestparser == 1.1 22:33:59 INFO - mozInstall == 1.12 22:33:59 INFO - mozcrash == 0.17 22:33:59 INFO - mozdebug == 0.1 22:33:59 INFO - mozdevice == 0.48 22:33:59 INFO - mozfile == 1.2 22:33:59 INFO - mozhttpd == 0.7 22:33:59 INFO - mozinfo == 0.9 22:33:59 INFO - mozleak == 0.1 22:33:59 INFO - mozlog == 3.2 22:33:59 INFO - moznetwork == 0.27 22:33:59 INFO - mozprocess == 0.22 22:33:59 INFO - mozprofile == 0.28 22:33:59 INFO - mozrunner == 6.11 22:33:59 INFO - mozscreenshot == 0.1 22:33:59 INFO - mozsystemmonitor == 0.3 22:33:59 INFO - moztest == 0.7 22:33:59 INFO - mozversion == 1.4 22:33:59 INFO - psutil == 3.1.1 22:33:59 INFO - requests == 1.2.3 22:33:59 INFO - wsgiref == 0.1.2 22:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:33: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 22:33: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 22:33:59 INFO - Using env: {'DISPLAY': ':0', 22:33:59 INFO - 'HOME': '/home/cltbld', 22:33:59 INFO - 'LANG': 'en_US.UTF-8', 22:33:59 INFO - 'LANGUAGE': 'en_US:en', 22:33:59 INFO - 'LOGNAME': 'cltbld', 22:33:59 INFO - 'MAIL': '/var/mail/cltbld', 22:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:59 INFO - 'MOZ_NO_REMOTE': '1', 22:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:59 INFO - 'NO_EM_RESTART': '1', 22:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:59 INFO - 'PWD': '/builds/slave/test', 22:33:59 INFO - 'SHELL': '/bin/bash', 22:33:59 INFO - 'SHLVL': '1', 22:33:59 INFO - 'TERM': 'linux', 22:33:59 INFO - 'TMOUT': '86400', 22:33:59 INFO - 'USER': 'cltbld', 22:33:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:59 INFO - '_': '/tools/buildbot/bin/python'} 22:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33: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)) 22:33:59 INFO - Cleaning up... 22:33:59 INFO - Return code: 0 22:33:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:33: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 22:33: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 22:33:59 INFO - Using env: {'DISPLAY': ':0', 22:33:59 INFO - 'HOME': '/home/cltbld', 22:33:59 INFO - 'LANG': 'en_US.UTF-8', 22:33:59 INFO - 'LANGUAGE': 'en_US:en', 22:33:59 INFO - 'LOGNAME': 'cltbld', 22:33:59 INFO - 'MAIL': '/var/mail/cltbld', 22:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:59 INFO - 'MOZ_NO_REMOTE': '1', 22:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:59 INFO - 'NO_EM_RESTART': '1', 22:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:59 INFO - 'PWD': '/builds/slave/test', 22:33:59 INFO - 'SHELL': '/bin/bash', 22:33:59 INFO - 'SHLVL': '1', 22:33:59 INFO - 'TERM': 'linux', 22:33:59 INFO - 'TMOUT': '86400', 22:33:59 INFO - 'USER': 'cltbld', 22:33:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:59 INFO - '_': '/tools/buildbot/bin/python'} 22:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:59 INFO - Downloading/unpacking jsonschema 22:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:34:01 INFO - Downloading/unpacking functools32 (from jsonschema) 22:34: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 22:34: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 22:34: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 22:34: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 22:34: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 22:34: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 22:34:01 INFO - Downloading functools32-3.2.3-2.tar.gz 22:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:34:02 INFO - warning: no files found matching '*.txt' 22:34:02 INFO - no previously-included directories found matching 'build' 22:34:02 INFO - no previously-included directories found matching 'dist' 22:34:02 INFO - no previously-included directories found matching '.git*' 22:34:02 INFO - Installing collected packages: jsonschema, functools32 22:34:02 INFO - Running setup.py install for functools32 22:34:02 INFO - warning: no files found matching '*.txt' 22:34:02 INFO - no previously-included directories found matching 'build' 22:34:02 INFO - no previously-included directories found matching 'dist' 22:34:02 INFO - no previously-included directories found matching '.git*' 22:34:02 INFO - Successfully installed jsonschema functools32 22:34:02 INFO - Cleaning up... 22:34:02 INFO - Return code: 0 22:34:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:34: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 0x7f988c1a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2768770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', '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 22:34: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 22:34: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 22:34:02 INFO - Using env: {'DISPLAY': ':0', 22:34:02 INFO - 'HOME': '/home/cltbld', 22:34:02 INFO - 'LANG': 'en_US.UTF-8', 22:34:02 INFO - 'LANGUAGE': 'en_US:en', 22:34:02 INFO - 'LOGNAME': 'cltbld', 22:34:02 INFO - 'MAIL': '/var/mail/cltbld', 22:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:34:02 INFO - 'MOZ_NO_REMOTE': '1', 22:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:34:02 INFO - 'NO_EM_RESTART': '1', 22:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:34:02 INFO - 'PWD': '/builds/slave/test', 22:34:02 INFO - 'SHELL': '/bin/bash', 22:34:02 INFO - 'SHLVL': '1', 22:34:02 INFO - 'TERM': 'linux', 22:34:02 INFO - 'TMOUT': '86400', 22:34:02 INFO - 'USER': 'cltbld', 22:34:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:34:02 INFO - '_': '/tools/buildbot/bin/python'} 22:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:34:02 INFO - Downloading/unpacking flake8 22:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:34:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:34:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:34:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:34:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:34:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:34:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:34:05 INFO - no previously-included directories found matching 'docs/_build' 22:34:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:34:05 INFO - Running setup.py install for pep8 22:34:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:34:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:34:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:34:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:34:05 INFO - no previously-included directories found matching 'docs/_build' 22:34:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:34:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:34:05 INFO - Cleaning up... 22:34:05 INFO - Return code: 0 22:34:05 INFO - Running post-action listener: _resource_record_post_action 22:34:05 INFO - Running post-action listener: _start_resource_monitoring 22:34:05 INFO - Starting resource monitoring. 22:34:05 INFO - ##### 22:34:05 INFO - ##### Finished create-virtualenv step (success) 22:34:05 INFO - ##### 22:34:05 INFO - ##### 22:34:05 INFO - ##### Running install step. 22:34:05 INFO - ##### 22:34:05 INFO - Running pre-action listener: _resource_record_pre_action 22:34:05 INFO - Running main action method: install 22:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:34:05 INFO - Reading from file tmpfile_stdout 22:34:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:34:05 INFO - Reading from file tmpfile_stdout 22:34:05 INFO - Output received: 22:34:05 INFO - Usage: mozinstall [options] installer 22:34:05 INFO - Options: 22:34:05 INFO - -h, --help show this help message and exit 22:34:05 INFO - -d DEST, --destination=DEST 22:34:05 INFO - Directory to install application into. [default: 22:34:05 INFO - "/builds/slave/test"] 22:34:05 INFO - --app=APP Application being installed. [default: firefox] 22:34:05 INFO - mkdir: /builds/slave/test/build/application 22:34: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'] 22:34: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 22:34:21 INFO - Reading from file tmpfile_stdout 22:34:21 INFO - Output received: 22:34:21 INFO - /builds/slave/test/build/application/firefox/firefox 22:34:21 INFO - Running post-action listener: _resource_record_post_action 22:34:21 INFO - ##### 22:34:21 INFO - ##### Finished install step (success) 22:34:21 INFO - ##### 22:34:21 INFO - ##### 22:34:21 INFO - ##### Running run-tests step. 22:34:21 INFO - ##### 22:34:21 INFO - Running pre-action listener: _resource_record_pre_action 22:34:21 INFO - Running main action method: run_tests 22:34:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:34:21 INFO - Python 2.7.3 22:34:21 INFO - Return code: 0 22:34:21 INFO - grabbing minidump binary from tooltool 22:34: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')]} 22:34: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 0x27f79c0>, '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 0x27f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f8d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:34: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 22:34: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 22:34: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 22:34:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:34:21 INFO - Return code: 0 22:34:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:34:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:34:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:34:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:34:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:34:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:34:22 INFO - Return code: 0 22:34: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/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 22:34: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/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 22:34:22 INFO - Using env: {'DISPLAY': ':0', 22:34:22 INFO - 'HOME': '/home/cltbld', 22:34:22 INFO - 'LANG': 'en_US.UTF-8', 22:34:22 INFO - 'LANGUAGE': 'en_US:en', 22:34:22 INFO - 'LOGNAME': 'cltbld', 22:34:22 INFO - 'MAIL': '/var/mail/cltbld', 22:34:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:34:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:34:22 INFO - 'MOZ_NO_REMOTE': '1', 22:34:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:34:22 INFO - 'NO_EM_RESTART': '1', 22:34:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:34:22 INFO - 'PWD': '/builds/slave/test', 22:34:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:34:22 INFO - 'SHELL': '/bin/bash', 22:34:22 INFO - 'SHLVL': '1', 22:34:22 INFO - 'TERM': 'linux', 22:34:22 INFO - 'TMOUT': '86400', 22:34:22 INFO - 'USER': 'cltbld', 22:34:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064', 22:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:34:22 INFO - '_': '/tools/buildbot/bin/python'} 22:34: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/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 22:34:22 INFO - mozversion application_buildid: 20160530220544 22:34:22 INFO - mozversion application_changeset: 11bba688023eb241c9b1c8c460a53d3679ae41f0 22:34:22 INFO - mozversion application_display_name: Nightly 22:34:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:34:22 INFO - mozversion application_name: Firefox 22:34:22 INFO - mozversion application_remotingname: firefox 22:34:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:34:22 INFO - mozversion application_vendor: Mozilla 22:34:22 INFO - mozversion application_version: 49.0a1 22:34:22 INFO - mozversion platform_buildid: 20160530220544 22:34:22 INFO - mozversion platform_changeset: 11bba688023eb241c9b1c8c460a53d3679ae41f0 22:34:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:34:22 INFO - mozversion platform_version: 49.0a1 22:34:22 INFO - using testdate: 1464672862 22:34:22 INFO - actual date: 1464672862 22:34:22 INFO - starting webserver on 'localhost:51376' 22:34:22 INFO - SUITE-START | Running 2 tests 22:34:22 INFO - TEST-START | dromaeo_css 22:34:22 INFO - operating with platform_type : linux_ 22:34:22 INFO - Initialising browser for dromaeo_css test... 22:34:22 INFO - TEST-INFO | started process 7349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr_F_A6/profile http://localhost:51376/getInfo.html) 22:34:28 INFO - PROCESS | 7349 | __metrics Screen width/height:1600/1200 22:34:28 INFO - PROCESS | 7349 | colorDepth:24 22:34:28 INFO - PROCESS | 7349 | Browser inner width/height: 1024/697 22:34:28 INFO - PROCESS | 7349 | __metrics 22:34:28 ERROR - PROCESS | 7349 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:34:29 INFO - TEST-INFO | 7349: exit 0 22:34:29 INFO - Browser initialized. 22:34:29 INFO - Running cycle 1/1 for dromaeo_css test... 22:34:29 INFO - TEST-INFO | started process 7468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr_F_A6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:41 INFO - PROCESS | 7468 | RSS: Main: 167583744 22:34:41 INFO - PROCESS | 7468 | 22:35:31 INFO - PROCESS | 7468 | 1464672931288 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:37:43 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:51376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51376/tests/dromaeo/cssquery-ext.html) 22:37:44 INFO - PROCESS | 7468 | RSS: Main: 170258432 22:37:44 INFO - PROCESS | 7468 | 22:40:46 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:51376/tests/dromaeo/cssquery-ext.html (next: http://localhost:51376/tests/dromaeo/cssquery-jquery.html) 22:40:46 INFO - PROCESS | 7468 | RSS: Main: 169521152 22:40:46 INFO - PROCESS | 7468 | 22:43:48 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:51376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51376/tests/dromaeo/cssquery-mootools.html) 22:43:49 INFO - PROCESS | 7468 | RSS: Main: 170311680 22:43:49 INFO - PROCESS | 7468 | 22:46:51 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:51376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51376/tests/dromaeo/cssquery-prototype.html) 22:46:51 INFO - PROCESS | 7468 | RSS: Main: 167833600 22:46:51 INFO - PROCESS | 7468 | 22:49:54 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:51376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51376/tests/dromaeo/cssquery-yui.html) 22:49:55 INFO - PROCESS | 7468 | RSS: Main: 169623552 22:49:55 INFO - PROCESS | 7468 | 22:52:57 INFO - PROCESS | 7468 | Cycle 1(1): loaded http://localhost:51376/tests/dromaeo/cssquery-yui.html (next: http://localhost:51376/tests/dromaeo/cssquery-dojo.html) 22:52:58 INFO - PROCESS | 7468 | RSS: Main: 171548672 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - PROCESS | 7468 | __start_tp_report 22:52:58 INFO - PROCESS | 7468 | _x_x_mozilla_page_load 22:52:58 INFO - PROCESS | 7468 | _x_x_mozilla_page_load_details 22:52:58 INFO - PROCESS | 7468 | |i|pagename|runs| 22:52:58 INFO - PROCESS | 7468 | |0;dojo.html;2653;2693.6094266331374;2709.444563864408;2712.7016028236876;2716.293763621459;4671.4861365249835;4695.788689508976;4732.10090082884;4809.591184749301;4870.147724148269;4719.834805781798;4723.692959957601;4729.9054018919605;4796.496367881375;4829.179039563274;4340.934885976721;4454.53227411122;4507.932381014288;4518.502964673883;4539.863804085882;621.6078018247792;4400.559944005589;4465.218586747306;4466.82132714691;4513.864584062483;4341.02326976431;4367.4322338096;4378;4385.057212699253;4424.159409712144;4305.052888364555;4375.496817865923;4411.117776444692;4431.446069241345;4451.488078870939;4355.869323920288;4356.150550642626;4360.520342762294;4377.23398405281;4425.7565833879125;4695.718256904596;4714.858554243378;4715.31627913954;4745.335653008547;4823.614110871122;5064.442911279756;5065.1642478990925;5129.846104616868;5174.016936781999;5186.844394668166;5161.4322424533275;5177.559907407875;5179.663321884065;5190.532852043334;5232.424433312332;4767.76161191939;4776.641751868624;4795.280707893844;4798.736069516141;4827.637927155442;5165.948340516622;5226.947730522646;5243.082460569385;5268.1834315681135;5357.892842143136;5064.11378008847;5080.339555857715;5087.491250874883;5091.210862316347;5122.359705036871;5193.974030129825;5202.895942081137;5205.7397130143345;5206.76569554371;5240.34495688039;4969.329140566049;5062.949370506321;5073.416557095908;5107.770150343244;5121;4990.950090499121;5026.246063090565;5049.6465247432325;5062.038212739568;5101.974490127525;4321.67587430944;4337.089211265669;4337.1976184405985;4337.783110844445;4374.890627734332;3711.55461344635;3728.067983004249;3739.121306492972;3776.169242766587;3830.214805964826;4443.289073748185;4448.866534003985;4450.710703804242;4457.130859482435;4497.977510112429;5132.409772876167;5140.691558506502;5142.357205349332;5145.716985565755;5153.819616313411;4333.43665323506;4418.226810308183;4459.308807134899;4466.932996004997;4469.5530446955045;4612.907741845212;4617.8152873884665;4623.491415944243;4624.676272660949;4656.8602941911795;4692.1084993851055;4874.7562621868765;4886.486918873609;4905.313256144214;4929.852104436873;5048.873778155576;5070.3155074064525;5072.061668591323;5086.109930762176;5103.4386217516785;4792.520747925179;4801.855944321676;4826.638002149923;4842.539958703917;4890.877728056827;5000.099982003274;5010.198368261061;5013.022460620144;5085.160948443466;5088.109580823415;5161.535461808456;5199.246109314204;5212.400573934046;5226.529612334908;5280.075986702235;5018.197088465974;5041.092603331289;5046.29351890743;5092.363454568179;5123.692578445305;4876.829310974099;4972.328735620789;4984.6759960603895;5055.924161137659;5066.797328106834;4763.356946812136;4901.754912254444;4914.36113305268;4949.109160351171;4976.402831660079;5095.87260318495;5100.719460429712;5100.744962751922;5112.71880046601;5157.871053223699;4874.073925954058;4919.3604831371695;4985.576226020684;4992.400911890596;5006.274090256965 22:52:58 INFO - PROCESS | 7468 | |1;ext.html;570.6262398129224;586.879689663619;593.7892048322844;607.3319348716412;621.142822904392;38575.99999999996;40181.18731688783;40516.59483405165;40586.39120413196;44262;41988.690622015856;42075.36886946698;42509.57490425103;42524.36213456801;42687.57312426875;7636.739937910252;7759.961200193991;7778.377729781604;7779.144294127642;7802.375809935192;7650.158482566913;7719.150893401721;7719.536827790351;7748.922510774876;7751.18612545683;7709.575973321465;7757.418193635472;7765.883511747328;7769.417293702995;7809.492382995116;7678.232176782277;7707.460477766558;7708.344790692798;7727.227277272256;7757.689692412297;7698.499597526199;7774.105977812567;7775.339096176832;7802.843943121163;7811.804704882424;38212.80893595542;38678.419823702665;38820.611793882264;39051.60948390508;39056.218875622326;2950.336174360773;3050.0392376401364;3079.2609773654385;3162.2094476380903;3601.513795637608;28907.277318067005;29124.417511649648;29222.853885730434;29473.852630736925;30434.086977390714;3229.1281354034513;3278.2623909620384;3325.866965321384;3333.399988002159;3356.2951780126205;257853;258799;260319;262253;262326;31951.360972780414;51695;51787;51875.22187167196;51984.48015519796;32655;33980;33987.66012339894;34198.316033679184;34237.486437703454;13115.868841311656;13235.66910827237;13264.40310186044;13264.535741249203;13266.336683165802;11348.546058157746;11495.195336326544;11503.827442588368;11528.365939873387;11592.304461732323;7859.174786647434;7903.881441778378;7959.681612735426;7983.560904150328;7986.520808751494;3084.475639141351;3111.175538482304;3126.515390114536;3144.3239703463864;3154.242981684379;822.8560001999626;824.1058451579983;853.2875049333752;867.4058270085012;985.7190700650281;27313.180604581896;28387.59348878148;28429.71570284312;28715.2821179468;28813.711862881522;825.3768404854417;903.2187158108189;905.8777065096259;939.727479031087;973.425678849468;14678.559643210721;15056.343802181751;15109.320080596399;15231.771523427158;15241.542753717184;385252;387413;388479;389452;390767;49017.754911225216;49818;50276.24585631218;50277.24584131241;50309.748451258245;1142.3493052539002;1150.3902931446346;1158.2066284594912;1162.041315914374;1166.6783101627868;26784.33039174036;27701.584476233274;27877.44245115127;27991.805921362284;28380.43239135247;42668.57331426646;43055;43422;43446.78276608597;43513;341825;344263;344553;345181;346230;24688.135915243598;25119.24642260735;25225.495490090463;25273.609951452112;25302.114425995736;41983.58016419797;42322.78838605787;42885.356719649855;43795.78102109469;43812.561874382125;35443;37266.81366593258;38888;39537.406938896514;39641.801790992016;36240.27519449649;37663.81168094142;38517;39001.414978774774;39292;30359.544606831358;34473.48289775706;35461;35933;36034;32047.679523204468;33520.64793520628;33628.49557256692;33775.66224337823;33966.150846229044;25186.874065629556;25711.357216069748;26064;26070.217893463225;26138.86930565335 22:52:58 INFO - PROCESS | 7468 | |2;jquery.html;352.82358820589707;354.9201429678324;357.0591491420108;358.0315247256172;372.6646018583276;15698.843011569881;16056.27746751396;17052.403165889198;17135.657286854257;17174.141292935336;15583.844161558382;16312.918435407806;16385.262663180154;16411.58971025725;16442.260098295574;4633.652476064301;5039.244113383003;5040.546350828425;5040.672356296847;5048.570871475929;4915.606751459874;4963.900721985558;4985.277134815449;5012.448630650625;5022.723750193738;4802.519748025187;4985.700857948516;4986.551210391082;4989.800407983695;5000.274960130797;4918.655694101414;4921.138800709861;4940.530649588283;4947.604191664658;4947.802087916497;4275.828966841354;4378.562143785628;4437.977810110929;4449.087936972913;4471;19173.712394314098;19297.903510482498;19828.306009289605;20211.595768084702;20284.290049848183;1707.77798886144;1777.9911100444544;1789.2485156234413;1818.6180902010594;1822.1982327775736;12752;13177.341132943315;13347;13412.262325572186;13463.12489688167;1699.541123896541;1701.2004357951866;1744.8385600343147;1749.5801007758173;1799.7930238022664;46840;60404.09393859096;60767;64367;67930;8866.645334186689;8934.821303573892;9390.812183756287;9404.482753448627;9436.386634868712;12336.383180840921;12464.688382790502;12483.188592741442;12544.623661290176;12556.246625202335;7138.821529461805;7269.454790890704;7320.853582928312;7421.886716992386;7454.180040195574;7054.5061845671335;7070.116235470567;7085.751998680022;7217.314355136254;7247.05788247535;5747.4252574742195;5852.707364631751;5865.149553314745;5909.881802363929;5916.7041647918295;1651.5705916461807;1699.2438364927489;1722.1733567887234;1728.0927513055747;1752.8334808193201;769.2000319667595;819.2299238715589;855.2815634866741;904.9864152149503;946.8532377481501;16312.347506099622;16417.507474775775;16733.91633041827;16941;17172.22724977379;845.2587669401054;860.3418384935529;862.5557837713583;895.5790778334173;922.1516205091332;9752.21982241419;9756.512174391251;9809.852852207223;9838.950805246071;9917;276732;371039;375835.96656133997;375955;379038;63275;76853.23146768572;80847.5957620208;81456.59271703604;81744.59127704443;950.4962369943803;960.7838236396894;982.4301904895144;1010.686687126993;1018.3431686562126;15074.09555426678;15251.542453726406;15262;15288.082715037133;15698.136602486516;36255.81872090622;36584.45123323205;37199.81400092982;37217.25565488621;37302.440463393614;49513.50486495089;49732.254016189065;50754.74622626863;51609.225861611354;52227.47772522378;6889.896651550131;6977.79066628002;7021.1574611047;7136.250693677297;7148.64256787169;8372.832543348977;10470.424126673106;10678.412687302272;10706.62526811589;10772.730681732706;9101.135392137736;9120.133587309196;9133.178013978773;9309;9645.228381729305;9357.766055848659;9475;9605.951970240105;9657.855132172883;9725.562349694423;8902.910970890209;9080.59137338808;9182.816343672956;9336.206422453895;9597.184239339735;6891.483138764713;6935.514513983972;6972.44220462372;7138.750143745152;7264.854702906018;8372.623231954698;8431.40980131385;8645.221930026328;8928.285737140883;9316.813663726824 22:52:58 INFO - PROCESS | 7468 | |3;mootools.html;1393.6376542099053;1414.9787753183705;1506.8568485993826;1677.1111311005172;1711.904381196034;6873.553219040771;7432.219616940224;7462.664180111894;7850.293473587376;7902.130765615785;7645.847083058349;7802.414818888577;7811.453198276123;7859.410544209179;7886.802829929255;2046.1099421751585;2090.226616152026;2091.9058642361056;2093.1836583732356;2096.6121267565472;2112.457905728819;2129.4463439505685;2177.3903307074042;2190.605690975624;2196.187410658059;2054.291269512016;2073.129285700002;2079.7712251652306;2080.8855512946784;2081.354780018199;2135.9038843252015;2156.450105223166;2159.827213822898;2161.945951351213;2162.178372218547;2065.5972085443345;2109.314472796347;2113.3448630924463;2117.925872594452;2123.9787602123934;7857.6856925722905;7913.564753938531;7922.841543169162;7923;7932.920670793276;4426.070525189714;4540.77296135192;4541.613962813165;4544.590986811169;4560.703554268962;2878.136559032282;2906.7529260012925;2929.091981485746;2946.558016297551;2999.5350720638335;807.3961474245511;848.8217474330398;848.8472075026493;854.5855260198798;862.3704695572204;10360.844587331196;10410.739731506697;10452.529636166391;10475.26673132881;10522.368657880475;4153.7300075494995;4224.324108142744;4274.465691788527;4312.870613881589;4316.115196384733;8945.105489451003;9061.22979546746;9066.320025998077;9086.363954523253;9094.954525227331;4673.228917228687;4736.478987311393;4745.786439610226;4765.976170119127;4768.260919557474;3729.5524537055726;4201.768902710381;4310.245707001262;4333.956660433355;4347.804348804311;3640.672339489459;3651.1419816343137;3724.3110024645525;3727.235916637083;3748.2128752962185;1141.7944769941491;1143.1826244235413;1156.3582211872324;1163.2729544034978;1181.3797756177903;717.7954283029312;821.2813787935556;828.5815663090101;835.0647275051981;840.9789755256168;5019.749012549358;5160.7419629018395;5228.816991405359;5240.895182096337;5242.7378631068295;377.3660250778718;390.04828219145196;393.125296215923;395.3496498260346;398.9361702127646;3597.352476554193;3603.261331427051;3668.8715894944085;3675.3935600626132;3720.6093360197333;9296.442213467213;9420.811583768285;9554.570044348022;9598;9606.471644059504;9290.210332121711;9395.859062114074;9401.717948461557;9430.905690943002;9442;7189.820254493679;7325.340719335285;7352.77941661751;7388.44586656003;7407.074115735533;5464.426235245242;5518.144687573433;5605.943940560543;5609.326880774333;5723.7996670116345;8738.563071846509;8911.50986695738;8924.821503570021;8987.281017518713;9015.2787776979;8895.154960278764;9009.909900900908;9034.864477032981;9136.908630913606;9158.816823663356;6642.103316052271;6679.098321726505;6768.695408706719;6884.690188941409;6892.931070689229;7417.851642967218;7448.329650331496;7456.7390141344795;7456.7762967111075;7480.401567874448;6655.23464801554;6798.218204906301;6828.9658551706925;6858.142732158481;6900.896486552605;6471.288158302677;6587.374199451045;6650.634215118215;6698.56459330142;6772.5936443813525;6392.4246817786625;6394.424501794861;6412.23053233615;6434.034894765822;6472.8705425890275;4505.256632655575;4553.089382123655;4571.931421028754;4590.88522786933;4597.149527337453;4495.078508905601;4594.4486661599485;4627.88430289232;4629.259318509157;4638.768061596839 22:52:58 INFO - PROCESS | 7468 | |4;prototype.html;280.2405481146095;284.73235158950587;286.79350867375507;289.1398090680226;293.52742085242755;4792.856214313568;4871.488493708162;4973.651844370891;5052.141136006879;5079.441261461241;4937.23472861707;4955.306257123996;4965.42897566779;4971.726555039471;4985.227289770082;3881.922361552767;3897.142628621699;3897.142628621699;3899.883003509885;3920.705947053968;3611.6568925952124;3928.764274143546;3946.6842652587725;3959.366501359783;3976.4432979382764;3777.3956167013284;3779.848806047755;3782.5082739244;3790.374588192945;3797.373433383488;3788.2234142000825;3801.182745709672;3808.333541630204;3814.275287695329;3856.9807150964066;3330.167458135466;3344.7491438142238;3349.1627093226693;3349.3133907548895;3357.9160520986925;4675.438947326343;4701.600363969067;4775.713457192544;4806.399200099988;4827.562081149033;4222.5566315536735;4238.4490016298;4258.169656916903;4292.1630282095;4304.225239456897;5160.225966105077;5160.483951604847;5162.303089082963;5172.629253247892;5195.974020129913;3471.791692498433;3566.892993210208;3612.259486805199;3612.4581312803025;3626.7279954003293;5431.646942948735;5450.754716037788;5460.453954604547;5473.7263136843;5484.2596249506605;3508.8771892983623;3566.5720113586017;3584.5877724061547;3585.121645196891;3594.335048016073;3626.202235508184;3630.7458477906293;3632.3824949758605;3635.909102272464;3638.526991491089;4104.548499665035;4241.427407299975;4251.128518653669;4270.871873843789;4272.829086836554;5096.337476128079;5109.182530795055;5130.51260130287;5209.140491818884;5214.7914083436235;1216.4404373987888;1269.9873001270055;1309.4173092973726;1317.1965101288206;1325.105553751214;839.4375768235298;842.2167384332507;852.6120615120105;857.7040920882285;858.3819649852221;4094.344904815215;4100.815463304159;4120.91758164835;4125.752454852718;4147.6267135957305;4667.673262871566;4687.32033855096;4711.8350857719815;4750.429948406213;4776.379070720784;4082.408050832613;4089.26393249218;4097.487814023247;4114.341705327133;4138.482689663792;2570.1133109077336;2621.6760535929616;2890.540277160063;2891.479533683957;2895.551189565621;5096.286519887219;5102.897942041212;5105.5149760772665;5111.667741596784;5139.177731562932;5329.387120481194;5531.672398624301;5537.252470916455;5561.860953476114;5562.415946325658;5019.67372120811;5020.246962955513;5050.419201791694;5114.207297868837;5125.46289586657;5362.624616276823;5367.973160134175;5384.246205531151;5414.810481633124;5423.972880135574;5006.424261210008;5259.395169555397;5269.604779641619;5287.735613219401;5310.734463276744;5063.772130254221;5065.696058236517;5075.7969681212335;5104.744762761921;5133.409657889241;3659.743817932719;3681.3189559931498;3699.204670995749;3701.8149092545805;3705.981470092632;5196.844094677014;5377.08589539787;5377.193420986883;5388.38033626138;5389.006067754955;5176.145935920531;5199.828104855959;5215.295935048872;5216.426193118829;5231.503007214308;5147;5186.818461353834;5215.16557350822;5220.869478262922;5233.764480598306;4930.359053323045;5079;5079.238114282887;5080.974595127001;5101.260317253903;5139.871503212449;5139.974300128475;5182.948170518246;5192.636515444034;5260.552853007537;5056.74716264178;5060.544550990281;5063.0380227756605;5073.670211436245;5105.33630628016 22:52:58 INFO - PROCESS | 7468 | |5;yui.html;653.8823011857863;690.3545185251787;696.7073828991823;712.6116266634683;752.9924700752991;10861.294015888961;12237.510499580017;12507.562235321766;12588.685282867933;12603.306818125;11472.942635286832;11511.136664750135;11556.133290003241;11602.825957610621;11621.012213961802;624.073251221935;761.9466637335389;784.619459562112;784.7528028670979;789.4355535791908;787.4920676163871;794.1026639896909;794.2454668065361;795.6300320351036;797.4617133434937;838.8070743728946;843.3295530053622;844.4553263145268;844.7085755414372;846.6105591427951;829.0838623321264;829.3862541719114;833.5915401453275;836.2348451167175;838.4256784102909;613.098744845077;613.310026220502;616.9352218017133;617.2623714660982;618.1994317359031;11210.103191744722;11222.943885280521;11229.887701122965;11231.596050493688;11238.66284011481;12534.310612916286;12782.552610658675;12852.357382130856;12893;12934.54729084487;9765.951170244103;9805.90194098057;9873.308868379216;9964.25268104895;10447.529861156267;3198.712115909579;3209.743220542351;3276.6887145721116;3290.572225610655;3299.637039925606;43219.783901080606;47088;47231.99999999966;47338.289925651145;47481.76259118682;9291.396059256127;9556.888957155477;9624.855627165598;9625.422474651543;9627.326087173831;15850.76223856643;15866;15880.364785408685;15887;15900.443484477988;6364.49084073273;6500.609963402211;6508.772192973223;6581.473482121514;6678.766243181465;3408.1138903885167;3417.743669224818;3557.7153827693724;3577.5885773136424;3605.8312975431636;2805.90179343722;2854.414844956779;2862.227198656351;2916.387558612715;2920.4889144399644;539.3635510098044;539.3851009848697;547.4388751529714;549.2722143160329;554.0498045851384;550.468797610308;583.4328952608556;593.890130325891;600.1567797244878;603.3604379357895;7356.337929586256;7390.176254809034;7397.297256760599;7527.774166775005;7677.884831727529;442.31882900333767;486.47217768721333;543.0415316965559;547.5181839980792;576.4840467781312;3457.775244609092;3503.6146023937345;3521.1725244567506;3529.4705794130573;3619.8552057917386;54501.72749136229;55010.72494637581;55239.17141242885;55438.72280638571;56525.71737141288;49370.259446108335;50294.49705502898;50799;51665;51815.96368072618;45071.77464112724;45987;46437.30344044842;46441;46743.532564673915;7190.388816950618;7241.891371629536;7286.48994570375;7334.559926404433;7360.105529822608;31463.528047078853;31522;31653.366932660756;31702.682973170897;32168.678313217504;38055.23889522139;38988.61011389963;41790;41905.37141942812;42383.3642495369;8675.262602678591;8862.291016718518;9050;9053.456792592466;9090.90909090927;9546.90453095488;9630.759231019281;9820.705378838646;9844.803103937738;9920.751981200528;8819.514926678838;9121.77195570116;9377.906220937703;9451.952740236255;9487.146156845916;8839.69061082859;9069.591868366071;9108.726738197865;9131.543422828965;9255.583498742439;9177.08229177077;9214.44713317203;9215.631374744935;9297.116773906468;9551.856722149312;7773.611319433892;7814.609269536387;7916.327112195298;7966.28303452692;8195.672173113247;7865.842683146419;8040.2361775631225;8213.466124701876;8329.875051874347;8369.832603347777 22:52:58 INFO - PROCESS | 7468 | __end_tp_report 22:52:58 INFO - PROCESS | 7468 | __start_cc_report 22:52:58 INFO - PROCESS | 7468 | _x_x_mozilla_cycle_collect,400 22:52:58 INFO - PROCESS | 7468 | __end_cc_report 22:52:58 INFO - PROCESS | 7468 | __startTimestamp1464673978038__endTimestamp 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - PROCESS | 7468 | ------- Summary: start ------- 22:52:58 INFO - PROCESS | 7468 | Number of tests: 6 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - PROCESS | 7468 | [#0] dojo.html Cycles:165 Average:4722.44 Median:4876.83 stddev:594.72 (12.2%) stddev-sans-first:573.96 22:52:58 INFO - PROCESS | 7468 | Values: 2653.0 2693.6 2709.4 2712.7 2716.3 4671.5 4695.8 4732.1 4809.6 4870.1 4719.8 4723.7 4729.9 4796.5 4829.2 4340.9 4454.5 4507.9 4518.5 4539.9 621.6 4400.6 4465.2 4466.8 4513.9 4341.0 4367.4 4378.0 4385.1 4424.2 4305.1 4375.5 4411.1 4431.4 4451.5 4355.9 4356.2 4360.5 4377.2 4425.8 4695.7 4714.9 4715.3 4745.3 4823.6 5064.4 5065.2 5129.8 5174.0 5186.8 5161.4 5177.6 5179.7 5190.5 5232.4 4767.8 4776.6 4795.3 4798.7 4827.6 5165.9 5226.9 5243.1 5268.2 5357.9 5064.1 5080.3 5087.5 5091.2 5122.4 5194.0 5202.9 5205.7 5206.8 5240.3 4969.3 5062.9 5073.4 5107.8 5121.0 4991.0 5026.2 5049.6 5062.0 5102.0 4321.7 4337.1 4337.2 4337.8 4374.9 3711.6 3728.1 3739.1 3776.2 3830.2 4443.3 4448.9 4450.7 4457.1 4498.0 5132.4 5140.7 5142.4 5145.7 5153.8 4333.4 4418.2 4459.3 4466.9 4469.6 4612.9 4617.8 4623.5 4624.7 4656.9 4692.1 4874.8 4886.5 4905.3 4929.9 5048.9 5070.3 5072.1 5086.1 5103.4 4792.5 4801.9 4826.6 4842.5 4890.9 5000.1 5010.2 5013.0 5085.2 5088.1 5161.5 5199.2 5212.4 5226.5 5280.1 5018.2 5041.1 5046.3 5092.4 5123.7 4876.8 4972.3 4984.7 5055.9 5066.8 4763.4 4901.8 4914.4 4949.1 4976.4 5095.9 5100.7 5100.7 5112.7 5157.9 4874.1 4919.4 4985.6 4992.4 5006.3 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - PROCESS | 7468 | [#1] ext.html Cycles:180 Average:47580.83 Median:38364.90 stddev:88470.25 (230.6%) stddev-sans-first:88648.02 22:52:58 INFO - PROCESS | 7468 | Values: 570.6 586.9 593.8 607.3 621.1 38576.0 40181.2 40516.6 40586.4 44262.0 41988.7 42075.4 42509.6 42524.4 42687.6 7636.7 7760.0 7778.4 7779.1 7802.4 7650.2 7719.2 7719.5 7748.9 7751.2 7709.6 7757.4 7765.9 7769.4 7809.5 7678.2 7707.5 7708.3 7727.2 7757.7 7698.5 7774.1 7775.3 7802.8 7811.8 38212.8 38678.4 38820.6 39051.6 39056.2 2950.3 3050.0 3079.3 3162.2 3601.5 28907.3 29124.4 29222.9 29473.9 30434.1 3229.1 3278.3 3325.9 3333.4 3356.3 257853.0 258799.0 260319.0 262253.0 262326.0 31951.4 51695.0 51787.0 51875.2 51984.5 32655.0 33980.0 33987.7 34198.3 34237.5 13115.9 13235.7 13264.4 13264.5 13266.3 11348.5 11495.2 11503.8 11528.4 11592.3 7859.2 7903.9 7959.7 7983.6 7986.5 3084.5 3111.2 3126.5 3144.3 3154.2 822.9 824.1 853.3 867.4 985.7 27313.2 28387.6 28429.7 28715.3 28813.7 825.4 903.2 905.9 939.7 973.4 14678.6 15056.3 15109.3 15231.8 15241.5 385252.0 387413.0 388479.0 389452.0 390767.0 49017.8 49818.0 50276.2 50277.2 50309.7 1142.3 1150.4 1158.2 1162.0 1166.7 26784.3 27701.6 27877.4 27991.8 28380.4 42668.6 43055.0 43422.0 43446.8 43513.0 341825.0 344263.0 344553.0 345181.0 346230.0 24688.1 25119.2 25225.5 25273.6 25302.1 41983.6 42322.8 42885.4 43795.8 43812.6 35443.0 37266.8 38888.0 39537.4 39641.8 36240.3 37663.8 38517.0 39001.4 39292.0 30359.5 34473.5 35461.0 35933.0 36034.0 32047.7 33520.6 33628.5 33775.7 33966.2 25186.9 25711.4 26064.0 26070.2 26138.9 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - PROCESS | 7468 | [#2] jquery.html Cycles:180 Average:22877.34 Median:4988.18 stddev:59227.34 (1187.4%) stddev-sans-first:59369.35 22:52:58 INFO - PROCESS | 7468 | Values: 352.8 354.9 357.1 358.0 372.7 15698.8 16056.3 17052.4 17135.7 17174.1 15583.8 16312.9 16385.3 16411.6 16442.3 4633.7 5039.2 5040.5 5040.7 5048.6 4915.6 4963.9 4985.3 5012.4 5022.7 4802.5 4985.7 4986.6 4989.8 5000.3 4918.7 4921.1 4940.5 4947.6 4947.8 4275.8 4378.6 4438.0 4449.1 4471.0 19173.7 19297.9 19828.3 20211.6 20284.3 1707.8 1778.0 1789.2 1818.6 1822.2 12752.0 13177.3 13347.0 13412.3 13463.1 1699.5 1701.2 1744.8 1749.6 1799.8 46840.0 60404.1 60767.0 64367.0 67930.0 8866.6 8934.8 9390.8 9404.5 9436.4 12336.4 12464.7 12483.2 12544.6 12556.2 7138.8 7269.5 7320.9 7421.9 7454.2 7054.5 7070.1 7085.8 7217.3 7247.1 5747.4 5852.7 5865.1 5909.9 5916.7 1651.6 1699.2 1722.2 1728.1 1752.8 769.2 819.2 855.3 905.0 946.9 16312.3 16417.5 16733.9 16941.0 17172.2 845.3 860.3 862.6 895.6 922.2 9752.2 9756.5 9809.9 9839.0 9917.0 276732.0 371039.0 375836.0 375955.0 379038.0 63275.0 76853.2 80847.6 81456.6 81744.6 950.5 960.8 982.4 1010.7 1018.3 15074.1 15251.5 15262.0 15288.1 15698.1 36255.8 36584.5 37199.8 37217.3 37302.4 49513.5 49732.3 50754.7 51609.2 52227.5 6889.9 6977.8 7021.2 7136.3 7148.6 8372.8 10470.4 10678.4 10706.6 10772.7 9101.1 9120.1 9133.2 9309.0 9645.2 9357.8 9475.0 9606.0 9657.9 9725.6 8902.9 9080.6 9182.8 9336.2 9597.2 6891.5 6935.5 6972.4 7138.8 7264.9 8372.6 8431.4 8645.2 8928.3 9316.8 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - PROCESS | 7468 | [#3] mootools.html Cycles:180 Average:5117.09 Median:5090.25 stddev:2878.72 (56.6%) stddev-sans-first:2873.20 22:52:58 INFO - PROCESS | 7468 | Values: 1393.6 1415.0 1506.9 1677.1 1711.9 6873.6 7432.2 7462.7 7850.3 7902.1 7645.8 7802.4 7811.5 7859.4 7886.8 2046.1 2090.2 2091.9 2093.2 2096.6 2112.5 2129.4 2177.4 2190.6 2196.2 2054.3 2073.1 2079.8 2080.9 2081.4 2135.9 2156.5 2159.8 2161.9 2162.2 2065.6 2109.3 2113.3 2117.9 2124.0 7857.7 7913.6 7922.8 7923.0 7932.9 4426.1 4540.8 4541.6 4544.6 4560.7 2878.1 2906.8 2929.1 2946.6 2999.5 807.4 848.8 848.8 854.6 862.4 10360.8 10410.7 10452.5 10475.3 10522.4 4153.7 4224.3 4274.5 4312.9 4316.1 8945.1 9061.2 9066.3 9086.4 9095.0 4673.2 4736.5 4745.8 4766.0 4768.3 3729.6 4201.8 4310.2 4334.0 4347.8 3640.7 3651.1 3724.3 3727.2 3748.2 1141.8 1143.2 1156.4 1163.3 1181.4 717.8 821.3 828.6 835.1 841.0 5019.7 5160.7 5228.8 5240.9 5242.7 377.4 390.0 393.1 395.3 398.9 3597.4 3603.3 3668.9 3675.4 3720.6 9296.4 9420.8 9554.6 9598.0 9606.5 9290.2 9395.9 9401.7 9430.9 9442.0 7189.8 7325.3 7352.8 7388.4 7407.1 5464.4 5518.1 5605.9 5609.3 5723.8 8738.6 8911.5 8924.8 8987.3 9015.3 8895.2 9009.9 9034.9 9136.9 9158.8 6642.1 6679.1 6768.7 6884.7 6892.9 7417.9 7448.3 7456.7 7456.8 7480.4 6655.2 6798.2 6829.0 6858.1 6900.9 6471.3 6587.4 6650.6 6698.6 6772.6 6392.4 6394.4 6412.2 6434.0 6472.9 4505.3 4553.1 4571.9 4590.9 4597.1 4495.1 4594.4 4627.9 4629.3 4638.8 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - PROCESS | 7468 | [#4] prototype.html Cycles:180 Average:4242.68 Median:4849.53 stddev:1264.25 (26.1%) stddev-sans-first:1232.31 22:52:58 INFO - PROCESS | 7468 | Values: 280.2 284.7 286.8 289.1 293.5 4792.9 4871.5 4973.7 5052.1 5079.4 4937.2 4955.3 4965.4 4971.7 4985.2 3881.9 3897.1 3897.1 3899.9 3920.7 3611.7 3928.8 3946.7 3959.4 3976.4 3777.4 3779.8 3782.5 3790.4 3797.4 3788.2 3801.2 3808.3 3814.3 3857.0 3330.2 3344.7 3349.2 3349.3 3357.9 4675.4 4701.6 4775.7 4806.4 4827.6 4222.6 4238.4 4258.2 4292.2 4304.2 5160.2 5160.5 5162.3 5172.6 5196.0 3471.8 3566.9 3612.3 3612.5 3626.7 5431.6 5450.8 5460.5 5473.7 5484.3 3508.9 3566.6 3584.6 3585.1 3594.3 3626.2 3630.7 3632.4 3635.9 3638.5 4104.5 4241.4 4251.1 4270.9 4272.8 5096.3 5109.2 5130.5 5209.1 5214.8 1216.4 1270.0 1309.4 1317.2 1325.1 839.4 842.2 852.6 857.7 858.4 4094.3 4100.8 4120.9 4125.8 4147.6 4667.7 4687.3 4711.8 4750.4 4776.4 4082.4 4089.3 4097.5 4114.3 4138.5 2570.1 2621.7 2890.5 2891.5 2895.6 5096.3 5102.9 5105.5 5111.7 5139.2 5329.4 5531.7 5537.3 5561.9 5562.4 5019.7 5020.2 5050.4 5114.2 5125.5 5362.6 5368.0 5384.2 5414.8 5424.0 5006.4 5259.4 5269.6 5287.7 5310.7 5063.8 5065.7 5075.8 5104.7 5133.4 3659.7 3681.3 3699.2 3701.8 3706.0 5196.8 5377.1 5377.2 5388.4 5389.0 5176.1 5199.8 5215.3 5216.4 5231.5 5147.0 5186.8 5215.2 5220.9 5233.8 4930.4 5079.0 5079.2 5081.0 5101.3 5139.9 5140.0 5182.9 5192.6 5260.6 5056.7 5060.5 5063.0 5073.7 5105.3 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - PROCESS | 7468 | [#5] yui.html Cycles:180 Average:12701.48 Median:608.23 stddev:15461.89 (2542.1%) stddev-sans-first:15478.80 22:52:58 INFO - PROCESS | 7468 | Values: 653.9 690.4 696.7 712.6 753.0 10861.3 12237.5 12507.6 12588.7 12603.3 11472.9 11511.1 11556.1 11602.8 11621.0 624.1 761.9 784.6 784.8 789.4 787.5 794.1 794.2 795.6 797.5 838.8 843.3 844.5 844.7 846.6 829.1 829.4 833.6 836.2 838.4 613.1 613.3 616.9 617.3 618.2 11210.1 11222.9 11229.9 11231.6 11238.7 12534.3 12782.6 12852.4 12893.0 12934.5 9766.0 9805.9 9873.3 9964.3 10447.5 3198.7 3209.7 3276.7 3290.6 3299.6 43219.8 47088.0 47232.0 47338.3 47481.8 9291.4 9556.9 9624.9 9625.4 9627.3 15850.8 15866.0 15880.4 15887.0 15900.4 6364.5 6500.6 6508.8 6581.5 6678.8 3408.1 3417.7 3557.7 3577.6 3605.8 2805.9 2854.4 2862.2 2916.4 2920.5 539.4 539.4 547.4 549.3 554.0 550.5 583.4 593.9 600.2 603.4 7356.3 7390.2 7397.3 7527.8 7677.9 442.3 486.5 543.0 547.5 576.5 3457.8 3503.6 3521.2 3529.5 3619.9 54501.7 55010.7 55239.2 55438.7 56525.7 49370.3 50294.5 50799.0 51665.0 51816.0 45071.8 45987.0 46437.3 46441.0 46743.5 7190.4 7241.9 7286.5 7334.6 7360.1 31463.5 31522.0 31653.4 31702.7 32168.7 38055.2 38988.6 41790.0 41905.4 42383.4 8675.3 8862.3 9050.0 9053.5 9090.9 9546.9 9630.8 9820.7 9844.8 9920.8 8819.5 9121.8 9377.9 9452.0 9487.1 8839.7 9069.6 9108.7 9131.5 9255.6 9177.1 9214.4 9215.6 9297.1 9551.9 7773.6 7814.6 7916.3 7966.3 8195.7 7865.8 8040.2 8213.5 8329.9 8369.8 22:52:58 INFO - PROCESS | 7468 | -------- Summary: end -------- 22:52:58 INFO - PROCESS | 7468 | 22:52:58 INFO - TEST-INFO | 7468: exit 0 22:52:58 INFO - TEST-OK | dromaeo_css | took 1115991ms 22:52:58 INFO - TEST-START | kraken 22:52:58 INFO - operating with platform_type : linux_ 22:52:58 INFO - Initialising browser for kraken test... 22:52:58 INFO - TEST-INFO | started process 7707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkVaMS/profile http://localhost:51376/getInfo.html) 22:53:03 INFO - PROCESS | 7707 | __metrics Screen width/height:1600/1200 22:53:03 INFO - PROCESS | 7707 | colorDepth:24 22:53:03 INFO - PROCESS | 7707 | Browser inner width/height: 1024/697 22:53:03 INFO - PROCESS | 7707 | __metrics 22:53:04 ERROR - PROCESS | 7707 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:53:05 INFO - TEST-INFO | 7707: exit 0 22:53:05 INFO - Browser initialized. 22:53:05 INFO - Running cycle 1/1 for kraken test... 22:53:05 INFO - TEST-INFO | started process 7825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkVaMS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:53:17 INFO - PROCESS | 7825 | RSS: Main: 167575552 22:53:17 INFO - PROCESS | 7825 | 22:53:20 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51376/tests/kraken/driver.html?testName=audio-beat-detection) 22:53:21 INFO - PROCESS | 7825 | RSS: Main: 173076480 22:53:21 INFO - PROCESS | 7825 | 22:53:23 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51376/tests/kraken/driver.html?testName=audio-dft) 22:53:24 INFO - PROCESS | 7825 | RSS: Main: 172904448 22:53:24 INFO - PROCESS | 7825 | 22:53:27 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51376/tests/kraken/driver.html?testName=audio-fft) 22:53:28 INFO - PROCESS | 7825 | RSS: Main: 167788544 22:53:28 INFO - PROCESS | 7825 | 22:53:30 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51376/tests/kraken/driver.html?testName=audio-oscillator) 22:53:30 INFO - PROCESS | 7825 | RSS: Main: 168140800 22:53:30 INFO - PROCESS | 7825 | 22:53:33 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:53:33 INFO - PROCESS | 7825 | RSS: Main: 168570880 22:53:33 INFO - PROCESS | 7825 | 22:53:36 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51376/tests/kraken/driver.html?testName=imaging-darkroom) 22:53:37 INFO - PROCESS | 7825 | RSS: Main: 168808448 22:53:37 INFO - PROCESS | 7825 | 22:53:41 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51376/tests/kraken/driver.html?testName=imaging-desaturate) 22:53:41 INFO - PROCESS | 7825 | RSS: Main: 166178816 22:53:41 INFO - PROCESS | 7825 | 22:53:44 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51376/tests/kraken/driver.html?testName=json-parse-financial) 22:53:45 INFO - PROCESS | 7825 | RSS: Main: 167624704 22:53:45 INFO - PROCESS | 7825 | 22:53:47 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:53:47 INFO - PROCESS | 7825 | RSS: Main: 167911424 22:53:47 INFO - PROCESS | 7825 | 22:53:49 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51376/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:53:50 INFO - PROCESS | 7825 | RSS: Main: 167854080 22:53:50 INFO - PROCESS | 7825 | 22:53:52 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:53:53 INFO - PROCESS | 7825 | RSS: Main: 168579072 22:53:53 INFO - PROCESS | 7825 | 22:53:55 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:53:56 INFO - PROCESS | 7825 | RSS: Main: 168878080 22:53:56 INFO - PROCESS | 7825 | 22:53:59 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:54:00 INFO - PROCESS | 7825 | RSS: Main: 168448000 22:54:00 INFO - PROCESS | 7825 | 22:54:01 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:51376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51376/tests/kraken/driver.html?testName=ai-astar) 22:54:02 INFO - PROCESS | 7825 | RSS: Main: 169394176 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | __start_tp_report 22:54:02 INFO - PROCESS | 7825 | _x_x_mozilla_page_load 22:54:02 INFO - PROCESS | 7825 | _x_x_mozilla_page_load_details 22:54:02 INFO - PROCESS | 7825 | |i|pagename|runs| 22:54:02 INFO - PROCESS | 7825 | |0;ai-astar;113;110;115;114;114;114;117;113;112;112 22:54:02 INFO - PROCESS | 7825 | |1;audio-beat-detection;172;132;156;185;130;164;154;134;182;134 22:54:02 INFO - PROCESS | 7825 | |2;audio-dft;164;162;166;167;168;164;163;163;164;161 22:54:02 INFO - PROCESS | 7825 | |3;audio-fft;76;79;76;151;77;78;76;76;160;76 22:54:02 INFO - PROCESS | 7825 | |4;audio-oscillator;85;85;138;86;86;87;138;85;84;143 22:54:02 INFO - PROCESS | 7825 | |5;imaging-gaussian-blur;118;118;117;118;117;120;119;119;118;117 22:54:02 INFO - PROCESS | 7825 | |6;imaging-darkroom;147;147;146;149;148;147;148;149;148;147 22:54:02 INFO - PROCESS | 7825 | |7;imaging-desaturate;96;96;96;95;96;95;95;100;95;96 22:54:02 INFO - PROCESS | 7825 | |8;json-parse-financial;61;63;62;62;62;63;63;63;63;63 22:54:02 INFO - PROCESS | 7825 | |9;json-stringify-tinderbox;65;64;65;66;64;64;65;64;64;65 22:54:02 INFO - PROCESS | 7825 | |10;stanford-crypto-aes;89;89;83;88;83;89;88;84;113;84 22:54:02 INFO - PROCESS | 7825 | |11;stanford-crypto-ccm;134;134;138;130;136;139;141;134;133;141 22:54:02 INFO - PROCESS | 7825 | |12;stanford-crypto-pbkdf2;173;181;174;170;172;167;169;170;170;171 22:54:02 INFO - PROCESS | 7825 | |13;stanford-crypto-sha256-iterative;70;68;76;66;70;65;66;66;67;66 22:54:02 INFO - PROCESS | 7825 | __end_tp_report 22:54:02 INFO - PROCESS | 7825 | __start_cc_report 22:54:02 INFO - PROCESS | 7825 | _x_x_mozilla_cycle_collect,961 22:54:02 INFO - PROCESS | 7825 | __end_cc_report 22:54:02 INFO - PROCESS | 7825 | __startTimestamp1464674042132__endTimestamp 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | ------- Summary: start ------- 22:54:02 INFO - PROCESS | 7825 | Number of tests: 14 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 22:54:02 INFO - PROCESS | 7825 | Values: 113.0 110.0 115.0 114.0 114.0 114.0 117.0 113.0 112.0 112.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:160.00 stddev:21.17 (13.2%) stddev-sans-first:21.46 22:54:02 INFO - PROCESS | 7825 | Values: 172.0 132.0 156.0 185.0 130.0 164.0 154.0 134.0 182.0 134.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.20 (1.3%) stddev-sans-first:2.33 22:54:02 INFO - PROCESS | 7825 | Values: 164.0 162.0 166.0 167.0 168.0 164.0 163.0 163.0 164.0 161.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:33.29 (43.8%) stddev-sans-first:34.77 22:54:02 INFO - PROCESS | 7825 | Values: 76.0 79.0 76.0 151.0 77.0 78.0 76.0 76.0 160.0 76.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:85.00 stddev:26.25 (30.9%) stddev-sans-first:27.13 22:54:02 INFO - PROCESS | 7825 | Values: 85.0 85.0 138.0 86.0 86.0 87.0 138.0 85.0 84.0 143.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 22:54:02 INFO - PROCESS | 7825 | Values: 118.0 118.0 117.0 118.0 117.0 120.0 119.0 119.0 118.0 117.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 22:54:02 INFO - PROCESS | 7825 | Values: 147.0 147.0 146.0 149.0 148.0 147.0 148.0 149.0 148.0 147.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 22:54:02 INFO - PROCESS | 7825 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 100.0 95.0 96.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 22:54:02 INFO - PROCESS | 7825 | Values: 61.0 63.0 62.0 62.0 62.0 63.0 63.0 63.0 63.0 63.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 22:54:02 INFO - PROCESS | 7825 | Values: 65.0 64.0 65.0 66.0 64.0 64.0 65.0 64.0 64.0 65.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:88.00 stddev:8.82 (10.0%) stddev-sans-first:9.35 22:54:02 INFO - PROCESS | 7825 | Values: 89.0 89.0 83.0 88.0 83.0 89.0 88.0 84.0 113.0 84.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:137.00 stddev:3.65 (2.7%) stddev-sans-first:3.80 22:54:02 INFO - PROCESS | 7825 | Values: 134.0 134.0 138.0 130.0 136.0 139.0 141.0 134.0 133.0 141.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:171.50 stddev:3.83 (2.2%) stddev-sans-first:4.03 22:54:02 INFO - PROCESS | 7825 | Values: 173.0 181.0 174.0 170.0 172.0 167.0 169.0 170.0 170.0 171.0 22:54:02 INFO - PROCESS | 7825 | 22:54:02 INFO - PROCESS | 7825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.50 stddev:3.30 (4.9%) stddev-sans-first:3.42 22:54:02 INFO - PROCESS | 7825 | Values: 70.0 68.0 76.0 66.0 70.0 65.0 66.0 66.0 67.0 66.0 22:54:02 INFO - PROCESS | 7825 | -------- Summary: end -------- 22:54:02 INFO - PROCESS | 7825 | 22:54:03 INFO - TEST-INFO | 7825: exit 0 22:54:03 INFO - TEST-OK | kraken | took 64367ms 22:54:03 INFO - SUITE-END | took 1180s 22:54:03 INFO - Completed test suite (00:19:40) 22:54:03 INFO - javascript benchmark 22:54:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6150.705020380149, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.0, 2693.6094266331374, 2709.444563864408, 2712.7016028236876, 2716.293763621459, 4671.4861365249835, 4695.788689508976, 4732.10090082884, 4809.591184749301, 4870.147724148269, 4719.834805781798, 4723.692959957601, 4729.9054018919605, 4796.496367881375, 4829.179039563274, 4340.934885976721, 4454.53227411122, 4507.932381014288, 4518.502964673883, 4539.863804085882, 621.6078018247792, 4400.559944005589, 4465.218586747306, 4466.82132714691, 4513.864584062483, 4341.02326976431, 4367.4322338096, 4378.0, 4385.057212699253, 4424.159409712144, 4305.052888364555, 4375.496817865923, 4411.117776444692, 4431.446069241345, 4451.488078870939, 4355.869323920288, 4356.150550642626, 4360.520342762294, 4377.23398405281, 4425.7565833879125, 4695.718256904596, 4714.858554243378, 4715.31627913954, 4745.335653008547, 4823.614110871122, 5064.442911279756, 5065.1642478990925, 5129.846104616868, 5174.016936781999, 5186.844394668166, 5161.4322424533275, 5177.559907407875, 5179.663321884065, 5190.532852043334, 5232.424433312332, 4767.76161191939, 4776.641751868624, 4795.280707893844, 4798.736069516141, 4827.637927155442, 5165.948340516622, 5226.947730522646, 5243.082460569385, 5268.1834315681135, 5357.892842143136, 5064.11378008847, 5080.339555857715, 5087.491250874883, 5091.210862316347, 5122.359705036871, 5193.974030129825, 5202.895942081137, 5205.7397130143345, 5206.76569554371, 5240.34495688039, 4969.329140566049, 5062.949370506321, 5073.416557095908, 5107.770150343244, 5121.0, 4990.950090499121, 5026.246063090565, 5049.6465247432325, 5062.038212739568, 5101.974490127525, 4321.67587430944, 4337.089211265669, 4337.1976184405985, 4337.783110844445, 4374.890627734332, 3711.55461344635, 3728.067983004249, 3739.121306492972, 3776.169242766587, 3830.214805964826, 4443.289073748185, 4448.866534003985, 4450.710703804242, 4457.130859482435, 4497.977510112429, 5132.409772876167, 5140.691558506502, 5142.357205349332, 5145.716985565755, 5153.819616313411, 4333.43665323506, 4418.226810308183, 4459.308807134899, 4466.932996004997, 4469.5530446955045, 4612.907741845212, 4617.8152873884665, 4623.491415944243, 4624.676272660949, 4656.8602941911795, 4692.1084993851055, 4874.7562621868765, 4886.486918873609, 4905.313256144214, 4929.852104436873, 5048.873778155576, 5070.3155074064525, 5072.061668591323, 5086.109930762176, 5103.4386217516785, 4792.520747925179, 4801.855944321676, 4826.638002149923, 4842.539958703917, 4890.877728056827, 5000.099982003274, 5010.198368261061, 5013.022460620144, 5085.160948443466, 5088.109580823415, 5161.535461808456, 5199.246109314204, 5212.400573934046, 5226.529612334908, 5280.075986702235, 5018.197088465974, 5041.092603331289, 5046.29351890743, 5092.363454568179, 5123.692578445305, 4876.829310974099, 4972.328735620789, 4984.6759960603895, 5055.924161137659, 5066.797328106834, 4763.356946812136, 4901.754912254444, 4914.36113305268, 4949.109160351171, 4976.402831660079, 5095.87260318495, 5100.719460429712, 5100.744962751922, 5112.71880046601, 5157.871053223699, 4874.073925954058, 4919.3604831371695, 4985.576226020684, 4992.400911890596, 5006.274090256965], "value": 4686.745156010916, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6262398129224, 586.879689663619, 593.7892048322844, 607.3319348716412, 621.142822904392, 38575.99999999996, 40181.18731688783, 40516.59483405165, 40586.39120413196, 44262.0, 41988.690622015856, 42075.36886946698, 42509.57490425103, 42524.36213456801, 42687.57312426875, 7636.739937910252, 7759.961200193991, 7778.377729781604, 7779.144294127642, 7802.375809935192, 7650.158482566913, 7719.150893401721, 7719.536827790351, 7748.922510774876, 7751.18612545683, 7709.575973321465, 7757.418193635472, 7765.883511747328, 7769.417293702995, 7809.492382995116, 7678.232176782277, 7707.460477766558, 7708.344790692798, 7727.227277272256, 7757.689692412297, 7698.499597526199, 7774.105977812567, 7775.339096176832, 7802.843943121163, 7811.804704882424, 38212.80893595542, 38678.419823702665, 38820.611793882264, 39051.60948390508, 39056.218875622326, 2950.336174360773, 3050.0392376401364, 3079.2609773654385, 3162.2094476380903, 3601.513795637608, 28907.277318067005, 29124.417511649648, 29222.853885730434, 29473.852630736925, 30434.086977390714, 3229.1281354034513, 3278.2623909620384, 3325.866965321384, 3333.399988002159, 3356.2951780126205, 257853.0, 258799.0, 260319.0, 262253.0, 262326.0, 31951.360972780414, 51695.0, 51787.0, 51875.22187167196, 51984.48015519796, 32655.0, 33980.0, 33987.66012339894, 34198.316033679184, 34237.486437703454, 13115.868841311656, 13235.66910827237, 13264.40310186044, 13264.535741249203, 13266.336683165802, 11348.546058157746, 11495.195336326544, 11503.827442588368, 11528.365939873387, 11592.304461732323, 7859.174786647434, 7903.881441778378, 7959.681612735426, 7983.560904150328, 7986.520808751494, 3084.475639141351, 3111.175538482304, 3126.515390114536, 3144.3239703463864, 3154.242981684379, 822.8560001999626, 824.1058451579983, 853.2875049333752, 867.4058270085012, 985.7190700650281, 27313.180604581896, 28387.59348878148, 28429.71570284312, 28715.2821179468, 28813.711862881522, 825.3768404854417, 903.2187158108189, 905.8777065096259, 939.727479031087, 973.425678849468, 14678.559643210721, 15056.343802181751, 15109.320080596399, 15231.771523427158, 15241.542753717184, 385252.0, 387413.0, 388479.0, 389452.0, 390767.0, 49017.754911225216, 49818.0, 50276.24585631218, 50277.24584131241, 50309.748451258245, 1142.3493052539002, 1150.3902931446346, 1158.2066284594912, 1162.041315914374, 1166.6783101627868, 26784.33039174036, 27701.584476233274, 27877.44245115127, 27991.805921362284, 28380.43239135247, 42668.57331426646, 43055.0, 43422.0, 43446.78276608597, 43513.0, 341825.0, 344263.0, 344553.0, 345181.0, 346230.0, 24688.135915243598, 25119.24642260735, 25225.495490090463, 25273.609951452112, 25302.114425995736, 41983.58016419797, 42322.78838605787, 42885.356719649855, 43795.78102109469, 43812.561874382125, 35443.0, 37266.81366593258, 38888.0, 39537.406938896514, 39641.801790992016, 36240.27519449649, 37663.81168094142, 38517.0, 39001.414978774774, 39292.0, 30359.544606831358, 34473.48289775706, 35461.0, 35933.0, 36034.0, 32047.679523204468, 33520.64793520628, 33628.49557256692, 33775.66224337823, 33966.150846229044, 25186.874065629556, 25711.357216069748, 26064.0, 26070.217893463225, 26138.86930565335], "value": 16577.576188971918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.82358820589707, 354.9201429678324, 357.0591491420108, 358.0315247256172, 372.6646018583276, 15698.843011569881, 16056.27746751396, 17052.403165889198, 17135.657286854257, 17174.141292935336, 15583.844161558382, 16312.918435407806, 16385.262663180154, 16411.58971025725, 16442.260098295574, 4633.652476064301, 5039.244113383003, 5040.546350828425, 5040.672356296847, 5048.570871475929, 4915.606751459874, 4963.900721985558, 4985.277134815449, 5012.448630650625, 5022.723750193738, 4802.519748025187, 4985.700857948516, 4986.551210391082, 4989.800407983695, 5000.274960130797, 4918.655694101414, 4921.138800709861, 4940.530649588283, 4947.604191664658, 4947.802087916497, 4275.828966841354, 4378.562143785628, 4437.977810110929, 4449.087936972913, 4471.0, 19173.712394314098, 19297.903510482498, 19828.306009289605, 20211.595768084702, 20284.290049848183, 1707.77798886144, 1777.9911100444544, 1789.2485156234413, 1818.6180902010594, 1822.1982327775736, 12752.0, 13177.341132943315, 13347.0, 13412.262325572186, 13463.12489688167, 1699.541123896541, 1701.2004357951866, 1744.8385600343147, 1749.5801007758173, 1799.7930238022664, 46840.0, 60404.09393859096, 60767.0, 64367.0, 67930.0, 8866.645334186689, 8934.821303573892, 9390.812183756287, 9404.482753448627, 9436.386634868712, 12336.383180840921, 12464.688382790502, 12483.188592741442, 12544.623661290176, 12556.246625202335, 7138.821529461805, 7269.454790890704, 7320.853582928312, 7421.886716992386, 7454.180040195574, 7054.5061845671335, 7070.116235470567, 7085.751998680022, 7217.314355136254, 7247.05788247535, 5747.4252574742195, 5852.707364631751, 5865.149553314745, 5909.881802363929, 5916.7041647918295, 1651.5705916461807, 1699.2438364927489, 1722.1733567887234, 1728.0927513055747, 1752.8334808193201, 769.2000319667595, 819.2299238715589, 855.2815634866741, 904.9864152149503, 946.8532377481501, 16312.347506099622, 16417.507474775775, 16733.91633041827, 16941.0, 17172.22724977379, 845.2587669401054, 860.3418384935529, 862.5557837713583, 895.5790778334173, 922.1516205091332, 9752.21982241419, 9756.512174391251, 9809.852852207223, 9838.950805246071, 9917.0, 276732.0, 371039.0, 375835.96656133997, 375955.0, 379038.0, 63275.0, 76853.23146768572, 80847.5957620208, 81456.59271703604, 81744.59127704443, 950.4962369943803, 960.7838236396894, 982.4301904895144, 1010.686687126993, 1018.3431686562126, 15074.09555426678, 15251.542453726406, 15262.0, 15288.082715037133, 15698.136602486516, 36255.81872090622, 36584.45123323205, 37199.81400092982, 37217.25565488621, 37302.440463393614, 49513.50486495089, 49732.254016189065, 50754.74622626863, 51609.225861611354, 52227.47772522378, 6889.896651550131, 6977.79066628002, 7021.1574611047, 7136.250693677297, 7148.64256787169, 8372.832543348977, 10470.424126673106, 10678.412687302272, 10706.62526811589, 10772.730681732706, 9101.135392137736, 9120.133587309196, 9133.178013978773, 9309.0, 9645.228381729305, 9357.766055848659, 9475.0, 9605.951970240105, 9657.855132172883, 9725.562349694423, 8902.910970890209, 9080.59137338808, 9182.816343672956, 9336.206422453895, 9597.184239339735, 6891.483138764713, 6935.514513983972, 6972.44220462372, 7138.750143745152, 7264.854702906018, 8372.623231954698, 8431.40980131385, 8645.221930026328, 8928.285737140883, 9316.813663726824], "value": 7951.942462565962, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.6376542099053, 1414.9787753183705, 1506.8568485993826, 1677.1111311005172, 1711.904381196034, 6873.553219040771, 7432.219616940224, 7462.664180111894, 7850.293473587376, 7902.130765615785, 7645.847083058349, 7802.414818888577, 7811.453198276123, 7859.410544209179, 7886.802829929255, 2046.1099421751585, 2090.226616152026, 2091.9058642361056, 2093.1836583732356, 2096.6121267565472, 2112.457905728819, 2129.4463439505685, 2177.3903307074042, 2190.605690975624, 2196.187410658059, 2054.291269512016, 2073.129285700002, 2079.7712251652306, 2080.8855512946784, 2081.354780018199, 2135.9038843252015, 2156.450105223166, 2159.827213822898, 2161.945951351213, 2162.178372218547, 2065.5972085443345, 2109.314472796347, 2113.3448630924463, 2117.925872594452, 2123.9787602123934, 7857.6856925722905, 7913.564753938531, 7922.841543169162, 7923.0, 7932.920670793276, 4426.070525189714, 4540.77296135192, 4541.613962813165, 4544.590986811169, 4560.703554268962, 2878.136559032282, 2906.7529260012925, 2929.091981485746, 2946.558016297551, 2999.5350720638335, 807.3961474245511, 848.8217474330398, 848.8472075026493, 854.5855260198798, 862.3704695572204, 10360.844587331196, 10410.739731506697, 10452.529636166391, 10475.26673132881, 10522.368657880475, 4153.7300075494995, 4224.324108142744, 4274.465691788527, 4312.870613881589, 4316.115196384733, 8945.105489451003, 9061.22979546746, 9066.320025998077, 9086.363954523253, 9094.954525227331, 4673.228917228687, 4736.478987311393, 4745.786439610226, 4765.976170119127, 4768.260919557474, 3729.5524537055726, 4201.768902710381, 4310.245707001262, 4333.956660433355, 4347.804348804311, 3640.672339489459, 3651.1419816343137, 3724.3110024645525, 3727.235916637083, 3748.2128752962185, 1141.7944769941491, 1143.1826244235413, 1156.3582211872324, 1163.2729544034978, 1181.3797756177903, 717.7954283029312, 821.2813787935556, 828.5815663090101, 835.0647275051981, 840.9789755256168, 5019.749012549358, 5160.7419629018395, 5228.816991405359, 5240.895182096337, 5242.7378631068295, 377.3660250778718, 390.04828219145196, 393.125296215923, 395.3496498260346, 398.9361702127646, 3597.352476554193, 3603.261331427051, 3668.8715894944085, 3675.3935600626132, 3720.6093360197333, 9296.442213467213, 9420.811583768285, 9554.570044348022, 9598.0, 9606.471644059504, 9290.210332121711, 9395.859062114074, 9401.717948461557, 9430.905690943002, 9442.0, 7189.820254493679, 7325.340719335285, 7352.77941661751, 7388.44586656003, 7407.074115735533, 5464.426235245242, 5518.144687573433, 5605.943940560543, 5609.326880774333, 5723.7996670116345, 8738.563071846509, 8911.50986695738, 8924.821503570021, 8987.281017518713, 9015.2787776979, 8895.154960278764, 9009.909900900908, 9034.864477032981, 9136.908630913606, 9158.816823663356, 6642.103316052271, 6679.098321726505, 6768.695408706719, 6884.690188941409, 6892.931070689229, 7417.851642967218, 7448.329650331496, 7456.7390141344795, 7456.7762967111075, 7480.401567874448, 6655.23464801554, 6798.218204906301, 6828.9658551706925, 6858.142732158481, 6900.896486552605, 6471.288158302677, 6587.374199451045, 6650.634215118215, 6698.56459330142, 6772.5936443813525, 6392.4246817786625, 6394.424501794861, 6412.23053233615, 6434.034894765822, 6472.8705425890275, 4505.256632655575, 4553.089382123655, 4571.931421028754, 4590.88522786933, 4597.149527337453, 4495.078508905601, 4594.4486661599485, 4627.88430289232, 4629.259318509157, 4638.768061596839], "value": 4031.9157428733306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.2405481146095, 284.73235158950587, 286.79350867375507, 289.1398090680226, 293.52742085242755, 4792.856214313568, 4871.488493708162, 4973.651844370891, 5052.141136006879, 5079.441261461241, 4937.23472861707, 4955.306257123996, 4965.42897566779, 4971.726555039471, 4985.227289770082, 3881.922361552767, 3897.142628621699, 3897.142628621699, 3899.883003509885, 3920.705947053968, 3611.6568925952124, 3928.764274143546, 3946.6842652587725, 3959.366501359783, 3976.4432979382764, 3777.3956167013284, 3779.848806047755, 3782.5082739244, 3790.374588192945, 3797.373433383488, 3788.2234142000825, 3801.182745709672, 3808.333541630204, 3814.275287695329, 3856.9807150964066, 3330.167458135466, 3344.7491438142238, 3349.1627093226693, 3349.3133907548895, 3357.9160520986925, 4675.438947326343, 4701.600363969067, 4775.713457192544, 4806.399200099988, 4827.562081149033, 4222.5566315536735, 4238.4490016298, 4258.169656916903, 4292.1630282095, 4304.225239456897, 5160.225966105077, 5160.483951604847, 5162.303089082963, 5172.629253247892, 5195.974020129913, 3471.791692498433, 3566.892993210208, 3612.259486805199, 3612.4581312803025, 3626.7279954003293, 5431.646942948735, 5450.754716037788, 5460.453954604547, 5473.7263136843, 5484.2596249506605, 3508.8771892983623, 3566.5720113586017, 3584.5877724061547, 3585.121645196891, 3594.335048016073, 3626.202235508184, 3630.7458477906293, 3632.3824949758605, 3635.909102272464, 3638.526991491089, 4104.548499665035, 4241.427407299975, 4251.128518653669, 4270.871873843789, 4272.829086836554, 5096.337476128079, 5109.182530795055, 5130.51260130287, 5209.140491818884, 5214.7914083436235, 1216.4404373987888, 1269.9873001270055, 1309.4173092973726, 1317.1965101288206, 1325.105553751214, 839.4375768235298, 842.2167384332507, 852.6120615120105, 857.7040920882285, 858.3819649852221, 4094.344904815215, 4100.815463304159, 4120.91758164835, 4125.752454852718, 4147.6267135957305, 4667.673262871566, 4687.32033855096, 4711.8350857719815, 4750.429948406213, 4776.379070720784, 4082.408050832613, 4089.26393249218, 4097.487814023247, 4114.341705327133, 4138.482689663792, 2570.1133109077336, 2621.6760535929616, 2890.540277160063, 2891.479533683957, 2895.551189565621, 5096.286519887219, 5102.897942041212, 5105.5149760772665, 5111.667741596784, 5139.177731562932, 5329.387120481194, 5531.672398624301, 5537.252470916455, 5561.860953476114, 5562.415946325658, 5019.67372120811, 5020.246962955513, 5050.419201791694, 5114.207297868837, 5125.46289586657, 5362.624616276823, 5367.973160134175, 5384.246205531151, 5414.810481633124, 5423.972880135574, 5006.424261210008, 5259.395169555397, 5269.604779641619, 5287.735613219401, 5310.734463276744, 5063.772130254221, 5065.696058236517, 5075.7969681212335, 5104.744762761921, 5133.409657889241, 3659.743817932719, 3681.3189559931498, 3699.204670995749, 3701.8149092545805, 3705.981470092632, 5196.844094677014, 5377.08589539787, 5377.193420986883, 5388.38033626138, 5389.006067754955, 5176.145935920531, 5199.828104855959, 5215.295935048872, 5216.426193118829, 5231.503007214308, 5147.0, 5186.818461353834, 5215.16557350822, 5220.869478262922, 5233.764480598306, 4930.359053323045, 5079.0, 5079.238114282887, 5080.974595127001, 5101.260317253903, 5139.871503212449, 5139.974300128475, 5182.948170518246, 5192.636515444034, 5260.552853007537, 5056.74716264178, 5060.544550990281, 5063.0380227756605, 5073.670211436245, 5105.33630628016], "value": 3836.6138210073414, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.8823011857863, 690.3545185251787, 696.7073828991823, 712.6116266634683, 752.9924700752991, 10861.294015888961, 12237.510499580017, 12507.562235321766, 12588.685282867933, 12603.306818125, 11472.942635286832, 11511.136664750135, 11556.133290003241, 11602.825957610621, 11621.012213961802, 624.073251221935, 761.9466637335389, 784.619459562112, 784.7528028670979, 789.4355535791908, 787.4920676163871, 794.1026639896909, 794.2454668065361, 795.6300320351036, 797.4617133434937, 838.8070743728946, 843.3295530053622, 844.4553263145268, 844.7085755414372, 846.6105591427951, 829.0838623321264, 829.3862541719114, 833.5915401453275, 836.2348451167175, 838.4256784102909, 613.098744845077, 613.310026220502, 616.9352218017133, 617.2623714660982, 618.1994317359031, 11210.103191744722, 11222.943885280521, 11229.887701122965, 11231.596050493688, 11238.66284011481, 12534.310612916286, 12782.552610658675, 12852.357382130856, 12893.0, 12934.54729084487, 9765.951170244103, 9805.90194098057, 9873.308868379216, 9964.25268104895, 10447.529861156267, 3198.712115909579, 3209.743220542351, 3276.6887145721116, 3290.572225610655, 3299.637039925606, 43219.783901080606, 47088.0, 47231.99999999966, 47338.289925651145, 47481.76259118682, 9291.396059256127, 9556.888957155477, 9624.855627165598, 9625.422474651543, 9627.326087173831, 15850.76223856643, 15866.0, 15880.364785408685, 15887.0, 15900.443484477988, 6364.49084073273, 6500.609963402211, 6508.772192973223, 6581.473482121514, 6678.766243181465, 3408.1138903885167, 3417.743669224818, 3557.7153827693724, 3577.5885773136424, 3605.8312975431636, 2805.90179343722, 2854.414844956779, 2862.227198656351, 2916.387558612715, 2920.4889144399644, 539.3635510098044, 539.3851009848697, 547.4388751529714, 549.2722143160329, 554.0498045851384, 550.468797610308, 583.4328952608556, 593.890130325891, 600.1567797244878, 603.3604379357895, 7356.337929586256, 7390.176254809034, 7397.297256760599, 7527.774166775005, 7677.884831727529, 442.31882900333767, 486.47217768721333, 543.0415316965559, 547.5181839980792, 576.4840467781312, 3457.775244609092, 3503.6146023937345, 3521.1725244567506, 3529.4705794130573, 3619.8552057917386, 54501.72749136229, 55010.72494637581, 55239.17141242885, 55438.72280638571, 56525.71737141288, 49370.259446108335, 50294.49705502898, 50799.0, 51665.0, 51815.96368072618, 45071.77464112724, 45987.0, 46437.30344044842, 46441.0, 46743.532564673915, 7190.388816950618, 7241.891371629536, 7286.48994570375, 7334.559926404433, 7360.105529822608, 31463.528047078853, 31522.0, 31653.366932660756, 31702.682973170897, 32168.678313217504, 38055.23889522139, 38988.61011389963, 41790.0, 41905.37141942812, 42383.3642495369, 8675.262602678591, 8862.291016718518, 9050.0, 9053.456792592466, 9090.90909090927, 9546.90453095488, 9630.759231019281, 9820.705378838646, 9844.803103937738, 9920.751981200528, 8819.514926678838, 9121.77195570116, 9377.906220937703, 9451.952740236255, 9487.146156845916, 8839.69061082859, 9069.591868366071, 9108.726738197865, 9131.543422828965, 9255.583498742439, 9177.08229177077, 9214.44713317203, 9215.631374744935, 9297.116773906468, 9551.856722149312, 7773.611319433892, 7814.609269536387, 7916.327112195298, 7966.28303452692, 8195.672173113247, 7865.842683146419, 8040.2361775631225, 8213.466124701876, 8329.875051874347, 8369.832603347777], "value": 5664.699455604145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 115.0, 114.0, 114.0, 114.0, 117.0, 113.0, 112.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 132.0, 156.0, 185.0, 130.0, 164.0, 154.0, 134.0, 182.0, 134.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 166.0, 167.0, 168.0, 164.0, 163.0, 163.0, 164.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 151.0, 77.0, 78.0, 76.0, 76.0, 160.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 138.0, 86.0, 86.0, 87.0, 138.0, 85.0, 84.0, 143.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 120.0, 119.0, 119.0, 118.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 149.0, 148.0, 147.0, 148.0, 149.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 100.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 66.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 83.0, 88.0, 83.0, 89.0, 88.0, 84.0, 113.0, 84.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 138.0, 130.0, 136.0, 139.0, 141.0, 134.0, 133.0, 141.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 181.0, 174.0, 170.0, 172.0, 167.0, 169.0, 170.0, 170.0, 171.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 76.0, 66.0, 70.0, 65.0, 66.0, 66.0, 67.0, 66.0], "value": 68.0, "unit": "score"}]}]} 22:54:03 INFO - Return code: 0 22:54:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:54:03 ERROR - # TBPL SUCCESS # 22:54:03 INFO - Running post-action listener: _resource_record_post_action 22:54:03 INFO - ##### 22:54:03 INFO - ##### Finished run-tests step (success) 22:54:03 INFO - ##### 22:54:03 INFO - Running post-run listener: _resource_record_post_run 22:54:03 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 360607744; Read time: 0; Write time: 390492 22:54:03 INFO - TinderboxPrint: CPU usage
13.4% 22:54:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:54:03 INFO - TinderboxPrint: I/O write bytes / time
360,607,744 / 390,492 22:54:03 INFO - TinderboxPrint: CPU idle
8,267.1 (86.5%) 22:54:03 INFO - TinderboxPrint: CPU user
1,229.4 (12.9%) 22:54:03 INFO - TinderboxPrint: Swap in / out
0 / 0 22:54:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 79900672; Read time: 0; Write time: 111040 22:54:03 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 280707072; Read time: 0; Write time: 279452 22:54:04 INFO - Running post-run listener: _upload_blobber_files 22:54:04 INFO - Blob upload gear active. 22:54:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:54:04 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 22:54:04 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'] 22:54:04 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 22:54:04 INFO - (blobuploader) - INFO - Open directory for files ... 22:54:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:54:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:54:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:54:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:54:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:54:06 INFO - (blobuploader) - INFO - Done attempting. 22:54:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:54:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:54:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:54:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:54:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:54:12 INFO - (blobuploader) - INFO - Done attempting. 22:54:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:54:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:54:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:54:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:54:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:54:12 INFO - (blobuploader) - INFO - Done attempting. 22:54:12 INFO - (blobuploader) - INFO - Iteration through files over. 22:54:12 INFO - Return code: 0 22:54:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:54:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:54:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a901cb094108cfc3bd2a5e8e0509e58a54684df33784bc1d58e39b209322cc9679e607681157df83942939a60175c853d8cddc3484662a817b41f1922949cadf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6453ce42d3dca0f75d2780f8f9a7030ea8aadcf6f5bc62fab32c891f5d5252380e28030f47cf763c5f6c1159288b073f965815afdb283d2f17ba876fd6e63536", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9fbee9e6efa8dd6ad185b2e068901981a92fb06adb23fc1d3f24a8f8a09c5b9708ff48e38fa823ac90b1a0717f221a05386fd24447de223a5b6835dfcdf8660"} 22:54:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:54:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:54:12 INFO - Contents: 22:54:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a901cb094108cfc3bd2a5e8e0509e58a54684df33784bc1d58e39b209322cc9679e607681157df83942939a60175c853d8cddc3484662a817b41f1922949cadf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6453ce42d3dca0f75d2780f8f9a7030ea8aadcf6f5bc62fab32c891f5d5252380e28030f47cf763c5f6c1159288b073f965815afdb283d2f17ba876fd6e63536", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9fbee9e6efa8dd6ad185b2e068901981a92fb06adb23fc1d3f24a8f8a09c5b9708ff48e38fa823ac90b1a0717f221a05386fd24447de223a5b6835dfcdf8660"} 22:54:12 INFO - Running post-run listener: copy_logs_to_upload_dir 22:54:12 INFO - Copying logs to upload dir... 22:54:12 INFO - mkdir: /builds/slave/test/build/upload/logs 22:54:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.910514 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-30 22:54:12.425453) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 22:54:12.428936) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064 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/a901cb094108cfc3bd2a5e8e0509e58a54684df33784bc1d58e39b209322cc9679e607681157df83942939a60175c853d8cddc3484662a817b41f1922949cadf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6453ce42d3dca0f75d2780f8f9a7030ea8aadcf6f5bc62fab32c891f5d5252380e28030f47cf763c5f6c1159288b073f965815afdb283d2f17ba876fd6e63536", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9fbee9e6efa8dd6ad185b2e068901981a92fb06adb23fc1d3f24a8f8a09c5b9708ff48e38fa823ac90b1a0717f221a05386fd24447de223a5b6835dfcdf8660"} build_url:https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/PMdak1UFROGFbAec2AVheg/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/a901cb094108cfc3bd2a5e8e0509e58a54684df33784bc1d58e39b209322cc9679e607681157df83942939a60175c853d8cddc3484662a817b41f1922949cadf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6453ce42d3dca0f75d2780f8f9a7030ea8aadcf6f5bc62fab32c891f5d5252380e28030f47cf763c5f6c1159288b073f965815afdb283d2f17ba876fd6e63536", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9fbee9e6efa8dd6ad185b2e068901981a92fb06adb23fc1d3f24a8f8a09c5b9708ff48e38fa823ac90b1a0717f221a05386fd24447de223a5b6835dfcdf8660"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 22:54:12.458868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 22:54:12.459614) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1464672754.664430-1946501064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 22:54:12.544364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 22:54:12.545118) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 22:54:12.545884) ========= ========= Total master_lag: 0.16 =========