builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1463706258.1 results: success (0) buildid: 20160519173313 builduid: c60de48900454dc8870c6eb9adfdce9c revision: 2013e1255bf82c59a3d90ebc69895f62e9a180f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.101676) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.102218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.102560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.168982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.169288) ========= 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=0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 18:04: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% 38.8M=0s 2016-05-19 18:04:18 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117809 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.305712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.306064) ========= 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=0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017970 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.356647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.357009) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2013e1255bf82c59a3d90ebc69895f62e9a180f7 --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 2013e1255bf82c59a3d90ebc69895f62e9a180f7 --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=0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 18:04:18,946 truncating revision to first 12 chars 2016-05-19 18:04:18,946 Setting DEBUG logging. 2016-05-19 18:04:18,946 attempt 1/10 2016-05-19 18:04:18,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2013e1255bf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 18:04:19,206 unpacking tar archive at: fx-team-2013e1255bf8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532838 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.905539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.905902) ========= script_repo_revision: 2013e1255bf82c59a3d90ebc69895f62e9a180f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.906395) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.906739) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 18:04:18.917312) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-19 18:04:18.917647) ========= /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=0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:04:19 INFO - MultiFileLogger online at 20160519 18:04:19 in /builds/slave/test 18:04: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 18:04:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:19 INFO - {'append_to_log': False, 18:04:19 INFO - 'base_work_dir': '/builds/slave/test', 18:04:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:04:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:19 INFO - 'branch': 'Fx-Team-Non-PGO', 18:04:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:19 INFO - 'config_files': ('talos/linux_config.py',), 18:04:19 INFO - 'default_actions': ('clobber', 18:04:19 INFO - 'read-buildbot-config', 18:04:19 INFO - 'download-and-extract', 18:04:19 INFO - 'populate-webroot', 18:04:19 INFO - 'create-virtualenv', 18:04:19 INFO - 'install', 18:04:19 INFO - 'run-tests'), 18:04:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:19 INFO - 'download_minidump_stackwalk': True, 18:04:19 INFO - 'download_symbols': 'ondemand', 18:04:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:04:19 INFO - 'tooltool.py': '/tools/tooltool.py', 18:04:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:04:19 INFO - '/tools/misc-python/virtualenv.py')}, 18:04:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:19 INFO - 'installer_path': 'installer.exe', 18:04:19 INFO - 'log_level': 'info', 18:04:19 INFO - 'log_name': 'talos', 18:04:19 INFO - 'log_to_console': True, 18:04:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:04:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:04:19 INFO - 'opt_config_files': (), 18:04:19 INFO - 'pip_index': False, 18:04:19 INFO - 'sps_profile': False, 18:04:19 INFO - 'sps_profile_interval': 0, 18:04:19 INFO - 'suite': 'dromaeojs-e10s', 18:04:19 INFO - 'system_bits': '32', 18:04:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:19 INFO - 'title': 'talos-linux64-ix-017', 18:04:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:19 INFO - 'use_talos_json': True, 18:04:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:19 INFO - 'work_dir': 'build'} 18:04:19 INFO - ##### 18:04:19 INFO - ##### Running clobber step. 18:04:19 INFO - ##### 18:04:19 INFO - Running pre-action listener: _resource_record_pre_action 18:04:19 INFO - Running main action method: clobber 18:04:19 INFO - rmtree: /builds/slave/test/build 18:04:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:20 INFO - Running post-action listener: _resource_record_post_action 18:04:20 INFO - ##### 18:04:20 INFO - ##### Finished clobber step (success) 18:04:20 INFO - ##### 18:04:20 INFO - ##### 18:04:20 INFO - ##### Running read-buildbot-config step. 18:04:20 INFO - ##### 18:04:20 INFO - Running pre-action listener: _resource_record_pre_action 18:04:20 INFO - Running main action method: read_buildbot_config 18:04:20 INFO - Using buildbot properties: 18:04:20 INFO - { 18:04:20 INFO - "project": "", 18:04:20 INFO - "product": "firefox", 18:04:20 INFO - "script_repo_revision": "production", 18:04:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:04:20 INFO - "repository": "", 18:04:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:04:20 INFO - "buildid": "20160519173313", 18:04:20 INFO - "pgo_build": "False", 18:04:20 INFO - "basedir": "/builds/slave/test", 18:04:20 INFO - "buildnumber": 1280, 18:04:20 INFO - "slavename": "talos-linux64-ix-017", 18:04:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:04:20 INFO - "platform": "ubuntu64_hw", 18:04:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:04:20 INFO - "branch": "fx-team", 18:04:20 INFO - "repo_path": "integration/fx-team", 18:04:20 INFO - "revision": "2013e1255bf82c59a3d90ebc69895f62e9a180f7", 18:04:20 INFO - "stage_platform": "linux64", 18:04:20 INFO - "builduid": "c60de48900454dc8870c6eb9adfdce9c", 18:04:20 INFO - "slavebuilddir": "test" 18:04:20 INFO - } 18:04:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:04:20 INFO - Running post-action listener: _resource_record_post_action 18:04:20 INFO - ##### 18:04:20 INFO - ##### Finished read-buildbot-config step (success) 18:04:20 INFO - ##### 18:04:20 INFO - ##### 18:04:20 INFO - ##### Running download-and-extract step. 18:04:20 INFO - ##### 18:04:20 INFO - Running pre-action listener: _resource_record_pre_action 18:04:20 INFO - Running main action method: download_and_extract 18:04:20 INFO - mkdir: /builds/slave/test/build/tests 18:04: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')]} 18:04:20 INFO - https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:32 INFO - Downloaded 1361 bytes. 18:04:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:04:32 INFO - Using the following test package requirements: 18:04:32 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:04:32 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:04:32 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:04:32 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:32 INFO - u'jsshell-linux-x86_64.zip'], 18:04:32 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:04:32 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:04:32 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:04:32 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:04:32 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:04:32 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:04:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:32 INFO - https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:36 INFO - Downloaded 22813669 bytes. 18:04:36 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'] 18:04:36 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 18:04:37 INFO - Return code: 0 18:04:37 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 18:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:37 INFO - https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:38 INFO - Downloaded 22813669 bytes. 18:04:38 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'] 18:04:38 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 18:04:40 INFO - Return code: 0 18:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:40 INFO - https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:04:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:04:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:04:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:41 INFO - Downloaded 10840359 bytes. 18:04:41 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'] 18:04:41 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 18:04:41 INFO - Return code: 0 18:04:41 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')]} 18:04:41 INFO - https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:04:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:04:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:04:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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 18:04:43 INFO - Downloaded 54811870 bytes. 18:04:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:04:43 INFO - mkdir: /builds/slave/test/properties 18:04:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:04:43 INFO - Writing to file /builds/slave/test/properties/build_url 18:04:43 INFO - Contents: 18:04:43 INFO - build_url:https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:04:44 INFO - Running post-action listener: _resource_record_post_action 18:04:44 INFO - Running post-action listener: set_extra_try_arguments 18:04:44 INFO - ##### 18:04:44 INFO - ##### Finished download-and-extract step (success) 18:04:44 INFO - ##### 18:04:44 INFO - ##### 18:04:44 INFO - ##### Running populate-webroot step. 18:04:44 INFO - ##### 18:04:44 INFO - Running pre-action listener: _resource_record_pre_action 18:04:44 INFO - Running main action method: populate_webroot 18:04:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:04:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:04:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:04:44 INFO - '--tppagecycles', 18:04:44 INFO - '7'], 18:04:44 INFO - 'tests': ['tsvgm']}}, 18:04:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:04:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:04:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:04:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:04:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:44 INFO - 'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:44 INFO - 'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['damp', 'tps']}, 18:04:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:44 INFO - 'tests': ['damp', 'tps']}, 18:04:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['dromaeo_dom']}, 18:04:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:04:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['a11yr', 18:04:44 INFO - 'ts_paint', 18:04:44 INFO - 'tpaint', 18:04:44 INFO - 'sessionrestore', 18:04:44 INFO - 'sessionrestore_no_auto_restore', 18:04:44 INFO - 'tabpaint']}, 18:04:44 INFO - 'other-e10s': {'tests': ['a11yr', 18:04:44 INFO - 'ts_paint', 18:04:44 INFO - 'tpaint', 18:04:44 INFO - 'sessionrestore', 18:04:44 INFO - 'sessionrestore_no_auto_restore', 18:04:44 INFO - 'tabpaint']}, 18:04:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:04:44 INFO - 'ts_paint', 18:04:44 INFO - 'tpaint', 18:04:44 INFO - 'sessionrestore', 18:04:44 INFO - 'sessionrestore_no_auto_restore', 18:04:44 INFO - 'tabpaint']}, 18:04:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:04:44 INFO - 'ts_paint', 18:04:44 INFO - 'tpaint', 18:04:44 INFO - 'sessionrestore', 18:04:44 INFO - 'sessionrestore_no_auto_restore', 18:04:44 INFO - 'tabpaint']}, 18:04:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['a11yr', 18:04:44 INFO - 'ts_paint', 18:04:44 INFO - 'tpaint', 18:04:44 INFO - 'sessionrestore', 18:04:44 INFO - 'sessionrestore_no_auto_restore', 18:04:44 INFO - 'tabpaint']}, 18:04:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['a11yr', 18:04:44 INFO - 'ts_paint', 18:04:44 INFO - 'tpaint', 18:04:44 INFO - 'sessionrestore', 18:04:44 INFO - 'sessionrestore_no_auto_restore', 18:04:44 INFO - 'tabpaint']}, 18:04:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['tsvgx', 18:04:44 INFO - 'tsvgr_opacity', 18:04:44 INFO - 'tart', 18:04:44 INFO - 'tscrollx', 18:04:44 INFO - 'cart']}, 18:04:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:04:44 INFO - 'tsvgr_opacity', 18:04:44 INFO - 'tart', 18:04:44 INFO - 'tscrollx', 18:04:44 INFO - 'cart']}, 18:04:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:44 INFO - 'talos_options': ['--disable-e10s'], 18:04:44 INFO - 'tests': ['tp5o']}, 18:04:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:44 INFO - 'tests': ['tp5o']}, 18:04:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:44 INFO - 'talos_options': ['--disable-e10s', 18:04:44 INFO - '--xperf_path', 18:04:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:44 INFO - 'tests': ['tp5n']}, 18:04:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:44 INFO - 'talos_options': ['--xperf_path', 18:04:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:44 INFO - 'tests': ['tp5n']}}, 18:04:44 INFO - 'talos.zip': {'path': '', 18:04:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:04:44 INFO - Running post-action listener: _resource_record_post_action 18:04:44 INFO - ##### 18:04:44 INFO - ##### Finished populate-webroot step (success) 18:04:44 INFO - ##### 18:04:44 INFO - ##### 18:04:44 INFO - ##### Running create-virtualenv step. 18:04:44 INFO - ##### 18:04:44 INFO - Running pre-action listener: _resource_record_pre_action 18:04:44 INFO - Running main action method: create_virtualenv 18:04:44 INFO - Creating virtualenv /builds/slave/test/build/venv 18:04:44 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 18:04:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:04:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:04:44 INFO - Using real prefix '/usr' 18:04:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:04:45 INFO - Installing distribute.............................................................................................................................................................................................done. 18:04:47 INFO - Installing pip.................done. 18:04:47 INFO - Return code: 0 18:04:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:47 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:04:47 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 18:04:47 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 18:04:47 INFO - Using env: {'DISPLAY': ':0', 18:04:47 INFO - 'HOME': '/home/cltbld', 18:04:47 INFO - 'LANG': 'en_US.UTF-8', 18:04:47 INFO - 'LANGUAGE': 'en_US:en', 18:04:47 INFO - 'LOGNAME': 'cltbld', 18:04:47 INFO - 'MAIL': '/var/mail/cltbld', 18:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:47 INFO - 'MOZ_NO_REMOTE': '1', 18:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:47 INFO - 'NO_EM_RESTART': '1', 18:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:47 INFO - 'PWD': '/builds/slave/test', 18:04:47 INFO - 'SHELL': '/bin/bash', 18:04:47 INFO - 'SHLVL': '1', 18:04:47 INFO - 'TERM': 'linux', 18:04:47 INFO - 'TMOUT': '86400', 18:04:47 INFO - 'USER': 'cltbld', 18:04:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:47 INFO - '_': '/tools/buildbot/bin/python'} 18:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:47 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 18:04:47 INFO - Cleaning up... 18:04:47 INFO - Return code: 0 18:04:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:47 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:04:47 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 18:04:47 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 18:04:47 INFO - Using env: {'DISPLAY': ':0', 18:04:47 INFO - 'HOME': '/home/cltbld', 18:04:47 INFO - 'LANG': 'en_US.UTF-8', 18:04:47 INFO - 'LANGUAGE': 'en_US:en', 18:04:47 INFO - 'LOGNAME': 'cltbld', 18:04:47 INFO - 'MAIL': '/var/mail/cltbld', 18:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:47 INFO - 'MOZ_NO_REMOTE': '1', 18:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:47 INFO - 'NO_EM_RESTART': '1', 18:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:47 INFO - 'PWD': '/builds/slave/test', 18:04:47 INFO - 'SHELL': '/bin/bash', 18:04:47 INFO - 'SHLVL': '1', 18:04:47 INFO - 'TERM': 'linux', 18:04:47 INFO - 'TMOUT': '86400', 18:04:47 INFO - 'USER': 'cltbld', 18:04:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:47 INFO - '_': '/tools/buildbot/bin/python'} 18:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:47 INFO - Downloading/unpacking psutil>=3.1.1 18:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:04:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:49 INFO - Installing collected packages: psutil 18:04:49 INFO - Running setup.py install for psutil 18:04:49 INFO - building 'psutil._psutil_linux' extension 18:04:49 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 18:04:49 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 18:04:49 INFO - building 'psutil._psutil_posix' extension 18:04:49 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 18:04:49 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 18:04:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:50 INFO - Successfully installed psutil 18:04:50 INFO - Cleaning up... 18:04:50 INFO - Return code: 0 18:04:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:50 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:04:50 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 18:04:50 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 18:04:50 INFO - Using env: {'DISPLAY': ':0', 18:04:50 INFO - 'HOME': '/home/cltbld', 18:04:50 INFO - 'LANG': 'en_US.UTF-8', 18:04:50 INFO - 'LANGUAGE': 'en_US:en', 18:04:50 INFO - 'LOGNAME': 'cltbld', 18:04:50 INFO - 'MAIL': '/var/mail/cltbld', 18:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:50 INFO - 'MOZ_NO_REMOTE': '1', 18:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:50 INFO - 'NO_EM_RESTART': '1', 18:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:50 INFO - 'PWD': '/builds/slave/test', 18:04:50 INFO - 'SHELL': '/bin/bash', 18:04:50 INFO - 'SHLVL': '1', 18:04:50 INFO - 'TERM': 'linux', 18:04:50 INFO - 'TMOUT': '86400', 18:04:50 INFO - 'USER': 'cltbld', 18:04:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:50 INFO - '_': '/tools/buildbot/bin/python'} 18:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:04:50 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 18:04:50 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 18:04:50 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 18:04:50 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 18:04:50 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 18:04:50 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 18:04:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:04:52 INFO - Installing collected packages: mozsystemmonitor 18:04:52 INFO - Running setup.py install for mozsystemmonitor 18:04:52 INFO - Successfully installed mozsystemmonitor 18:04:52 INFO - Cleaning up... 18:04:52 INFO - Return code: 0 18:04:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:04: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')]} 18:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04: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')]} 18:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:52 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:04:52 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 18:04:52 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 18:04:52 INFO - Using env: {'DISPLAY': ':0', 18:04:52 INFO - 'HOME': '/home/cltbld', 18:04:52 INFO - 'LANG': 'en_US.UTF-8', 18:04:52 INFO - 'LANGUAGE': 'en_US:en', 18:04:52 INFO - 'LOGNAME': 'cltbld', 18:04:52 INFO - 'MAIL': '/var/mail/cltbld', 18:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:52 INFO - 'MOZ_NO_REMOTE': '1', 18:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:52 INFO - 'NO_EM_RESTART': '1', 18:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:52 INFO - 'PWD': '/builds/slave/test', 18:04:52 INFO - 'SHELL': '/bin/bash', 18:04:52 INFO - 'SHLVL': '1', 18:04:52 INFO - 'TERM': 'linux', 18:04:52 INFO - 'TMOUT': '86400', 18:04:52 INFO - 'USER': 'cltbld', 18:04:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:52 INFO - '_': '/tools/buildbot/bin/python'} 18:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:52 INFO - Downloading/unpacking blobuploader==1.2.4 18:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:54 INFO - Downloading blobuploader-1.2.4.tar.gz 18:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:04:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:04:54 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 18:04:54 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 18:04:54 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 18:04:54 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 18:04:54 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 18:04:54 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 18:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:04:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:04:54 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 18:04:54 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 18:04:54 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 18:04:54 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 18:04:54 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 18:04:54 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 18:04:55 INFO - Downloading docopt-0.6.1.tar.gz 18:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:04:55 INFO - Installing collected packages: blobuploader, requests, docopt 18:04:55 INFO - Running setup.py install for blobuploader 18:04:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:04:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:04:55 INFO - Running setup.py install for requests 18:04:55 INFO - Running setup.py install for docopt 18:04:55 INFO - Successfully installed blobuploader requests docopt 18:04:55 INFO - Cleaning up... 18:04:55 INFO - Return code: 0 18:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04: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')]} 18:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04: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')]} 18:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:55 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:04:55 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 18:04:55 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 18:04:55 INFO - Using env: {'DISPLAY': ':0', 18:04:55 INFO - 'HOME': '/home/cltbld', 18:04:55 INFO - 'LANG': 'en_US.UTF-8', 18:04:55 INFO - 'LANGUAGE': 'en_US:en', 18:04:55 INFO - 'LOGNAME': 'cltbld', 18:04:55 INFO - 'MAIL': '/var/mail/cltbld', 18:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:55 INFO - 'MOZ_NO_REMOTE': '1', 18:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:55 INFO - 'NO_EM_RESTART': '1', 18:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:55 INFO - 'PWD': '/builds/slave/test', 18:04:55 INFO - 'SHELL': '/bin/bash', 18:04:55 INFO - 'SHLVL': '1', 18:04:55 INFO - 'TERM': 'linux', 18:04:55 INFO - 'TMOUT': '86400', 18:04:55 INFO - 'USER': 'cltbld', 18:04:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:55 INFO - '_': '/tools/buildbot/bin/python'} 18:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:56 INFO - Running setup.py (path:/tmp/pip-RqeWFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:56 INFO - Running setup.py (path:/tmp/pip-gt7uzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:56 INFO - Running setup.py (path:/tmp/pip-KRHAXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:56 INFO - Running setup.py (path:/tmp/pip-8CQaxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:56 INFO - Running setup.py (path:/tmp/pip-31BNiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:56 INFO - Running setup.py (path:/tmp/pip-uPHXiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:56 INFO - Running setup.py (path:/tmp/pip-3SuNkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:56 INFO - Running setup.py (path:/tmp/pip-Gs4qcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:56 INFO - Running setup.py (path:/tmp/pip-8O34zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:56 INFO - Running setup.py (path:/tmp/pip-5HNMCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:56 INFO - Running setup.py (path:/tmp/pip-rHuKqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:04:56 INFO - Running setup.py (path:/tmp/pip-_WgATP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:04:56 INFO - Running setup.py (path:/tmp/pip-EZ9xZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:04:56 INFO - Running setup.py (path:/tmp/pip-avDBTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:57 INFO - Running setup.py (path:/tmp/pip-j3bwNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:04:57 INFO - Running setup.py (path:/tmp/pip-JH1DWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:04:57 INFO - Running setup.py (path:/tmp/pip-LaUi5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:04:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:04:57 INFO - Running setup.py install for manifestparser 18:04:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:04:57 INFO - Running setup.py install for mozcrash 18:04:57 INFO - Running setup.py install for mozdebug 18:04:57 INFO - Running setup.py install for mozdevice 18:04:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:04:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:04:57 INFO - Running setup.py install for mozfile 18:04:57 INFO - Running setup.py install for mozhttpd 18:04:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:04:57 INFO - Running setup.py install for mozinfo 18:04:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:04:57 INFO - Running setup.py install for mozInstall 18:04:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for mozleak 18:04:58 INFO - Running setup.py install for mozlog 18:04:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for moznetwork 18:04:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for mozprocess 18:04:58 INFO - Running setup.py install for mozprofile 18:04:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for mozrunner 18:04:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:04:58 INFO - Running setup.py install for mozscreenshot 18:04:58 INFO - Running setup.py install for moztest 18:04:58 INFO - Running setup.py install for mozversion 18:04:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:04:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:04:59 INFO - Cleaning up... 18:04:59 INFO - Return code: 0 18:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04: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')]} 18:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04: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')]} 18:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:59 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:04:59 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 18:04:59 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 18:04:59 INFO - Using env: {'DISPLAY': ':0', 18:04:59 INFO - 'HOME': '/home/cltbld', 18:04:59 INFO - 'LANG': 'en_US.UTF-8', 18:04:59 INFO - 'LANGUAGE': 'en_US:en', 18:04:59 INFO - 'LOGNAME': 'cltbld', 18:04:59 INFO - 'MAIL': '/var/mail/cltbld', 18:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:59 INFO - 'MOZ_NO_REMOTE': '1', 18:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:59 INFO - 'NO_EM_RESTART': '1', 18:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:59 INFO - 'PWD': '/builds/slave/test', 18:04:59 INFO - 'SHELL': '/bin/bash', 18:04:59 INFO - 'SHLVL': '1', 18:04:59 INFO - 'TERM': 'linux', 18:04:59 INFO - 'TMOUT': '86400', 18:04:59 INFO - 'USER': 'cltbld', 18:04:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:59 INFO - '_': '/tools/buildbot/bin/python'} 18:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:59 INFO - Running setup.py (path:/tmp/pip-7yELHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:59 INFO - Running setup.py (path:/tmp/pip-pp_0Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:59 INFO - Running setup.py (path:/tmp/pip-1zIFgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:59 INFO - Running setup.py (path:/tmp/pip-pjMOvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:59 INFO - Running setup.py (path:/tmp/pip-iYjOyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:59 INFO - Running setup.py (path:/tmp/pip-JwzRv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:59 INFO - Running setup.py (path:/tmp/pip-t4_PQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:59 INFO - Running setup.py (path:/tmp/pip-DvbKjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:59 INFO - Running setup.py (path:/tmp/pip-SM5uDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:59 INFO - Running setup.py (path:/tmp/pip-8Hhyiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:59 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)) 18:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:59 INFO - Running setup.py (path:/tmp/pip-qQ8xGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:00 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)) 18:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:00 INFO - Running setup.py (path:/tmp/pip-iP4qiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:00 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)) 18:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:00 INFO - Running setup.py (path:/tmp/pip-jbrrXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:00 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)) 18:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:00 INFO - Running setup.py (path:/tmp/pip-N8wRTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:00 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)) 18:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:00 INFO - Running setup.py (path:/tmp/pip-CJIG_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:00 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)) 18:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:00 INFO - Running setup.py (path:/tmp/pip-7kAi_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:00 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)) 18:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:00 INFO - Running setup.py (path:/tmp/pip-DsQhGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:00 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)) 18:05:00 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)) 18:05:00 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)) 18:05:00 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)) 18:05:00 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)) 18:05:00 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)) 18:05:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:02 INFO - Downloading blessings-1.6.tar.gz 18:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:05:02 INFO - Installing collected packages: blessings 18:05:02 INFO - Running setup.py install for blessings 18:05:02 INFO - Successfully installed blessings 18:05:02 INFO - Cleaning up... 18:05:02 INFO - Return code: 0 18:05:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:02 INFO - Reading from file tmpfile_stdout 18:05:02 INFO - Current package versions: 18:05:02 INFO - argparse == 1.2.1 18:05:02 INFO - blessings == 1.6 18:05:02 INFO - blobuploader == 1.2.4 18:05:02 INFO - docopt == 0.6.1 18:05:02 INFO - manifestparser == 1.1 18:05:02 INFO - mozInstall == 1.12 18:05:02 INFO - mozcrash == 0.17 18:05:02 INFO - mozdebug == 0.1 18:05:02 INFO - mozdevice == 0.48 18:05:02 INFO - mozfile == 1.2 18:05:02 INFO - mozhttpd == 0.7 18:05:02 INFO - mozinfo == 0.9 18:05:02 INFO - mozleak == 0.1 18:05:02 INFO - mozlog == 3.2 18:05:02 INFO - moznetwork == 0.27 18:05:02 INFO - mozprocess == 0.22 18:05:02 INFO - mozprofile == 0.28 18:05:02 INFO - mozrunner == 6.11 18:05:02 INFO - mozscreenshot == 0.1 18:05:02 INFO - mozsystemmonitor == 0.3 18:05:02 INFO - moztest == 0.7 18:05:02 INFO - mozversion == 1.4 18:05:02 INFO - psutil == 3.1.1 18:05:02 INFO - requests == 1.2.3 18:05:02 INFO - wsgiref == 0.1.2 18:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:02 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:05:02 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 18:05:02 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 18:05:02 INFO - Using env: {'DISPLAY': ':0', 18:05:02 INFO - 'HOME': '/home/cltbld', 18:05:02 INFO - 'LANG': 'en_US.UTF-8', 18:05:02 INFO - 'LANGUAGE': 'en_US:en', 18:05:02 INFO - 'LOGNAME': 'cltbld', 18:05:02 INFO - 'MAIL': '/var/mail/cltbld', 18:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:02 INFO - 'MOZ_NO_REMOTE': '1', 18:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:02 INFO - 'NO_EM_RESTART': '1', 18:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:02 INFO - 'PWD': '/builds/slave/test', 18:05:02 INFO - 'SHELL': '/bin/bash', 18:05:02 INFO - 'SHLVL': '1', 18:05:02 INFO - 'TERM': 'linux', 18:05:02 INFO - 'TMOUT': '86400', 18:05:02 INFO - 'USER': 'cltbld', 18:05:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:02 INFO - '_': '/tools/buildbot/bin/python'} 18:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 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)) 18:05:03 INFO - Cleaning up... 18:05:03 INFO - Return code: 0 18:05:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:05:03 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')]} 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 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')]} 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:05:03 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 18:05:03 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 18:05:03 INFO - Using env: {'DISPLAY': ':0', 18:05:03 INFO - 'HOME': '/home/cltbld', 18:05:03 INFO - 'LANG': 'en_US.UTF-8', 18:05:03 INFO - 'LANGUAGE': 'en_US:en', 18:05:03 INFO - 'LOGNAME': 'cltbld', 18:05:03 INFO - 'MAIL': '/var/mail/cltbld', 18:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:03 INFO - 'MOZ_NO_REMOTE': '1', 18:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:03 INFO - 'NO_EM_RESTART': '1', 18:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:03 INFO - 'PWD': '/builds/slave/test', 18:05:03 INFO - 'SHELL': '/bin/bash', 18:05:03 INFO - 'SHLVL': '1', 18:05:03 INFO - 'TERM': 'linux', 18:05:03 INFO - 'TMOUT': '86400', 18:05:03 INFO - 'USER': 'cltbld', 18:05:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:03 INFO - '_': '/tools/buildbot/bin/python'} 18:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:03 INFO - Downloading/unpacking jsonschema 18:05:03 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 18:05:03 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 18:05:03 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 18:05:03 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 18:05:03 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 18:05:03 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 18:05:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:05:05 INFO - Downloading/unpacking functools32 (from jsonschema) 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:05 INFO - Downloading functools32-3.2.3-2.tar.gz 18:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:05:05 INFO - warning: no files found matching '*.txt' 18:05:05 INFO - no previously-included directories found matching 'build' 18:05:05 INFO - no previously-included directories found matching 'dist' 18:05:05 INFO - no previously-included directories found matching '.git*' 18:05:05 INFO - Installing collected packages: jsonschema, functools32 18:05:05 INFO - Running setup.py install for functools32 18:05:05 INFO - warning: no files found matching '*.txt' 18:05:05 INFO - no previously-included directories found matching 'build' 18:05:05 INFO - no previously-included directories found matching 'dist' 18:05:05 INFO - no previously-included directories found matching '.git*' 18:05:05 INFO - Successfully installed jsonschema functools32 18:05:05 INFO - Cleaning up... 18:05:05 INFO - Return code: 0 18:05:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:05 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 0x7f33b463cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, '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': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', '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 18:05:05 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 18:05:05 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 18:05:05 INFO - Using env: {'DISPLAY': ':0', 18:05:05 INFO - 'HOME': '/home/cltbld', 18:05:05 INFO - 'LANG': 'en_US.UTF-8', 18:05:05 INFO - 'LANGUAGE': 'en_US:en', 18:05:05 INFO - 'LOGNAME': 'cltbld', 18:05:05 INFO - 'MAIL': '/var/mail/cltbld', 18:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:05 INFO - 'MOZ_NO_REMOTE': '1', 18:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:05 INFO - 'NO_EM_RESTART': '1', 18:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:05 INFO - 'PWD': '/builds/slave/test', 18:05:05 INFO - 'SHELL': '/bin/bash', 18:05:05 INFO - 'SHLVL': '1', 18:05:05 INFO - 'TERM': 'linux', 18:05:05 INFO - 'TMOUT': '86400', 18:05:05 INFO - 'USER': 'cltbld', 18:05:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:05 INFO - '_': '/tools/buildbot/bin/python'} 18:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:05 INFO - Downloading/unpacking flake8 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:05:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:05:07 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 18:05:07 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 18:05:07 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 18:05:07 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 18:05:07 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 18:05:07 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 18:05:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:05:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:05:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:05:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:05:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:05:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:05:08 INFO - no previously-included directories found matching 'docs/_build' 18:05:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:05:08 INFO - Running setup.py install for pep8 18:05:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:05:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:05:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:05:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:05:08 INFO - no previously-included directories found matching 'docs/_build' 18:05:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:05:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:05:08 INFO - Cleaning up... 18:05:08 INFO - Return code: 0 18:05:08 INFO - Running post-action listener: _resource_record_post_action 18:05:08 INFO - Running post-action listener: _start_resource_monitoring 18:05:08 INFO - Starting resource monitoring. 18:05:08 INFO - ##### 18:05:08 INFO - ##### Finished create-virtualenv step (success) 18:05:08 INFO - ##### 18:05:08 INFO - ##### 18:05:08 INFO - ##### Running install step. 18:05:08 INFO - ##### 18:05:08 INFO - Running pre-action listener: _resource_record_pre_action 18:05:08 INFO - Running main action method: install 18:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:09 INFO - Reading from file tmpfile_stdout 18:05:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:05:09 INFO - Reading from file tmpfile_stdout 18:05:09 INFO - Output received: 18:05:09 INFO - Usage: mozinstall [options] installer 18:05:09 INFO - Options: 18:05:09 INFO - -h, --help show this help message and exit 18:05:09 INFO - -d DEST, --destination=DEST 18:05:09 INFO - Directory to install application into. [default: 18:05:09 INFO - "/builds/slave/test"] 18:05:09 INFO - --app=APP Application being installed. [default: firefox] 18:05:09 INFO - mkdir: /builds/slave/test/build/application 18:05:09 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'] 18:05:09 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 18:05:24 INFO - Reading from file tmpfile_stdout 18:05:24 INFO - Output received: 18:05:24 INFO - /builds/slave/test/build/application/firefox/firefox 18:05:24 INFO - Running post-action listener: _resource_record_post_action 18:05:24 INFO - ##### 18:05:24 INFO - ##### Finished install step (success) 18:05:24 INFO - ##### 18:05:24 INFO - ##### 18:05:24 INFO - ##### Running run-tests step. 18:05:24 INFO - ##### 18:05:24 INFO - Running pre-action listener: _resource_record_pre_action 18:05:24 INFO - Running main action method: run_tests 18:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:05:24 INFO - Python 2.7.3 18:05:24 INFO - Return code: 0 18:05:24 INFO - grabbing minidump binary from tooltool 18:05: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')]} 18:05:24 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 0x1b0e9c0>, '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 0x1b0f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:05:24 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 18:05:24 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 18:05:24 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 18:05:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:05:24 INFO - Return code: 0 18:05:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:05:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:05:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:05:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:05:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:05:25 INFO - Return code: 0 18:05:25 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/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 18:05:25 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/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 18:05:25 INFO - Using env: {'DISPLAY': ':0', 18:05:25 INFO - 'HOME': '/home/cltbld', 18:05:25 INFO - 'LANG': 'en_US.UTF-8', 18:05:25 INFO - 'LANGUAGE': 'en_US:en', 18:05:25 INFO - 'LOGNAME': 'cltbld', 18:05:25 INFO - 'MAIL': '/var/mail/cltbld', 18:05:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:05:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:25 INFO - 'MOZ_NO_REMOTE': '1', 18:05:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:25 INFO - 'NO_EM_RESTART': '1', 18:05:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:25 INFO - 'PWD': '/builds/slave/test', 18:05:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:05:25 INFO - 'SHELL': '/bin/bash', 18:05:25 INFO - 'SHLVL': '1', 18:05:25 INFO - 'TERM': 'linux', 18:05:25 INFO - 'TMOUT': '86400', 18:05:25 INFO - 'USER': 'cltbld', 18:05:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662', 18:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:25 INFO - '_': '/tools/buildbot/bin/python'} 18:05:25 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/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 18:05:26 INFO - mozversion application_buildid: 20160519173313 18:05:26 INFO - mozversion application_changeset: 2013e1255bf82c59a3d90ebc69895f62e9a180f7 18:05:26 INFO - mozversion application_display_name: Nightly 18:05:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:05:26 INFO - mozversion application_name: Firefox 18:05:26 INFO - mozversion application_remotingname: firefox 18:05:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:05:26 INFO - mozversion application_vendor: Mozilla 18:05:26 INFO - mozversion application_version: 49.0a1 18:05:26 INFO - mozversion platform_buildid: 20160519173313 18:05:26 INFO - mozversion platform_changeset: 2013e1255bf82c59a3d90ebc69895f62e9a180f7 18:05:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:05:26 INFO - mozversion platform_version: 49.0a1 18:05:26 INFO - using testdate: 1463706326 18:05:26 INFO - actual date: 1463706326 18:05:26 INFO - starting webserver on 'localhost:55954' 18:05:26 INFO - SUITE-START | Running 2 tests 18:05:26 INFO - TEST-START | dromaeo_css 18:05:26 INFO - operating with platform_type : linux_ 18:05:26 INFO - Initialising browser for dromaeo_css test... 18:05:26 INFO - TEST-INFO | started process 26755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu785vn/profile http://localhost:55954/getInfo.html) 18:05:29 INFO - PROCESS | 26755 | 18:05:29 INFO - PROCESS | 26755 | (process:26821): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:05:30 INFO - PROCESS | 26755 | __metrics Screen width/height:1600/1200 18:05:30 INFO - PROCESS | 26755 | colorDepth:24 18:05:30 INFO - PROCESS | 26755 | Browser inner width/height: 1024/697 18:05:30 INFO - PROCESS | 26755 | __metrics 18:05:31 ERROR - PROCESS | 26755 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 18:05:32 INFO - TEST-INFO | 26755: exit 0 18:05:32 INFO - Browser initialized. 18:05:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:05:32 INFO - TEST-INFO | started process 26872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu785vn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:05:34 INFO - PROCESS | 26872 | 18:05:34 INFO - PROCESS | 26872 | (process:26932): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:05:44 INFO - PROCESS | 26872 | RSS: Main: 165105664 18:05:44 INFO - PROCESS | 26872 | 18:06:33 INFO - PROCESS | 26872 | 1463706393813 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] 18:08:45 INFO - PROCESS | 26872 | Cycle 1(1): loaded http://localhost:55954/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55954/tests/dromaeo/cssquery-ext.html) 18:08:46 INFO - PROCESS | 26872 | RSS: Main: 166219776 18:08:46 INFO - PROCESS | 26872 | 18:11:48 INFO - PROCESS | 26872 | Cycle 1(1): loaded http://localhost:55954/tests/dromaeo/cssquery-ext.html (next: http://localhost:55954/tests/dromaeo/cssquery-jquery.html) 18:11:49 INFO - PROCESS | 26872 | RSS: Main: 167186432 18:11:49 INFO - PROCESS | 26872 | 18:14:51 INFO - PROCESS | 26872 | Cycle 1(1): loaded http://localhost:55954/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55954/tests/dromaeo/cssquery-mootools.html) 18:14:51 INFO - PROCESS | 26872 | RSS: Main: 167849984 18:14:51 INFO - PROCESS | 26872 | 18:17:53 INFO - PROCESS | 26872 | Cycle 1(1): loaded http://localhost:55954/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55954/tests/dromaeo/cssquery-prototype.html) 18:17:54 INFO - PROCESS | 26872 | RSS: Main: 165634048 18:17:54 INFO - PROCESS | 26872 | 18:20:57 INFO - PROCESS | 26872 | Cycle 1(1): loaded http://localhost:55954/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55954/tests/dromaeo/cssquery-yui.html) 18:20:57 INFO - PROCESS | 26872 | RSS: Main: 166727680 18:20:57 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | Cycle 1(1): loaded http://localhost:55954/tests/dromaeo/cssquery-yui.html (next: http://localhost:55954/tests/dromaeo/cssquery-dojo.html) 18:24:00 INFO - PROCESS | 26872 | RSS: Main: 169082880 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | __start_tp_report 18:24:00 INFO - PROCESS | 26872 | _x_x_mozilla_page_load 18:24:00 INFO - PROCESS | 26872 | _x_x_mozilla_page_load_details 18:24:00 INFO - PROCESS | 26872 | |i|pagename|runs| 18:24:00 INFO - PROCESS | 26872 | |0;dojo.html;2670.3057205126665;2688.0457437609653;2697.069511018698;2697.6223328733968;2720.673519177698;4661.510541393156;4686.601638860697;4728.314394412808;4795.904081918359;4817.759112044401;4618.930716039262;4716.787744551495;4728.314394412817;4764.404449443819;4773.427188737348;4297.033167537303;4304.160688665712;4360.6293465055505;4435.46774387074;4442.489113751912;4138.961524094135;4420.756858372788;4448.0436706108185;4454.866354009385;4466.687331886769;4221.577842215754;4300.677449191323;4318.870433886988;4367.912641747163;4450.132224216279;4274.978625106885;4289.656827453796;4292.18448494785;4316.223079845627;4343.5656434356315;4325.07010992635;4328.761918094504;4336.544662810391;4338.58783415575;4387.100644367929;4592.885177870547;4605.078984203173;4618;4635.281531362644;4649.721016738973;5027.773750181251;5056.988602279559;5066.873328166788;5084.389873215201;5121.078205922932;5016.523430274118;5119.87200319995;5132.769025393866;5149.459306772772;5189.610779191576;4772.451168115642;4788.904221915543;4789.856304310876;4790.401199850019;4799.0401919616215;5222.92165617516;5225.399079105876;5252.579793616578;5252.816151434681;5266.131088370453;4874.8537543873745;4906.215005599087;4974.900501990012;5038.067957427887;5053.545180933734;4993.450720420751;5011.749412529359;5035.144025515671;5035.496450355008;5089.134847076006;4913.31213630092;5016.849494515171;5018.573421259234;5078.314427552307;5080.695158290514;4961.7519124044375;5002.949970500248;5058.721770302669;5059.97470012655;5141.562967147759;4363.585459381354;4366.061296821199;4366.868993930188;4378.16814805186;4387.605115539617;3725.4784330193793;3747.9063023424633;3766.7174961877968;3810.218905124498;3819.388897776342;4353.804078816461;4370.67219958498;4371.256886329332;4374.650027997753;4402.801873915681;5058.4435712071645;5070.112730272262;5072.315237442972;5088.898222035538;5128.102582048126;4270.44484217056;4367.541408152162;4403.3174857897075;4418.64650827933;4421.823127074946;4588.426446694163;4605.286180642006;4607.792649330788;4625.283081122431;4661.184292748755;4682.976585117052;4779.832705855348;4792.95207047939;4812.230043193073;4831;5042.9243561345875;5088.135017047037;5099.1331473648825;5120.48795120485;5140.768665409991;4762.452317983476;4796.25658023007;4798.448178459382;4820.469748327611;4844.442889067803;4900.264960255848;5017.774200160929;5047.343845300087;5054.7978080876355;5079.87300317495;5119.539241468286;5140.665856719302;5153.6907785532985;5172.71550064735;5205.427402985744;4985.75071246429;4989.426215985208;4997.125503036881;5003.474635163256;5033.219850923113;4857.295692124551;4866.416030076413;4917.655764096622;4980.5019498049905;4982.900341993068;4762.690425122356;4828.396450443694;4836.347093142381;4858.17411040117;4884.731339776346;5000.924986125284;5008.333915542891;5010.198368261061;5016.272640467185;5051.06555287273;4748.216544270295;4856.902861942812;4892.535209155125;4894.1679914415345;4919.286703428054 18:24:00 INFO - PROCESS | 26872 | |1;ext.html;537.2156651289117;575.0482950716565;603.6378173096143;620.5749061892606;628.7516431009755;34241.48637770432;37676.43485347715;37834;38019.80990095049;38099.42850857236;39803;40530;40718.18563628726;40725.59274407255;41001;7572.0534933133495;7749.108852481952;7757.146713861471;7792.883106753375;7810.882836757453;7649.961750191269;7687.846243075135;7748.031496062992;7757.49576277543;7774.028246469192;7755.6509957051785;7770.145284018781;7773.611319434034;7803.687852485922;7817.804554886116;7726.459147859652;7745.3029227369525;7763.689452421896;7766.922330776676;7772.18392068836;7689.653965571562;7708.730194443224;7772.06735191775;7778.6110694465615;7795;37023.444648330296;37550.06124846874;37609.62390376116;37646.05884852873;37659.623403766156;3070.125014370916;3125.3749250149835;3260.3805276997296;3342.4819153031317;3882.1847412043503;29454;29998.85000575005;30071.09786706402;30137.246568835737;30213.69786302131;3038.229978933076;3048.5579590959187;3142.0887942496647;3149.7007784260686;3173.809571425722;250972;251038.99999999817;251302;251559;252030.35787494882;29397.11808645744;30330.090097297118;30382.240443989078;54804.17793733097;55048.44951550513;32707.345853082807;32847.178820529676;32855;33012;33119;12622.873771262353;12753.489860405665;12759.170653907466;12832.294223817593;12838.229706217657;10818.296810707436;10823.891761082446;10830.241883068267;10835.458227088771;10876;7966.522008679498;7993.080795708452;8002.1997800219515;8057.395695322874;8080;3133.905982820519;3147.244661281276;3155.195425166568;3159.2575744699975;3175.3173067790535;837.4389159263308;847.5169153582399;878.934079943994;883.4566741453959;981.8806560521011;28378.43243135126;29215.123546293646;29426.411471770873;29544.852275738485;29627.25931851678;945.1493655709916;978.1245785022508;979.5445118020012;1044.4203467075845;1055.4669891704793;15099;15255.466058687893;15440.227988600525;15481.535553933174;15542.456014039455;396853;400005;400552;401583;402915;50821;51212.74393628082;51253.48746512562;51612.74193629008;51724.22413663798;1166.6011924593597;1234.4198226833373;1253.642711827125;1255.1465003797323;1270.326726834779;28247.29381765472;29380.706192937796;29450.11649650514;29750.851245743634;30294;44260.336094959246;44719.32921006122;44760.552394475635;44798.328025079;45153.77423112995;282276;284670;285963;288461;288494;25179.370515737253;25187.74812251854;25481.235562933143;25593.744062559137;25604.871975640002;42018.57981420269;42166.57833421749;42562.14875702531;43137;43604.56395436005;36423.81788091148;36465.45301820528;36503.45244821383;36521.634783651825;36866.81566592257;36724.81637591795;37052.81473592615;37065.444018340284;37152.81423592865;37765;35607.82196089003;35642.64357356393;36090;36122.277554448236;36422.4536631956;32963.67036329606;33305.500417494244;33413.49879751854;33685;33693.49459758057;25409.110681126072;25493.61759573645;25556.616650749882;25557.744422555537;25910 18:24:00 INFO - PROCESS | 26872 | |2;jquery.html;355.05909340248337;364.99452508212363;366.1596635721021;371.6079536089426;380.64790069185995;15845.445409410673;16207.75688364674;17294;17416.30334786607;17435.651286974255;16543.83456165438;17069;17871.285148594074;17872.37446689366;17878.463646090604;5094.847154585359;5273.868153296179;5275.841724748264;5280.630355875091;5289.100852855024;5056.064628043805;5215.895682086356;5256.684598924057;5266.104762190437;5266.3943646480575;5155.896882062357;5183.248428977796;5201.297824793661;5238.240455134003;5245.4754524547625;4862.270659401082;5134.0758663440565;5155.896882062357;5167.612429067835;5186;4657.115148121846;4658.906821863544;4662.650301227388;4663.510331415187;4683.672142949961;19992.500187495283;20259.89870050655;20842.68735968962;21206.575868482545;21223.363299101053;1874.6813041782793;1906.818852209038;1995.950101247466;2019.5758890632985;2309.261036468331;13122.540711075066;13586;13765.242911639856;13840.446382144703;14008.579742607739;1728.4900954218535;1774.8640869843312;1798.4784412520353;1837.7059670452797;1884.3122260375;62289.377106228814;65490.01764973577;68446.31553684449;68961.65519172422;69093.65453172752;9758.804823903482;9986.30095893295;10236.641717539851;10367.32612380193;10528.736781580368;14071.85928140726;14129.576112716635;14174.14955102697;14196.077254978394;14262;6835.58986460814;7014.929850701427;7082.150141982995;7085.299528113319;7153.177384600734;6554.901676474857;6628.171478565179;6641.501887358468;6761.560498567577;6775;4189.790510474464;4197.580241975839;4251.6386107180615;4288.656907447396;4527.932081018787;1777.2802015183872;1785.2501949181114;1854.7403363529118;1904.5333893196255;1928.6914093744933;835.4527784301292;867.7353407210861;900.4552245891141;943.2831048403262;997.4115271989416;15853;16722.59729944381;16770.58073548171;17015.91492042532;17134.828651713324;845.2603971524916;884.4339622641514;899.9730008099767;921.6267411698273;925.047201382577;9258.583363748647;9512.38169518979;9539.713808585753;9699.175570076623;9710.817565155296;290995;294263;397371;399139;402782;50371.496285037414;51367.74316128396;57794;64300.35699642944;76425;890.1810334492283;919.3013309884402;921.9585118669676;937.3251259093441;953.2755106119538;15940.442084526985;15944;16093.195340233176;16105.597360066093;16370.590735231715;37454.250914981;37612;37899;38197.42703859389;39237.41143882901;46468.849228075145;51972;53683;53892;54355.72822136022;7477.626118694152;7678.232176782277;7693.115291741521;7736.806579835549;7901.920980790119;10444.477776111013;11393.886061139614;11602.825957610812;11786.941065294961;12272.815907761213;10149.543270552991;10411.271211015157;10593.52329145175;10611.09805666527;10795.136389088697;10148.086672199537;10164.33931794431;10182.694519164437;10237.897621023694;10390.948045259725;10332.483375831029;10365.9481702591;10551.208659350426;10773.784524309627;10849.132069434585;7499.962500187464;7519.586422746802;7522.962385188039;7623.580703061385;7639.04511936008;10138.442385668564;10163.593456261668;10257.58969641206;10430;10488.685339439524 18:24:00 INFO - PROCESS | 26872 | |3;mootools.html;1268.2390565660605;1389.32617680425;1394.6234516680497;1744.0930716027658;1767.0546257752096;6717.865642687143;7424.814379640505;7567.432442566802;7908.327792137668;7912.090109637394;7693.115291741451;7886.053673559181;7928.9207107928905;7938.2855543001115;7981.481203721754;2222.20000799712;2265.6035193841094;2288.336382449088;2294.105298933417;2300.3559003479054;2191.3316438486254;2199.6480563109826;2233.8101261392803;2241.3388050525136;2246.0903334149693;2240.9103635854544;2247.3482690019873;2250.8424410291286;2254.5490901819703;2263.2418139923147;2165.8917054147228;2167.6206663833764;2168.7072245246845;2173.4892300309416;2186.147402513021;2120.385088324384;2130;2139.368886178581;2143.592717383692;2145.184829764695;7727.227277272228;7800;7823.295903368724;7828.452008359417;7850.646720897574;4482.103579284124;4541.250693635546;4546.431696037996;4564.589186973155;4580.9770951145365;2743.369025124213;2797.608334833125;2816.802823802335;2818.4504021715775;2821.39340041892;869.6173683579268;872.0930232558131;897.9146981036791;898.3397203055749;898.4743924803997;10284.845727314096;10286.639967601099;10306.433146176958;10306.587736490457;10307.639232626898;4147.170565886835;4153.397757325231;4163.271427500175;4168.6665066794585;4173.749575025508;8842.557872106498;8899.377043607015;8902.332325075646;8904.777380565538;8909.73270801877;4298.935515967263;4312.5903039211225;4323.718958267703;4340.60934515895;4349.760763157993;3639.4176931690804;3895.5325360956867;4011.197760447922;4098.979505102456;4137.089840235143;3703.2223233121344;3724.0689827543115;3749.4000959846294;3802.6197380262306;3843.404272337792;1207.704112492445;1212.7816992941355;1234.962951111468;1252.1297698099734;1263.444084602772;759;780.6994307191773;853.470848074198;868.639514601446;892.4154678685471;5238.135707608279;5353;5354.651947623392;5490.69801160932;5551.472610102034;405.4283460320992;405.9086705491241;408.2977279080037;412.7667867654765;412.8080442594148;3628.74598778083;3700.481932529448;3702.9814850925573;3706.184639379332;3727.3290807654885;9008.59461324242;9324.90675093254;9359.29805264608;9367.578458969363;9380.906190938003;8929.955350223207;9232.215261702697;9240.722778316662;9313.44119352841;9415.717528474157;7123.394511466479;7326.3040011198855;7350.77947661571;7357.742479013209;7359.300866417789;5200.2199670049795;5442.482964118402;5458.235846981346;5547.750351234285;5648.887022259614;8418.494890306602;8450.239478446969;8558.657653693783;8714.12858714149;8733.650653974024;8648.524331161594;8658.39391242607;8729.956350218208;8744.256738177326;8767.736967890973;6121;6258.624482531062;6457.61254324742;6601.537892347682;6722.495812814156;7512.849743005;7516.285952834472;7578.280063393969;7584.658690358837;7624.771256862081;6394.360563943568;6608.8764909966385;6622.90065649006;6631.171103612049;6699.665016749045;6593.769218077345;6603.339666033358;6634;6652.401283884474;6736.157980252468;6145.66198859067;6146.938530614637;6204.844878877883;6221.2845522765465;6268.655223962726;4336.826526939013;4500.977495112635;4623.907521849612;4731.668783185281;4784.880377990578;4616;4718.669693121448;4755.500672429345;4849.684770489906;4853.514648535118 18:24:00 INFO - PROCESS | 26872 | |4;prototype.html;279.99342364200703;280.4965087667636;284.5447284345048;292.41225137473674;294.3465506575402;4852.223644216926;5008.223725322581;5110.259012443194;5116.820911268106;5137.7688004039865;4991.800327986876;5028.773705183266;5028.974855125728;5048.091343558158;5051.924221136685;3978.940315895257;3981.6018398160095;3999.560048394674;4005.8998525036814;4008.258472182641;3875.275502401418;3976.522817261918;3977.5425826030087;3988.421678856564;4022.4569683092845;3900.1419687668667;3940.4435248076993;3940.8817735467983;3942.6254505822044;3947.98026009871;3944.6982495776324;3951.004742604995;3957.861474848395;3960.980195099006;3970.153878446522;3508.9824550877083;3522.6125126236093;3546.074488546959;3549.2723991581665;3566.5363502744476;4746.501617330199;4789.928151077736;4831.154547954094;4836.685615435021;4906.435759887588;4558.749268790215;4561.996360800618;4566.520515345874;4567.817287308504;4583.587477127075;5293.57651387888;5306.8407947761625;5308.469153084699;5316.813911513079;5340.172273297645;3734.607866174067;3811.561670407883;3813.828377723009;3845.4616353710503;3850.7100121459343;5538.778448862041;5563.221149039137;5565.193047008202;5572.4706152915405;5580.302462192267;3905.9609403906165;3924.274009308287;3928.253631809947;3945.6448919597374;3963.920721585552;3864.864729734502;3949.624785645359;3972.463717398172;3978.1645854370904;3983.362661974128;4447.08834688888;4470.8435204767675;4482.843100491467;4508.706934049276;4511.8195272189405;5299.258103865462;5302.28419163408;5333.5199832015305;5344.167591176682;5375.650582712111;1279.2516377918835;1336.3719052045524;1364.3587513868465;1369.582277405381;1369.6645770373805;840.357126798;873.6505397840788;891.5319457284847;891.6879092317766;897.533282693009;4109.486314210723;4115.382692596075;4121.2993791055;4177.644900183518;4186.3092589722355;4789.8323558675975;4822;4822.0344488140245;4829.468758436569;4830.4444988826735;4106.753594784323;4107.856225032169;4135.56576559463;4178.394132850781;4191.413202151702;2520.911768088108;2550.579154439534;2611.856347900846;2612.542805009116;2630.8026897982727;4509.301058335897;4542.954570454253;4543.159515489645;4554.223852697451;4591.403117594758;4943.3573635427165;4948.233023881304;4987.5760560352055;4992.450830408652;5050.217216331474;4415.558444155623;4429.648957068061;4503.68474206809;4534.977325113353;4541;4804.303376010389;4818.301346304696;4833.468318484894;4852.927206091841;4858.659893807399;4746.881327966828;4762.904741905212;4777.259524773665;4784.803799050237;4795.832145874878;4596.4254468191475;4713.78787954536;5114.693118412907;5153.871153221199;5172.870678233075;3775.867844625425;3798.6011468795377;3840.5583357914197;3847;3858.2283543292015;5272.209168624737;5527.364353099445;5531.9723401382735;5554.583406244628;5556.888862222652;5148.845534633967;5263.184206448007;5264.131418315935;5267.341582302212;5287.8149264777085;5263.710495922608;5293.761780719799;5294.708791016377;5320.2817619620855;5333.599980001593;5078.873028174326;5195.3113289564835;5200.245964335075;5227.477252274742;5237.81667641646;5345.305110335631;5348.465153484621;5378;5379.973100134474;5381.27352807366;5221.2690223368;5222.302751605667;5235.240890070994;5237.214417837355;5245.737713114253 18:24:00 INFO - PROCESS | 26872 | |5;yui.html;633.5691729623854;668.2115104177072;727.2400341642983;750.4934169435629;752.1688534169745;11058.281211721232;11740.882591174086;11751.882481175207;11848.703782405433;13432.529861454852;13673.453061877537;14012.579622611338;14147;14178.220197889112;14196;629.0564153769346;799.8240387114826;809.6235250608465;811.0146172400532;814.5804910471112;796.3907610677836;822.2065706593137;823.086374124721;823.8887750153713;825.0882774534143;845.4842546046938;847.4872702015284;849.3205435651485;853.8377708235415;855.6192494340021;840.4243093480954;841.2092632925091;842.7134774176778;843.1779015459908;846.3990566697652;618.3692633513836;621.6891554222889;622.5082185073786;622.6886556721639;622.9844253893689;12589.93705031469;12630;12695.809562856564;12698.428570714248;12707.809382859265;11331.32012079278;11572.53709851605;11635.185537012412;11787.998020168296;12092.516299348015;9075.27950310559;9328.440293582338;9375.390599611072;9384.90615093854;9530.237580993504;3238.8380580970856;3250.9512357314425;3266.199781053633;3297.653746356646;3311.9006429806905;45248.77375613134;45573.77213113946;45909;46026;46338.30492542581;9087.772805679911;9273.72178834636;9296;9312.161905428544;9427.575759090858;16378.836211637969;16561.08914009717;16564.917175414044;16584.6683066338;16593.170341482877;6361.713722882481;6446.8388290293115;6480.773172938924;6526.510511711641;6593;3666.2667466506273;3684.4104943209495;3706.8517259309865;3752.6810221130963;3784.9432258516144;2636.907708230241;2725.277801382635;2730.12635956496;2735.7811375089946;2737.233574599076;490.35518293444005;508.4838888528147;511.1719015195407;527.6069328350403;566.7955594361981;432.86797526754015;531.3597115475842;543.2557396367002;543.7063985447813;546.701121782902;7562.508436951691;8025.23760242776;8077.192280771876;8084.757457276173;8104.149064348158;509.1573445946964;566.7789562070795;579.2759051186017;582.1587805620837;583.3320847629441;3790.7156963227867;3837.6354246346555;3868.574456809749;3881.670058045098;3945.191235796655;59424.40575594275;59461.405385946455;60673.089903650594;60803.08795368073;60834;54901;55243.44756552383;55776.72111639416;56374;57701;50140.24789628159;50780;50807.49192508101;50815;50963.23555146676;7280.817979550554;7393.704251830081;7444.143923448873;7573.962130189314;7591.424465027271;33051.83474082614;33735;33847;34013.82993085019;34252.31495370129;41080;44224.55775442204;44243.11513769642;44252;44448.77775611231;9664.75838104053;10046.648367307402;10285.9485702571;10544.472776361305;10682.57269709203;10785.62250321235;10813.243072984815;11425.714357141138;11633.53465861356;11714.531418743154;9791.069848364394;10958.12335013213;11003.834942476029;11107;11121.332720036824;10356.741081473023;10596.947015264874;10668.57325706994;10841.241113122005;10940.507677154388;10464.581416743245;10541.367517948947;10747.946260268649;10951.069159121564;11014.724631883946;9328.939484721173;9378.95310523443;9431.151196392357;9502;9710.563024663767;9539.666111686058;9615.182709469773;9620.663276785279;9641.710748677551;9695 18:24:00 INFO - PROCESS | 26872 | __end_tp_report 18:24:00 INFO - PROCESS | 26872 | __start_cc_report 18:24:00 INFO - PROCESS | 26872 | _x_x_mozilla_cycle_collect,358 18:24:00 INFO - PROCESS | 26872 | __end_cc_report 18:24:00 INFO - PROCESS | 26872 | __startTimestamp1463707440371__endTimestamp 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | ------- Summary: start ------- 18:24:00 INFO - PROCESS | 26872 | Number of tests: 6 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | [#0] dojo.html Cycles:165 Average:4693.81 Median:4812.23 stddev:489.55 (10.2%) stddev-sans-first:464.60 18:24:00 INFO - PROCESS | 26872 | Values: 2670.3 2688.0 2697.1 2697.6 2720.7 4661.5 4686.6 4728.3 4795.9 4817.8 4618.9 4716.8 4728.3 4764.4 4773.4 4297.0 4304.2 4360.6 4435.5 4442.5 4139.0 4420.8 4448.0 4454.9 4466.7 4221.6 4300.7 4318.9 4367.9 4450.1 4275.0 4289.7 4292.2 4316.2 4343.6 4325.1 4328.8 4336.5 4338.6 4387.1 4592.9 4605.1 4618.0 4635.3 4649.7 5027.8 5057.0 5066.9 5084.4 5121.1 5016.5 5119.9 5132.8 5149.5 5189.6 4772.5 4788.9 4789.9 4790.4 4799.0 5222.9 5225.4 5252.6 5252.8 5266.1 4874.9 4906.2 4974.9 5038.1 5053.5 4993.5 5011.7 5035.1 5035.5 5089.1 4913.3 5016.8 5018.6 5078.3 5080.7 4961.8 5002.9 5058.7 5060.0 5141.6 4363.6 4366.1 4366.9 4378.2 4387.6 3725.5 3747.9 3766.7 3810.2 3819.4 4353.8 4370.7 4371.3 4374.7 4402.8 5058.4 5070.1 5072.3 5088.9 5128.1 4270.4 4367.5 4403.3 4418.6 4421.8 4588.4 4605.3 4607.8 4625.3 4661.2 4683.0 4779.8 4793.0 4812.2 4831.0 5042.9 5088.1 5099.1 5120.5 5140.8 4762.5 4796.3 4798.4 4820.5 4844.4 4900.3 5017.8 5047.3 5054.8 5079.9 5119.5 5140.7 5153.7 5172.7 5205.4 4985.8 4989.4 4997.1 5003.5 5033.2 4857.3 4866.4 4917.7 4980.5 4982.9 4762.7 4828.4 4836.3 4858.2 4884.7 5000.9 5008.3 5010.2 5016.3 5051.1 4748.2 4856.9 4892.5 4894.2 4919.3 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | [#1] ext.html Cycles:180 Average:45733.34 Median:36444.64 stddev:84178.85 (231.0%) stddev-sans-first:84346.59 18:24:00 INFO - PROCESS | 26872 | Values: 537.2 575.0 603.6 620.6 628.8 34241.5 37676.4 37834.0 38019.8 38099.4 39803.0 40530.0 40718.2 40725.6 41001.0 7572.1 7749.1 7757.1 7792.9 7810.9 7650.0 7687.8 7748.0 7757.5 7774.0 7755.7 7770.1 7773.6 7803.7 7817.8 7726.5 7745.3 7763.7 7766.9 7772.2 7689.7 7708.7 7772.1 7778.6 7795.0 37023.4 37550.1 37609.6 37646.1 37659.6 3070.1 3125.4 3260.4 3342.5 3882.2 29454.0 29998.9 30071.1 30137.2 30213.7 3038.2 3048.6 3142.1 3149.7 3173.8 250972.0 251039.0 251302.0 251559.0 252030.4 29397.1 30330.1 30382.2 54804.2 55048.4 32707.3 32847.2 32855.0 33012.0 33119.0 12622.9 12753.5 12759.2 12832.3 12838.2 10818.3 10823.9 10830.2 10835.5 10876.0 7966.5 7993.1 8002.2 8057.4 8080.0 3133.9 3147.2 3155.2 3159.3 3175.3 837.4 847.5 878.9 883.5 981.9 28378.4 29215.1 29426.4 29544.9 29627.3 945.1 978.1 979.5 1044.4 1055.5 15099.0 15255.5 15440.2 15481.5 15542.5 396853.0 400005.0 400552.0 401583.0 402915.0 50821.0 51212.7 51253.5 51612.7 51724.2 1166.6 1234.4 1253.6 1255.1 1270.3 28247.3 29380.7 29450.1 29750.9 30294.0 44260.3 44719.3 44760.6 44798.3 45153.8 282276.0 284670.0 285963.0 288461.0 288494.0 25179.4 25187.7 25481.2 25593.7 25604.9 42018.6 42166.6 42562.1 43137.0 43604.6 36423.8 36465.5 36503.5 36521.6 36866.8 36724.8 37052.8 37065.4 37152.8 37765.0 35607.8 35642.6 36090.0 36122.3 36422.5 32963.7 33305.5 33413.5 33685.0 33693.5 25409.1 25493.6 25556.6 25557.7 25910.0 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | [#2] jquery.html Cycles:180 Average:23051.87 Median:398255.00 stddev:59428.06 (14.9%) stddev-sans-first:59570.34 18:24:00 INFO - PROCESS | 26872 | Values: 355.1 365.0 366.2 371.6 380.6 15845.4 16207.8 17294.0 17416.3 17435.7 16543.8 17069.0 17871.3 17872.4 17878.5 5094.8 5273.9 5275.8 5280.6 5289.1 5056.1 5215.9 5256.7 5266.1 5266.4 5155.9 5183.2 5201.3 5238.2 5245.5 4862.3 5134.1 5155.9 5167.6 5186.0 4657.1 4658.9 4662.7 4663.5 4683.7 19992.5 20259.9 20842.7 21206.6 21223.4 1874.7 1906.8 1996.0 2019.6 2309.3 13122.5 13586.0 13765.2 13840.4 14008.6 1728.5 1774.9 1798.5 1837.7 1884.3 62289.4 65490.0 68446.3 68961.7 69093.7 9758.8 9986.3 10236.6 10367.3 10528.7 14071.9 14129.6 14174.1 14196.1 14262.0 6835.6 7014.9 7082.2 7085.3 7153.2 6554.9 6628.2 6641.5 6761.6 6775.0 4189.8 4197.6 4251.6 4288.7 4527.9 1777.3 1785.3 1854.7 1904.5 1928.7 835.5 867.7 900.5 943.3 997.4 15853.0 16722.6 16770.6 17015.9 17134.8 845.3 884.4 900.0 921.6 925.0 9258.6 9512.4 9539.7 9699.2 9710.8 290995.0 294263.0 397371.0 399139.0 402782.0 50371.5 51367.7 57794.0 64300.4 76425.0 890.2 919.3 922.0 937.3 953.3 15940.4 15944.0 16093.2 16105.6 16370.6 37454.3 37612.0 37899.0 38197.4 39237.4 46468.8 51972.0 53683.0 53892.0 54355.7 7477.6 7678.2 7693.1 7736.8 7901.9 10444.5 11393.9 11602.8 11786.9 12272.8 10149.5 10411.3 10593.5 10611.1 10795.1 10148.1 10164.3 10182.7 10237.9 10390.9 10332.5 10365.9 10551.2 10773.8 10849.1 7500.0 7519.6 7523.0 7623.6 7639.0 10138.4 10163.6 10257.6 10430.0 10488.7 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | [#3] mootools.html Cycles:180 Average:5063.99 Median:5219.18 stddev:2802.54 (53.7%) stddev-sans-first:2795.88 18:24:00 INFO - PROCESS | 26872 | Values: 1268.2 1389.3 1394.6 1744.1 1767.1 6717.9 7424.8 7567.4 7908.3 7912.1 7693.1 7886.1 7928.9 7938.3 7981.5 2222.2 2265.6 2288.3 2294.1 2300.4 2191.3 2199.6 2233.8 2241.3 2246.1 2240.9 2247.3 2250.8 2254.5 2263.2 2165.9 2167.6 2168.7 2173.5 2186.1 2120.4 2130.0 2139.4 2143.6 2145.2 7727.2 7800.0 7823.3 7828.5 7850.6 4482.1 4541.3 4546.4 4564.6 4581.0 2743.4 2797.6 2816.8 2818.5 2821.4 869.6 872.1 897.9 898.3 898.5 10284.8 10286.6 10306.4 10306.6 10307.6 4147.2 4153.4 4163.3 4168.7 4173.7 8842.6 8899.4 8902.3 8904.8 8909.7 4298.9 4312.6 4323.7 4340.6 4349.8 3639.4 3895.5 4011.2 4099.0 4137.1 3703.2 3724.1 3749.4 3802.6 3843.4 1207.7 1212.8 1235.0 1252.1 1263.4 759.0 780.7 853.5 868.6 892.4 5238.1 5353.0 5354.7 5490.7 5551.5 405.4 405.9 408.3 412.8 412.8 3628.7 3700.5 3703.0 3706.2 3727.3 9008.6 9324.9 9359.3 9367.6 9380.9 8930.0 9232.2 9240.7 9313.4 9415.7 7123.4 7326.3 7350.8 7357.7 7359.3 5200.2 5442.5 5458.2 5547.8 5648.9 8418.5 8450.2 8558.7 8714.1 8733.7 8648.5 8658.4 8730.0 8744.3 8767.7 6121.0 6258.6 6457.6 6601.5 6722.5 7512.8 7516.3 7578.3 7584.7 7624.8 6394.4 6608.9 6622.9 6631.2 6699.7 6593.8 6603.3 6634.0 6652.4 6736.2 6145.7 6146.9 6204.8 6221.3 6268.7 4336.8 4501.0 4623.9 4731.7 4784.9 4616.0 4718.7 4755.5 4849.7 4853.5 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | [#4] prototype.html Cycles:180 Average:4268.50 Median:4655.11 stddev:1232.71 (26.5%) stddev-sans-first:1199.27 18:24:00 INFO - PROCESS | 26872 | Values: 280.0 280.5 284.5 292.4 294.3 4852.2 5008.2 5110.3 5116.8 5137.8 4991.8 5028.8 5029.0 5048.1 5051.9 3978.9 3981.6 3999.6 4005.9 4008.3 3875.3 3976.5 3977.5 3988.4 4022.5 3900.1 3940.4 3940.9 3942.6 3948.0 3944.7 3951.0 3957.9 3961.0 3970.2 3509.0 3522.6 3546.1 3549.3 3566.5 4746.5 4789.9 4831.2 4836.7 4906.4 4558.7 4562.0 4566.5 4567.8 4583.6 5293.6 5306.8 5308.5 5316.8 5340.2 3734.6 3811.6 3813.8 3845.5 3850.7 5538.8 5563.2 5565.2 5572.5 5580.3 3906.0 3924.3 3928.3 3945.6 3963.9 3864.9 3949.6 3972.5 3978.2 3983.4 4447.1 4470.8 4482.8 4508.7 4511.8 5299.3 5302.3 5333.5 5344.2 5375.7 1279.3 1336.4 1364.4 1369.6 1369.7 840.4 873.7 891.5 891.7 897.5 4109.5 4115.4 4121.3 4177.6 4186.3 4789.8 4822.0 4822.0 4829.5 4830.4 4106.8 4107.9 4135.6 4178.4 4191.4 2520.9 2550.6 2611.9 2612.5 2630.8 4509.3 4543.0 4543.2 4554.2 4591.4 4943.4 4948.2 4987.6 4992.5 5050.2 4415.6 4429.6 4503.7 4535.0 4541.0 4804.3 4818.3 4833.5 4852.9 4858.7 4746.9 4762.9 4777.3 4784.8 4795.8 4596.4 4713.8 5114.7 5153.9 5172.9 3775.9 3798.6 3840.6 3847.0 3858.2 5272.2 5527.4 5532.0 5554.6 5556.9 5148.8 5263.2 5264.1 5267.3 5287.8 5263.7 5293.8 5294.7 5320.3 5333.6 5078.9 5195.3 5200.2 5227.5 5237.8 5345.3 5348.5 5378.0 5380.0 5381.3 5221.3 5222.3 5235.2 5237.2 5245.7 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | [#5] yui.html Cycles:180 Average:13617.46 Median:25736.20 stddev:16601.84 (64.5%) stddev-sans-first:16619.78 18:24:00 INFO - PROCESS | 26872 | Values: 633.6 668.2 727.2 750.5 752.2 11058.3 11740.9 11751.9 11848.7 13432.5 13673.5 14012.6 14147.0 14178.2 14196.0 629.1 799.8 809.6 811.0 814.6 796.4 822.2 823.1 823.9 825.1 845.5 847.5 849.3 853.8 855.6 840.4 841.2 842.7 843.2 846.4 618.4 621.7 622.5 622.7 623.0 12589.9 12630.0 12695.8 12698.4 12707.8 11331.3 11572.5 11635.2 11788.0 12092.5 9075.3 9328.4 9375.4 9384.9 9530.2 3238.8 3251.0 3266.2 3297.7 3311.9 45248.8 45573.8 45909.0 46026.0 46338.3 9087.8 9273.7 9296.0 9312.2 9427.6 16378.8 16561.1 16564.9 16584.7 16593.2 6361.7 6446.8 6480.8 6526.5 6593.0 3666.3 3684.4 3706.9 3752.7 3784.9 2636.9 2725.3 2730.1 2735.8 2737.2 490.4 508.5 511.2 527.6 566.8 432.9 531.4 543.3 543.7 546.7 7562.5 8025.2 8077.2 8084.8 8104.1 509.2 566.8 579.3 582.2 583.3 3790.7 3837.6 3868.6 3881.7 3945.2 59424.4 59461.4 60673.1 60803.1 60834.0 54901.0 55243.4 55776.7 56374.0 57701.0 50140.2 50780.0 50807.5 50815.0 50963.2 7280.8 7393.7 7444.1 7574.0 7591.4 33051.8 33735.0 33847.0 34013.8 34252.3 41080.0 44224.6 44243.1 44252.0 44448.8 9664.8 10046.6 10285.9 10544.5 10682.6 10785.6 10813.2 11425.7 11633.5 11714.5 9791.1 10958.1 11003.8 11107.0 11121.3 10356.7 10596.9 10668.6 10841.2 10940.5 10464.6 10541.4 10747.9 10951.1 11014.7 9328.9 9379.0 9431.2 9502.0 9710.6 9539.7 9615.2 9620.7 9641.7 9695.0 18:24:00 INFO - PROCESS | 26872 | -------- Summary: end -------- 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | 18:24:00 INFO - PROCESS | 26872 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 18:24:00 INFO - PROCESS | 26872 | 18:24:01 INFO - TEST-INFO | 26872: exit 0 18:24:01 INFO - TEST-OK | dromaeo_css | took 1114997ms 18:24:01 INFO - TEST-START | kraken 18:24:01 INFO - operating with platform_type : linux_ 18:24:01 INFO - Initialising browser for kraken test... 18:24:01 INFO - TEST-INFO | started process 27109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfZNDUa/profile http://localhost:55954/getInfo.html) 18:24:04 INFO - PROCESS | 27109 | 18:24:04 INFO - PROCESS | 27109 | (process:27178): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:24:05 INFO - PROCESS | 27109 | __metrics Screen width/height:1600/1200 18:24:05 INFO - PROCESS | 27109 | colorDepth:24 18:24:05 INFO - PROCESS | 27109 | Browser inner width/height: 1024/697 18:24:05 INFO - PROCESS | 27109 | __metrics 18:24:05 ERROR - PROCESS | 27109 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 18:24:06 INFO - TEST-INFO | 27109: exit 0 18:24:06 INFO - Browser initialized. 18:24:06 INFO - Running cycle 1/1 for kraken test... 18:24:06 INFO - TEST-INFO | started process 27229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfZNDUa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:08 INFO - PROCESS | 27229 | 18:24:08 INFO - PROCESS | 27229 | (process:27288): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:24:18 INFO - PROCESS | 27229 | RSS: Main: 165593088 18:24:18 INFO - PROCESS | 27229 | 18:24:21 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55954/tests/kraken/driver.html?testName=audio-beat-detection) 18:24:22 INFO - PROCESS | 27229 | RSS: Main: 169357312 18:24:22 INFO - PROCESS | 27229 | 18:24:25 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55954/tests/kraken/driver.html?testName=audio-dft) 18:24:26 INFO - PROCESS | 27229 | RSS: Main: 169095168 18:24:26 INFO - PROCESS | 27229 | 18:24:29 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55954/tests/kraken/driver.html?testName=audio-fft) 18:24:29 INFO - PROCESS | 27229 | RSS: Main: 164749312 18:24:29 INFO - PROCESS | 27229 | 18:24:31 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55954/tests/kraken/driver.html?testName=audio-oscillator) 18:24:32 INFO - PROCESS | 27229 | RSS: Main: 165658624 18:24:32 INFO - PROCESS | 27229 | 18:24:34 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55954/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:24:35 INFO - PROCESS | 27229 | RSS: Main: 165335040 18:24:35 INFO - PROCESS | 27229 | 18:24:38 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55954/tests/kraken/driver.html?testName=imaging-darkroom) 18:24:39 INFO - PROCESS | 27229 | RSS: Main: 165765120 18:24:39 INFO - PROCESS | 27229 | 18:24:43 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55954/tests/kraken/driver.html?testName=imaging-desaturate) 18:24:43 INFO - PROCESS | 27229 | RSS: Main: 163614720 18:24:43 INFO - PROCESS | 27229 | 18:24:46 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55954/tests/kraken/driver.html?testName=json-parse-financial) 18:24:47 INFO - PROCESS | 27229 | RSS: Main: 164331520 18:24:47 INFO - PROCESS | 27229 | 18:24:49 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55954/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:24:49 INFO - PROCESS | 27229 | RSS: Main: 164810752 18:24:49 INFO - PROCESS | 27229 | 18:24:51 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55954/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:24:52 INFO - PROCESS | 27229 | RSS: Main: 165724160 18:24:52 INFO - PROCESS | 27229 | 18:24:54 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55954/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:24:55 INFO - PROCESS | 27229 | RSS: Main: 165769216 18:24:55 INFO - PROCESS | 27229 | 18:24:58 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55954/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:24:58 INFO - PROCESS | 27229 | RSS: Main: 165298176 18:24:58 INFO - PROCESS | 27229 | 18:25:01 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55954/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:25:02 INFO - PROCESS | 27229 | RSS: Main: 165339136 18:25:02 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | Cycle 1(1): loaded http://localhost:55954/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55954/tests/kraken/driver.html?testName=ai-astar) 18:25:04 INFO - PROCESS | 27229 | RSS: Main: 168009728 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | __start_tp_report 18:25:04 INFO - PROCESS | 27229 | _x_x_mozilla_page_load 18:25:04 INFO - PROCESS | 27229 | _x_x_mozilla_page_load_details 18:25:04 INFO - PROCESS | 27229 | |i|pagename|runs| 18:25:04 INFO - PROCESS | 27229 | |0;ai-astar;113;115;107;116;115;117;110;118;116;119 18:25:04 INFO - PROCESS | 27229 | |1;audio-beat-detection;159;132;158;215;132;157;153;132;191;138 18:25:04 INFO - PROCESS | 27229 | |2;audio-dft;164;166;173;163;162;164;163;163;162;165 18:25:04 INFO - PROCESS | 27229 | |3;audio-fft;76;77;76;166;76;77;75;76;169;75 18:25:04 INFO - PROCESS | 27229 | |4;audio-oscillator;93;95;175;95;94;94;136;94;93;141 18:25:04 INFO - PROCESS | 27229 | |5;imaging-gaussian-blur;117;118;118;117;118;117;119;117;118;118 18:25:04 INFO - PROCESS | 27229 | |6;imaging-darkroom;148;148;146;148;148;148;147;147;147;148 18:25:04 INFO - PROCESS | 27229 | |7;imaging-desaturate;95;95;95;97;96;95;96;95;95;95 18:25:04 INFO - PROCESS | 27229 | |8;json-parse-financial;66;66;69;65;65;65;69;67;66;65 18:25:04 INFO - PROCESS | 27229 | |9;json-stringify-tinderbox;64;70;64;64;65;65;65;65;65;65 18:25:04 INFO - PROCESS | 27229 | |10;stanford-crypto-aes;82;82;82;82;82;83;84;84;144;92 18:25:04 INFO - PROCESS | 27229 | |11;stanford-crypto-ccm;127;131;131;129;135;130;138;133;152;131 18:25:04 INFO - PROCESS | 27229 | |12;stanford-crypto-pbkdf2;171;175;175;171;171;172;169;168;168;169 18:25:04 INFO - PROCESS | 27229 | |13;stanford-crypto-sha256-iterative;71;68;70;72;66;67;67;68;68;69 18:25:04 INFO - PROCESS | 27229 | __end_tp_report 18:25:04 INFO - PROCESS | 27229 | __start_cc_report 18:25:04 INFO - PROCESS | 27229 | _x_x_mozilla_cycle_collect,963 18:25:04 INFO - PROCESS | 27229 | __end_cc_report 18:25:04 INFO - PROCESS | 27229 | __startTimestamp1463707504483__endTimestamp 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | ------- Summary: start ------- 18:25:04 INFO - PROCESS | 27229 | Number of tests: 14 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#0] ai-astar Cycles:10 Average:114.60 Median:116.00 stddev:3.69 (3.2%) stddev-sans-first:3.87 18:25:04 INFO - PROCESS | 27229 | Values: 113.0 115.0 107.0 116.0 115.0 117.0 110.0 118.0 116.0 119.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:157.50 stddev:27.44 (17.4%) stddev-sans-first:29.09 18:25:04 INFO - PROCESS | 27229 | Values: 159.0 132.0 158.0 215.0 132.0 157.0 153.0 132.0 191.0 138.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:3.24 (2.0%) stddev-sans-first:3.43 18:25:04 INFO - PROCESS | 27229 | Values: 164.0 166.0 173.0 163.0 162.0 164.0 163.0 163.0 162.0 165.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:38.59 (50.8%) stddev-sans-first:40.36 18:25:04 INFO - PROCESS | 27229 | Values: 76.0 77.0 76.0 166.0 76.0 77.0 75.0 76.0 169.0 75.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:94.00 stddev:29.15 (31.0%) stddev-sans-first:30.18 18:25:04 INFO - PROCESS | 27229 | Values: 93.0 95.0 175.0 95.0 94.0 94.0 136.0 94.0 93.0 141.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 18:25:04 INFO - PROCESS | 27229 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 119.0 117.0 118.0 118.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 18:25:04 INFO - PROCESS | 27229 | Values: 148.0 148.0 146.0 148.0 148.0 148.0 147.0 147.0 147.0 148.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 18:25:04 INFO - PROCESS | 27229 | Values: 95.0 95.0 95.0 97.0 96.0 95.0 96.0 95.0 95.0 95.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.66 18:25:04 INFO - PROCESS | 27229 | Values: 66.0 66.0 69.0 65.0 65.0 65.0 69.0 67.0 66.0 65.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.75 (2.7%) stddev-sans-first:1.80 18:25:04 INFO - PROCESS | 27229 | Values: 64.0 70.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:82.50 stddev:19.32 (23.4%) stddev-sans-first:20.29 18:25:04 INFO - PROCESS | 27229 | Values: 82.0 82.0 82.0 82.0 82.0 83.0 84.0 84.0 144.0 92.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:132.00 stddev:7.13 (5.4%) stddev-sans-first:7.14 18:25:04 INFO - PROCESS | 27229 | Values: 127.0 131.0 131.0 129.0 135.0 130.0 138.0 133.0 152.0 131.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:171.00 stddev:2.56 (1.5%) stddev-sans-first:2.71 18:25:04 INFO - PROCESS | 27229 | Values: 171.0 175.0 175.0 171.0 171.0 172.0 169.0 168.0 168.0 169.0 18:25:04 INFO - PROCESS | 27229 | 18:25:04 INFO - PROCESS | 27229 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.90 (2.8%) stddev-sans-first:1.80 18:25:04 INFO - PROCESS | 27229 | Values: 71.0 68.0 70.0 72.0 66.0 67.0 67.0 68.0 68.0 69.0 18:25:04 INFO - PROCESS | 27229 | -------- Summary: end -------- 18:25:04 INFO - PROCESS | 27229 | 18:25:05 INFO - TEST-INFO | 27229: exit 0 18:25:05 INFO - TEST-OK | kraken | took 64367ms 18:25:05 INFO - SUITE-END | took 1179s 18:25:05 INFO - Completed test suite (00:19:39) 18:25:05 INFO - javascript benchmark 18:25:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6233.264082338835, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2670.3057205126665, 2688.0457437609653, 2697.069511018698, 2697.6223328733968, 2720.673519177698, 4661.510541393156, 4686.601638860697, 4728.314394412808, 4795.904081918359, 4817.759112044401, 4618.930716039262, 4716.787744551495, 4728.314394412817, 4764.404449443819, 4773.427188737348, 4297.033167537303, 4304.160688665712, 4360.6293465055505, 4435.46774387074, 4442.489113751912, 4138.961524094135, 4420.756858372788, 4448.0436706108185, 4454.866354009385, 4466.687331886769, 4221.577842215754, 4300.677449191323, 4318.870433886988, 4367.912641747163, 4450.132224216279, 4274.978625106885, 4289.656827453796, 4292.18448494785, 4316.223079845627, 4343.5656434356315, 4325.07010992635, 4328.761918094504, 4336.544662810391, 4338.58783415575, 4387.100644367929, 4592.885177870547, 4605.078984203173, 4618.0, 4635.281531362644, 4649.721016738973, 5027.773750181251, 5056.988602279559, 5066.873328166788, 5084.389873215201, 5121.078205922932, 5016.523430274118, 5119.87200319995, 5132.769025393866, 5149.459306772772, 5189.610779191576, 4772.451168115642, 4788.904221915543, 4789.856304310876, 4790.401199850019, 4799.0401919616215, 5222.92165617516, 5225.399079105876, 5252.579793616578, 5252.816151434681, 5266.131088370453, 4874.8537543873745, 4906.215005599087, 4974.900501990012, 5038.067957427887, 5053.545180933734, 4993.450720420751, 5011.749412529359, 5035.144025515671, 5035.496450355008, 5089.134847076006, 4913.31213630092, 5016.849494515171, 5018.573421259234, 5078.314427552307, 5080.695158290514, 4961.7519124044375, 5002.949970500248, 5058.721770302669, 5059.97470012655, 5141.562967147759, 4363.585459381354, 4366.061296821199, 4366.868993930188, 4378.16814805186, 4387.605115539617, 3725.4784330193793, 3747.9063023424633, 3766.7174961877968, 3810.218905124498, 3819.388897776342, 4353.804078816461, 4370.67219958498, 4371.256886329332, 4374.650027997753, 4402.801873915681, 5058.4435712071645, 5070.112730272262, 5072.315237442972, 5088.898222035538, 5128.102582048126, 4270.44484217056, 4367.541408152162, 4403.3174857897075, 4418.64650827933, 4421.823127074946, 4588.426446694163, 4605.286180642006, 4607.792649330788, 4625.283081122431, 4661.184292748755, 4682.976585117052, 4779.832705855348, 4792.95207047939, 4812.230043193073, 4831.0, 5042.9243561345875, 5088.135017047037, 5099.1331473648825, 5120.48795120485, 5140.768665409991, 4762.452317983476, 4796.25658023007, 4798.448178459382, 4820.469748327611, 4844.442889067803, 4900.264960255848, 5017.774200160929, 5047.343845300087, 5054.7978080876355, 5079.87300317495, 5119.539241468286, 5140.665856719302, 5153.6907785532985, 5172.71550064735, 5205.427402985744, 4985.75071246429, 4989.426215985208, 4997.125503036881, 5003.474635163256, 5033.219850923113, 4857.295692124551, 4866.416030076413, 4917.655764096622, 4980.5019498049905, 4982.900341993068, 4762.690425122356, 4828.396450443694, 4836.347093142381, 4858.17411040117, 4884.731339776346, 5000.924986125284, 5008.333915542891, 5010.198368261061, 5016.272640467185, 5051.06555287273, 4748.216544270295, 4856.902861942812, 4892.535209155125, 4894.1679914415345, 4919.286703428054], "value": 4663.096062932625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.2156651289117, 575.0482950716565, 603.6378173096143, 620.5749061892606, 628.7516431009755, 34241.48637770432, 37676.43485347715, 37834.0, 38019.80990095049, 38099.42850857236, 39803.0, 40530.0, 40718.18563628726, 40725.59274407255, 41001.0, 7572.0534933133495, 7749.108852481952, 7757.146713861471, 7792.883106753375, 7810.882836757453, 7649.961750191269, 7687.846243075135, 7748.031496062992, 7757.49576277543, 7774.028246469192, 7755.6509957051785, 7770.145284018781, 7773.611319434034, 7803.687852485922, 7817.804554886116, 7726.459147859652, 7745.3029227369525, 7763.689452421896, 7766.922330776676, 7772.18392068836, 7689.653965571562, 7708.730194443224, 7772.06735191775, 7778.6110694465615, 7795.0, 37023.444648330296, 37550.06124846874, 37609.62390376116, 37646.05884852873, 37659.623403766156, 3070.125014370916, 3125.3749250149835, 3260.3805276997296, 3342.4819153031317, 3882.1847412043503, 29454.0, 29998.85000575005, 30071.09786706402, 30137.246568835737, 30213.69786302131, 3038.229978933076, 3048.5579590959187, 3142.0887942496647, 3149.7007784260686, 3173.809571425722, 250972.0, 251038.99999999817, 251302.0, 251559.0, 252030.35787494882, 29397.11808645744, 30330.090097297118, 30382.240443989078, 54804.17793733097, 55048.44951550513, 32707.345853082807, 32847.178820529676, 32855.0, 33012.0, 33119.0, 12622.873771262353, 12753.489860405665, 12759.170653907466, 12832.294223817593, 12838.229706217657, 10818.296810707436, 10823.891761082446, 10830.241883068267, 10835.458227088771, 10876.0, 7966.522008679498, 7993.080795708452, 8002.1997800219515, 8057.395695322874, 8080.0, 3133.905982820519, 3147.244661281276, 3155.195425166568, 3159.2575744699975, 3175.3173067790535, 837.4389159263308, 847.5169153582399, 878.934079943994, 883.4566741453959, 981.8806560521011, 28378.43243135126, 29215.123546293646, 29426.411471770873, 29544.852275738485, 29627.25931851678, 945.1493655709916, 978.1245785022508, 979.5445118020012, 1044.4203467075845, 1055.4669891704793, 15099.0, 15255.466058687893, 15440.227988600525, 15481.535553933174, 15542.456014039455, 396853.0, 400005.0, 400552.0, 401583.0, 402915.0, 50821.0, 51212.74393628082, 51253.48746512562, 51612.74193629008, 51724.22413663798, 1166.6011924593597, 1234.4198226833373, 1253.642711827125, 1255.1465003797323, 1270.326726834779, 28247.29381765472, 29380.706192937796, 29450.11649650514, 29750.851245743634, 30294.0, 44260.336094959246, 44719.32921006122, 44760.552394475635, 44798.328025079, 45153.77423112995, 282276.0, 284670.0, 285963.0, 288461.0, 288494.0, 25179.370515737253, 25187.74812251854, 25481.235562933143, 25593.744062559137, 25604.871975640002, 42018.57981420269, 42166.57833421749, 42562.14875702531, 43137.0, 43604.56395436005, 36423.81788091148, 36465.45301820528, 36503.45244821383, 36521.634783651825, 36866.81566592257, 36724.81637591795, 37052.81473592615, 37065.444018340284, 37152.81423592865, 37765.0, 35607.82196089003, 35642.64357356393, 36090.0, 36122.277554448236, 36422.4536631956, 32963.67036329606, 33305.500417494244, 33413.49879751854, 33685.0, 33693.49459758057, 25409.110681126072, 25493.61759573645, 25556.616650749882, 25557.744422555537, 25910.0], "value": 16434.276956036145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.05909340248337, 364.99452508212363, 366.1596635721021, 371.6079536089426, 380.64790069185995, 15845.445409410673, 16207.75688364674, 17294.0, 17416.30334786607, 17435.651286974255, 16543.83456165438, 17069.0, 17871.285148594074, 17872.37446689366, 17878.463646090604, 5094.847154585359, 5273.868153296179, 5275.841724748264, 5280.630355875091, 5289.100852855024, 5056.064628043805, 5215.895682086356, 5256.684598924057, 5266.104762190437, 5266.3943646480575, 5155.896882062357, 5183.248428977796, 5201.297824793661, 5238.240455134003, 5245.4754524547625, 4862.270659401082, 5134.0758663440565, 5155.896882062357, 5167.612429067835, 5186.0, 4657.115148121846, 4658.906821863544, 4662.650301227388, 4663.510331415187, 4683.672142949961, 19992.500187495283, 20259.89870050655, 20842.68735968962, 21206.575868482545, 21223.363299101053, 1874.6813041782793, 1906.818852209038, 1995.950101247466, 2019.5758890632985, 2309.261036468331, 13122.540711075066, 13586.0, 13765.242911639856, 13840.446382144703, 14008.579742607739, 1728.4900954218535, 1774.8640869843312, 1798.4784412520353, 1837.7059670452797, 1884.3122260375, 62289.377106228814, 65490.01764973577, 68446.31553684449, 68961.65519172422, 69093.65453172752, 9758.804823903482, 9986.30095893295, 10236.641717539851, 10367.32612380193, 10528.736781580368, 14071.85928140726, 14129.576112716635, 14174.14955102697, 14196.077254978394, 14262.0, 6835.58986460814, 7014.929850701427, 7082.150141982995, 7085.299528113319, 7153.177384600734, 6554.901676474857, 6628.171478565179, 6641.501887358468, 6761.560498567577, 6775.0, 4189.790510474464, 4197.580241975839, 4251.6386107180615, 4288.656907447396, 4527.932081018787, 1777.2802015183872, 1785.2501949181114, 1854.7403363529118, 1904.5333893196255, 1928.6914093744933, 835.4527784301292, 867.7353407210861, 900.4552245891141, 943.2831048403262, 997.4115271989416, 15853.0, 16722.59729944381, 16770.58073548171, 17015.91492042532, 17134.828651713324, 845.2603971524916, 884.4339622641514, 899.9730008099767, 921.6267411698273, 925.047201382577, 9258.583363748647, 9512.38169518979, 9539.713808585753, 9699.175570076623, 9710.817565155296, 290995.0, 294263.0, 397371.0, 399139.0, 402782.0, 50371.496285037414, 51367.74316128396, 57794.0, 64300.35699642944, 76425.0, 890.1810334492283, 919.3013309884402, 921.9585118669676, 937.3251259093441, 953.2755106119538, 15940.442084526985, 15944.0, 16093.195340233176, 16105.597360066093, 16370.590735231715, 37454.250914981, 37612.0, 37899.0, 38197.42703859389, 39237.41143882901, 46468.849228075145, 51972.0, 53683.0, 53892.0, 54355.72822136022, 7477.626118694152, 7678.232176782277, 7693.115291741521, 7736.806579835549, 7901.920980790119, 10444.477776111013, 11393.886061139614, 11602.825957610812, 11786.941065294961, 12272.815907761213, 10149.543270552991, 10411.271211015157, 10593.52329145175, 10611.09805666527, 10795.136389088697, 10148.086672199537, 10164.33931794431, 10182.694519164437, 10237.897621023694, 10390.948045259725, 10332.483375831029, 10365.9481702591, 10551.208659350426, 10773.784524309627, 10849.132069434585, 7499.962500187464, 7519.586422746802, 7522.962385188039, 7623.580703061385, 7639.04511936008, 10138.442385668564, 10163.593456261668, 10257.58969641206, 10430.0, 10488.685339439524], "value": 8223.65500970027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.2390565660605, 1389.32617680425, 1394.6234516680497, 1744.0930716027658, 1767.0546257752096, 6717.865642687143, 7424.814379640505, 7567.432442566802, 7908.327792137668, 7912.090109637394, 7693.115291741451, 7886.053673559181, 7928.9207107928905, 7938.2855543001115, 7981.481203721754, 2222.20000799712, 2265.6035193841094, 2288.336382449088, 2294.105298933417, 2300.3559003479054, 2191.3316438486254, 2199.6480563109826, 2233.8101261392803, 2241.3388050525136, 2246.0903334149693, 2240.9103635854544, 2247.3482690019873, 2250.8424410291286, 2254.5490901819703, 2263.2418139923147, 2165.8917054147228, 2167.6206663833764, 2168.7072245246845, 2173.4892300309416, 2186.147402513021, 2120.385088324384, 2130.0, 2139.368886178581, 2143.592717383692, 2145.184829764695, 7727.227277272228, 7800.0, 7823.295903368724, 7828.452008359417, 7850.646720897574, 4482.103579284124, 4541.250693635546, 4546.431696037996, 4564.589186973155, 4580.9770951145365, 2743.369025124213, 2797.608334833125, 2816.802823802335, 2818.4504021715775, 2821.39340041892, 869.6173683579268, 872.0930232558131, 897.9146981036791, 898.3397203055749, 898.4743924803997, 10284.845727314096, 10286.639967601099, 10306.433146176958, 10306.587736490457, 10307.639232626898, 4147.170565886835, 4153.397757325231, 4163.271427500175, 4168.6665066794585, 4173.749575025508, 8842.557872106498, 8899.377043607015, 8902.332325075646, 8904.777380565538, 8909.73270801877, 4298.935515967263, 4312.5903039211225, 4323.718958267703, 4340.60934515895, 4349.760763157993, 3639.4176931690804, 3895.5325360956867, 4011.197760447922, 4098.979505102456, 4137.089840235143, 3703.2223233121344, 3724.0689827543115, 3749.4000959846294, 3802.6197380262306, 3843.404272337792, 1207.704112492445, 1212.7816992941355, 1234.962951111468, 1252.1297698099734, 1263.444084602772, 759.0, 780.6994307191773, 853.470848074198, 868.639514601446, 892.4154678685471, 5238.135707608279, 5353.0, 5354.651947623392, 5490.69801160932, 5551.472610102034, 405.4283460320992, 405.9086705491241, 408.2977279080037, 412.7667867654765, 412.8080442594148, 3628.74598778083, 3700.481932529448, 3702.9814850925573, 3706.184639379332, 3727.3290807654885, 9008.59461324242, 9324.90675093254, 9359.29805264608, 9367.578458969363, 9380.906190938003, 8929.955350223207, 9232.215261702697, 9240.722778316662, 9313.44119352841, 9415.717528474157, 7123.394511466479, 7326.3040011198855, 7350.77947661571, 7357.742479013209, 7359.300866417789, 5200.2199670049795, 5442.482964118402, 5458.235846981346, 5547.750351234285, 5648.887022259614, 8418.494890306602, 8450.239478446969, 8558.657653693783, 8714.12858714149, 8733.650653974024, 8648.524331161594, 8658.39391242607, 8729.956350218208, 8744.256738177326, 8767.736967890973, 6121.0, 6258.624482531062, 6457.61254324742, 6601.537892347682, 6722.495812814156, 7512.849743005, 7516.285952834472, 7578.280063393969, 7584.658690358837, 7624.771256862081, 6394.360563943568, 6608.8764909966385, 6622.90065649006, 6631.171103612049, 6699.665016749045, 6593.769218077345, 6603.339666033358, 6634.0, 6652.401283884474, 6736.157980252468, 6145.66198859067, 6146.938530614637, 6204.844878877883, 6221.2845522765465, 6268.655223962726, 4336.826526939013, 4500.977495112635, 4623.907521849612, 4731.668783185281, 4784.880377990578, 4616.0, 4718.669693121448, 4755.500672429345, 4849.684770489906, 4853.514648535118], "value": 4032.576940888656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.99342364200703, 280.4965087667636, 284.5447284345048, 292.41225137473674, 294.3465506575402, 4852.223644216926, 5008.223725322581, 5110.259012443194, 5116.820911268106, 5137.7688004039865, 4991.800327986876, 5028.773705183266, 5028.974855125728, 5048.091343558158, 5051.924221136685, 3978.940315895257, 3981.6018398160095, 3999.560048394674, 4005.8998525036814, 4008.258472182641, 3875.275502401418, 3976.522817261918, 3977.5425826030087, 3988.421678856564, 4022.4569683092845, 3900.1419687668667, 3940.4435248076993, 3940.8817735467983, 3942.6254505822044, 3947.98026009871, 3944.6982495776324, 3951.004742604995, 3957.861474848395, 3960.980195099006, 3970.153878446522, 3508.9824550877083, 3522.6125126236093, 3546.074488546959, 3549.2723991581665, 3566.5363502744476, 4746.501617330199, 4789.928151077736, 4831.154547954094, 4836.685615435021, 4906.435759887588, 4558.749268790215, 4561.996360800618, 4566.520515345874, 4567.817287308504, 4583.587477127075, 5293.57651387888, 5306.8407947761625, 5308.469153084699, 5316.813911513079, 5340.172273297645, 3734.607866174067, 3811.561670407883, 3813.828377723009, 3845.4616353710503, 3850.7100121459343, 5538.778448862041, 5563.221149039137, 5565.193047008202, 5572.4706152915405, 5580.302462192267, 3905.9609403906165, 3924.274009308287, 3928.253631809947, 3945.6448919597374, 3963.920721585552, 3864.864729734502, 3949.624785645359, 3972.463717398172, 3978.1645854370904, 3983.362661974128, 4447.08834688888, 4470.8435204767675, 4482.843100491467, 4508.706934049276, 4511.8195272189405, 5299.258103865462, 5302.28419163408, 5333.5199832015305, 5344.167591176682, 5375.650582712111, 1279.2516377918835, 1336.3719052045524, 1364.3587513868465, 1369.582277405381, 1369.6645770373805, 840.357126798, 873.6505397840788, 891.5319457284847, 891.6879092317766, 897.533282693009, 4109.486314210723, 4115.382692596075, 4121.2993791055, 4177.644900183518, 4186.3092589722355, 4789.8323558675975, 4822.0, 4822.0344488140245, 4829.468758436569, 4830.4444988826735, 4106.753594784323, 4107.856225032169, 4135.56576559463, 4178.394132850781, 4191.413202151702, 2520.911768088108, 2550.579154439534, 2611.856347900846, 2612.542805009116, 2630.8026897982727, 4509.301058335897, 4542.954570454253, 4543.159515489645, 4554.223852697451, 4591.403117594758, 4943.3573635427165, 4948.233023881304, 4987.5760560352055, 4992.450830408652, 5050.217216331474, 4415.558444155623, 4429.648957068061, 4503.68474206809, 4534.977325113353, 4541.0, 4804.303376010389, 4818.301346304696, 4833.468318484894, 4852.927206091841, 4858.659893807399, 4746.881327966828, 4762.904741905212, 4777.259524773665, 4784.803799050237, 4795.832145874878, 4596.4254468191475, 4713.78787954536, 5114.693118412907, 5153.871153221199, 5172.870678233075, 3775.867844625425, 3798.6011468795377, 3840.5583357914197, 3847.0, 3858.2283543292015, 5272.209168624737, 5527.364353099445, 5531.9723401382735, 5554.583406244628, 5556.888862222652, 5148.845534633967, 5263.184206448007, 5264.131418315935, 5267.341582302212, 5287.8149264777085, 5263.710495922608, 5293.761780719799, 5294.708791016377, 5320.2817619620855, 5333.599980001593, 5078.873028174326, 5195.3113289564835, 5200.245964335075, 5227.477252274742, 5237.81667641646, 5345.305110335631, 5348.465153484621, 5378.0, 5379.973100134474, 5381.27352807366, 5221.2690223368, 5222.302751605667, 5235.240890070994, 5237.214417837355, 5245.737713114253], "value": 3871.9703192175807, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.5691729623854, 668.2115104177072, 727.2400341642983, 750.4934169435629, 752.1688534169745, 11058.281211721232, 11740.882591174086, 11751.882481175207, 11848.703782405433, 13432.529861454852, 13673.453061877537, 14012.579622611338, 14147.0, 14178.220197889112, 14196.0, 629.0564153769346, 799.8240387114826, 809.6235250608465, 811.0146172400532, 814.5804910471112, 796.3907610677836, 822.2065706593137, 823.086374124721, 823.8887750153713, 825.0882774534143, 845.4842546046938, 847.4872702015284, 849.3205435651485, 853.8377708235415, 855.6192494340021, 840.4243093480954, 841.2092632925091, 842.7134774176778, 843.1779015459908, 846.3990566697652, 618.3692633513836, 621.6891554222889, 622.5082185073786, 622.6886556721639, 622.9844253893689, 12589.93705031469, 12630.0, 12695.809562856564, 12698.428570714248, 12707.809382859265, 11331.32012079278, 11572.53709851605, 11635.185537012412, 11787.998020168296, 12092.516299348015, 9075.27950310559, 9328.440293582338, 9375.390599611072, 9384.90615093854, 9530.237580993504, 3238.8380580970856, 3250.9512357314425, 3266.199781053633, 3297.653746356646, 3311.9006429806905, 45248.77375613134, 45573.77213113946, 45909.0, 46026.0, 46338.30492542581, 9087.772805679911, 9273.72178834636, 9296.0, 9312.161905428544, 9427.575759090858, 16378.836211637969, 16561.08914009717, 16564.917175414044, 16584.6683066338, 16593.170341482877, 6361.713722882481, 6446.8388290293115, 6480.773172938924, 6526.510511711641, 6593.0, 3666.2667466506273, 3684.4104943209495, 3706.8517259309865, 3752.6810221130963, 3784.9432258516144, 2636.907708230241, 2725.277801382635, 2730.12635956496, 2735.7811375089946, 2737.233574599076, 490.35518293444005, 508.4838888528147, 511.1719015195407, 527.6069328350403, 566.7955594361981, 432.86797526754015, 531.3597115475842, 543.2557396367002, 543.7063985447813, 546.701121782902, 7562.508436951691, 8025.23760242776, 8077.192280771876, 8084.757457276173, 8104.149064348158, 509.1573445946964, 566.7789562070795, 579.2759051186017, 582.1587805620837, 583.3320847629441, 3790.7156963227867, 3837.6354246346555, 3868.574456809749, 3881.670058045098, 3945.191235796655, 59424.40575594275, 59461.405385946455, 60673.089903650594, 60803.08795368073, 60834.0, 54901.0, 55243.44756552383, 55776.72111639416, 56374.0, 57701.0, 50140.24789628159, 50780.0, 50807.49192508101, 50815.0, 50963.23555146676, 7280.817979550554, 7393.704251830081, 7444.143923448873, 7573.962130189314, 7591.424465027271, 33051.83474082614, 33735.0, 33847.0, 34013.82993085019, 34252.31495370129, 41080.0, 44224.55775442204, 44243.11513769642, 44252.0, 44448.77775611231, 9664.75838104053, 10046.648367307402, 10285.9485702571, 10544.472776361305, 10682.57269709203, 10785.62250321235, 10813.243072984815, 11425.714357141138, 11633.53465861356, 11714.531418743154, 9791.069848364394, 10958.12335013213, 11003.834942476029, 11107.0, 11121.332720036824, 10356.741081473023, 10596.947015264874, 10668.57325706994, 10841.241113122005, 10940.507677154388, 10464.581416743245, 10541.367517948947, 10747.946260268649, 10951.069159121564, 11014.724631883946, 9328.939484721173, 9378.95310523443, 9431.151196392357, 9502.0, 9710.563024663767, 9539.666111686058, 9615.182709469773, 9620.663276785279, 9641.710748677551, 9695.0], "value": 5959.935900188782, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 107.0, 116.0, 115.0, 117.0, 110.0, 118.0, 116.0, 119.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 158.0, 215.0, 132.0, 157.0, 153.0, 132.0, 191.0, 138.0], "value": 156.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 173.0, 163.0, 162.0, 164.0, 163.0, 163.0, 162.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 166.0, 76.0, 77.0, 75.0, 76.0, 169.0, 75.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 175.0, 95.0, 94.0, 94.0, 136.0, 94.0, 93.0, 141.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 69.0, 65.0, 65.0, 65.0, 69.0, 67.0, 66.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 83.0, 84.0, 84.0, 144.0, 92.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 131.0, 131.0, 129.0, 135.0, 130.0, 138.0, 133.0, 152.0, 131.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 175.0, 171.0, 171.0, 172.0, 169.0, 168.0, 168.0, 169.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 72.0, 66.0, 67.0, 67.0, 68.0, 68.0, 69.0], "value": 68.6, "unit": "score"}]}]} 18:25:05 INFO - Return code: 0 18:25:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:25:05 ERROR - # TBPL SUCCESS # 18:25:05 INFO - Running post-action listener: _resource_record_post_action 18:25:05 INFO - ##### 18:25:05 INFO - ##### Finished run-tests step (success) 18:25:05 INFO - ##### 18:25:05 INFO - Running post-run listener: _resource_record_post_run 18:25:05 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 521494528; Read time: 0; Write time: 398480 18:25:05 INFO - TinderboxPrint: CPU usage
13.4% 18:25:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:25:05 INFO - TinderboxPrint: I/O write bytes / time
521,494,528 / 398,480 18:25:05 INFO - TinderboxPrint: CPU idle
8,264.1 (86.6%) 18:25:05 INFO - TinderboxPrint: CPU user
1,231.7 (12.9%) 18:25:05 INFO - TinderboxPrint: Swap in / out
0 / 0 18:25:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236216320; Read time: 0; Write time: 217896 18:25:05 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 284536832; Read time: 0; Write time: 180576 18:25:06 INFO - Running post-run listener: _upload_blobber_files 18:25:06 INFO - Blob upload gear active. 18:25:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:25:06 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 18:25:06 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'] 18:25:06 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 18:25:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:25:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:25:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:25:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:07 INFO - (blobuploader) - INFO - Done attempting. 18:25:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:25:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:25:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:08 INFO - (blobuploader) - INFO - Done attempting. 18:25:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:25:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:25:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:12 INFO - (blobuploader) - INFO - Done attempting. 18:25:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:25:12 INFO - Return code: 0 18:25:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:25:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:25: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/507fb6d26e9d7b2251f4ead24ef4a8fc483139817bd3101d138a4306d301f8a7da981cf0ca29cd7375fe00bb180b03b8691b2e33e2a0a9ca75f38f4f4f3e30b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfc9da45fb990e62dcaaf8024a5ad2539e24821dd0bd26de6476f9c5f6da4ef4506f7f126e6fd5035ddab75ca596c06eccaeeba1301a3411109c0b8c7c08f6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f3516b98c9af85ed2b17902388a1158335bb184c85a5889b13eaffcf999a1166aee23793f07e48d079abeea0a34df016f6b432f2ea92ec17251eb4191f61951"} 18:25:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:25:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:25:12 INFO - Contents: 18:25:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/507fb6d26e9d7b2251f4ead24ef4a8fc483139817bd3101d138a4306d301f8a7da981cf0ca29cd7375fe00bb180b03b8691b2e33e2a0a9ca75f38f4f4f3e30b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfc9da45fb990e62dcaaf8024a5ad2539e24821dd0bd26de6476f9c5f6da4ef4506f7f126e6fd5035ddab75ca596c06eccaeeba1301a3411109c0b8c7c08f6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f3516b98c9af85ed2b17902388a1158335bb184c85a5889b13eaffcf999a1166aee23793f07e48d079abeea0a34df016f6b432f2ea92ec17251eb4191f61951"} 18:25:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:25:12 INFO - Copying logs to upload dir... 18:25:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:25:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.211644 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-19 18:25:12.145893) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 18:25:12.149937) ========= 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=0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662 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/507fb6d26e9d7b2251f4ead24ef4a8fc483139817bd3101d138a4306d301f8a7da981cf0ca29cd7375fe00bb180b03b8691b2e33e2a0a9ca75f38f4f4f3e30b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfc9da45fb990e62dcaaf8024a5ad2539e24821dd0bd26de6476f9c5f6da4ef4506f7f126e6fd5035ddab75ca596c06eccaeeba1301a3411109c0b8c7c08f6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f3516b98c9af85ed2b17902388a1158335bb184c85a5889b13eaffcf999a1166aee23793f07e48d079abeea0a34df016f6b432f2ea92ec17251eb4191f61951"} build_url:https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/PdE33pfTTEWwQBwKWIvGAQ/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/507fb6d26e9d7b2251f4ead24ef4a8fc483139817bd3101d138a4306d301f8a7da981cf0ca29cd7375fe00bb180b03b8691b2e33e2a0a9ca75f38f4f4f3e30b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfc9da45fb990e62dcaaf8024a5ad2539e24821dd0bd26de6476f9c5f6da4ef4506f7f126e6fd5035ddab75ca596c06eccaeeba1301a3411109c0b8c7c08f6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f3516b98c9af85ed2b17902388a1158335bb184c85a5889b13eaffcf999a1166aee23793f07e48d079abeea0a34df016f6b432f2ea92ec17251eb4191f61951"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 18:25:12.177853) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 18:25:12.178353) ========= 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=0333a256a5e4f052382dd180000001b1-1463704919.744306-2026295662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004331 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 18:25:12.262564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 18:25:12.262921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 18:25:12.263254) ========= ========= Total master_lag: 0.18 =========