builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1458576585.79 results: success (0) buildid: 20160321073234 builduid: 9e9f7597b0d44b3f9353a9805e80b018 revision: 4037eb98974db1b1e0b5012c8a7f3a36428eaa11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.788263) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.788828) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.789158) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006339 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.838890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.839239) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.917169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.917548) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.997591) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.997944) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.998359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:45.998682) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-21 09:09:46-- 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% 224M=0s 2016-03-21 09:09:46 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196544 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:46.223071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:46.223399) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016122 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:46.306420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:46.306837) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4037eb98974db1b1e0b5012c8a7f3a36428eaa11 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4037eb98974db1b1e0b5012c8a7f3a36428eaa11 --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=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-21 09:09:46,574 truncating revision to first 12 chars 2016-03-21 09:09:46,574 Setting DEBUG logging. 2016-03-21 09:09:46,574 attempt 1/10 2016-03-21 09:09:46,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4037eb98974d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 09:09:46,966 unpacking tar archive at: mozilla-central-4037eb98974d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.833993 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:47.172325) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:47.172728) ========= echo 4037eb98974db1b1e0b5012c8a7f3a36428eaa11 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4037eb98974db1b1e0b5012c8a7f3a36428eaa11'] 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=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4037eb98974db1b1e0b5012c8a7f3a36428eaa11 program finished with exit code 0 elapsedTime=0.004674 script_repo_revision: '4037eb98974db1b1e0b5012c8a7f3a36428eaa11' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:47.251984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:47.252360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 09:09:47.325375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-21 09:09:47.325854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:09:47 INFO - MultiFileLogger online at 20160321 09:09:47 in /builds/slave/test 09:09:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:09:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:09:47 INFO - {'append_to_log': False, 09:09:47 INFO - 'base_work_dir': '/builds/slave/test', 09:09:47 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:09:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:09:47 INFO - 'branch': 'Firefox-Non-PGO', 09:09:47 INFO - 'buildbot_json_path': 'buildprops.json', 09:09:47 INFO - 'config_files': ('talos/linux_config.py',), 09:09:47 INFO - 'default_actions': ('clobber', 09:09:47 INFO - 'read-buildbot-config', 09:09:47 INFO - 'download-and-extract', 09:09:47 INFO - 'populate-webroot', 09:09:47 INFO - 'create-virtualenv', 09:09:47 INFO - 'install', 09:09:47 INFO - 'run-tests'), 09:09:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:09:47 INFO - 'download_minidump_stackwalk': True, 09:09:47 INFO - 'download_symbols': 'ondemand', 09:09:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:09:47 INFO - 'tooltool.py': '/tools/tooltool.py', 09:09:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:09:47 INFO - '/tools/misc-python/virtualenv.py')}, 09:09:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:09:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:09:47 INFO - 'installer_path': 'installer.exe', 09:09:47 INFO - 'log_level': 'info', 09:09:47 INFO - 'log_name': 'talos', 09:09:47 INFO - 'log_to_console': True, 09:09:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:09:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:09:47 INFO - 'opt_config_files': (), 09:09:47 INFO - 'pip_index': False, 09:09:47 INFO - 'sps_profile': False, 09:09:47 INFO - 'sps_profile_interval': 0, 09:09:47 INFO - 'suite': 'dromaeojs-e10s', 09:09:47 INFO - 'system_bits': '32', 09:09:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:09:47 INFO - 'title': 'talos-linux64-ix-011', 09:09:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:09:47 INFO - 'use_talos_json': True, 09:09:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:09:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:09:47 INFO - 'work_dir': 'build'} 09:09:47 INFO - ##### 09:09:47 INFO - ##### Running clobber step. 09:09:47 INFO - ##### 09:09:47 INFO - Running pre-action listener: _resource_record_pre_action 09:09:47 INFO - Running main action method: clobber 09:09:47 INFO - rmtree: /builds/slave/test/build 09:09:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:09:48 INFO - Running post-action listener: _resource_record_post_action 09:09:48 INFO - ##### 09:09:48 INFO - ##### Running read-buildbot-config step. 09:09:48 INFO - ##### 09:09:48 INFO - Running pre-action listener: _resource_record_pre_action 09:09:48 INFO - Running main action method: read_buildbot_config 09:09:48 INFO - Using buildbot properties: 09:09:48 INFO - { 09:09:48 INFO - "project": "", 09:09:48 INFO - "product": "firefox", 09:09:48 INFO - "script_repo_revision": "production", 09:09:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:09:48 INFO - "repository": "", 09:09:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:09:48 INFO - "buildid": "20160321073234", 09:09:48 INFO - "pgo_build": "False", 09:09:48 INFO - "basedir": "/builds/slave/test", 09:09:48 INFO - "buildnumber": 289, 09:09:48 INFO - "slavename": "talos-linux64-ix-011", 09:09:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:09:48 INFO - "platform": "ubuntu64_hw", 09:09:48 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:09:48 INFO - "branch": "mozilla-central", 09:09:48 INFO - "repo_path": "mozilla-central", 09:09:48 INFO - "revision": "4037eb98974db1b1e0b5012c8a7f3a36428eaa11", 09:09:48 INFO - "stage_platform": "linux64", 09:09:48 INFO - "builduid": "9e9f7597b0d44b3f9353a9805e80b018", 09:09:48 INFO - "slavebuilddir": "test" 09:09:48 INFO - } 09:09:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:09:48 INFO - Running post-action listener: _resource_record_post_action 09:09:48 INFO - ##### 09:09:48 INFO - ##### Running download-and-extract step. 09:09:48 INFO - ##### 09:09:48 INFO - Running pre-action listener: _resource_record_pre_action 09:09:48 INFO - Running main action method: download_and_extract 09:09:48 INFO - mkdir: /builds/slave/test/build/tests 09:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:48 INFO - https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:09:51 INFO - Downloaded 1361 bytes. 09:09:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:09:51 INFO - Using the following test package requirements: 09:09:51 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:09:51 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:09:51 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:09:51 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:51 INFO - u'jsshell-linux-x86_64.zip'], 09:09:51 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:09:51 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:09:51 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:09:51 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:09:51 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:09:51 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:09:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:51 INFO - https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:09:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:09:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:09:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:09:53 INFO - Downloaded 21999690 bytes. 09:09:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:09:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:09:54 INFO - Return code: 0 09:09:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:54 INFO - https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:09:58 INFO - Downloaded 21999690 bytes. 09:09:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:09:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:09:59 INFO - Return code: 0 09:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:59 INFO - https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:10:03 INFO - Downloaded 10847637 bytes. 09:10:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:10:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:10:03 INFO - Return code: 0 09:10: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')]} 09:10:03 INFO - https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:10:06 INFO - Downloaded 54167580 bytes. 09:10:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:10:06 INFO - mkdir: /builds/slave/test/properties 09:10:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:10:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:10:06 INFO - Contents: 09:10:06 INFO - build_url:https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:10:07 INFO - Running post-action listener: _resource_record_post_action 09:10:07 INFO - Running post-action listener: set_extra_try_arguments 09:10:07 INFO - ##### 09:10:07 INFO - ##### Running populate-webroot step. 09:10:07 INFO - ##### 09:10:07 INFO - Running pre-action listener: _resource_record_pre_action 09:10:07 INFO - Running main action method: populate_webroot 09:10:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:10:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:10:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:10:07 INFO - '--tppagecycles', 09:10:07 INFO - '7'], 09:10:07 INFO - 'tests': ['tsvgm']}}, 09:10:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:10:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:10:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:10:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:10:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'tests': ['damp', 'tps']}, 09:10:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['damp', 'tps']}, 09:10:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:10:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:10:07 INFO - 'other': {'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other_l64': {'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other_nol64': {'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'svgr': {'tests': ['tsvgx', 09:10:07 INFO - 'tsvgr_opacity', 09:10:07 INFO - 'tart', 09:10:07 INFO - 'tscrollx', 09:10:07 INFO - 'cart']}, 09:10:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['tsvgx', 09:10:07 INFO - 'tsvgr_opacity', 09:10:07 INFO - 'tart', 09:10:07 INFO - 'tscrollx', 09:10:07 INFO - 'cart']}, 09:10:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'tests': ['tp5o']}, 09:10:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['tp5o']}, 09:10:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--xperf_path', 09:10:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:07 INFO - 'tests': ['tp5n']}, 09:10:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--e10s', 09:10:07 INFO - '--xperf_path', 09:10:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:07 INFO - 'tests': ['tp5n']}}, 09:10:07 INFO - 'talos.zip': {'path': '', 09:10:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:10:07 INFO - Running post-action listener: _resource_record_post_action 09:10:07 INFO - ##### 09:10:07 INFO - ##### Running create-virtualenv step. 09:10:07 INFO - ##### 09:10:07 INFO - Running pre-action listener: _resource_record_pre_action 09:10:07 INFO - Running main action method: create_virtualenv 09:10:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:10:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:10:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:10:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:10:07 INFO - Using real prefix '/usr' 09:10:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:10:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:10:10 INFO - Installing pip.................done. 09:10:10 INFO - Return code: 0 09:10:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:10 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 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:10:10 INFO - Using env: {'DISPLAY': ':0', 09:10:10 INFO - 'HOME': '/home/cltbld', 09:10:10 INFO - 'LANG': 'en_US.UTF-8', 09:10:10 INFO - 'LANGUAGE': 'en_US:en', 09:10:10 INFO - 'LOGNAME': 'cltbld', 09:10:10 INFO - 'MAIL': '/var/mail/cltbld', 09:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:10 INFO - 'MOZ_NO_REMOTE': '1', 09:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:10 INFO - 'NO_EM_RESTART': '1', 09:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:10 INFO - 'PWD': '/builds/slave/test', 09:10:10 INFO - 'SHELL': '/bin/bash', 09:10:10 INFO - 'SHLVL': '1', 09:10:10 INFO - 'TERM': 'linux', 09:10:10 INFO - 'TMOUT': '86400', 09:10:10 INFO - 'USER': 'cltbld', 09:10:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:10 INFO - '_': '/tools/buildbot/bin/python'} 09:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:10:10 INFO - Cleaning up... 09:10:10 INFO - Return code: 0 09:10:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:10 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:10 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>=0.7.1'] in /builds/slave/test/build 09:10:10 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>=0.7.1 09:10:10 INFO - Using env: {'DISPLAY': ':0', 09:10:10 INFO - 'HOME': '/home/cltbld', 09:10:10 INFO - 'LANG': 'en_US.UTF-8', 09:10:10 INFO - 'LANGUAGE': 'en_US:en', 09:10:10 INFO - 'LOGNAME': 'cltbld', 09:10:10 INFO - 'MAIL': '/var/mail/cltbld', 09:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:10 INFO - 'MOZ_NO_REMOTE': '1', 09:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:10 INFO - 'NO_EM_RESTART': '1', 09:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:10 INFO - 'PWD': '/builds/slave/test', 09:10:10 INFO - 'SHELL': '/bin/bash', 09:10:10 INFO - 'SHLVL': '1', 09:10:10 INFO - 'TERM': 'linux', 09:10:10 INFO - 'TMOUT': '86400', 09:10:10 INFO - 'USER': 'cltbld', 09:10:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:10 INFO - '_': '/tools/buildbot/bin/python'} 09:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:10 INFO - Downloading/unpacking psutil>=0.7.1 09:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:10:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:13 INFO - Installing collected packages: psutil 09:10:13 INFO - Running setup.py install for psutil 09:10:13 INFO - building 'psutil._psutil_linux' extension 09:10:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:10:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:10:14 INFO - building 'psutil._psutil_posix' extension 09:10:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:10:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:10:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:14 INFO - Successfully installed psutil 09:10:14 INFO - Cleaning up... 09:10:14 INFO - Return code: 0 09:10:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:14 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:14 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.0.0'] in /builds/slave/test/build 09:10:14 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.0.0 09:10:14 INFO - Using env: {'DISPLAY': ':0', 09:10:14 INFO - 'HOME': '/home/cltbld', 09:10:14 INFO - 'LANG': 'en_US.UTF-8', 09:10:14 INFO - 'LANGUAGE': 'en_US:en', 09:10:14 INFO - 'LOGNAME': 'cltbld', 09:10:14 INFO - 'MAIL': '/var/mail/cltbld', 09:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:14 INFO - 'MOZ_NO_REMOTE': '1', 09:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:14 INFO - 'NO_EM_RESTART': '1', 09:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:14 INFO - 'PWD': '/builds/slave/test', 09:10:14 INFO - 'SHELL': '/bin/bash', 09:10:14 INFO - 'SHLVL': '1', 09:10:14 INFO - 'TERM': 'linux', 09:10:14 INFO - 'TMOUT': '86400', 09:10:14 INFO - 'USER': 'cltbld', 09:10:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:14 INFO - '_': '/tools/buildbot/bin/python'} 09:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:10:17 INFO - Installing collected packages: mozsystemmonitor 09:10:17 INFO - Running setup.py install for mozsystemmonitor 09:10:17 INFO - Successfully installed mozsystemmonitor 09:10:17 INFO - Cleaning up... 09:10:17 INFO - Return code: 0 09:10:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:17 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 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:10:17 INFO - Using env: {'DISPLAY': ':0', 09:10:17 INFO - 'HOME': '/home/cltbld', 09:10:17 INFO - 'LANG': 'en_US.UTF-8', 09:10:17 INFO - 'LANGUAGE': 'en_US:en', 09:10:17 INFO - 'LOGNAME': 'cltbld', 09:10:17 INFO - 'MAIL': '/var/mail/cltbld', 09:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:17 INFO - 'MOZ_NO_REMOTE': '1', 09:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:17 INFO - 'NO_EM_RESTART': '1', 09:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:17 INFO - 'PWD': '/builds/slave/test', 09:10:17 INFO - 'SHELL': '/bin/bash', 09:10:17 INFO - 'SHLVL': '1', 09:10:17 INFO - 'TERM': 'linux', 09:10:17 INFO - 'TMOUT': '86400', 09:10:17 INFO - 'USER': 'cltbld', 09:10:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:17 INFO - '_': '/tools/buildbot/bin/python'} 09:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:17 INFO - Downloading/unpacking blobuploader==1.2.4 09:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:20 INFO - Downloading blobuploader-1.2.4.tar.gz 09:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:10:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:10:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:21 INFO - Downloading docopt-0.6.1.tar.gz 09:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:10:21 INFO - Installing collected packages: blobuploader, requests, docopt 09:10:21 INFO - Running setup.py install for blobuploader 09:10:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:10:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:10:21 INFO - Running setup.py install for requests 09:10:21 INFO - Running setup.py install for docopt 09:10:21 INFO - Successfully installed blobuploader requests docopt 09:10:21 INFO - Cleaning up... 09:10:21 INFO - Return code: 0 09:10:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:21 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 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:10:21 INFO - Using env: {'DISPLAY': ':0', 09:10:21 INFO - 'HOME': '/home/cltbld', 09:10:21 INFO - 'LANG': 'en_US.UTF-8', 09:10:21 INFO - 'LANGUAGE': 'en_US:en', 09:10:21 INFO - 'LOGNAME': 'cltbld', 09:10:21 INFO - 'MAIL': '/var/mail/cltbld', 09:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:21 INFO - 'MOZ_NO_REMOTE': '1', 09:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:21 INFO - 'NO_EM_RESTART': '1', 09:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:21 INFO - 'PWD': '/builds/slave/test', 09:10:21 INFO - 'SHELL': '/bin/bash', 09:10:21 INFO - 'SHLVL': '1', 09:10:21 INFO - 'TERM': 'linux', 09:10:21 INFO - 'TMOUT': '86400', 09:10:21 INFO - 'USER': 'cltbld', 09:10:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:21 INFO - '_': '/tools/buildbot/bin/python'} 09:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:22 INFO - Running setup.py (path:/tmp/pip-pfFFVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:22 INFO - Running setup.py (path:/tmp/pip-KsofCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:22 INFO - Running setup.py (path:/tmp/pip-R8tqw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:22 INFO - Running setup.py (path:/tmp/pip-VmINn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:22 INFO - Running setup.py (path:/tmp/pip-T96Fcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:22 INFO - Running setup.py (path:/tmp/pip-wH__7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:22 INFO - Running setup.py (path:/tmp/pip-S0slDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:22 INFO - Running setup.py (path:/tmp/pip-hCGu9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:22 INFO - Running setup.py (path:/tmp/pip-zIeTDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:22 INFO - Running setup.py (path:/tmp/pip-BXpviT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:22 INFO - Running setup.py (path:/tmp/pip-kyBXME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:22 INFO - Running setup.py (path:/tmp/pip-wNWWrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:22 INFO - Running setup.py (path:/tmp/pip-V8fpJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:22 INFO - Running setup.py (path:/tmp/pip-1kmZFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:23 INFO - Running setup.py (path:/tmp/pip-Pbx51S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:23 INFO - Running setup.py (path:/tmp/pip-QlPERN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:23 INFO - Running setup.py (path:/tmp/pip-7vG3WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:10:23 INFO - Running setup.py install for manifestparser 09:10:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:10:23 INFO - Running setup.py install for mozcrash 09:10:23 INFO - Running setup.py install for mozdebug 09:10:23 INFO - Running setup.py install for mozdevice 09:10:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:10:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:10:23 INFO - Running setup.py install for mozfile 09:10:23 INFO - Running setup.py install for mozhttpd 09:10:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:10:23 INFO - Running setup.py install for mozinfo 09:10:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:10:23 INFO - Running setup.py install for mozInstall 09:10:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Running setup.py install for mozleak 09:10:24 INFO - Running setup.py install for mozlog 09:10:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Running setup.py install for moznetwork 09:10:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Running setup.py install for mozprocess 09:10:24 INFO - Running setup.py install for mozprofile 09:10:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Running setup.py install for mozrunner 09:10:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:10:24 INFO - Running setup.py install for mozscreenshot 09:10:24 INFO - Running setup.py install for moztest 09:10:24 INFO - Running setup.py install for mozversion 09:10:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:10:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:10:25 INFO - Cleaning up... 09:10:25 INFO - Return code: 0 09:10:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:25 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 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:10:25 INFO - Using env: {'DISPLAY': ':0', 09:10:25 INFO - 'HOME': '/home/cltbld', 09:10:25 INFO - 'LANG': 'en_US.UTF-8', 09:10:25 INFO - 'LANGUAGE': 'en_US:en', 09:10:25 INFO - 'LOGNAME': 'cltbld', 09:10:25 INFO - 'MAIL': '/var/mail/cltbld', 09:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:25 INFO - 'MOZ_NO_REMOTE': '1', 09:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:25 INFO - 'NO_EM_RESTART': '1', 09:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:25 INFO - 'PWD': '/builds/slave/test', 09:10:25 INFO - 'SHELL': '/bin/bash', 09:10:25 INFO - 'SHLVL': '1', 09:10:25 INFO - 'TERM': 'linux', 09:10:25 INFO - 'TMOUT': '86400', 09:10:25 INFO - 'USER': 'cltbld', 09:10:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:25 INFO - '_': '/tools/buildbot/bin/python'} 09:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:25 INFO - Running setup.py (path:/tmp/pip-wCo0wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:25 INFO - Running setup.py (path:/tmp/pip-DqSV8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:25 INFO - Running setup.py (path:/tmp/pip-kL9V1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:25 INFO - Running setup.py (path:/tmp/pip-UyuPli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:25 INFO - Running setup.py (path:/tmp/pip-VeJkyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:25 INFO - Running setup.py (path:/tmp/pip-Qvzgct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:25 INFO - Running setup.py (path:/tmp/pip-uvrs2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:25 INFO - Running setup.py (path:/tmp/pip-nCU6fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:25 INFO - Running setup.py (path:/tmp/pip-tTWLf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:25 INFO - Running setup.py (path:/tmp/pip-LvzTad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:25 INFO - Running setup.py (path:/tmp/pip-aAMpd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:26 INFO - Running setup.py (path:/tmp/pip-ML1kFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:26 INFO - Running setup.py (path:/tmp/pip-rDC8vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:26 INFO - Running setup.py (path:/tmp/pip-jlWsW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:26 INFO - Running setup.py (path:/tmp/pip-xDFntG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:26 INFO - Running setup.py (path:/tmp/pip-Rueau4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:26 INFO - Running setup.py (path:/tmp/pip-y7doUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:28 INFO - Downloading blessings-1.6.tar.gz 09:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:10:29 INFO - Installing collected packages: blessings 09:10:29 INFO - Running setup.py install for blessings 09:10:29 INFO - Successfully installed blessings 09:10:29 INFO - Cleaning up... 09:10:29 INFO - Return code: 0 09:10:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:29 INFO - Reading from file tmpfile_stdout 09:10:29 INFO - Current package versions: 09:10:29 INFO - argparse == 1.2.1 09:10:29 INFO - blessings == 1.6 09:10:29 INFO - blobuploader == 1.2.4 09:10:29 INFO - docopt == 0.6.1 09:10:29 INFO - manifestparser == 1.1 09:10:29 INFO - mozInstall == 1.12 09:10:29 INFO - mozcrash == 0.17 09:10:29 INFO - mozdebug == 0.1 09:10:29 INFO - mozdevice == 0.48 09:10:29 INFO - mozfile == 1.2 09:10:29 INFO - mozhttpd == 0.7 09:10:29 INFO - mozinfo == 0.9 09:10:29 INFO - mozleak == 0.1 09:10:29 INFO - mozlog == 3.1 09:10:29 INFO - moznetwork == 0.27 09:10:29 INFO - mozprocess == 0.22 09:10:29 INFO - mozprofile == 0.28 09:10:29 INFO - mozrunner == 6.11 09:10:29 INFO - mozscreenshot == 0.1 09:10:29 INFO - mozsystemmonitor == 0.0 09:10:29 INFO - moztest == 0.7 09:10:29 INFO - mozversion == 1.4 09:10:29 INFO - psutil == 3.1.1 09:10:29 INFO - requests == 1.2.3 09:10:29 INFO - wsgiref == 0.1.2 09:10:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:29 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 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:10:29 INFO - Using env: {'DISPLAY': ':0', 09:10:29 INFO - 'HOME': '/home/cltbld', 09:10:29 INFO - 'LANG': 'en_US.UTF-8', 09:10:29 INFO - 'LANGUAGE': 'en_US:en', 09:10:29 INFO - 'LOGNAME': 'cltbld', 09:10:29 INFO - 'MAIL': '/var/mail/cltbld', 09:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:29 INFO - 'MOZ_NO_REMOTE': '1', 09:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:29 INFO - 'NO_EM_RESTART': '1', 09:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:29 INFO - 'PWD': '/builds/slave/test', 09:10:29 INFO - 'SHELL': '/bin/bash', 09:10:29 INFO - 'SHLVL': '1', 09:10:29 INFO - 'TERM': 'linux', 09:10:29 INFO - 'TMOUT': '86400', 09:10:29 INFO - 'USER': 'cltbld', 09:10:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:29 INFO - '_': '/tools/buildbot/bin/python'} 09:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:10:29 INFO - Cleaning up... 09:10:29 INFO - Return code: 0 09:10:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:29 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 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:10:29 INFO - Using env: {'DISPLAY': ':0', 09:10:29 INFO - 'HOME': '/home/cltbld', 09:10:29 INFO - 'LANG': 'en_US.UTF-8', 09:10:29 INFO - 'LANGUAGE': 'en_US:en', 09:10:29 INFO - 'LOGNAME': 'cltbld', 09:10:29 INFO - 'MAIL': '/var/mail/cltbld', 09:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:29 INFO - 'MOZ_NO_REMOTE': '1', 09:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:29 INFO - 'NO_EM_RESTART': '1', 09:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:29 INFO - 'PWD': '/builds/slave/test', 09:10:29 INFO - 'SHELL': '/bin/bash', 09:10:29 INFO - 'SHLVL': '1', 09:10:29 INFO - 'TERM': 'linux', 09:10:29 INFO - 'TMOUT': '86400', 09:10:29 INFO - 'USER': 'cltbld', 09:10:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:29 INFO - '_': '/tools/buildbot/bin/python'} 09:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:29 INFO - Downloading/unpacking jsonschema 09:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:10:33 INFO - Downloading/unpacking functools32 (from jsonschema) 09:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:33 INFO - Downloading functools32-3.2.3-2.tar.gz 09:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:10:33 INFO - warning: no files found matching '*.txt' 09:10:33 INFO - no previously-included directories found matching 'build' 09:10:33 INFO - no previously-included directories found matching 'dist' 09:10:33 INFO - no previously-included directories found matching '.git*' 09:10:33 INFO - Installing collected packages: jsonschema, functools32 09:10:33 INFO - Running setup.py install for functools32 09:10:34 INFO - warning: no files found matching '*.txt' 09:10:34 INFO - no previously-included directories found matching 'build' 09:10:34 INFO - no previously-included directories found matching 'dist' 09:10:34 INFO - no previously-included directories found matching '.git*' 09:10:34 INFO - Successfully installed jsonschema functools32 09:10:34 INFO - Cleaning up... 09:10:34 INFO - Return code: 0 09:10:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:34 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 0x7f171e362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:10:34 INFO - Using env: {'DISPLAY': ':0', 09:10:34 INFO - 'HOME': '/home/cltbld', 09:10:34 INFO - 'LANG': 'en_US.UTF-8', 09:10:34 INFO - 'LANGUAGE': 'en_US:en', 09:10:34 INFO - 'LOGNAME': 'cltbld', 09:10:34 INFO - 'MAIL': '/var/mail/cltbld', 09:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:34 INFO - 'MOZ_NO_REMOTE': '1', 09:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:34 INFO - 'NO_EM_RESTART': '1', 09:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:34 INFO - 'PWD': '/builds/slave/test', 09:10:34 INFO - 'SHELL': '/bin/bash', 09:10:34 INFO - 'SHLVL': '1', 09:10:34 INFO - 'TERM': 'linux', 09:10:34 INFO - 'TMOUT': '86400', 09:10:34 INFO - 'USER': 'cltbld', 09:10:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:34 INFO - '_': '/tools/buildbot/bin/python'} 09:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:34 INFO - Downloading/unpacking flake8 09:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:10:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:10:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:10:39 INFO - no previously-included directories found matching 'docs/_build' 09:10:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:10:39 INFO - Running setup.py install for pep8 09:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:10:39 INFO - no previously-included directories found matching 'docs/_build' 09:10:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:10:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:10:39 INFO - Cleaning up... 09:10:39 INFO - Return code: 0 09:10:39 INFO - Running post-action listener: _resource_record_post_action 09:10:39 INFO - Running post-action listener: _start_resource_monitoring 09:10:39 INFO - Starting resource monitoring. 09:10:39 INFO - ##### 09:10:39 INFO - ##### Running install step. 09:10:39 INFO - ##### 09:10:39 INFO - Running pre-action listener: _resource_record_pre_action 09:10:39 INFO - Running main action method: install 09:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:39 INFO - Reading from file tmpfile_stdout 09:10:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:10:39 INFO - Reading from file tmpfile_stdout 09:10:39 INFO - Output received: 09:10:39 INFO - Usage: mozinstall [options] installer 09:10:39 INFO - Options: 09:10:39 INFO - -h, --help show this help message and exit 09:10:39 INFO - -d DEST, --destination=DEST 09:10:39 INFO - Directory to install application into. [default: 09:10:39 INFO - "/builds/slave/test"] 09:10:39 INFO - --app=APP Application being installed. [default: firefox] 09:10:39 INFO - mkdir: /builds/slave/test/build/application 09:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:10:55 INFO - Reading from file tmpfile_stdout 09:10:55 INFO - Output received: 09:10:55 INFO - /builds/slave/test/build/application/firefox/firefox 09:10:55 INFO - Running post-action listener: _resource_record_post_action 09:10:55 INFO - ##### 09:10:55 INFO - ##### Running run-tests step. 09:10:55 INFO - ##### 09:10:55 INFO - Running pre-action listener: _resource_record_pre_action 09:10:55 INFO - Running main action method: run_tests 09:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:55 INFO - Python 2.7.3 09:10:55 INFO - Return code: 0 09:10:55 INFO - grabbing minidump binary from tooltool 09:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:55 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b8410>, '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 0x22b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:10:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:10:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:55 INFO - Return code: 0 09:10:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:10:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:10:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:10:56 INFO - Return code: 0 09:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:10:56 INFO - Using env: {'DISPLAY': ':0', 09:10:56 INFO - 'HOME': '/home/cltbld', 09:10:56 INFO - 'LANG': 'en_US.UTF-8', 09:10:56 INFO - 'LANGUAGE': 'en_US:en', 09:10:56 INFO - 'LOGNAME': 'cltbld', 09:10:56 INFO - 'MAIL': '/var/mail/cltbld', 09:10:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:56 INFO - 'MOZ_NO_REMOTE': '1', 09:10:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:56 INFO - 'NO_EM_RESTART': '1', 09:10:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:56 INFO - 'PWD': '/builds/slave/test', 09:10:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:56 INFO - 'SHELL': '/bin/bash', 09:10:56 INFO - 'SHLVL': '1', 09:10:56 INFO - 'TERM': 'linux', 09:10:56 INFO - 'TMOUT': '86400', 09:10:56 INFO - 'USER': 'cltbld', 09:10:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059', 09:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:56 INFO - '_': '/tools/buildbot/bin/python'} 09:10:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:10:56 INFO - mozversion application_buildid: 20160321073234 09:10:56 INFO - mozversion application_changeset: 4037eb98974db1b1e0b5012c8a7f3a36428eaa11 09:10:56 INFO - mozversion application_display_name: Nightly 09:10:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:56 INFO - mozversion application_name: Firefox 09:10:56 INFO - mozversion application_remotingname: firefox 09:10:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:10:56 INFO - mozversion application_vendor: Mozilla 09:10:56 INFO - mozversion application_version: 48.0a1 09:10:56 INFO - mozversion platform_buildid: 20160321073234 09:10:56 INFO - mozversion platform_changeset: 4037eb98974db1b1e0b5012c8a7f3a36428eaa11 09:10:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:10:56 INFO - mozversion platform_version: 48.0a1 09:10:56 INFO - using testdate: 1458576656 09:10:56 INFO - actual date: 1458576656 09:10:56 INFO - starting webserver on 'localhost:41035' 09:10:56 INFO - SUITE-START | Running 2 tests 09:10:56 INFO - TEST-START | dromaeo_css 09:10:56 INFO - operating with platform_type : linux_ 09:10:56 INFO - Initialising browser for dromaeo_css test... 09:10:56 INFO - TEST-INFO | started process 20712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprpABHV/profile http://localhost:41035/getInfo.html) 09:11:01 INFO - PROCESS | 20712 | 09:11:01 INFO - PROCESS | 20712 | (process:20790): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:11:01 INFO - PROCESS | 20712 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:11:03 INFO - PROCESS | 20712 | __metrics Screen width/height:1600/1200 09:11:03 INFO - PROCESS | 20712 | colorDepth:24 09:11:03 INFO - PROCESS | 20712 | Browser inner width/height: 1024/697 09:11:03 INFO - PROCESS | 20712 | __metrics 09:11:03 ERROR - PROCESS | 20712 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:11:04 INFO - TEST-INFO | 20712: exit 0 09:11:04 INFO - Browser initialized. 09:11:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:11:04 INFO - TEST-INFO | started process 20841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprpABHV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:06 INFO - PROCESS | 20841 | 09:11:06 INFO - PROCESS | 20841 | (process:20900): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:11:16 INFO - PROCESS | 20841 | RSS: Main: 167841792 09:11:16 INFO - PROCESS | 20841 | 09:12:06 INFO - PROCESS | 20841 | 1458576726125 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:14:17 INFO - PROCESS | 20841 | Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41035/tests/dromaeo/cssquery-ext.html) 09:14:19 INFO - PROCESS | 20841 | RSS: Main: 172507136 09:14:19 INFO - PROCESS | 20841 | 09:17:21 INFO - PROCESS | 20841 | Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-ext.html (next: http://localhost:41035/tests/dromaeo/cssquery-jquery.html) 09:17:21 INFO - PROCESS | 20841 | RSS: Main: 169836544 09:17:21 INFO - PROCESS | 20841 | 09:20:23 INFO - PROCESS | 20841 | Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41035/tests/dromaeo/cssquery-mootools.html) 09:20:24 INFO - PROCESS | 20841 | RSS: Main: 169672704 09:20:24 INFO - PROCESS | 20841 | 09:23:25 INFO - PROCESS | 20841 | Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41035/tests/dromaeo/cssquery-prototype.html) 09:23:26 INFO - PROCESS | 20841 | RSS: Main: 168366080 09:23:26 INFO - PROCESS | 20841 | 09:26:29 INFO - PROCESS | 20841 | Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41035/tests/dromaeo/cssquery-yui.html) 09:26:29 INFO - PROCESS | 20841 | RSS: Main: 169705472 09:26:29 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-yui.html (next: http://localhost:41035/tests/dromaeo/cssquery-dojo.html) 09:29:32 INFO - PROCESS | 20841 | RSS: Main: 171360256 09:29:32 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | __start_tp_report 09:29:32 INFO - PROCESS | 20841 | _x_x_mozilla_page_load 09:29:32 INFO - PROCESS | 20841 | _x_x_mozilla_page_load_details 09:29:32 INFO - PROCESS | 20841 | |i|pagename|runs| 09:29:32 INFO - PROCESS | 20841 | |0;dojo.html;2647.2587675450873;2691.623172755814;2711.267957651433;2715.2125883493786;2727.304537342976;4782.8326008589665;4823.614110871131;4833.468318484973;4850.490698476662;4853.975730121353;4742.881427964294;4854.271859221119;4905;4922.335484709563;4951.950480495194;4465.799039043234;4503.0318481526465;4560.179167749804;4573.908521829561;4604.424446944132;4538.319252112176;4554.2713165893465;4591.380163677894;4598.241290187132;4654.860354189363;4395.252807022814;4413.845515406945;4450.2434586120435;4471;4494.752788596626;4455.621272191867;4487.618552423048;4497.482789479219;4511.8646440606835;4530.524294949048;4461.42001539801;4474.127545128668;4475.888102797424;4485.798139083749;4520.52534483881;4741.383620129361;4838.588719958808;4840.661153719241;4848.442429120661;4882.3408839806525;5142.357205349332;5155.510226528474;5186.196139598368;5188.351456067991;5239.292695486099;5109.795608175668;5193.480651934814;5194.4805519447755;5198.350206224222;5204.089284375219;4851.054044461296;4871.732054736953;4874.488178741252;4876.756162191876;4922.778474968599;5293.708846013506;5331.333583302087;5336.706481143497;5338.199270109515;5388.110961691277;4965.677230979974;5052.368453943257;5108.233764935289;5109.029284435946;5134.922976155361;5001.599872010231;5157.252198431206;5160.0969830279555;5164.664296820694;5213.374395072616;5108.233764935289;5109.233614957711;5114.565261952701;5130.102232109366;5163.096458119814;5043.84868453947;5100.515451032146;5138.794448222104;5155;5170.302009228706;4249.745015299092;4287.849925252601;4288.50682171548;4295.098029413795;4305.052888364555;3719.8512059517857;3761.9247615047548;3778.9244215115546;3788.1287303919703;3812.8856134316015;4539.773011349485;4547.545245475426;4551;4557.316402539579;4599.9080018399445;5069;5184.7407629618365;5235.476452354734;5237.895242095136;5240.895182096413;4505.098980203972;4552.3171524270965;4552.954470455253;4575.611073058827;4590;4596.37948876904;4614.0310534787395;4619.23782575878;4625.838095666702;4671.929921051187;4796.56830885222;4822.228443449031;4888.120138375127;4893.535114164149;4908.803647854117;5171.50870667301;5193;5204.8178313758835;5217.634765566374;5229.424763276113;4856.174450343521;4922.163232250455;4930.309756634002;4941.258811178352;4991;5001.624878134082;5119.436861945109;5127.564157046543;5179.326687530597;5211.739413029409;5191.377034755854;5193.870153246048;5202.1416466282635;5206.297149884717;5209.348831396075;5041.445441001413;5052.924206136984;5053.84838454847;5058.595312374928;5085.567726743268;4912.557869791736;4951.183054796063;4964.05682920244;5005.7997680092385;5032.194848824171;4955.950440495693;4976.328195693535;4989.725565093955;4995.07591095634;5003.574696150868;5065.493450654905;5075.340205773374;5079.847604571869;5089.720065396439;5106.7701953412925;4867.5132486751045;4944.92582611254;4989.401271847401;5022.146235139962;5025.623078269071 09:29:32 INFO - PROCESS | 20841 | |1;ext.html;540.9945900540995;541.7074779619004;561.9155030790575;562.6989560585087;632.475045712059;34471.65528344716;34924.825375873086;35016.82491587545;35163.4725479118;35271;37766.4335034974;38136;38404.80797596015;38452.61547384525;38535.22929541407;7712.421568382366;7858.803529911741;7872.527648341118;7883.684652613889;7884.566348850811;7648.885266721004;7802.687892484294;7815.687372505093;7817.921820781805;7843;7845.490043147177;7850.332721718661;7862.292393684567;7881.921180788176;7882.921170788276;7792.688292468294;7806.219378062206;7858.057033156001;7864.960675196645;7894.092179399385;7762.650680719381;7838.294553490156;7881;7890.684372625088;7896.249856263646;35762.46356304658;35965.28069438623;36045.63954360449;36186.81906590477;36191.81904090489;3103.5810165627577;3218.372417378612;3386.356592247465;3537.6108628050893;3642.7267954903486;26715.732842671714;28858;29350.706492935013;29734.553981690075;29973;3251.2197072702616;3354.4632858742484;3360.1263671445354;3390.1016230698883;3501.3872572299747;239786;240292;240297;241346;241961.7901910497;56324.43675563192;56366.71816640891;56510.717446412506;56603.71698141483;56727.43272567222;64952;65574;65771;65791;65841.67079164574;12438.502459901503;12544.121911466109;12584.4337004835;12592.181508201938;12623.495060197673;9235.953820230856;9258.72223833286;9274.118958698913;9276.536173191313;9293.442393456415;19834.60330793376;20144;20169.29407470761;20180.39458816238;20264.493387665425;7837.1379148293645;8058.798530036679;8150.510969341858;8171.42800003994;8286.668533258722;870.3081050564816;881.6164968238836;937.0769791755116;1026.071405378134;1027.465717826741;26807.86596067007;26973.460530789274;26996.32509187286;27056.59415108775;27127;997.3915911294105;1002.6841544913475;1012.9088382045651;1013.8986101389802;1038.2109596706557;13649.385777640031;14197.219152946687;14223.079884215706;14395;14410.279486025656;279012;283245;285067;285153;286139;47337;47852;47986.28020579694;48006;48012.7599362001;1218.3968935377045;1219.2379762648345;1235.32057368447;1242.6458459339226;1257.9433925473559;26121.216363509124;26241.606375904757;26471.470570588866;26540.734592653826;26925;41655.37516937188;41939.37090943577;42037.78981105075;42046.57953420427;42191.1561768769;258709;260321;260442;262407;263217;31441.8427907859;32840.50739238865;32863.342733144724;32882.38293787633;32926.67073329332;40091.59908400878;40834.59165408308;41073.38389924094;41281.58718412898;42241.57758422499;34368.82815586006;34705.30589388148;34861.30277394489;34969.47545786866;35416.64583354133;34200.65799342074;34625.30749385049;34843;35046;35163.64836351604;35636;35843;36754.26491470102;37681.43477847779;37859.62140378671;27871.30023121146;29188.562171567868;29527.409451811272;31549;31797.523037154922;25030.62454063154;25880.35299117462;26344;26941.191764247105;26948 09:29:32 INFO - PROCESS | 20841 | |2;jquery.html;338.6562638921495;354.33562071116654;355.5342501323267;360.7835298820708;365.0708945733109;13238.867611323883;15605.14171720555;15894.841051589481;16003.75994360084;16019.919900400497;10410.375377477356;10570.78858422831;10602.893971060286;10642.840357394645;14307.856921430783;4474.82100715971;4685.554872287127;4718.032803275338;4721.150192965265;4737.881552961169;4582.679212455129;4999.925001124986;5154.74226288686;5168.689878607277;5206.661566998152;5121.615878809085;5147.6654017488745;5164.04465173944;5180.611454140936;5330.333708286465;5420.268263784378;5425.267588875491;5430.294061771964;5440.510354068113;5453.318335208099;4861;4876.780544875489;5224.4775522447835;5230.476952304777;5238.554722848562;12121.33332666703;12249.265044097383;12256.81614775779;12292.201006934522;12309.322987235699;1882.6046530228668;1929.2958070304378;1973.842092632586;2089.7492300923836;2289.038603786397;8904.73285801427;8924.955375223082;8932.776680582972;8970.327225458052;9098.454092754457;1688.8733344999052;1762.6827171109196;1774.104077440897;1774.4853992342205;1784.857211423083;59037.40962590405;59192.70403647954;59192.704036479976;59648.10527842086;60380.69809650924;9978.301518893608;10122.59509619607;10281.485925703684;10372.066514013775;10416.531256093494;13144.145630534176;13175.14361566495;13187.73624527504;13202.603921882359;13274.668133296746;5960;6499.1876015498065;6676.732930682815;6748.257691653914;6765.8646827063185;6085.817425477243;6089.451949324582;6114.38856114385;6150.600210986271;6208.906866397007;4261.062566235423;4342.218400687906;4352.586504282088;4399.1641588098155;4433.1577000369825;1785.4911350265113;1864.2263460663673;1870.298638010746;1883.7268596053495;1893.4319704088718;852.3394369363792;896.8161526886972;907;931.6785708930408;950.102153464969;15717;15842.76235856463;15944.202789860461;16051;16283;869.1612593846842;884.3500027479797;890.6882591093066;924.1590152960773;972.9659461918799;8991.190792828676;9187.035361287102;9207;9327.720168394959;9394.436333819993;430165;439299;439940;440579;450803;64134;64677.353226468076;66339;66749.66625166843;67240.32759672438;895.7626229049307;900.8873890763655;903.2412773270485;908.1871724806261;908.5184852028435;14313.141211527342;14673.413063477341;14678.633034173803;14685.118892866461;14908.701825963637;24264.87867560651;31660.366792664478;32002.83998579992;32302;33101.17247068843;43596;43839.34240986451;43955;44507.10985780331;44654.77672611746;7111.359977601834;7191.676374563052;7295.270472952662;7362.300581444754;7378.9631051846545;8138.267555919995;10656.684042962612;11215.111981299848;11244.887551124712;11332.490037948148;9546.949835518226;9663.516824158623;9781.902180978099;9816.411015339103;9818;6042.486388657014;9207.40151890125;9626.085521875411;9633.90366096358;10051.296409251283;9479.668211612561;9661.275404344842;9812.318055817834;10101.545430455793;10172.84740728875;7115.181754098345;7186.6047367395295;7352.338289553966;7446.329830315298;7565.2812982766545;7665;9060.95469522648;9713.271504637321;9855.507224638883;9985.950070249603 09:29:32 INFO - PROCESS | 20841 | |3;mootools.html;1411.8941079419044;1431.2843578210898;1574.2364952997793;1735.0977491704307;1745.2931562717104;6472.773452929148;6944.51388402812;7239.819004524889;7455.254474552542;7458.664360103801;7254.274572542743;7254.274572542743;7258.274172582753;7301.780946571598;7354.742584009561;2161.3083813179787;2203.283932721864;2206.8675879447283;2212.83403744719;2215.4904371994453;2199.9780002200014;2218.82249420046;2229.297771202066;2235.519363336882;2238.238998740428;2215.656573231152;2219.4007617943143;2229.7993180613744;2238.529908719171;2246.7416247131546;2201.3175915466177;2229.8216142708707;2237.1610646007666;2246.764089770575;2257.142285931352;2245.5508898220423;2258.6612008198736;2260.8304377171776;2260.9095636174534;2266.150193677371;7346.742863999734;7429.62851857405;7431.925680743231;7453.329200371938;7454.5899975501325;4382.452193475816;4477.910441791146;4493.258612328995;4496.0783039477155;4498.167838949772;2913.373624670706;3089.9185285150243;3104.5498402731705;3125.140586338752;3131.545925840763;895.8835351404341;907.6959218661756;918.8437965545874;933.2813733425224;941.9152276295098;10093.192544596415;10104.89895101047;10116.797664046751;10131.189504839595;10145.34055286404;4207.600277973649;4239.300515414983;4288.699791014661;4318.050028993616;4335.739855608674;8650.394472386999;8651.04838467768;8655.264302534355;8661.090585488559;8675.91324086751;4445.888852778642;4451.332300154938;4459.264221403497;4470.619997300201;4487.730736155841;3654.3604869148326;4011.4584531088512;4085.8978525536504;4105.281575724236;4111.732737372061;3616.349057169682;3625.728070394678;3679.8528058877882;3702.851885924533;3718.0518967663616;1144.8626164860104;1156.70504021474;1166.003067377397;1173.5481839491856;1182.3674334231146;1223.920445171061;1228.5700004998357;1237.1834589171103;1240.0265791353745;1257.9496820127276;6856.691448884812;6873.072135261776;6913.274106218774;7037.6481175941;7044.049053377831;470.545923184129;471.98820029498853;474.1986043586328;474.91214125386915;476.1334371444008;5467.507924286754;5476.397596264408;5492.203630473559;5620.775168993195;5624.97187514068;8932.151445612657;9164.495952722531;9180.724578262663;9200.539973001458;9211.618257261465;8208.343332533383;8456.957715211385;8505.65977360911;8963.462192268486;8971.327150463741;7001.544899581511;7059.2940705928995;7062.611556364449;7091.219965803757;7094.219635840053;7103.893441598483;7107.857842843011;7180.425565954607;7184.820379490555;7202.49582529218;7968.123506414174;8041;8120.944277243921;8124.512529248264;8159.26566609008;8254.0507841599;8328.708495202638;8348.540830254395;8370.414071014971;8442.535660538484;5890.558208134321;6219.844503887439;6397.808065758035;6595.505337099641;6690.29751876046;6890.517663763689;6914.274001229798;6973.790786276217;6996.685149168198;6997.440204783707;6347.936520634735;6361.118734562548;6385.968070159805;6388.936110638834;6459.838504037437;6401.8719625608155;6421.582597131359;6421.678916054272;6461.256955450183;6484.221893372825;6714.865702685821;6756.020377045203;6760.966195168992;6761.425278851353;6775.728970841111;6168.814935551941;6199.28708198563;6205.565610407228;6213.9067913982235;6223.719932602953;6363.809085727436;6371.5221358397375;6382.840428989312;6385.393387628168;6386.042093685985 09:29:32 INFO - PROCESS | 20841 | |4;prototype.html;307.8183871515805;313.9089663997439;314.9653538110809;318.9282411457424;319.2593183813553;5508.3114610673665;5621.128725047619;5661.716914154286;5664.490195882369;5680.9431905680985;5549.972250138754;5550.944490555094;5553.666779993193;5556;5583.637063590863;4085.142120154771;4186.413902053715;4266.914661706764;4323.805428755698;4339.41611311872;4273.978630106845;4294.269974104394;4298.441202643652;4313.741175529462;4333.978330108345;4234.724742891717;4245.426867372896;4254.298040823276;4256.553061928499;4260.744355338674;4258.829646814123;4260.72305300156;4264.061906380607;4268.487781466213;4277.422547956048;3725.7205709571617;3729.6083911189476;3735.364987952055;3736.178040831013;3738.887833365003;5325.4940780625775;5331.973340133313;5367.141257398797;5372.247885296062;5373.543248823855;4641.466231383401;4739.881502962419;4900.387451568554;4930.235813448921;4948.480409556981;5807.5644326675665;5845.357010728816;5862.882742345129;5895.61678490901;5930.258717660293;3912.726109172359;3937.877704854103;3942.56631770505;3946.6645335146545;3950.920981580381;6107.938920610782;6124.387561243884;6143.539234557471;6170.568060235785;6180.412860778264;4092.4270602115726;4127.938080928789;4134.069834287321;4138.730982486129;4139.275626765364;4189.937150942738;4195.098053918422;4200.264953633163;4201.516825565038;4202.411662367271;4646.767661616906;4761.976190119097;4769.928451073237;4863.635227357962;4882.633802464829;5814.76740930358;5832.504237139806;5863.442972917566;5871.6770577618645;5891.351951285355;1456.876165525921;1466.6480044789173;1476.859698328657;1479.9556013319618;1480.4004378226834;961.2262128986233;976.1897624971257;985.4383001689112;994.3288280410694;1001.3191030099457;5175.534201921845;5185.585153187736;5204.42751297357;5210.296609957683;5213.843584692465;6094;6099.3900609938655;6104.572679912452;6114.357992410822;6116.48009919153;4981.178105612534;5148.9742551287;5172.991266702957;5178.300929374562;5190.11767999441;3228.338190670907;3308.586426696663;3324.5013248012992;3329.051220402174;3329.6337402885665;5792.79725209624;5808.012637851575;5809.970950145307;5820.097884827858;5829.941700583025;6280.403361680633;6307.148534947815;6312.5581209314905;6318.494520438354;6323.7786677466065;5751.626144300607;5790.449907258803;5797.681127537941;5802.738876750556;5805.419458054161;5987.9401205989125;6110.7250173741395;6161.045038019114;6184.6598437086395;6191.783287584913;6001.639901605918;6030.638161710312;6034;6041.426064523863;6044.063170208625;5775.220345253337;5777.711114444345;5795.275590551181;5803.158542011469;5811.622244554091;4182.707210495358;4187.183499217624;4191.077962848169;4192.496900371975;4203.495580530356;6064.848378790565;6103.481204097701;6126.326104128453;6132.448079672851;6147.754089836357;5691.26013618227;5914.408559144224;5934.6142500737315;5934.881302374015;5956.642601443928;5925.200097986716;5946.672932988728;5947.434993675594;5953.184278795009;5954.047352423591;5814.5639077068545;5846.444587764156;5853.795117170878;5855.414458554111;5858.414158584107;5948.078047902582;5969.611975221596;5973.372795856372;5983.640981541122;5997.280326360865;5600;5776.624519406225;5841.357450680507;5846.444587764156;5849.415058494116 09:29:32 INFO - PROCESS | 20841 | |5;yui.html;676.3540818518312;680.7821497120921;687.3229868579448;735.6211551051206;760.3423039071198;10865.67402977911;12488.937555312223;12633.936830315846;12650.240985540873;13925.37335819888;13922.443102275896;13974.510892118778;13998.860011399884;14016.789748153786;14029.36867840947;634.2737565487514;788.8737801951689;792.9762107136795;800.6957356204634;801.5150833745587;799.5842162075717;804.9678012879477;807.4993504027511;807.8424707182102;808.4300568099505;849.3375167369462;849.3799526345771;849.426637020009;849.464837152596;850.3919697416346;841.8568843296624;842.3934766967805;845.995770021146;847.3348421489163;847.9279261262769;616.2943429772885;618.6721037849946;619.0992106485054;619.8729260501632;620.5563022438932;13354.666133346647;13378.197308161542;13458;13475.797863031965;13478.12392194514;12403.503859845596;12428.565000225039;12449.564265250763;12533.185342952771;12880.162789418659;10090.747731306703;10149.137323327526;10163.136133428667;10182.796344073076;10542.36745795247;3317.9170520737175;3324.8670053198084;3343.498475228711;3352.7317814574776;3405.165734395089;45243.77378113088;45712.54287457116;45819.77090114528;45929.31106033412;46059.30911036337;9845;9917.404955702681;10003.749906252402;10025.448600326907;10050.045245701647;17186.91406542959;17203.56991075208;17222.741658875126;17226.569335766708;17238.310467581407;6513.804585862432;6867.141607299088;7030.7344677957435;7180.246074162243;7285.7814265572115;3458.6541345865717;3867.0719027433215;3876.96123038766;3920.666743326792;3982.880513584539;2996.4456575533595;3040.939181216363;3047.1467988963127;3054.633443986736;3057.4496590613903;530.3158924986724;544.7113030094057;549.3682265394748;551.3328872064847;553.8809156031392;553.441024565192;565.6577770448902;568.5536853569928;593.092568370394;596.976120955157;7681.3854891608535;7715.382769378436;7738.922610773933;7922.4850384724805;7964.960175199087;476.19047619047757;493.8518444466646;526.394646156915;529.4811085136511;589.8112603966689;3621.583517895476;3665.2669466106886;3673.485712000322;3689.401140684417;3694.51971243742;46381.30428043582;46646.5335346649;46689.76655116703;46908;48488.27267590989;38898.22203555913;39252.21495570073;39275.41086883699;39387.60612393897;39871.40192897109;39297.2140557193;40017.39973900394;40428.79785601112;40921.59078409178;41988.58011419847;8221.54781487024;8238.134995825352;8250.587470626564;8342.582870856555;8434.493930364199;30490;30837.537436938015;31704.524432133996;32131.518027229144;32178.35643287168;37809.810950945066;38629.42055869108;39036;39816.203675926896;41891;10585.523651435858;10802;10892.78214435691;10999.395033273247;11089.722756931142;11775.587854425054;12349.691257718629;12375.504979800708;12412.81380779307;12477.126601138196;11250.606228781953;11283.66149015531;11483.483243253906;11599.420028998347;12117.75764484723;9934.354266972623;10296.845547316647;10565.418901960158;10569.101626361846;10627.25609207379;10061.094501494901;11212.887871121184;11531.711707207387;11964.76070478603;12037.458314375699;8495.532745699045;8578.485290882567;8590.91409085901;8605.827883442422;8965.50689712072;8683.739487815375;8962.910370896469;9086.409383390059;9105.681301154693;9143.845373346185 09:29:32 INFO - PROCESS | 20841 | __end_tp_report 09:29:32 INFO - PROCESS | 20841 | __start_cc_report 09:29:32 INFO - PROCESS | 20841 | _x_x_mozilla_cycle_collect,346 09:29:32 INFO - PROCESS | 20841 | __end_cc_report 09:29:32 INFO - PROCESS | 20841 | __startTimestamp1458577772370__endTimestamp 09:29:32 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | ------- Summary: start ------- 09:29:32 INFO - PROCESS | 20841 | Number of tests: 6 09:29:32 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | [#0] dojo.html Cycles:165 Average:4794.20 Median:4922.78 stddev:500.21 (10.2%) stddev-sans-first:472.54 09:29:32 INFO - PROCESS | 20841 | Values: 2647.3 2691.6 2711.3 2715.2 2727.3 4782.8 4823.6 4833.5 4850.5 4854.0 4742.9 4854.3 4905.0 4922.3 4952.0 4465.8 4503.0 4560.2 4573.9 4604.4 4538.3 4554.3 4591.4 4598.2 4654.9 4395.3 4413.8 4450.2 4471.0 4494.8 4455.6 4487.6 4497.5 4511.9 4530.5 4461.4 4474.1 4475.9 4485.8 4520.5 4741.4 4838.6 4840.7 4848.4 4882.3 5142.4 5155.5 5186.2 5188.4 5239.3 5109.8 5193.5 5194.5 5198.4 5204.1 4851.1 4871.7 4874.5 4876.8 4922.8 5293.7 5331.3 5336.7 5338.2 5388.1 4965.7 5052.4 5108.2 5109.0 5134.9 5001.6 5157.3 5160.1 5164.7 5213.4 5108.2 5109.2 5114.6 5130.1 5163.1 5043.8 5100.5 5138.8 5155.0 5170.3 4249.7 4287.8 4288.5 4295.1 4305.1 3719.9 3761.9 3778.9 3788.1 3812.9 4539.8 4547.5 4551.0 4557.3 4599.9 5069.0 5184.7 5235.5 5237.9 5240.9 4505.1 4552.3 4553.0 4575.6 4590.0 4596.4 4614.0 4619.2 4625.8 4671.9 4796.6 4822.2 4888.1 4893.5 4908.8 5171.5 5193.0 5204.8 5217.6 5229.4 4856.2 4922.2 4930.3 4941.3 4991.0 5001.6 5119.4 5127.6 5179.3 5211.7 5191.4 5193.9 5202.1 5206.3 5209.3 5041.4 5052.9 5053.8 5058.6 5085.6 4912.6 4951.2 4964.1 5005.8 5032.2 4956.0 4976.3 4989.7 4995.1 5003.6 5065.5 5075.3 5079.8 5089.7 5106.8 4867.5 4944.9 4989.4 5022.1 5025.6 09:29:32 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | [#1] ext.html Cycles:180 Average:42756.94 Median:35163.56 stddev:68492.36 (194.8%) stddev-sans-first:68611.16 09:29:32 INFO - PROCESS | 20841 | Values: 541.0 541.7 561.9 562.7 632.5 34471.7 34924.8 35016.8 35163.5 35271.0 37766.4 38136.0 38404.8 38452.6 38535.2 7712.4 7858.8 7872.5 7883.7 7884.6 7648.9 7802.7 7815.7 7817.9 7843.0 7845.5 7850.3 7862.3 7881.9 7882.9 7792.7 7806.2 7858.1 7865.0 7894.1 7762.7 7838.3 7881.0 7890.7 7896.2 35762.5 35965.3 36045.6 36186.8 36191.8 3103.6 3218.4 3386.4 3537.6 3642.7 26715.7 28858.0 29350.7 29734.6 29973.0 3251.2 3354.5 3360.1 3390.1 3501.4 239786.0 240292.0 240297.0 241346.0 241961.8 56324.4 56366.7 56510.7 56603.7 56727.4 64952.0 65574.0 65771.0 65791.0 65841.7 12438.5 12544.1 12584.4 12592.2 12623.5 9236.0 9258.7 9274.1 9276.5 9293.4 19834.6 20144.0 20169.3 20180.4 20264.5 7837.1 8058.8 8150.5 8171.4 8286.7 870.3 881.6 937.1 1026.1 1027.5 26807.9 26973.5 26996.3 27056.6 27127.0 997.4 1002.7 1012.9 1013.9 1038.2 13649.4 14197.2 14223.1 14395.0 14410.3 279012.0 283245.0 285067.0 285153.0 286139.0 47337.0 47852.0 47986.3 48006.0 48012.8 1218.4 1219.2 1235.3 1242.6 1257.9 26121.2 26241.6 26471.5 26540.7 26925.0 41655.4 41939.4 42037.8 42046.6 42191.2 258709.0 260321.0 260442.0 262407.0 263217.0 31441.8 32840.5 32863.3 32882.4 32926.7 40091.6 40834.6 41073.4 41281.6 42241.6 34368.8 34705.3 34861.3 34969.5 35416.6 34200.7 34625.3 34843.0 35046.0 35163.6 35636.0 35843.0 36754.3 37681.4 37859.6 27871.3 29188.6 29527.4 31549.0 31797.5 25030.6 25880.4 26344.0 26941.2 26948.0 09:29:32 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | [#2] jquery.html Cycles:180 Average:24038.71 Median:5134.64 stddev:72080.12 (1403.8%) stddev-sans-first:72260.36 09:29:32 INFO - PROCESS | 20841 | Values: 338.7 354.3 355.5 360.8 365.1 13238.9 15605.1 15894.8 16003.8 16019.9 10410.4 10570.8 10602.9 10642.8 14307.9 4474.8 4685.6 4718.0 4721.2 4737.9 4582.7 4999.9 5154.7 5168.7 5206.7 5121.6 5147.7 5164.0 5180.6 5330.3 5420.3 5425.3 5430.3 5440.5 5453.3 4861.0 4876.8 5224.5 5230.5 5238.6 12121.3 12249.3 12256.8 12292.2 12309.3 1882.6 1929.3 1973.8 2089.7 2289.0 8904.7 8925.0 8932.8 8970.3 9098.5 1688.9 1762.7 1774.1 1774.5 1784.9 59037.4 59192.7 59192.7 59648.1 60380.7 9978.3 10122.6 10281.5 10372.1 10416.5 13144.1 13175.1 13187.7 13202.6 13274.7 5960.0 6499.2 6676.7 6748.3 6765.9 6085.8 6089.5 6114.4 6150.6 6208.9 4261.1 4342.2 4352.6 4399.2 4433.2 1785.5 1864.2 1870.3 1883.7 1893.4 852.3 896.8 907.0 931.7 950.1 15717.0 15842.8 15944.2 16051.0 16283.0 869.2 884.4 890.7 924.2 973.0 8991.2 9187.0 9207.0 9327.7 9394.4 430165.0 439299.0 439940.0 440579.0 450803.0 64134.0 64677.4 66339.0 66749.7 67240.3 895.8 900.9 903.2 908.2 908.5 14313.1 14673.4 14678.6 14685.1 14908.7 24264.9 31660.4 32002.8 32302.0 33101.2 43596.0 43839.3 43955.0 44507.1 44654.8 7111.4 7191.7 7295.3 7362.3 7379.0 8138.3 10656.7 11215.1 11244.9 11332.5 9546.9 9663.5 9781.9 9816.4 9818.0 6042.5 9207.4 9626.1 9633.9 10051.3 9479.7 9661.3 9812.3 10101.5 10172.8 7115.2 7186.6 7352.3 7446.3 7565.3 7665.0 9061.0 9713.3 9855.5 9986.0 09:29:32 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | [#3] mootools.html Cycles:180 Average:5206.41 Median:6221.78 stddev:2683.02 (43.1%) stddev-sans-first:2675.39 09:29:32 INFO - PROCESS | 20841 | Values: 1411.9 1431.3 1574.2 1735.1 1745.3 6472.8 6944.5 7239.8 7455.3 7458.7 7254.3 7254.3 7258.3 7301.8 7354.7 2161.3 2203.3 2206.9 2212.8 2215.5 2200.0 2218.8 2229.3 2235.5 2238.2 2215.7 2219.4 2229.8 2238.5 2246.7 2201.3 2229.8 2237.2 2246.8 2257.1 2245.6 2258.7 2260.8 2260.9 2266.2 7346.7 7429.6 7431.9 7453.3 7454.6 4382.5 4477.9 4493.3 4496.1 4498.2 2913.4 3089.9 3104.5 3125.1 3131.5 895.9 907.7 918.8 933.3 941.9 10093.2 10104.9 10116.8 10131.2 10145.3 4207.6 4239.3 4288.7 4318.1 4335.7 8650.4 8651.0 8655.3 8661.1 8675.9 4445.9 4451.3 4459.3 4470.6 4487.7 3654.4 4011.5 4085.9 4105.3 4111.7 3616.3 3625.7 3679.9 3702.9 3718.1 1144.9 1156.7 1166.0 1173.5 1182.4 1223.9 1228.6 1237.2 1240.0 1257.9 6856.7 6873.1 6913.3 7037.6 7044.0 470.5 472.0 474.2 474.9 476.1 5467.5 5476.4 5492.2 5620.8 5625.0 8932.2 9164.5 9180.7 9200.5 9211.6 8208.3 8457.0 8505.7 8963.5 8971.3 7001.5 7059.3 7062.6 7091.2 7094.2 7103.9 7107.9 7180.4 7184.8 7202.5 7968.1 8041.0 8120.9 8124.5 8159.3 8254.1 8328.7 8348.5 8370.4 8442.5 5890.6 6219.8 6397.8 6595.5 6690.3 6890.5 6914.3 6973.8 6996.7 6997.4 6347.9 6361.1 6386.0 6388.9 6459.8 6401.9 6421.6 6421.7 6461.3 6484.2 6714.9 6756.0 6761.0 6761.4 6775.7 6168.8 6199.3 6205.6 6213.9 6223.7 6363.8 6371.5 6382.8 6385.4 6386.0 09:29:32 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | [#4] prototype.html Cycles:180 Average:4866.53 Median:5569.82 stddev:1456.35 (26.1%) stddev-sans-first:1419.67 09:29:32 INFO - PROCESS | 20841 | Values: 307.8 313.9 315.0 318.9 319.3 5508.3 5621.1 5661.7 5664.5 5680.9 5550.0 5550.9 5553.7 5556.0 5583.6 4085.1 4186.4 4266.9 4323.8 4339.4 4274.0 4294.3 4298.4 4313.7 4334.0 4234.7 4245.4 4254.3 4256.6 4260.7 4258.8 4260.7 4264.1 4268.5 4277.4 3725.7 3729.6 3735.4 3736.2 3738.9 5325.5 5332.0 5367.1 5372.2 5373.5 4641.5 4739.9 4900.4 4930.2 4948.5 5807.6 5845.4 5862.9 5895.6 5930.3 3912.7 3937.9 3942.6 3946.7 3950.9 6107.9 6124.4 6143.5 6170.6 6180.4 4092.4 4127.9 4134.1 4138.7 4139.3 4189.9 4195.1 4200.3 4201.5 4202.4 4646.8 4762.0 4769.9 4863.6 4882.6 5814.8 5832.5 5863.4 5871.7 5891.4 1456.9 1466.6 1476.9 1480.0 1480.4 961.2 976.2 985.4 994.3 1001.3 5175.5 5185.6 5204.4 5210.3 5213.8 6094.0 6099.4 6104.6 6114.4 6116.5 4981.2 5149.0 5173.0 5178.3 5190.1 3228.3 3308.6 3324.5 3329.1 3329.6 5792.8 5808.0 5810.0 5820.1 5829.9 6280.4 6307.1 6312.6 6318.5 6323.8 5751.6 5790.4 5797.7 5802.7 5805.4 5987.9 6110.7 6161.0 6184.7 6191.8 6001.6 6030.6 6034.0 6041.4 6044.1 5775.2 5777.7 5795.3 5803.2 5811.6 4182.7 4187.2 4191.1 4192.5 4203.5 6064.8 6103.5 6126.3 6132.4 6147.8 5691.3 5914.4 5934.6 5934.9 5956.6 5925.2 5946.7 5947.4 5953.2 5954.0 5814.6 5846.4 5853.8 5855.4 5858.4 5948.1 5969.6 5973.4 5983.6 5997.3 5600.0 5776.6 5841.4 5846.4 5849.4 09:29:32 INFO - PROCESS | 20841 | 09:29:32 INFO - PROCESS | 20841 | [#5] yui.html Cycles:180 Average:12520.04 Median:21927.14 stddev:13598.13 (62.0%) stddev-sans-first:13607.19 09:29:32 INFO - PROCESS | 20841 | Values: 676.4 680.8 687.3 735.6 760.3 10865.7 12488.9 12633.9 12650.2 13925.4 13922.4 13974.5 13998.9 14016.8 14029.4 634.3 788.9 793.0 800.7 801.5 799.6 805.0 807.5 807.8 808.4 849.3 849.4 849.4 849.5 850.4 841.9 842.4 846.0 847.3 847.9 616.3 618.7 619.1 619.9 620.6 13354.7 13378.2 13458.0 13475.8 13478.1 12403.5 12428.6 12449.6 12533.2 12880.2 10090.7 10149.1 10163.1 10182.8 10542.4 3317.9 3324.9 3343.5 3352.7 3405.2 45243.8 45712.5 45819.8 45929.3 46059.3 9845.0 9917.4 10003.7 10025.4 10050.0 17186.9 17203.6 17222.7 17226.6 17238.3 6513.8 6867.1 7030.7 7180.2 7285.8 3458.7 3867.1 3877.0 3920.7 3982.9 2996.4 3040.9 3047.1 3054.6 3057.4 530.3 544.7 549.4 551.3 553.9 553.4 565.7 568.6 593.1 597.0 7681.4 7715.4 7738.9 7922.5 7965.0 476.2 493.9 526.4 529.5 589.8 3621.6 3665.3 3673.5 3689.4 3694.5 46381.3 46646.5 46689.8 46908.0 48488.3 38898.2 39252.2 39275.4 39387.6 39871.4 39297.2 40017.4 40428.8 40921.6 41988.6 8221.5 8238.1 8250.6 8342.6 8434.5 30490.0 30837.5 31704.5 32131.5 32178.4 37809.8 38629.4 39036.0 39816.2 41891.0 10585.5 10802.0 10892.8 10999.4 11089.7 11775.6 12349.7 12375.5 12412.8 12477.1 11250.6 11283.7 11483.5 11599.4 12117.8 9934.4 10296.8 10565.4 10569.1 10627.3 10061.1 11212.9 11531.7 11964.8 12037.5 8495.5 8578.5 8590.9 8605.8 8965.5 8683.7 8962.9 9086.4 9105.7 9143.8 09:29:32 INFO - PROCESS | 20841 | -------- Summary: end -------- 09:29:32 INFO - PROCESS | 20841 | 09:29:33 INFO - TEST-INFO | 20841: exit 0 09:29:33 INFO - TEST-OK | dromaeo_css | took 1116546ms 09:29:33 INFO - TEST-START | kraken 09:29:33 INFO - operating with platform_type : linux_ 09:29:33 INFO - Initialising browser for kraken test... 09:29:33 INFO - TEST-INFO | started process 21078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpESsMki/profile http://localhost:41035/getInfo.html) 09:29:37 INFO - PROCESS | 21078 | 09:29:37 INFO - PROCESS | 21078 | (process:21149): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:29:37 INFO - PROCESS | 21078 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:29:38 INFO - PROCESS | 21078 | __metrics Screen width/height:1600/1200 09:29:38 INFO - PROCESS | 21078 | colorDepth:24 09:29:38 INFO - PROCESS | 21078 | Browser inner width/height: 1024/697 09:29:38 INFO - PROCESS | 21078 | __metrics 09:29:39 ERROR - PROCESS | 21078 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:29:40 INFO - TEST-INFO | 21078: exit 0 09:29:40 INFO - Browser initialized. 09:29:40 INFO - Running cycle 1/1 for kraken test... 09:29:40 INFO - TEST-INFO | started process 21200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpESsMki/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:42 INFO - PROCESS | 21200 | 09:29:42 INFO - PROCESS | 21200 | (process:21260): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:29:52 INFO - PROCESS | 21200 | RSS: Main: 168562688 09:29:52 INFO - PROCESS | 21200 | 09:29:54 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41035/tests/kraken/driver.html?testName=audio-beat-detection) 09:29:55 INFO - PROCESS | 21200 | RSS: Main: 172048384 09:29:55 INFO - PROCESS | 21200 | 09:29:58 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41035/tests/kraken/driver.html?testName=audio-dft) 09:29:58 INFO - PROCESS | 21200 | RSS: Main: 174436352 09:29:58 INFO - PROCESS | 21200 | 09:30:01 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41035/tests/kraken/driver.html?testName=audio-fft) 09:30:02 INFO - PROCESS | 21200 | RSS: Main: 168583168 09:30:02 INFO - PROCESS | 21200 | 09:30:04 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41035/tests/kraken/driver.html?testName=audio-oscillator) 09:30:05 INFO - PROCESS | 21200 | RSS: Main: 167448576 09:30:05 INFO - PROCESS | 21200 | 09:30:07 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41035/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:30:07 INFO - PROCESS | 21200 | RSS: Main: 167874560 09:30:07 INFO - PROCESS | 21200 | 09:30:11 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41035/tests/kraken/driver.html?testName=imaging-darkroom) 09:30:11 INFO - PROCESS | 21200 | RSS: Main: 169865216 09:30:11 INFO - PROCESS | 21200 | 09:30:15 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41035/tests/kraken/driver.html?testName=imaging-desaturate) 09:30:15 INFO - PROCESS | 21200 | RSS: Main: 169631744 09:30:15 INFO - PROCESS | 21200 | 09:30:18 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41035/tests/kraken/driver.html?testName=json-parse-financial) 09:30:19 INFO - PROCESS | 21200 | RSS: Main: 170061824 09:30:19 INFO - PROCESS | 21200 | 09:30:21 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41035/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:30:21 INFO - PROCESS | 21200 | RSS: Main: 168726528 09:30:21 INFO - PROCESS | 21200 | 09:30:23 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:30:24 INFO - PROCESS | 21200 | RSS: Main: 169336832 09:30:24 INFO - PROCESS | 21200 | 09:30:26 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:30:27 INFO - PROCESS | 21200 | RSS: Main: 170483712 09:30:27 INFO - PROCESS | 21200 | 09:30:29 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:30:30 INFO - PROCESS | 21200 | RSS: Main: 169713664 09:30:30 INFO - PROCESS | 21200 | 09:30:32 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:30:33 INFO - PROCESS | 21200 | RSS: Main: 169607168 09:30:33 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41035/tests/kraken/driver.html?testName=ai-astar) 09:30:35 INFO - PROCESS | 21200 | RSS: Main: 171630592 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | __start_tp_report 09:30:35 INFO - PROCESS | 21200 | _x_x_mozilla_page_load 09:30:35 INFO - PROCESS | 21200 | _x_x_mozilla_page_load_details 09:30:35 INFO - PROCESS | 21200 | |i|pagename|runs| 09:30:35 INFO - PROCESS | 21200 | |0;ai-astar;116;108;115;113;114;124;112;112;112;112 09:30:35 INFO - PROCESS | 21200 | |1;audio-beat-detection;160;132;148;180;132;156;152;135;173;131 09:30:35 INFO - PROCESS | 21200 | |2;audio-dft;162;163;163;163;163;170;167;165;166;163 09:30:35 INFO - PROCESS | 21200 | |3;audio-fft;75;77;77;78;74;74;73;74;138;76 09:30:35 INFO - PROCESS | 21200 | |4;audio-oscillator;94;95;144;94;94;94;141;94;95;134 09:30:35 INFO - PROCESS | 21200 | |5;imaging-gaussian-blur;118;117;118;117;117;117;118;118;117;122 09:30:35 INFO - PROCESS | 21200 | |6;imaging-darkroom;146;148;148;147;150;148;149;146;147;148 09:30:35 INFO - PROCESS | 21200 | |7;imaging-desaturate;95;98;96;96;96;97;96;97;96;97 09:30:35 INFO - PROCESS | 21200 | |8;json-parse-financial;69;74;71;69;70;71;71;70;70;72 09:30:35 INFO - PROCESS | 21200 | |9;json-stringify-tinderbox;63;64;63;64;65;64;64;65;65;65 09:30:35 INFO - PROCESS | 21200 | |10;stanford-crypto-aes;81;92;85;93;84;87;86;85;83;81 09:30:35 INFO - PROCESS | 21200 | |11;stanford-crypto-ccm;134;131;119;124;117;119;129;124;128;125 09:30:35 INFO - PROCESS | 21200 | |12;stanford-crypto-pbkdf2;133;138;141;145;142;133;138;143;139;130 09:30:35 INFO - PROCESS | 21200 | |13;stanford-crypto-sha256-iterative;69;68;71;68;67;69;68;72;72;71 09:30:35 INFO - PROCESS | 21200 | __end_tp_report 09:30:35 INFO - PROCESS | 21200 | __start_cc_report 09:30:35 INFO - PROCESS | 21200 | _x_x_mozilla_cycle_collect,937 09:30:35 INFO - PROCESS | 21200 | __end_cc_report 09:30:35 INFO - PROCESS | 21200 | __startTimestamp1458577835407__endTimestamp 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | ------- Summary: start ------- 09:30:35 INFO - PROCESS | 21200 | Number of tests: 14 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.50 stddev:4.18 (3.7%) stddev-sans-first:4.36 09:30:35 INFO - PROCESS | 21200 | Values: 116.0 108.0 115.0 113.0 114.0 124.0 112.0 112.0 112.0 112.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:154.00 stddev:17.66 (11.5%) stddev-sans-first:18.35 09:30:35 INFO - PROCESS | 21200 | Values: 160.0 132.0 148.0 180.0 132.0 156.0 152.0 135.0 173.0 131.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.51 (1.5%) stddev-sans-first:2.49 09:30:35 INFO - PROCESS | 21200 | Values: 162.0 163.0 163.0 163.0 163.0 170.0 167.0 165.0 166.0 163.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.50 stddev:19.88 (26.3%) stddev-sans-first:20.95 09:30:35 INFO - PROCESS | 21200 | Values: 75.0 77.0 77.0 78.0 74.0 74.0 73.0 74.0 138.0 76.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.00 stddev:22.06 (23.5%) stddev-sans-first:22.82 09:30:35 INFO - PROCESS | 21200 | Values: 94.0 95.0 144.0 94.0 94.0 94.0 141.0 94.0 95.0 134.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 09:30:35 INFO - PROCESS | 21200 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 122.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 09:30:35 INFO - PROCESS | 21200 | Values: 146.0 148.0 148.0 147.0 150.0 148.0 149.0 146.0 147.0 148.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.73 09:30:35 INFO - PROCESS | 21200 | Values: 95.0 98.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 97.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:71.00 stddev:1.49 (2.1%) stddev-sans-first:1.45 09:30:35 INFO - PROCESS | 21200 | Values: 69.0 74.0 71.0 69.0 70.0 71.0 71.0 70.0 70.0 72.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 09:30:35 INFO - PROCESS | 21200 | Values: 63.0 64.0 63.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:4.08 (4.8%) stddev-sans-first:3.96 09:30:35 INFO - PROCESS | 21200 | Values: 81.0 92.0 85.0 93.0 84.0 87.0 86.0 85.0 83.0 81.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.50 stddev:5.58 (4.4%) stddev-sans-first:4.87 09:30:35 INFO - PROCESS | 21200 | Values: 134.0 131.0 119.0 124.0 117.0 119.0 129.0 124.0 128.0 125.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.20 Median:140.00 stddev:4.87 (3.5%) stddev-sans-first:4.79 09:30:35 INFO - PROCESS | 21200 | Values: 133.0 138.0 141.0 145.0 142.0 133.0 138.0 143.0 139.0 130.0 09:30:35 INFO - PROCESS | 21200 | 09:30:35 INFO - PROCESS | 21200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.84 (2.6%) stddev-sans-first:1.94 09:30:35 INFO - PROCESS | 21200 | Values: 69.0 68.0 71.0 68.0 67.0 69.0 68.0 72.0 72.0 71.0 09:30:35 INFO - PROCESS | 21200 | -------- Summary: end -------- 09:30:35 INFO - PROCESS | 21200 | 09:30:36 INFO - TEST-INFO | 21200: exit 0 09:30:36 INFO - TEST-OK | kraken | took 63361ms 09:30:36 INFO - SUITE-END | took 1179s 09:30:36 INFO - Completed test suite (00:19:40) 09:30:36 INFO - javascript benchmark 09:30:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2647.2587675450873, 2691.623172755814, 2711.267957651433, 2715.2125883493786, 2727.304537342976, 4782.8326008589665, 4823.614110871131, 4833.468318484973, 4850.490698476662, 4853.975730121353, 4742.881427964294, 4854.271859221119, 4905.0, 4922.335484709563, 4951.950480495194, 4465.799039043234, 4503.0318481526465, 4560.179167749804, 4573.908521829561, 4604.424446944132, 4538.319252112176, 4554.2713165893465, 4591.380163677894, 4598.241290187132, 4654.860354189363, 4395.252807022814, 4413.845515406945, 4450.2434586120435, 4471.0, 4494.752788596626, 4455.621272191867, 4487.618552423048, 4497.482789479219, 4511.8646440606835, 4530.524294949048, 4461.42001539801, 4474.127545128668, 4475.888102797424, 4485.798139083749, 4520.52534483881, 4741.383620129361, 4838.588719958808, 4840.661153719241, 4848.442429120661, 4882.3408839806525, 5142.357205349332, 5155.510226528474, 5186.196139598368, 5188.351456067991, 5239.292695486099, 5109.795608175668, 5193.480651934814, 5194.4805519447755, 5198.350206224222, 5204.089284375219, 4851.054044461296, 4871.732054736953, 4874.488178741252, 4876.756162191876, 4922.778474968599, 5293.708846013506, 5331.333583302087, 5336.706481143497, 5338.199270109515, 5388.110961691277, 4965.677230979974, 5052.368453943257, 5108.233764935289, 5109.029284435946, 5134.922976155361, 5001.599872010231, 5157.252198431206, 5160.0969830279555, 5164.664296820694, 5213.374395072616, 5108.233764935289, 5109.233614957711, 5114.565261952701, 5130.102232109366, 5163.096458119814, 5043.84868453947, 5100.515451032146, 5138.794448222104, 5155.0, 5170.302009228706, 4249.745015299092, 4287.849925252601, 4288.50682171548, 4295.098029413795, 4305.052888364555, 3719.8512059517857, 3761.9247615047548, 3778.9244215115546, 3788.1287303919703, 3812.8856134316015, 4539.773011349485, 4547.545245475426, 4551.0, 4557.316402539579, 4599.9080018399445, 5069.0, 5184.7407629618365, 5235.476452354734, 5237.895242095136, 5240.895182096413, 4505.098980203972, 4552.3171524270965, 4552.954470455253, 4575.611073058827, 4590.0, 4596.37948876904, 4614.0310534787395, 4619.23782575878, 4625.838095666702, 4671.929921051187, 4796.56830885222, 4822.228443449031, 4888.120138375127, 4893.535114164149, 4908.803647854117, 5171.50870667301, 5193.0, 5204.8178313758835, 5217.634765566374, 5229.424763276113, 4856.174450343521, 4922.163232250455, 4930.309756634002, 4941.258811178352, 4991.0, 5001.624878134082, 5119.436861945109, 5127.564157046543, 5179.326687530597, 5211.739413029409, 5191.377034755854, 5193.870153246048, 5202.1416466282635, 5206.297149884717, 5209.348831396075, 5041.445441001413, 5052.924206136984, 5053.84838454847, 5058.595312374928, 5085.567726743268, 4912.557869791736, 4951.183054796063, 4964.05682920244, 5005.7997680092385, 5032.194848824171, 4955.950440495693, 4976.328195693535, 4989.725565093955, 4995.07591095634, 5003.574696150868, 5065.493450654905, 5075.340205773374, 5079.847604571869, 5089.720065396439, 5106.7701953412925, 4867.5132486751045, 4944.92582611254, 4989.401271847401, 5022.146235139962, 5025.623078269071], "unit": "score", "name": "dojo.html", "value": 4762.042225926897}, {"lowerIsBetter": false, "replicates": [540.9945900540995, 541.7074779619004, 561.9155030790575, 562.6989560585087, 632.475045712059, 34471.65528344716, 34924.825375873086, 35016.82491587545, 35163.4725479118, 35271.0, 37766.4335034974, 38136.0, 38404.80797596015, 38452.61547384525, 38535.22929541407, 7712.421568382366, 7858.803529911741, 7872.527648341118, 7883.684652613889, 7884.566348850811, 7648.885266721004, 7802.687892484294, 7815.687372505093, 7817.921820781805, 7843.0, 7845.490043147177, 7850.332721718661, 7862.292393684567, 7881.921180788176, 7882.921170788276, 7792.688292468294, 7806.219378062206, 7858.057033156001, 7864.960675196645, 7894.092179399385, 7762.650680719381, 7838.294553490156, 7881.0, 7890.684372625088, 7896.249856263646, 35762.46356304658, 35965.28069438623, 36045.63954360449, 36186.81906590477, 36191.81904090489, 3103.5810165627577, 3218.372417378612, 3386.356592247465, 3537.6108628050893, 3642.7267954903486, 26715.732842671714, 28858.0, 29350.706492935013, 29734.553981690075, 29973.0, 3251.2197072702616, 3354.4632858742484, 3360.1263671445354, 3390.1016230698883, 3501.3872572299747, 239786.0, 240292.0, 240297.0, 241346.0, 241961.7901910497, 56324.43675563192, 56366.71816640891, 56510.717446412506, 56603.71698141483, 56727.43272567222, 64952.0, 65574.0, 65771.0, 65791.0, 65841.67079164574, 12438.502459901503, 12544.121911466109, 12584.4337004835, 12592.181508201938, 12623.495060197673, 9235.953820230856, 9258.72223833286, 9274.118958698913, 9276.536173191313, 9293.442393456415, 19834.60330793376, 20144.0, 20169.29407470761, 20180.39458816238, 20264.493387665425, 7837.1379148293645, 8058.798530036679, 8150.510969341858, 8171.42800003994, 8286.668533258722, 870.3081050564816, 881.6164968238836, 937.0769791755116, 1026.071405378134, 1027.465717826741, 26807.86596067007, 26973.460530789274, 26996.32509187286, 27056.59415108775, 27127.0, 997.3915911294105, 1002.6841544913475, 1012.9088382045651, 1013.8986101389802, 1038.2109596706557, 13649.385777640031, 14197.219152946687, 14223.079884215706, 14395.0, 14410.279486025656, 279012.0, 283245.0, 285067.0, 285153.0, 286139.0, 47337.0, 47852.0, 47986.28020579694, 48006.0, 48012.7599362001, 1218.3968935377045, 1219.2379762648345, 1235.32057368447, 1242.6458459339226, 1257.9433925473559, 26121.216363509124, 26241.606375904757, 26471.470570588866, 26540.734592653826, 26925.0, 41655.37516937188, 41939.37090943577, 42037.78981105075, 42046.57953420427, 42191.1561768769, 258709.0, 260321.0, 260442.0, 262407.0, 263217.0, 31441.8427907859, 32840.50739238865, 32863.342733144724, 32882.38293787633, 32926.67073329332, 40091.59908400878, 40834.59165408308, 41073.38389924094, 41281.58718412898, 42241.57758422499, 34368.82815586006, 34705.30589388148, 34861.30277394489, 34969.47545786866, 35416.64583354133, 34200.65799342074, 34625.30749385049, 34843.0, 35046.0, 35163.64836351604, 35636.0, 35843.0, 36754.26491470102, 37681.43477847779, 37859.62140378671, 27871.30023121146, 29188.562171567868, 29527.409451811272, 31549.0, 31797.523037154922, 25030.62454063154, 25880.35299117462, 26344.0, 26941.191764247105, 26948.0], "unit": "score", "name": "ext.html", "value": 17311.634046238658}, {"lowerIsBetter": false, "replicates": [338.6562638921495, 354.33562071116654, 355.5342501323267, 360.7835298820708, 365.0708945733109, 13238.867611323883, 15605.14171720555, 15894.841051589481, 16003.75994360084, 16019.919900400497, 10410.375377477356, 10570.78858422831, 10602.893971060286, 10642.840357394645, 14307.856921430783, 4474.82100715971, 4685.554872287127, 4718.032803275338, 4721.150192965265, 4737.881552961169, 4582.679212455129, 4999.925001124986, 5154.74226288686, 5168.689878607277, 5206.661566998152, 5121.615878809085, 5147.6654017488745, 5164.04465173944, 5180.611454140936, 5330.333708286465, 5420.268263784378, 5425.267588875491, 5430.294061771964, 5440.510354068113, 5453.318335208099, 4861.0, 4876.780544875489, 5224.4775522447835, 5230.476952304777, 5238.554722848562, 12121.33332666703, 12249.265044097383, 12256.81614775779, 12292.201006934522, 12309.322987235699, 1882.6046530228668, 1929.2958070304378, 1973.842092632586, 2089.7492300923836, 2289.038603786397, 8904.73285801427, 8924.955375223082, 8932.776680582972, 8970.327225458052, 9098.454092754457, 1688.8733344999052, 1762.6827171109196, 1774.104077440897, 1774.4853992342205, 1784.857211423083, 59037.40962590405, 59192.70403647954, 59192.704036479976, 59648.10527842086, 60380.69809650924, 9978.301518893608, 10122.59509619607, 10281.485925703684, 10372.066514013775, 10416.531256093494, 13144.145630534176, 13175.14361566495, 13187.73624527504, 13202.603921882359, 13274.668133296746, 5960.0, 6499.1876015498065, 6676.732930682815, 6748.257691653914, 6765.8646827063185, 6085.817425477243, 6089.451949324582, 6114.38856114385, 6150.600210986271, 6208.906866397007, 4261.062566235423, 4342.218400687906, 4352.586504282088, 4399.1641588098155, 4433.1577000369825, 1785.4911350265113, 1864.2263460663673, 1870.298638010746, 1883.7268596053495, 1893.4319704088718, 852.3394369363792, 896.8161526886972, 907.0, 931.6785708930408, 950.102153464969, 15717.0, 15842.76235856463, 15944.202789860461, 16051.0, 16283.0, 869.1612593846842, 884.3500027479797, 890.6882591093066, 924.1590152960773, 972.9659461918799, 8991.190792828676, 9187.035361287102, 9207.0, 9327.720168394959, 9394.436333819993, 430165.0, 439299.0, 439940.0, 440579.0, 450803.0, 64134.0, 64677.353226468076, 66339.0, 66749.66625166843, 67240.32759672438, 895.7626229049307, 900.8873890763655, 903.2412773270485, 908.1871724806261, 908.5184852028435, 14313.141211527342, 14673.413063477341, 14678.633034173803, 14685.118892866461, 14908.701825963637, 24264.87867560651, 31660.366792664478, 32002.83998579992, 32302.0, 33101.17247068843, 43596.0, 43839.34240986451, 43955.0, 44507.10985780331, 44654.77672611746, 7111.359977601834, 7191.676374563052, 7295.270472952662, 7362.300581444754, 7378.9631051846545, 8138.267555919995, 10656.684042962612, 11215.111981299848, 11244.887551124712, 11332.490037948148, 9546.949835518226, 9663.516824158623, 9781.902180978099, 9816.411015339103, 9818.0, 6042.486388657014, 9207.40151890125, 9626.085521875411, 9633.90366096358, 10051.296409251283, 9479.668211612561, 9661.275404344842, 9812.318055817834, 10101.545430455793, 10172.84740728875, 7115.181754098345, 7186.6047367395295, 7352.338289553966, 7446.329830315298, 7565.2812982766545, 7665.0, 9060.95469522648, 9713.271504637321, 9855.507224638883, 9985.950070249603], "unit": "score", "name": "jquery.html", "value": 7631.323366074387}, {"lowerIsBetter": false, "replicates": [1411.8941079419044, 1431.2843578210898, 1574.2364952997793, 1735.0977491704307, 1745.2931562717104, 6472.773452929148, 6944.51388402812, 7239.819004524889, 7455.254474552542, 7458.664360103801, 7254.274572542743, 7254.274572542743, 7258.274172582753, 7301.780946571598, 7354.742584009561, 2161.3083813179787, 2203.283932721864, 2206.8675879447283, 2212.83403744719, 2215.4904371994453, 2199.9780002200014, 2218.82249420046, 2229.297771202066, 2235.519363336882, 2238.238998740428, 2215.656573231152, 2219.4007617943143, 2229.7993180613744, 2238.529908719171, 2246.7416247131546, 2201.3175915466177, 2229.8216142708707, 2237.1610646007666, 2246.764089770575, 2257.142285931352, 2245.5508898220423, 2258.6612008198736, 2260.8304377171776, 2260.9095636174534, 2266.150193677371, 7346.742863999734, 7429.62851857405, 7431.925680743231, 7453.329200371938, 7454.5899975501325, 4382.452193475816, 4477.910441791146, 4493.258612328995, 4496.0783039477155, 4498.167838949772, 2913.373624670706, 3089.9185285150243, 3104.5498402731705, 3125.140586338752, 3131.545925840763, 895.8835351404341, 907.6959218661756, 918.8437965545874, 933.2813733425224, 941.9152276295098, 10093.192544596415, 10104.89895101047, 10116.797664046751, 10131.189504839595, 10145.34055286404, 4207.600277973649, 4239.300515414983, 4288.699791014661, 4318.050028993616, 4335.739855608674, 8650.394472386999, 8651.04838467768, 8655.264302534355, 8661.090585488559, 8675.91324086751, 4445.888852778642, 4451.332300154938, 4459.264221403497, 4470.619997300201, 4487.730736155841, 3654.3604869148326, 4011.4584531088512, 4085.8978525536504, 4105.281575724236, 4111.732737372061, 3616.349057169682, 3625.728070394678, 3679.8528058877882, 3702.851885924533, 3718.0518967663616, 1144.8626164860104, 1156.70504021474, 1166.003067377397, 1173.5481839491856, 1182.3674334231146, 1223.920445171061, 1228.5700004998357, 1237.1834589171103, 1240.0265791353745, 1257.9496820127276, 6856.691448884812, 6873.072135261776, 6913.274106218774, 7037.6481175941, 7044.049053377831, 470.545923184129, 471.98820029498853, 474.1986043586328, 474.91214125386915, 476.1334371444008, 5467.507924286754, 5476.397596264408, 5492.203630473559, 5620.775168993195, 5624.97187514068, 8932.151445612657, 9164.495952722531, 9180.724578262663, 9200.539973001458, 9211.618257261465, 8208.343332533383, 8456.957715211385, 8505.65977360911, 8963.462192268486, 8971.327150463741, 7001.544899581511, 7059.2940705928995, 7062.611556364449, 7091.219965803757, 7094.219635840053, 7103.893441598483, 7107.857842843011, 7180.425565954607, 7184.820379490555, 7202.49582529218, 7968.123506414174, 8041.0, 8120.944277243921, 8124.512529248264, 8159.26566609008, 8254.0507841599, 8328.708495202638, 8348.540830254395, 8370.414071014971, 8442.535660538484, 5890.558208134321, 6219.844503887439, 6397.808065758035, 6595.505337099641, 6690.29751876046, 6890.517663763689, 6914.274001229798, 6973.790786276217, 6996.685149168198, 6997.440204783707, 6347.936520634735, 6361.118734562548, 6385.968070159805, 6388.936110638834, 6459.838504037437, 6401.8719625608155, 6421.582597131359, 6421.678916054272, 6461.256955450183, 6484.221893372825, 6714.865702685821, 6756.020377045203, 6760.966195168992, 6761.425278851353, 6775.728970841111, 6168.814935551941, 6199.28708198563, 6205.565610407228, 6213.9067913982235, 6223.719932602953, 6363.809085727436, 6371.5221358397375, 6382.840428989312, 6385.393387628168, 6386.042093685985], "unit": "score", "name": "mootools.html", "value": 4230.901741653387}, {"lowerIsBetter": false, "replicates": [307.8183871515805, 313.9089663997439, 314.9653538110809, 318.9282411457424, 319.2593183813553, 5508.3114610673665, 5621.128725047619, 5661.716914154286, 5664.490195882369, 5680.9431905680985, 5549.972250138754, 5550.944490555094, 5553.666779993193, 5556.0, 5583.637063590863, 4085.142120154771, 4186.413902053715, 4266.914661706764, 4323.805428755698, 4339.41611311872, 4273.978630106845, 4294.269974104394, 4298.441202643652, 4313.741175529462, 4333.978330108345, 4234.724742891717, 4245.426867372896, 4254.298040823276, 4256.553061928499, 4260.744355338674, 4258.829646814123, 4260.72305300156, 4264.061906380607, 4268.487781466213, 4277.422547956048, 3725.7205709571617, 3729.6083911189476, 3735.364987952055, 3736.178040831013, 3738.887833365003, 5325.4940780625775, 5331.973340133313, 5367.141257398797, 5372.247885296062, 5373.543248823855, 4641.466231383401, 4739.881502962419, 4900.387451568554, 4930.235813448921, 4948.480409556981, 5807.5644326675665, 5845.357010728816, 5862.882742345129, 5895.61678490901, 5930.258717660293, 3912.726109172359, 3937.877704854103, 3942.56631770505, 3946.6645335146545, 3950.920981580381, 6107.938920610782, 6124.387561243884, 6143.539234557471, 6170.568060235785, 6180.412860778264, 4092.4270602115726, 4127.938080928789, 4134.069834287321, 4138.730982486129, 4139.275626765364, 4189.937150942738, 4195.098053918422, 4200.264953633163, 4201.516825565038, 4202.411662367271, 4646.767661616906, 4761.976190119097, 4769.928451073237, 4863.635227357962, 4882.633802464829, 5814.76740930358, 5832.504237139806, 5863.442972917566, 5871.6770577618645, 5891.351951285355, 1456.876165525921, 1466.6480044789173, 1476.859698328657, 1479.9556013319618, 1480.4004378226834, 961.2262128986233, 976.1897624971257, 985.4383001689112, 994.3288280410694, 1001.3191030099457, 5175.534201921845, 5185.585153187736, 5204.42751297357, 5210.296609957683, 5213.843584692465, 6094.0, 6099.3900609938655, 6104.572679912452, 6114.357992410822, 6116.48009919153, 4981.178105612534, 5148.9742551287, 5172.991266702957, 5178.300929374562, 5190.11767999441, 3228.338190670907, 3308.586426696663, 3324.5013248012992, 3329.051220402174, 3329.6337402885665, 5792.79725209624, 5808.012637851575, 5809.970950145307, 5820.097884827858, 5829.941700583025, 6280.403361680633, 6307.148534947815, 6312.5581209314905, 6318.494520438354, 6323.7786677466065, 5751.626144300607, 5790.449907258803, 5797.681127537941, 5802.738876750556, 5805.419458054161, 5987.9401205989125, 6110.7250173741395, 6161.045038019114, 6184.6598437086395, 6191.783287584913, 6001.639901605918, 6030.638161710312, 6034.0, 6041.426064523863, 6044.063170208625, 5775.220345253337, 5777.711114444345, 5795.275590551181, 5803.158542011469, 5811.622244554091, 4182.707210495358, 4187.183499217624, 4191.077962848169, 4192.496900371975, 4203.495580530356, 6064.848378790565, 6103.481204097701, 6126.326104128453, 6132.448079672851, 6147.754089836357, 5691.26013618227, 5914.408559144224, 5934.6142500737315, 5934.881302374015, 5956.642601443928, 5925.200097986716, 5946.672932988728, 5947.434993675594, 5953.184278795009, 5954.047352423591, 5814.5639077068545, 5846.444587764156, 5853.795117170878, 5855.414458554111, 5858.414158584107, 5948.078047902582, 5969.611975221596, 5973.372795856372, 5983.640981541122, 5997.280326360865, 5600.0, 5776.624519406225, 5841.357450680507, 5846.444587764156, 5849.415058494116], "unit": "score", "name": "prototype.html", "value": 4394.610401140417}, {"lowerIsBetter": false, "replicates": [676.3540818518312, 680.7821497120921, 687.3229868579448, 735.6211551051206, 760.3423039071198, 10865.67402977911, 12488.937555312223, 12633.936830315846, 12650.240985540873, 13925.37335819888, 13922.443102275896, 13974.510892118778, 13998.860011399884, 14016.789748153786, 14029.36867840947, 634.2737565487514, 788.8737801951689, 792.9762107136795, 800.6957356204634, 801.5150833745587, 799.5842162075717, 804.9678012879477, 807.4993504027511, 807.8424707182102, 808.4300568099505, 849.3375167369462, 849.3799526345771, 849.426637020009, 849.464837152596, 850.3919697416346, 841.8568843296624, 842.3934766967805, 845.995770021146, 847.3348421489163, 847.9279261262769, 616.2943429772885, 618.6721037849946, 619.0992106485054, 619.8729260501632, 620.5563022438932, 13354.666133346647, 13378.197308161542, 13458.0, 13475.797863031965, 13478.12392194514, 12403.503859845596, 12428.565000225039, 12449.564265250763, 12533.185342952771, 12880.162789418659, 10090.747731306703, 10149.137323327526, 10163.136133428667, 10182.796344073076, 10542.36745795247, 3317.9170520737175, 3324.8670053198084, 3343.498475228711, 3352.7317814574776, 3405.165734395089, 45243.77378113088, 45712.54287457116, 45819.77090114528, 45929.31106033412, 46059.30911036337, 9845.0, 9917.404955702681, 10003.749906252402, 10025.448600326907, 10050.045245701647, 17186.91406542959, 17203.56991075208, 17222.741658875126, 17226.569335766708, 17238.310467581407, 6513.804585862432, 6867.141607299088, 7030.7344677957435, 7180.246074162243, 7285.7814265572115, 3458.6541345865717, 3867.0719027433215, 3876.96123038766, 3920.666743326792, 3982.880513584539, 2996.4456575533595, 3040.939181216363, 3047.1467988963127, 3054.633443986736, 3057.4496590613903, 530.3158924986724, 544.7113030094057, 549.3682265394748, 551.3328872064847, 553.8809156031392, 553.441024565192, 565.6577770448902, 568.5536853569928, 593.092568370394, 596.976120955157, 7681.3854891608535, 7715.382769378436, 7738.922610773933, 7922.4850384724805, 7964.960175199087, 476.19047619047757, 493.8518444466646, 526.394646156915, 529.4811085136511, 589.8112603966689, 3621.583517895476, 3665.2669466106886, 3673.485712000322, 3689.401140684417, 3694.51971243742, 46381.30428043582, 46646.5335346649, 46689.76655116703, 46908.0, 48488.27267590989, 38898.22203555913, 39252.21495570073, 39275.41086883699, 39387.60612393897, 39871.40192897109, 39297.2140557193, 40017.39973900394, 40428.79785601112, 40921.59078409178, 41988.58011419847, 8221.54781487024, 8238.134995825352, 8250.587470626564, 8342.582870856555, 8434.493930364199, 30490.0, 30837.537436938015, 31704.524432133996, 32131.518027229144, 32178.35643287168, 37809.810950945066, 38629.42055869108, 39036.0, 39816.203675926896, 41891.0, 10585.523651435858, 10802.0, 10892.78214435691, 10999.395033273247, 11089.722756931142, 11775.587854425054, 12349.691257718629, 12375.504979800708, 12412.81380779307, 12477.126601138196, 11250.606228781953, 11283.66149015531, 11483.483243253906, 11599.420028998347, 12117.75764484723, 9934.354266972623, 10296.845547316647, 10565.418901960158, 10569.101626361846, 10627.25609207379, 10061.094501494901, 11212.887871121184, 11531.711707207387, 11964.76070478603, 12037.458314375699, 8495.532745699045, 8578.485290882567, 8590.91409085901, 8605.827883442422, 8965.50689712072, 8683.739487815375, 8962.910370896469, 9086.409383390059, 9105.681301154693, 9143.845373346185], "unit": "score", "name": "yui.html", "value": 5922.643560797554}], "name": "dromaeo_css", "value": 6408.753647476236}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 115.0, 113.0, 114.0, 124.0, 112.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [160.0, 132.0, 148.0, 180.0, 132.0, 156.0, 152.0, 135.0, 173.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 163.0, 163.0, 170.0, 167.0, 165.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 77.0, 78.0, 74.0, 74.0, 73.0, 74.0, 138.0, 76.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 144.0, 94.0, 94.0, 94.0, 141.0, 94.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 122.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.9}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 148.0, 147.0, 150.0, 148.0, 149.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [69.0, 74.0, 71.0, 69.0, 70.0, 71.0, 71.0, 70.0, 70.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [81.0, 92.0, 85.0, 93.0, 84.0, 87.0, 86.0, 85.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [134.0, 131.0, 119.0, 124.0, 117.0, 119.0, 129.0, 124.0, 128.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [133.0, 138.0, 141.0, 145.0, 142.0, 133.0, 138.0, 143.0, 139.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 71.0, 68.0, 67.0, 69.0, 68.0, 72.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1533.0}]} 09:30:36 INFO - Return code: 0 09:30:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:30:36 ERROR - # TBPL SUCCESS # 09:30:36 INFO - Running post-action listener: _resource_record_post_action 09:30:36 INFO - Running post-run listener: _resource_record_post_run 09:30:37 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 300511232; Read time: 620; Write time: 576796 09:30:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 16396288; Read time: 0; Write time: 12828 09:30:37 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284114944; Read time: 620; Write time: 563968 09:30:37 INFO - Running post-run listener: _upload_blobber_files 09:30:37 INFO - Blob upload gear active. 09:30:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:30:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:30:37 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:30:37 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:30:38 INFO - (blobuploader) - INFO - Open directory for files ... 09:30:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:30:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:39 INFO - (blobuploader) - INFO - Done attempting. 09:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:30:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:40 INFO - (blobuploader) - INFO - Done attempting. 09:30:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:30:40 INFO - Return code: 0 09:30:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:30:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:30:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d51bf4df643680fab993189e3e0ab9d251246ef02d8727e8996d324ae976a31899ccabeac5043ced1f378d9b028dd2861a7c23744868c8f3cf34f2d668d2635", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12511159219c4b6153928ceca63e02bdbc141c4fbcb708266551bd5dd6b6f71f1f565ccb5fca18c25751e24b6c5bc436f9f4a62ecab9e0329cbd2d6c3a105717"} 09:30:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:30:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:30:40 INFO - Contents: 09:30:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d51bf4df643680fab993189e3e0ab9d251246ef02d8727e8996d324ae976a31899ccabeac5043ced1f378d9b028dd2861a7c23744868c8f3cf34f2d668d2635", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12511159219c4b6153928ceca63e02bdbc141c4fbcb708266551bd5dd6b6f71f1f565ccb5fca18c25751e24b6c5bc436f9f4a62ecab9e0329cbd2d6c3a105717"} 09:30:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:30:40 INFO - Copying logs to upload dir... 09:30:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:30:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.337178 ========= master_lag: 8.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-21 09:30:49.004750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 09:30:49.008111) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 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/Firefox-Non-PGO/sha512/0d51bf4df643680fab993189e3e0ab9d251246ef02d8727e8996d324ae976a31899ccabeac5043ced1f378d9b028dd2861a7c23744868c8f3cf34f2d668d2635", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12511159219c4b6153928ceca63e02bdbc141c4fbcb708266551bd5dd6b6f71f1f565ccb5fca18c25751e24b6c5bc436f9f4a62ecab9e0329cbd2d6c3a105717"} build_url:https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/WFlRY1DXRhSr1tSRWv7pnw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d51bf4df643680fab993189e3e0ab9d251246ef02d8727e8996d324ae976a31899ccabeac5043ced1f378d9b028dd2861a7c23744868c8f3cf34f2d668d2635", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12511159219c4b6153928ceca63e02bdbc141c4fbcb708266551bd5dd6b6f71f1f565ccb5fca18c25751e24b6c5bc436f9f4a62ecab9e0329cbd2d6c3a105717"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 09:30:49.047786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:30:49.048108) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458576378.992807-1846221059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004783 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:30:49.136729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 09:30:49.137033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 09:30:49.137364) ========= ========= Total master_lag: 8.77 =========