builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1460324956.17 results: success (0) buildid: 20160410132212 builduid: 03c93c0bb91749b98fdfd04f24ae4308 revision: 29d5a4175c8b74f45482276a53985cf2568b4be2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.169161) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.169906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.170191) ========= 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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005868 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.223147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.223436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.273103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.273374) ========= 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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.046950 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.330245) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.330522) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.330853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.331123) ========= 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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-10 14:49:16-- 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% 27.8M=0s 2016-04-10 14:49:16 (27.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.468373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.468649) ========= 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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.122609 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:16.603243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-10 14:49:16.603587) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29d5a4175c8b74f45482276a53985cf2568b4be2 --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 29d5a4175c8b74f45482276a53985cf2568b4be2 --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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-10 14:49:16,796 truncating revision to first 12 chars 2016-04-10 14:49:16,796 Setting DEBUG logging. 2016-04-10 14:49:16,796 attempt 1/10 2016-04-10 14:49:16,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29d5a4175c8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-10 14:49:17,681 unpacking tar archive at: mozilla-central-29d5a4175c8b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.164818 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-10 14:49:17.781406) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:17.781757) ========= echo 29d5a4175c8b74f45482276a53985cf2568b4be2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'29d5a4175c8b74f45482276a53985cf2568b4be2'] 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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 29d5a4175c8b74f45482276a53985cf2568b4be2 program finished with exit code 0 elapsedTime=0.004731 script_repo_revision: '29d5a4175c8b74f45482276a53985cf2568b4be2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:17.833038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:17.833359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 14:49:17.854802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-10 14:49:17.855198) ========= /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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:49:18 INFO - MultiFileLogger online at 20160410 14:49:18 in /builds/slave/test 14:49:18 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 14:49:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:49:18 INFO - {'append_to_log': False, 14:49:18 INFO - 'base_work_dir': '/builds/slave/test', 14:49:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:49:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:49:18 INFO - 'branch': 'Firefox-Non-PGO', 14:49:18 INFO - 'buildbot_json_path': 'buildprops.json', 14:49:18 INFO - 'config_files': ('talos/linux_config.py',), 14:49:18 INFO - 'default_actions': ('clobber', 14:49:18 INFO - 'read-buildbot-config', 14:49:18 INFO - 'download-and-extract', 14:49:18 INFO - 'populate-webroot', 14:49:18 INFO - 'create-virtualenv', 14:49:18 INFO - 'install', 14:49:18 INFO - 'run-tests'), 14:49:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:49:18 INFO - 'download_minidump_stackwalk': True, 14:49:18 INFO - 'download_symbols': 'ondemand', 14:49:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:49:18 INFO - 'tooltool.py': '/tools/tooltool.py', 14:49:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:49:18 INFO - '/tools/misc-python/virtualenv.py')}, 14:49:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:49:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:49:18 INFO - 'installer_path': 'installer.exe', 14:49:18 INFO - 'log_level': 'info', 14:49:18 INFO - 'log_name': 'talos', 14:49:18 INFO - 'log_to_console': True, 14:49:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:49:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:49:18 INFO - 'opt_config_files': (), 14:49:18 INFO - 'pip_index': False, 14:49:18 INFO - 'sps_profile': False, 14:49:18 INFO - 'sps_profile_interval': 0, 14:49:18 INFO - 'suite': 'dromaeojs-e10s', 14:49:18 INFO - 'system_bits': '32', 14:49:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:49:18 INFO - 'title': 'talos-linux64-ix-031', 14:49:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:49:18 INFO - 'use_talos_json': True, 14:49:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:49:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:49:18 INFO - 'work_dir': 'build'} 14:49:18 INFO - ##### 14:49:18 INFO - ##### Running clobber step. 14:49:18 INFO - ##### 14:49:18 INFO - Running pre-action listener: _resource_record_pre_action 14:49:18 INFO - Running main action method: clobber 14:49:18 INFO - rmtree: /builds/slave/test/build 14:49:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:49:19 INFO - Running post-action listener: _resource_record_post_action 14:49:19 INFO - ##### 14:49:19 INFO - ##### Running read-buildbot-config step. 14:49:19 INFO - ##### 14:49:19 INFO - Running pre-action listener: _resource_record_pre_action 14:49:19 INFO - Running main action method: read_buildbot_config 14:49:19 INFO - Using buildbot properties: 14:49:19 INFO - { 14:49:19 INFO - "project": "", 14:49:19 INFO - "product": "firefox", 14:49:19 INFO - "script_repo_revision": "production", 14:49:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:49:19 INFO - "repository": "", 14:49:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:49:19 INFO - "buildid": "20160410132212", 14:49:19 INFO - "pgo_build": "False", 14:49:19 INFO - "basedir": "/builds/slave/test", 14:49:19 INFO - "buildnumber": 23, 14:49:19 INFO - "slavename": "talos-linux64-ix-031", 14:49:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:49:19 INFO - "platform": "ubuntu64_hw", 14:49:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:49:19 INFO - "branch": "mozilla-central", 14:49:19 INFO - "repo_path": "mozilla-central", 14:49:19 INFO - "revision": "29d5a4175c8b74f45482276a53985cf2568b4be2", 14:49:19 INFO - "stage_platform": "linux64", 14:49:19 INFO - "builduid": "03c93c0bb91749b98fdfd04f24ae4308", 14:49:19 INFO - "slavebuilddir": "test" 14:49:19 INFO - } 14:49:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:49:19 INFO - Running post-action listener: _resource_record_post_action 14:49:19 INFO - ##### 14:49:19 INFO - ##### Running download-and-extract step. 14:49:19 INFO - ##### 14:49:19 INFO - Running pre-action listener: _resource_record_pre_action 14:49:19 INFO - Running main action method: download_and_extract 14:49:19 INFO - mkdir: /builds/slave/test/build/tests 14:49:19 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')]} 14:49:19 INFO - https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:21 INFO - Downloaded 1361 bytes. 14:49:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:49:21 INFO - Using the following test package requirements: 14:49:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:49:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:49:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:49:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:49:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:49:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:49:21 INFO - u'jsshell-linux-x86_64.zip'], 14:49:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:49:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:49:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:49:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:49:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:49:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:49:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:49:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:49:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:49:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:49:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:49:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:49: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')]} 14:49:21 INFO - https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:49:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:49:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:49:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:24 INFO - Downloaded 22190241 bytes. 14:49:24 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'] 14:49:24 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 14:49:25 INFO - Return code: 0 14:49:25 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 14:49: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')]} 14:49:25 INFO - https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:28 INFO - Downloaded 22190241 bytes. 14:49:28 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'] 14:49:28 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 14:49:29 INFO - Return code: 0 14:49: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')]} 14:49:29 INFO - https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:49:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:49:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:49:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:30 INFO - Downloaded 10841046 bytes. 14:49:30 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'] 14:49:30 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 14:49:31 INFO - Return code: 0 14:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:31 INFO - https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LP71fBZtStm2zmDOGtpLkw/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 14:49:32 INFO - Downloaded 54093616 bytes. 14:49:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:49:32 INFO - mkdir: /builds/slave/test/properties 14:49:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:49:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:49:32 INFO - Contents: 14:49:32 INFO - build_url:https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:49:33 INFO - Running post-action listener: _resource_record_post_action 14:49:33 INFO - Running post-action listener: set_extra_try_arguments 14:49:33 INFO - ##### 14:49:33 INFO - ##### Running populate-webroot step. 14:49:33 INFO - ##### 14:49:33 INFO - Running pre-action listener: _resource_record_pre_action 14:49:33 INFO - Running main action method: populate_webroot 14:49:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:49:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:49:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:49:33 INFO - '--tppagecycles', 14:49:33 INFO - '7'], 14:49:33 INFO - 'tests': ['tsvgm']}}, 14:49:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:49:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:49:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:49:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:49:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:49:33 INFO - 'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:49:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:49:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:49:33 INFO - 'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['damp', 'tps']}, 14:49:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:49:33 INFO - 'tests': ['damp', 'tps']}, 14:49:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['dromaeo_dom']}, 14:49:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:49:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['a11yr', 14:49:33 INFO - 'ts_paint', 14:49:33 INFO - 'tpaint', 14:49:33 INFO - 'sessionrestore', 14:49:33 INFO - 'sessionrestore_no_auto_restore', 14:49:33 INFO - 'tabpaint']}, 14:49:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:49:33 INFO - 'ts_paint', 14:49:33 INFO - 'tpaint', 14:49:33 INFO - 'sessionrestore', 14:49:33 INFO - 'sessionrestore_no_auto_restore', 14:49:33 INFO - 'tabpaint']}, 14:49:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:49:33 INFO - 'ts_paint', 14:49:33 INFO - 'tpaint', 14:49:33 INFO - 'sessionrestore', 14:49:33 INFO - 'sessionrestore_no_auto_restore', 14:49:33 INFO - 'tabpaint']}, 14:49:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:49:33 INFO - 'ts_paint', 14:49:33 INFO - 'tpaint', 14:49:33 INFO - 'sessionrestore', 14:49:33 INFO - 'sessionrestore_no_auto_restore', 14:49:33 INFO - 'tabpaint']}, 14:49:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['a11yr', 14:49:33 INFO - 'ts_paint', 14:49:33 INFO - 'tpaint', 14:49:33 INFO - 'sessionrestore', 14:49:33 INFO - 'sessionrestore_no_auto_restore', 14:49:33 INFO - 'tabpaint']}, 14:49:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['a11yr', 14:49:33 INFO - 'ts_paint', 14:49:33 INFO - 'tpaint', 14:49:33 INFO - 'sessionrestore', 14:49:33 INFO - 'sessionrestore_no_auto_restore', 14:49:33 INFO - 'tabpaint']}, 14:49:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['tsvgx', 14:49:33 INFO - 'tsvgr_opacity', 14:49:33 INFO - 'tart', 14:49:33 INFO - 'tscrollx', 14:49:33 INFO - 'cart']}, 14:49:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:49:33 INFO - 'tsvgr_opacity', 14:49:33 INFO - 'tart', 14:49:33 INFO - 'tscrollx', 14:49:33 INFO - 'cart']}, 14:49:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:49:33 INFO - 'talos_options': ['--disable-e10s'], 14:49:33 INFO - 'tests': ['tp5o']}, 14:49:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:49:33 INFO - 'tests': ['tp5o']}, 14:49:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:49:33 INFO - 'talos_options': ['--disable-e10s', 14:49:33 INFO - '--xperf_path', 14:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:49:33 INFO - 'tests': ['tp5n']}, 14:49:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:49:33 INFO - 'talos_options': ['--xperf_path', 14:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:49:33 INFO - 'tests': ['tp5n']}}, 14:49:33 INFO - 'talos.zip': {'path': '', 14:49:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:49:33 INFO - Running post-action listener: _resource_record_post_action 14:49:33 INFO - ##### 14:49:33 INFO - ##### Running create-virtualenv step. 14:49:33 INFO - ##### 14:49:33 INFO - Running pre-action listener: _resource_record_pre_action 14:49:33 INFO - Running main action method: create_virtualenv 14:49:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:49:33 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 14:49:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:49:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:49:34 INFO - Using real prefix '/usr' 14:49:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:49:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:49:37 INFO - Installing pip.................done. 14:49:37 INFO - Return code: 0 14:49:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:37 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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:37 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 14:49:37 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 14:49:37 INFO - Using env: {'DISPLAY': ':0', 14:49:37 INFO - 'HOME': '/home/cltbld', 14:49:37 INFO - 'LANG': 'en_US.UTF-8', 14:49:37 INFO - 'LANGUAGE': 'en_US:en', 14:49:37 INFO - 'LOGNAME': 'cltbld', 14:49:37 INFO - 'MAIL': '/var/mail/cltbld', 14:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:37 INFO - 'MOZ_NO_REMOTE': '1', 14:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:37 INFO - 'NO_EM_RESTART': '1', 14:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:37 INFO - 'PWD': '/builds/slave/test', 14:49:37 INFO - 'SHELL': '/bin/bash', 14:49:37 INFO - 'SHLVL': '1', 14:49:37 INFO - 'TERM': 'linux', 14:49:37 INFO - 'TMOUT': '86400', 14:49:37 INFO - 'USER': 'cltbld', 14:49:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:37 INFO - '_': '/tools/buildbot/bin/python'} 14:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:37 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 14:49:37 INFO - Cleaning up... 14:49:37 INFO - Return code: 0 14:49:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:37 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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:37 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 14:49:37 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 14:49:37 INFO - Using env: {'DISPLAY': ':0', 14:49:37 INFO - 'HOME': '/home/cltbld', 14:49:37 INFO - 'LANG': 'en_US.UTF-8', 14:49:37 INFO - 'LANGUAGE': 'en_US:en', 14:49:37 INFO - 'LOGNAME': 'cltbld', 14:49:37 INFO - 'MAIL': '/var/mail/cltbld', 14:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:37 INFO - 'MOZ_NO_REMOTE': '1', 14:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:37 INFO - 'NO_EM_RESTART': '1', 14:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:37 INFO - 'PWD': '/builds/slave/test', 14:49:37 INFO - 'SHELL': '/bin/bash', 14:49:37 INFO - 'SHLVL': '1', 14:49:37 INFO - 'TERM': 'linux', 14:49:37 INFO - 'TMOUT': '86400', 14:49:37 INFO - 'USER': 'cltbld', 14:49:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:37 INFO - '_': '/tools/buildbot/bin/python'} 14:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:37 INFO - Downloading/unpacking psutil>=0.7.1 14:49: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 14:49: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 14:49: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 14:49: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 14:49: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 14:49: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 14:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:39 INFO - Installing collected packages: psutil 14:49:39 INFO - Running setup.py install for psutil 14:49:39 INFO - building 'psutil._psutil_linux' extension 14:49:39 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 14:49:40 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 14:49:41 INFO - building 'psutil._psutil_posix' extension 14:49:41 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 14:49:41 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 14:49:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:41 INFO - Successfully installed psutil 14:49:41 INFO - Cleaning up... 14:49:41 INFO - Return code: 0 14:49:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:41 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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:41 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 14:49:41 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 14:49:41 INFO - Using env: {'DISPLAY': ':0', 14:49:41 INFO - 'HOME': '/home/cltbld', 14:49:41 INFO - 'LANG': 'en_US.UTF-8', 14:49:41 INFO - 'LANGUAGE': 'en_US:en', 14:49:41 INFO - 'LOGNAME': 'cltbld', 14:49:41 INFO - 'MAIL': '/var/mail/cltbld', 14:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:41 INFO - 'MOZ_NO_REMOTE': '1', 14:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:41 INFO - 'NO_EM_RESTART': '1', 14:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:41 INFO - 'PWD': '/builds/slave/test', 14:49:41 INFO - 'SHELL': '/bin/bash', 14:49:41 INFO - 'SHLVL': '1', 14:49:41 INFO - 'TERM': 'linux', 14:49:41 INFO - 'TMOUT': '86400', 14:49:41 INFO - 'USER': 'cltbld', 14:49:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:41 INFO - '_': '/tools/buildbot/bin/python'} 14:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:49:41 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 14:49:41 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 14:49:41 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 14:49:41 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 14:49:41 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 14:49:41 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 14:49:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:49:43 INFO - Installing collected packages: mozsystemmonitor 14:49:43 INFO - Running setup.py install for mozsystemmonitor 14:49:43 INFO - Successfully installed mozsystemmonitor 14:49:43 INFO - Cleaning up... 14:49:43 INFO - Return code: 0 14:49:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:49:43 INFO - Using env: {'DISPLAY': ':0', 14:49:43 INFO - 'HOME': '/home/cltbld', 14:49:43 INFO - 'LANG': 'en_US.UTF-8', 14:49:43 INFO - 'LANGUAGE': 'en_US:en', 14:49:43 INFO - 'LOGNAME': 'cltbld', 14:49:43 INFO - 'MAIL': '/var/mail/cltbld', 14:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:43 INFO - 'MOZ_NO_REMOTE': '1', 14:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:43 INFO - 'NO_EM_RESTART': '1', 14:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:43 INFO - 'PWD': '/builds/slave/test', 14:49:43 INFO - 'SHELL': '/bin/bash', 14:49:43 INFO - 'SHLVL': '1', 14:49:43 INFO - 'TERM': 'linux', 14:49:43 INFO - 'TMOUT': '86400', 14:49:43 INFO - 'USER': 'cltbld', 14:49:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:43 INFO - '_': '/tools/buildbot/bin/python'} 14:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:43 INFO - Downloading/unpacking blobuploader==1.2.4 14:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:45 INFO - Downloading blobuploader-1.2.4.tar.gz 14:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:49:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:49:45 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 14:49:45 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 14:49:45 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 14:49:45 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 14:49:45 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 14:49:45 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 14:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:49:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:46 INFO - Downloading docopt-0.6.1.tar.gz 14:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:49:46 INFO - Installing collected packages: blobuploader, requests, docopt 14:49:46 INFO - Running setup.py install for blobuploader 14:49:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:49:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:49:46 INFO - Running setup.py install for requests 14:49:46 INFO - Running setup.py install for docopt 14:49:47 INFO - Successfully installed blobuploader requests docopt 14:49:47 INFO - Cleaning up... 14:49:47 INFO - Return code: 0 14:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:47 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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:47 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 14:49:47 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 14:49:47 INFO - Using env: {'DISPLAY': ':0', 14:49:47 INFO - 'HOME': '/home/cltbld', 14:49:47 INFO - 'LANG': 'en_US.UTF-8', 14:49:47 INFO - 'LANGUAGE': 'en_US:en', 14:49:47 INFO - 'LOGNAME': 'cltbld', 14:49:47 INFO - 'MAIL': '/var/mail/cltbld', 14:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:47 INFO - 'MOZ_NO_REMOTE': '1', 14:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:47 INFO - 'NO_EM_RESTART': '1', 14:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:47 INFO - 'PWD': '/builds/slave/test', 14:49:47 INFO - 'SHELL': '/bin/bash', 14:49:47 INFO - 'SHLVL': '1', 14:49:47 INFO - 'TERM': 'linux', 14:49:47 INFO - 'TMOUT': '86400', 14:49:47 INFO - 'USER': 'cltbld', 14:49:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:47 INFO - '_': '/tools/buildbot/bin/python'} 14:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:47 INFO - Running setup.py (path:/tmp/pip-8g2PRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:47 INFO - Running setup.py (path:/tmp/pip-33tyQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:47 INFO - Running setup.py (path:/tmp/pip-rHfLM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:47 INFO - Running setup.py (path:/tmp/pip-F__T7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:47 INFO - Running setup.py (path:/tmp/pip-r8QKSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:47 INFO - Running setup.py (path:/tmp/pip-AnHmc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:47 INFO - Running setup.py (path:/tmp/pip-4sQQUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:47 INFO - Running setup.py (path:/tmp/pip-E_XHaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:47 INFO - Running setup.py (path:/tmp/pip-Jwlodr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:47 INFO - Running setup.py (path:/tmp/pip-LgtXGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:48 INFO - Running setup.py (path:/tmp/pip-uk6EdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:48 INFO - Running setup.py (path:/tmp/pip-vdBO3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:48 INFO - Running setup.py (path:/tmp/pip-DxPK33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:48 INFO - Running setup.py (path:/tmp/pip-oZzOy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:48 INFO - Running setup.py (path:/tmp/pip-CXfDfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:48 INFO - Running setup.py (path:/tmp/pip-LgE9aT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:48 INFO - Running setup.py (path:/tmp/pip-uCWax2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:49:48 INFO - Running setup.py install for manifestparser 14:49:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Running setup.py install for mozcrash 14:49:48 INFO - Running setup.py install for mozdebug 14:49:48 INFO - Running setup.py install for mozdevice 14:49:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Running setup.py install for mozfile 14:49:49 INFO - Running setup.py install for mozhttpd 14:49:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for mozinfo 14:49:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for mozInstall 14:49:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for mozleak 14:49:49 INFO - Running setup.py install for mozlog 14:49:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for moznetwork 14:49:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for mozprocess 14:49:49 INFO - Running setup.py install for mozprofile 14:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for mozrunner 14:49:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for mozscreenshot 14:49:50 INFO - Running setup.py install for moztest 14:49:50 INFO - Running setup.py install for mozversion 14:49:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:49:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:49:50 INFO - Cleaning up... 14:49:50 INFO - Return code: 0 14:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:50 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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:50 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 14:49:50 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 14:49:50 INFO - Using env: {'DISPLAY': ':0', 14:49:50 INFO - 'HOME': '/home/cltbld', 14:49:50 INFO - 'LANG': 'en_US.UTF-8', 14:49:50 INFO - 'LANGUAGE': 'en_US:en', 14:49:50 INFO - 'LOGNAME': 'cltbld', 14:49:50 INFO - 'MAIL': '/var/mail/cltbld', 14:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:50 INFO - 'MOZ_NO_REMOTE': '1', 14:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:50 INFO - 'NO_EM_RESTART': '1', 14:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:50 INFO - 'PWD': '/builds/slave/test', 14:49:50 INFO - 'SHELL': '/bin/bash', 14:49:50 INFO - 'SHLVL': '1', 14:49:50 INFO - 'TERM': 'linux', 14:49:50 INFO - 'TMOUT': '86400', 14:49:50 INFO - 'USER': 'cltbld', 14:49:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:50 INFO - '_': '/tools/buildbot/bin/python'} 14:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:50 INFO - Running setup.py (path:/tmp/pip-WOxFrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:50 INFO - Running setup.py (path:/tmp/pip-FsKlVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:50 INFO - Running setup.py (path:/tmp/pip-uPEPF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:50 INFO - Running setup.py (path:/tmp/pip-YrSSpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:50 INFO - Running setup.py (path:/tmp/pip-8vGYjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:50 INFO - Running setup.py (path:/tmp/pip-IykbVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:50 INFO - Running setup.py (path:/tmp/pip-pOFqLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:51 INFO - Running setup.py (path:/tmp/pip-gMOeS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:51 INFO - Running setup.py (path:/tmp/pip-MufWRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:51 INFO - Running setup.py (path:/tmp/pip-Yg_4aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:51 INFO - Running setup.py (path:/tmp/pip-rjlyqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:51 INFO - Running setup.py (path:/tmp/pip-zDowZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:51 INFO - Running setup.py (path:/tmp/pip-lv8Ytf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:51 INFO - Running setup.py (path:/tmp/pip-jpN2mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:51 INFO - Running setup.py (path:/tmp/pip-4QuEy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:51 INFO - Running setup.py (path:/tmp/pip-cQ2Ahk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:51 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)) 14:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:51 INFO - Running setup.py (path:/tmp/pip-J_dcCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:53 INFO - Downloading blessings-1.6.tar.gz 14:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:49:53 INFO - Installing collected packages: blessings 14:49:53 INFO - Running setup.py install for blessings 14:49:53 INFO - Successfully installed blessings 14:49:53 INFO - Cleaning up... 14:49:54 INFO - Return code: 0 14:49:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:54 INFO - Reading from file tmpfile_stdout 14:49:54 INFO - Current package versions: 14:49:54 INFO - argparse == 1.2.1 14:49:54 INFO - blessings == 1.6 14:49:54 INFO - blobuploader == 1.2.4 14:49:54 INFO - docopt == 0.6.1 14:49:54 INFO - manifestparser == 1.1 14:49:54 INFO - mozInstall == 1.12 14:49:54 INFO - mozcrash == 0.17 14:49:54 INFO - mozdebug == 0.1 14:49:54 INFO - mozdevice == 0.48 14:49:54 INFO - mozfile == 1.2 14:49:54 INFO - mozhttpd == 0.7 14:49:54 INFO - mozinfo == 0.9 14:49:54 INFO - mozleak == 0.1 14:49:54 INFO - mozlog == 3.1 14:49:54 INFO - moznetwork == 0.27 14:49:54 INFO - mozprocess == 0.22 14:49:54 INFO - mozprofile == 0.28 14:49:54 INFO - mozrunner == 6.11 14:49:54 INFO - mozscreenshot == 0.1 14:49:54 INFO - mozsystemmonitor == 0.0 14:49:54 INFO - moztest == 0.7 14:49:54 INFO - mozversion == 1.4 14:49:54 INFO - psutil == 3.1.1 14:49:54 INFO - requests == 1.2.3 14:49:54 INFO - wsgiref == 0.1.2 14:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49: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')]} 14:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:54 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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:54 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 14:49:54 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 14:49:54 INFO - Using env: {'DISPLAY': ':0', 14:49:54 INFO - 'HOME': '/home/cltbld', 14:49:54 INFO - 'LANG': 'en_US.UTF-8', 14:49:54 INFO - 'LANGUAGE': 'en_US:en', 14:49:54 INFO - 'LOGNAME': 'cltbld', 14:49:54 INFO - 'MAIL': '/var/mail/cltbld', 14:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:54 INFO - 'MOZ_NO_REMOTE': '1', 14:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:54 INFO - 'NO_EM_RESTART': '1', 14:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:54 INFO - 'PWD': '/builds/slave/test', 14:49:54 INFO - 'SHELL': '/bin/bash', 14:49:54 INFO - 'SHLVL': '1', 14:49:54 INFO - 'TERM': 'linux', 14:49:54 INFO - 'TMOUT': '86400', 14:49:54 INFO - 'USER': 'cltbld', 14:49:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:54 INFO - '_': '/tools/buildbot/bin/python'} 14:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 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)) 14:49:54 INFO - Cleaning up... 14:49:54 INFO - Return code: 0 14:49:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49: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')]} 14:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:54 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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:54 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 14:49:54 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 14:49:54 INFO - Using env: {'DISPLAY': ':0', 14:49:54 INFO - 'HOME': '/home/cltbld', 14:49:54 INFO - 'LANG': 'en_US.UTF-8', 14:49:54 INFO - 'LANGUAGE': 'en_US:en', 14:49:54 INFO - 'LOGNAME': 'cltbld', 14:49:54 INFO - 'MAIL': '/var/mail/cltbld', 14:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:54 INFO - 'MOZ_NO_REMOTE': '1', 14:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:54 INFO - 'NO_EM_RESTART': '1', 14:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:54 INFO - 'PWD': '/builds/slave/test', 14:49:54 INFO - 'SHELL': '/bin/bash', 14:49:54 INFO - 'SHLVL': '1', 14:49:54 INFO - 'TERM': 'linux', 14:49:54 INFO - 'TMOUT': '86400', 14:49:54 INFO - 'USER': 'cltbld', 14:49:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:54 INFO - '_': '/tools/buildbot/bin/python'} 14:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:54 INFO - Downloading/unpacking jsonschema 14:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:49:56 INFO - Downloading/unpacking functools32 (from jsonschema) 14:49:56 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 14:49:56 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 14:49:56 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 14:49:56 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 14:49:56 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 14:49:56 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 14:49:56 INFO - Downloading functools32-3.2.3-2.tar.gz 14:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:49:56 INFO - warning: no files found matching '*.txt' 14:49:56 INFO - no previously-included directories found matching 'build' 14:49:56 INFO - no previously-included directories found matching 'dist' 14:49:56 INFO - no previously-included directories found matching '.git*' 14:49:56 INFO - Installing collected packages: jsonschema, functools32 14:49:56 INFO - Running setup.py install for functools32 14:49:56 INFO - warning: no files found matching '*.txt' 14:49:56 INFO - no previously-included directories found matching 'build' 14:49:56 INFO - no previously-included directories found matching 'dist' 14:49:56 INFO - no previously-included directories found matching '.git*' 14:49:56 INFO - Successfully installed jsonschema functools32 14:49:56 INFO - Cleaning up... 14:49:57 INFO - Return code: 0 14:49:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:57 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 0x7ff6ae46ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', '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 14:49:57 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 14:49:57 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 14:49:57 INFO - Using env: {'DISPLAY': ':0', 14:49:57 INFO - 'HOME': '/home/cltbld', 14:49:57 INFO - 'LANG': 'en_US.UTF-8', 14:49:57 INFO - 'LANGUAGE': 'en_US:en', 14:49:57 INFO - 'LOGNAME': 'cltbld', 14:49:57 INFO - 'MAIL': '/var/mail/cltbld', 14:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:57 INFO - 'MOZ_NO_REMOTE': '1', 14:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:57 INFO - 'NO_EM_RESTART': '1', 14:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:57 INFO - 'PWD': '/builds/slave/test', 14:49:57 INFO - 'SHELL': '/bin/bash', 14:49:57 INFO - 'SHLVL': '1', 14:49:57 INFO - 'TERM': 'linux', 14:49:57 INFO - 'TMOUT': '86400', 14:49:57 INFO - 'USER': 'cltbld', 14:49:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:57 INFO - '_': '/tools/buildbot/bin/python'} 14:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:57 INFO - Downloading/unpacking flake8 14:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:49:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:49:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:49:59 INFO - no previously-included directories found matching 'docs/_build' 14:49:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:49:59 INFO - Running setup.py install for pep8 14:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:49:59 INFO - no previously-included directories found matching 'docs/_build' 14:49:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:49:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:49:59 INFO - Cleaning up... 14:50:00 INFO - Return code: 0 14:50:00 INFO - Running post-action listener: _resource_record_post_action 14:50:00 INFO - Running post-action listener: _start_resource_monitoring 14:50:00 INFO - Starting resource monitoring. 14:50:00 INFO - ##### 14:50:00 INFO - ##### Running install step. 14:50:00 INFO - ##### 14:50:00 INFO - Running pre-action listener: _resource_record_pre_action 14:50:00 INFO - Running main action method: install 14:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:50:00 INFO - Reading from file tmpfile_stdout 14:50:00 INFO - Detecting whether we're running mozinstall >=1.0... 14:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:50:00 INFO - Reading from file tmpfile_stdout 14:50:00 INFO - Output received: 14:50:00 INFO - Usage: mozinstall [options] installer 14:50:00 INFO - Options: 14:50:00 INFO - -h, --help show this help message and exit 14:50:00 INFO - -d DEST, --destination=DEST 14:50:00 INFO - Directory to install application into. [default: 14:50:00 INFO - "/builds/slave/test"] 14:50:00 INFO - --app=APP Application being installed. [default: firefox] 14:50:00 INFO - mkdir: /builds/slave/test/build/application 14:50:00 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'] 14:50:00 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 14:50:15 INFO - Reading from file tmpfile_stdout 14:50:15 INFO - Output received: 14:50:15 INFO - /builds/slave/test/build/application/firefox/firefox 14:50:15 INFO - Running post-action listener: _resource_record_post_action 14:50:15 INFO - ##### 14:50:15 INFO - ##### Running run-tests step. 14:50:15 INFO - ##### 14:50:15 INFO - Running pre-action listener: _resource_record_pre_action 14:50:15 INFO - Running main action method: run_tests 14:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:50:15 INFO - Python 2.7.3 14:50:15 INFO - Return code: 0 14:50:15 INFO - grabbing minidump binary from tooltool 14:50:15 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')]} 14:50:15 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 0x1322410>, '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 0x1323310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13237a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:50:15 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 14:50:15 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 14:50:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:50:16 INFO - Return code: 0 14:50:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:50:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:50:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:50:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:50:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:50:17 INFO - Return code: 0 14:50:17 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/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 14:50:17 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/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 14:50:17 INFO - Using env: {'DISPLAY': ':0', 14:50:17 INFO - 'HOME': '/home/cltbld', 14:50:17 INFO - 'LANG': 'en_US.UTF-8', 14:50:17 INFO - 'LANGUAGE': 'en_US:en', 14:50:17 INFO - 'LOGNAME': 'cltbld', 14:50:17 INFO - 'MAIL': '/var/mail/cltbld', 14:50:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:50:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:17 INFO - 'MOZ_NO_REMOTE': '1', 14:50:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:17 INFO - 'NO_EM_RESTART': '1', 14:50:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:17 INFO - 'PWD': '/builds/slave/test', 14:50:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:50:17 INFO - 'SHELL': '/bin/bash', 14:50:17 INFO - 'SHLVL': '1', 14:50:17 INFO - 'TERM': 'linux', 14:50:17 INFO - 'TMOUT': '86400', 14:50:17 INFO - 'USER': 'cltbld', 14:50:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187', 14:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:17 INFO - '_': '/tools/buildbot/bin/python'} 14:50:17 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/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 14:50:17 INFO - mozversion application_buildid: 20160410132212 14:50:17 INFO - mozversion application_changeset: 29d5a4175c8b74f45482276a53985cf2568b4be2 14:50:17 INFO - mozversion application_display_name: Nightly 14:50:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:50:17 INFO - mozversion application_name: Firefox 14:50:17 INFO - mozversion application_remotingname: firefox 14:50:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:50:17 INFO - mozversion application_vendor: Mozilla 14:50:17 INFO - mozversion application_version: 48.0a1 14:50:17 INFO - mozversion platform_buildid: 20160410132212 14:50:17 INFO - mozversion platform_changeset: 29d5a4175c8b74f45482276a53985cf2568b4be2 14:50:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:50:17 INFO - mozversion platform_version: 48.0a1 14:50:17 INFO - using testdate: 1460325017 14:50:17 INFO - actual date: 1460325017 14:50:17 INFO - starting webserver on 'localhost:59510' 14:50:17 INFO - SUITE-START | Running 2 tests 14:50:17 INFO - TEST-START | dromaeo_css 14:50:17 INFO - operating with platform_type : linux_ 14:50:17 INFO - Initialising browser for dromaeo_css test... 14:50:17 INFO - TEST-INFO | started process 3347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyOVq1g/profile http://localhost:59510/getInfo.html) 14:50:22 INFO - PROCESS | 3347 | 14:50:22 INFO - PROCESS | 3347 | (process:3419): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:50:22 INFO - PROCESS | 3347 | 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] 14:50:23 INFO - PROCESS | 3347 | __metrics Screen width/height:1600/1200 14:50:23 INFO - PROCESS | 3347 | colorDepth:24 14:50:23 INFO - PROCESS | 3347 | Browser inner width/height: 1024/697 14:50:23 INFO - PROCESS | 3347 | __metrics 14:50:23 ERROR - PROCESS | 3347 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 14:50:24 INFO - TEST-INFO | 3347: exit 0 14:50:24 INFO - Browser initialized. 14:50:24 INFO - Running cycle 1/1 for dromaeo_css test... 14:50:24 INFO - TEST-INFO | started process 3470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyOVq1g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:26 INFO - PROCESS | 3470 | 14:50:26 INFO - PROCESS | 3470 | (process:3529): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:50:36 INFO - PROCESS | 3470 | RSS: Main: 164446208 14:50:36 INFO - PROCESS | 3470 | 14:51:26 INFO - PROCESS | 3470 | 1460325086131 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] 14:53:38 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:59510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59510/tests/dromaeo/cssquery-ext.html) 14:53:39 INFO - PROCESS | 3470 | RSS: Main: 168640512 14:53:39 INFO - PROCESS | 3470 | 14:56:41 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:59510/tests/dromaeo/cssquery-ext.html (next: http://localhost:59510/tests/dromaeo/cssquery-jquery.html) 14:56:42 INFO - PROCESS | 3470 | RSS: Main: 165679104 14:56:42 INFO - PROCESS | 3470 | 14:59:43 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:59510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59510/tests/dromaeo/cssquery-mootools.html) 14:59:44 INFO - PROCESS | 3470 | RSS: Main: 166694912 14:59:44 INFO - PROCESS | 3470 | 15:02:46 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:59510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59510/tests/dromaeo/cssquery-prototype.html) 15:02:46 INFO - PROCESS | 3470 | RSS: Main: 164216832 15:02:46 INFO - PROCESS | 3470 | 15:05:49 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:59510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59510/tests/dromaeo/cssquery-yui.html) 15:05:50 INFO - PROCESS | 3470 | RSS: Main: 165634048 15:05:50 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:59510/tests/dromaeo/cssquery-yui.html (next: http://localhost:59510/tests/dromaeo/cssquery-dojo.html) 15:08:52 INFO - PROCESS | 3470 | RSS: Main: 167878656 15:08:52 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | __start_tp_report 15:08:52 INFO - PROCESS | 3470 | _x_x_mozilla_page_load 15:08:52 INFO - PROCESS | 3470 | _x_x_mozilla_page_load_details 15:08:52 INFO - PROCESS | 3470 | |i|pagename|runs| 15:08:52 INFO - PROCESS | 3470 | |0;dojo.html;2660.0556802335173;2683.503551842908;2734.4941185880602;2744.2041807875717;2751.1883994221703;4752.287156926458;4770.30830529573;4782.713037217769;4800.447948485925;4800.5679488846;4643.489216186225;4751.714897106176;4776.641751868607;4807.471178170407;4840.854774356766;4344.066025804452;4421;4427.092446048552;4434.645228381738;4515.932261016087;4348.869533913988;4362.19299429605;4410.955890441102;4416.624586910117;4470.061287129706;4223.366495025755;4321.373400856858;4376.0591472833175;4408.448943882015;4420.04968931678;4400.515943246241;4419.204543182226;4421.867343979686;4431.490378606437;4473.926257698162;4339.435873336478;4401.2517871961845;4405.8237670493145;4430.623397011258;4452.955470445287;4588.816447342102;4714.222153344694;4717.551832575899;4725.031368569435;4765.261384485376;5062.417821950449;5117.46266642001;5125.692458452468;5126.769295381717;5157.6647517911215;4963.950360496385;5109.591232701375;5161.870953226162;5200.739963001834;5222.503862133091;4796.784144713496;4806.206975848946;4817.470078291385;4848.442429120661;4864.610831133501;5232.712200828915;5257.763400646903;5270;5272.6836389816735;5276.683398995996;4884.0476107158765;4982.053409852117;5051.090803655304;5082.491750824888;5103.719295438712;4923.212286034289;5016.724080175625;5099.6685215460875;5107.846764597068;5162.819301324435;5073.16292811682;5098.260752190911;5109.9744501278;5162.380514338229;5165.070287348238;4957.628177886673;5020.899582008413;5069.391672999263;5086.109930762176;5159.355080614923;4403.867883963486;4415.811486077028;4421.7346959181905;4425.247707889602;4458.910821783546;3800.467934489174;3842.3852183650483;3846.5961074086817;3854.9229015420096;3871.2064026874423;4339.522652508222;4401.295792673157;4451.998300382388;4505.324201369821;4526.343680166357;5113.207452844815;5120.462351453119;5124.359455068116;5169.81905633301;5180.352455943007;4341.240282950471;4418.5802348776815;4438.844640437569;4452.532484089124;4472.396226509444;4626.560476754703;4701.153792317347;4707.411573553306;4741.810327586858;4756.048790241896;4881.707097574086;4912.975435122801;4917.557419832232;4927.310176575211;4972.378452693486;4993.425756038102;5005;5197.480251974772;5210.97394513025;5264.763085661078;4809.975950120227;4815.470298267258;4819.734914579732;4830.3237546744185;4844.079624871263;5012.298278241122;5017.698938063728;5020.221865610836;5031.22016087507;5067.797288108434;5002.449730529566;5063.3417655704525;5104.106781313181;5144.742762861767;5210.739463026757;4849.975750121227;4875.488073752205;4920.015996800583;4932.3341348918875;5048.7475626219275;4927.876803079808;4987.401511818605;4988.45127036033;4991.875203119951;5035.16919708244;4730.834420795256;4888.755562221946;4901.754912254444;4914.066327397783;4923.556879880828;4889.975550122226;4975.303457515878;4996.225585034325;5056.898862022813;5059.291699162194;4895.681780684244;4908.361912951294;4922.8769280768265;4926.4088309403105;4959.826406075915 15:08:52 INFO - PROCESS | 3470 | |1;ext.html;565.2369301443052;589.1869220475743;607.2712744706353;637.2575949019392;651.9641419721913;31202.84398578007;31996.360072798587;32084.839575802118;32119.839400802994;32207.67792322076;31567.52648710271;32016.519752203734;32084.518732219036;32086.197845053885;32132.518012229837;7400.555966642005;7542.472026958115;7555.508891922035;7559.3196612305155;7573.545587264782;7514.699412023512;7560.546367217957;7564.394848412114;7631.694732210733;7656.502327348732;7613.771586852404;7643.961780191091;7644.426667999895;7650.120236172828;7680.923190768104;7566.20554841742;7623.504472209289;7627.961860190719;7646.541207527538;7711.190325015848;7556.848863022708;7641.121271053845;7670.501417407906;7684.385249180053;7690.192529784404;32261.225632590435;32662.836685816656;32759.836200818845;32776.836115819504;32818.50772238418;2518.874056297196;2791.4835755385116;3102.332998405331;3284.490903909898;3727.869524566627;23289.3013209604;23459.530809383887;23589.764102358928;23675.171369002;23712.62873712632;3266.7876588021704;3328.6338502764675;3337.93324133516;3399.8130102844334;3402.795832250048;138460;139522.3023884874;139869.3006534961;140038;180136;31061.844690776852;31137.532937005963;31220.531692024637;31266.374672506878;31356.686433135375;31579;32639.18402039968;33467.16332091717;33504.664953350155;33705.325893482484;12334.568290109803;12407.93796031014;12504.374781261082;12561.057920655987;12569.622911312676;9733.124018838338;9737.07497787709;9758.609655613838;9771.853422198672;9776.266779991529;7708.267714567107;7752.108507521594;7839.686412543549;7844.901713760079;7898.973133492609;3071.754259659222;3110.5225018116666;3136.8745250190195;3174.619045714483;3184.1561986073707;935.2331088507494;942.2920806625813;944.4286206844897;980.4411485453223;1034.3070143004206;27049.729502704722;27737;28135.155945321672;28190.71809281922;28240.43519129647;988.9109980101825;1007.4459047523833;1058.2803693488347;1058.5501162006117;1110.2846102771239;14572.85427145715;14732.337044833008;14945.925270373797;15074.321655525308;15208.315625796866;298353;299528;299959;304786;305082;46687;47228.29157562639;47241.76379118083;47525.76237118861;47556.5244347559;1207.0826172109084;1211.2308683985557;1251.0992085698283;1253.2981530343036;1265.044891107208;25000;26269.605955910294;26663;26812;26996.865015674797;39876;40366.79816600898;40398.19203615852;40684.38973415342;40700.59299407087;265141;266367;267963;269326;269351;24557.508849822545;25190.748092519574;25291.367715806515;25382.746172538777;25450.74549254558;39651.60348396479;40112.19775604413;40949.1810163801;40962.18075638411;41633.79183104186;34947.47578786269;35311.82344088263;35591.64408355884;35754.463683045295;36375.45436818397;34695.479567805996;35331;35392.823035884656;35481.82259088688;35501.28997420089;35059.824700877354;35499.467507987916;35912.64087359093;37087.25825483421;37198.44202336913;28135.296617584725;30018;30177;30367.696323036485;30399.392012160075;23443.41391465227;23529.41176470602;24236.515269694155;24311.63532546978;24342.51314973726 15:08:52 INFO - PROCESS | 3470 | |2;jquery.html;375.76514678326043;379.6412390291175;385.59319917487056;386.1851493349033;387.10385457665484;15037.172955487458;16178.514644560668;16970.49088527343;16970.66058678827;16973.745393819103;14507.347169377377;15343.539693809204;16735.246913888874;16837.242324095416;16858.241379137937;4632.166210082184;4767.499412561683;4789.2816077588295;4789.521047895218;4813.951860481403;3439.1574064354145;4757.26262429324;5073.467285934979;5372;5385.892282154355;5304.602154838383;5309.920351194735;5321.228421878825;5353.5984801139875;5374.6237763356585;4912.975435122819;5242.108841496935;5247.055530004598;5255.1066318725525;5360.356757189143;5102.897942041175;5108.872278193037;5113.590912726973;5986.910196347058;6473.579217350904;19903.402897913085;19938;20580;20840;20888;1988.3140316590752;2109.0825490911348;2166.653335466318;2272.2192140128523;2283.0068920019844;13490.055696101277;14131.788023179557;14308.856911430856;14604.780928286084;14723.631909202248;1884.660761063008;1937.5737337785665;1945.737325461073;1998.1108406758854;2069.9379018629465;76975;77377.22622773757;79055.20944790593;79786.60106699487;79954.20045799584;15401.46094886696;16205.594860128354;16375.590610234602;16455.094969776776;16547.669046619;28695.71304286972;28746.99385521497;28980.710192898223;29061.85469072641;29068;8132.146124656826;8461.957690211633;8477.618507167192;8620.95689521561;8671.089535598798;6947.062146610244;6956.304369563104;6972.616506092214;7112.822179445452;7128.215896251409;7917.406194535433;8008.719694810654;8081.191880811872;8116.2695357418115;8261.545614991233;1787.302951848754;1829.9451016469527;1851.6481868445221;3289.5723555937575;3342.1310459280276;791.8930944322558;853.0829358439702;864.831357885219;906.5784410249134;932.1889955738416;14233.78649320261;14647.487337943121;15370.692586148214;15466.845331546765;15654.9217253913;826.8553003224412;833.954132522705;859.0507489224442;859.5573279760928;861.4486728493769;8641.524716140673;8714.346424018224;8798.692045778367;8971.641134354553;9012.504312262758;385312;386654;390029;390248;392037;72480.47675709211;73498.63250683712;75220.24011666176;75748.62125689337;76319.23680763232;920.6409500294891;936.9016253293306;937.0676177203726;943.9339246252696;945.716285114463;13859.30703464843;14004.929975350058;14132.646683832987;14134.222617756122;14277;33180.83409583033;33188.83405582957;34254.14364640904;34587.48118778271;34622.82688586541;44977.55022449734;47098;47343;47346.28980565363;47440.2883956734;7036.753713620204;7630.694772209049;7661.616919154131;7839.9216007839195;7860.4104692147175;8754.91245087541;11046.558137674725;11099.836546584507;11270.436478175894;11548.48031838586;10243.641472548425;10248.436336001592;10435.32170408921;10513.89486105129;10581.841272381074;10329.638462654071;10367.481625918825;10415.270931034755;10454.059134677611;10739.731506712395;10538.525766340379;10614.988215555393;10779.02988731018;10780.514876830719;10891.455427228766;7357.2642735726;7404.6667899945705;7465.738699145504;7618.466707330434;7646.502977306457;9979.60081596728;10009.749756256151;10052.899471005196;10167.644132455329;10213.234007449322 15:08:52 INFO - PROCESS | 3470 | |3;mootools.html;1435.0815478094014;1447.971939922655;1549.806274215723;1719.3122750899647;1760.2782859027793;6946.374826265635;7539.4345424093135;7566.129895062069;7811.882821757671;7819.374450044004;7549.7735067947915;7666.655000524976;7674.693012279516;7712.305892469677;7725.690972361099;2244.7306323241232;2294.701688780456;2300.102959845653;2305.700258966332;2310.8960096795686;2231.4867580456503;2256.424611724008;2262.3891549281684;2265.728112626487;2274.0676322707695;2274.283600665793;2297.3682237384687;2305.3199306204624;2335.684682567857;2336.4859730859184;2225.254539729193;2226.198568515333;2226.3209721035078;2237.6307909195043;2238.2837492002564;2244.5062086340977;2246.5057687308768;2255.650374192003;2255.6842042113954;2262.558801033799;7656.0812702475505;7675.270849269311;7709.884351734672;7721.382289416833;7738.690452381898;4553.863384098482;4612.746298953556;4669.766511674403;4679.60223381013;4690.882727931795;2842.6730925943575;2857.4506213339478;2966.4808658484894;2967.1988563087843;3005.834679092649;906.8005038891433;907.7685190276503;914.8033172867865;939.3612343606345;955.1451450951429;10164.745881352952;10653.414062226575;10690.572377104907;10702.090322322612;10727.302725322828;4173.10278290163;4252.340887162495;4399.208142534375;4431.379606855043;4465.4864690561;9234.122758337948;9238.399504032217;9246.583903724348;9262.861057084148;9277.443353398818;4755.785989630475;4763.833265835679;4789.233722604366;4797.304390863375;4807.95192048082;3754.5869954305003;4187.874363769091;4319.956800431955;4320.524742278347;4378.10248898975;3656.634336566322;3662.908427289339;3736.663700266989;3736.831842567091;3776.811159442017;1219.481720268882;1237.6782036670531;1246.1339369138361;1247.376311844078;1260.24385368778;1006.3056491021172;1016.2073582605432;1185.8873407026492;1204.4700331853956;1231.2550906701317;7307.3423391894985;7315.378192853561;7336.706531738778;7368.815779605446;7405.962970185223;1020.806046851096;1068.5618896252654;1070.652038087609;1091.307020042279;1096.7477480179602;5754.6547207167705;5770.6249093808765;5891.793787217427;5920.407959204045;5957.314908785458;9056.50189239585;9427.481488518197;9485.383450075724;9536.61853525865;9543.284253681002;9268.304877134107;9431.386959847589;9450.85823712645;9506.429614223169;9591.520423978773;7255;7365.079365079365;7391.260873912674;7413.110426748717;7451.441141914378;6920;7137.393321567725;7147.3924716397605;7153.928460715534;7159.57042577447;8435.47476402957;8562.52906090171;8669.306455483673;8800.47197168172;8822.07368226327;8637.56812159377;8667.419254937693;8759.649614015369;8842.955785221033;8920.152585504367;5921.851953701192;6540.803775886731;6631.900521492085;6749.696263668245;6768.526203165731;7348.742794002184;7366.558006519626;7378.778636640909;7436;7448.068991376078;6584.341565843377;6888.138982627172;6898;6909.2399836019;6987.196472405535;6697.564658297195;6768.120144381199;6809;6855.211650660039;6896.827579310558;7126.5011449198055;7164.928350716635;7223.674934627849;7229.819254518679;7233.276672332725;6377.808665740035;6423.518236132215;6507.544471886922;6514.706838192198;6520.413162815369;6377.681115944277;6426.228852537725;6436.613803171825;6446.065320528591;6460.418562329413 15:08:52 INFO - PROCESS | 3470 | |4;prototype.html;313.2435169066704;315.3755563983313;315.91628218522095;324.9382617302714;328.26796244375026;5190.377154741432;5361.276227709263;5414;5450.781968721247;5451.918221226685;5241.3186285782895;5314.724466128121;5320.600954928376;5322.600804939635;5322.866928326794;3874.3994680824376;3971.543272523668;4076.408920706496;4106;4118.155778065497;4056.492938382702;4068.105016896278;4068.4304197412384;4091.509018917734;4099.159672267178;4064.2887494688457;4070.1249231415386;4071.409645601386;4074.8981275468054;4079.8980025499304;3826;4031.314676504972;4047.4738284023038;4056.4118202860714;4074.4295798588223;3482.721382289411;3510.3154884797473;3511.087117349482;3512.7892326460496;3524.4360902255517;5017.949820501784;5054.823081192178;5062.54437100659;5077.0607437623785;5107.591392688576;4553.2942393929;4649.907001859978;4650.465196502378;4665.393498845162;4674.649401294882;5523.309586301712;5575.637583557056;5582.162675598693;5587.944120558783;5598.524125449301;3823.0693499782433;3866.497355343787;3874.748141370802;3874.8062596870327;3874.9612503874882;5638.774449021993;5772.971135144339;5869.882602347929;5874.882502349929;5889.322727886305;3955.0705584187695;3955.3275943089743;3965.325894597925;3976.58245884178;3979.7413168143976;4032.1734044520804;4049.5950404959267;4053.2906741320153;4065.4511640928686;4072.083781149277;4680.882977925511;4682.227432473672;4683.344331793552;4687.765611719468;4707.7175369477945;5449.264349312792;5622.831315060473;5625.746841392147;5634.915476267859;5644.096944488944;1395.9371828267751;1407.7043820797746;1417.8511256318145;1418.822647169104;1425.0594607558962;872.5462759365095;925.3106435705442;944.9244060475284;964.1178321835582;966.5940305071887;4788.545088216614;4909.846186146253;4936.456989731127;4967.82612608557;4982.2775697524385;5843.970780146072;5856.297244330707;5856.355800861902;5867.325257595346;5868;4782.163121453732;4898.436679781871;4940.925886111711;4948.505149485023;4955.40535135786;3087.1818967973504;3106.580611617448;3123.1723593247807;3128.6402063762503;3129.6087989001376;5396.731768034509;5470.398256191816;5478.753456094485;5484.61607687466;5484.945150548523;5679.460451257124;5927.555433342516;5978.581499295007;5982.46157845796;5992.13114098462;5448.128299472145;5450.972745136249;5452;5473.67157970523;5498.505134537991;5491.643043202179;5772.7690892363835;5788.971055144697;5793.971030144822;5794.913076303943;5730.627509211888;5733.967885780599;5746.655200687972;5754.136879468113;5767.452092051249;5493.670379777226;5502.669839809624;5509.953108909294;5528.318765398859;5537.197106419627;3944.1914407546956;3995.940060899147;4017.5580686125086;4023.7384570002855;4034.818433170573;5793.362730099601;5796.8550786229;5818.301803783573;5819.272590926134;5828.242328497268;5552.278203833475;5564.304461942257;5582.302212223472;5609.74756135983;5626.2967129108865;5313.123334649739;5520.723963801875;5527.972360138174;5554.944450555443;5605.551555875439;5439.891202175855;5458.645188062763;5468.207109969112;5498.395176530658;5559.527440167631;5312.707801070824;5365;5620.859478512906;5637.887242255214;5641.361321947403;5470.863228419322;5483.040467918178;5488.1767734838495;5495.670259784426;5525.944740552543 15:08:52 INFO - PROCESS | 3470 | |5;yui.html;691.6334342798317;722.6314579564424;724.1816747075803;781.2968328504342;792.6670798264728;11908.940455297723;12088.516459341627;12154.878451215485;12168.939155304233;12209.38953052346;11413.486393112309;11589.42052897356;11637.301761894292;11639.127065470082;11656.883431165686;794.467706636552;800.2877439079224;828.4325237212498;831.7795784117184;836.6444261189001;835.052215735142;838.2748922182299;841.0790184747691;841.2680967558202;842.0316635868738;860.4192170285032;862.4782006885838;864.515871112176;864.7665130414784;866.9826603467927;843.8607629741085;847.1740053447901;848.6647774129184;849.0448245723561;852.1606217875387;628.8396458902996;631.6683741035947;632.9082283068975;633.7686744338283;634.8603307272439;12433.875661243454;12586.307753073577;12618.74762504754;12627.179233349894;12641.051921105955;12469.563565275263;12533.93733031329;12714.61856144317;12767.957126859657;13131;10051.447170405625;10072.194224462026;10208.234382421348;10411.375317480899;10562.841557376645;3269.9509507357407;3299.851506682205;3332.5334453176574;3334.333133373311;3343.9331213375594;45225;45687;46015.76992115018;46208.075838483375;46263;9990.550425230882;9997.050280223368;10062.24533160016;10147.847782283272;10231.386116832866;17315.220815063352;17332.133393330536;17458.214380352914;17497.737533937;17550.561235968948;6959.582425054412;6969.6166710830375;6970.546914450544;7028.156621205386;7036.085308909809;3776.0182352587976;3839.404892241707;3903.7072219583647;3971.6425521703186;3987.8205480753436;2802.691703912568;2894.3487715263896;2896.189067061226;2897.826130432181;2902.0133154727496;503.8488453463946;509.66634173375064;513.2019709351994;518.9014087323396;526.368357970437;594.3343455330058;605.9638018987581;642.4314481683743;649.577774446604;651.7588492257801;7523.322900938832;7837.09873364559;7946.404019698546;8286.544240066734;8355.373346999;461.78296200785576;474.2483164184737;561.4077148608258;582.7144699097412;584.4535359438938;3918.8628398005935;4042.939355909664;4273;4361.302191649321;4372.650187984954;48297.758511207925;48685;49072;49186.26220606694;50125.49874501281;47542;48445.757771211625;48453;48613;50380.244296335586;44092.118157636665;44100.55899440964;44163.55836441594;44267;44927.326090108676;8467.407281490237;8505.74482765518;8648.610812513327;8724;8769.38614296993;28790.42419151647;29642.25894352572;29647.555286671148;29689.109326720234;29974.100776976724;35613.465798012534;38782.6121738779;39137;39245;39481.21037579175;11069.5572177112;11182;11188.440577970907;11234.943825280821;11239.325640461599;11776.411179440822;11782.351970641697;11955.043596512432;12090.818637720617;12180.390980451119;11152.219344645797;11516.712082198012;11929.522819087486;12062.215955962834;12398.690032749253;10487.37075775456;10600.25798194119;11444.713882153013;11755.353455560027;11844.28934263947;9772.511374431393;10403.687889363331;10417.374957502574;11478.598249061242;11717.765644686888;9012.188902998761;9170;9218.308626853148;9439.339246252697;9748.220142388735;8753.6936207235;9023.639054437748;9066.274698024274;9400.435973841591;9742.171915387271 15:08:52 INFO - PROCESS | 3470 | __end_tp_report 15:08:52 INFO - PROCESS | 3470 | __start_cc_report 15:08:52 INFO - PROCESS | 3470 | _x_x_mozilla_cycle_collect,394 15:08:52 INFO - PROCESS | 3470 | __end_cc_report 15:08:52 INFO - PROCESS | 3470 | __startTimestamp1460326132754__endTimestamp 15:08:52 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | ------- Summary: start ------- 15:08:52 INFO - PROCESS | 3470 | Number of tests: 6 15:08:52 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | [#0] dojo.html Cycles:165 Average:4735.83 Median:4875.49 stddev:483.11 (9.9%) stddev-sans-first:456.33 15:08:52 INFO - PROCESS | 3470 | Values: 2660.1 2683.5 2734.5 2744.2 2751.2 4752.3 4770.3 4782.7 4800.4 4800.6 4643.5 4751.7 4776.6 4807.5 4840.9 4344.1 4421.0 4427.1 4434.6 4515.9 4348.9 4362.2 4411.0 4416.6 4470.1 4223.4 4321.4 4376.1 4408.4 4420.0 4400.5 4419.2 4421.9 4431.5 4473.9 4339.4 4401.3 4405.8 4430.6 4453.0 4588.8 4714.2 4717.6 4725.0 4765.3 5062.4 5117.5 5125.7 5126.8 5157.7 4964.0 5109.6 5161.9 5200.7 5222.5 4796.8 4806.2 4817.5 4848.4 4864.6 5232.7 5257.8 5270.0 5272.7 5276.7 4884.0 4982.1 5051.1 5082.5 5103.7 4923.2 5016.7 5099.7 5107.8 5162.8 5073.2 5098.3 5110.0 5162.4 5165.1 4957.6 5020.9 5069.4 5086.1 5159.4 4403.9 4415.8 4421.7 4425.2 4458.9 3800.5 3842.4 3846.6 3854.9 3871.2 4339.5 4401.3 4452.0 4505.3 4526.3 5113.2 5120.5 5124.4 5169.8 5180.4 4341.2 4418.6 4438.8 4452.5 4472.4 4626.6 4701.2 4707.4 4741.8 4756.0 4881.7 4913.0 4917.6 4927.3 4972.4 4993.4 5005.0 5197.5 5211.0 5264.8 4810.0 4815.5 4819.7 4830.3 4844.1 5012.3 5017.7 5020.2 5031.2 5067.8 5002.4 5063.3 5104.1 5144.7 5210.7 4850.0 4875.5 4920.0 4932.3 5048.7 4927.9 4987.4 4988.5 4991.9 5035.2 4730.8 4888.8 4901.8 4914.1 4923.6 4890.0 4975.3 4996.2 5056.9 5059.3 4895.7 4908.4 4922.9 4926.4 4959.8 15:08:52 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | [#1] ext.html Cycles:180 Average:37944.72 Median:17952.99 stddev:65218.82 (363.3%) stddev-sans-first:65341.39 15:08:52 INFO - PROCESS | 3470 | Values: 565.2 589.2 607.3 637.3 652.0 31202.8 31996.4 32084.8 32119.8 32207.7 31567.5 32016.5 32084.5 32086.2 32132.5 7400.6 7542.5 7555.5 7559.3 7573.5 7514.7 7560.5 7564.4 7631.7 7656.5 7613.8 7644.0 7644.4 7650.1 7680.9 7566.2 7623.5 7628.0 7646.5 7711.2 7556.8 7641.1 7670.5 7684.4 7690.2 32261.2 32662.8 32759.8 32776.8 32818.5 2518.9 2791.5 3102.3 3284.5 3727.9 23289.3 23459.5 23589.8 23675.2 23712.6 3266.8 3328.6 3337.9 3399.8 3402.8 138460.0 139522.3 139869.3 140038.0 180136.0 31061.8 31137.5 31220.5 31266.4 31356.7 31579.0 32639.2 33467.2 33504.7 33705.3 12334.6 12407.9 12504.4 12561.1 12569.6 9733.1 9737.1 9758.6 9771.9 9776.3 7708.3 7752.1 7839.7 7844.9 7899.0 3071.8 3110.5 3136.9 3174.6 3184.2 935.2 942.3 944.4 980.4 1034.3 27049.7 27737.0 28135.2 28190.7 28240.4 988.9 1007.4 1058.3 1058.6 1110.3 14572.9 14732.3 14945.9 15074.3 15208.3 298353.0 299528.0 299959.0 304786.0 305082.0 46687.0 47228.3 47241.8 47525.8 47556.5 1207.1 1211.2 1251.1 1253.3 1265.0 25000.0 26269.6 26663.0 26812.0 26996.9 39876.0 40366.8 40398.2 40684.4 40700.6 265141.0 266367.0 267963.0 269326.0 269351.0 24557.5 25190.7 25291.4 25382.7 25450.7 39651.6 40112.2 40949.2 40962.2 41633.8 34947.5 35311.8 35591.6 35754.5 36375.5 34695.5 35331.0 35392.8 35481.8 35501.3 35059.8 35499.5 35912.6 37087.3 37198.4 28135.3 30018.0 30177.0 30367.7 30399.4 23443.4 23529.4 24236.5 24311.6 24342.5 15:08:52 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | [#2] jquery.html Cycles:180 Average:24987.28 Median:195208.05 stddev:64209.98 (32.9%) stddev-sans-first:64363.51 15:08:52 INFO - PROCESS | 3470 | Values: 375.8 379.6 385.6 386.2 387.1 15037.2 16178.5 16970.5 16970.7 16973.7 14507.3 15343.5 16735.2 16837.2 16858.2 4632.2 4767.5 4789.3 4789.5 4814.0 3439.2 4757.3 5073.5 5372.0 5385.9 5304.6 5309.9 5321.2 5353.6 5374.6 4913.0 5242.1 5247.1 5255.1 5360.4 5102.9 5108.9 5113.6 5986.9 6473.6 19903.4 19938.0 20580.0 20840.0 20888.0 1988.3 2109.1 2166.7 2272.2 2283.0 13490.1 14131.8 14308.9 14604.8 14723.6 1884.7 1937.6 1945.7 1998.1 2069.9 76975.0 77377.2 79055.2 79786.6 79954.2 15401.5 16205.6 16375.6 16455.1 16547.7 28695.7 28747.0 28980.7 29061.9 29068.0 8132.1 8462.0 8477.6 8621.0 8671.1 6947.1 6956.3 6972.6 7112.8 7128.2 7917.4 8008.7 8081.2 8116.3 8261.5 1787.3 1829.9 1851.6 3289.6 3342.1 791.9 853.1 864.8 906.6 932.2 14233.8 14647.5 15370.7 15466.8 15654.9 826.9 834.0 859.1 859.6 861.4 8641.5 8714.3 8798.7 8971.6 9012.5 385312.0 386654.0 390029.0 390248.0 392037.0 72480.5 73498.6 75220.2 75748.6 76319.2 920.6 936.9 937.1 943.9 945.7 13859.3 14004.9 14132.6 14134.2 14277.0 33180.8 33188.8 34254.1 34587.5 34622.8 44977.6 47098.0 47343.0 47346.3 47440.3 7036.8 7630.7 7661.6 7839.9 7860.4 8754.9 11046.6 11099.8 11270.4 11548.5 10243.6 10248.4 10435.3 10513.9 10581.8 10329.6 10367.5 10415.3 10454.1 10739.7 10538.5 10615.0 10779.0 10780.5 10891.5 7357.3 7404.7 7465.7 7618.5 7646.5 9979.6 10009.7 10052.9 10167.6 10213.2 15:08:52 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | [#3] mootools.html Cycles:180 Average:5452.06 Median:6441.34 stddev:2833.88 (44.0%) stddev-sans-first:2825.74 15:08:52 INFO - PROCESS | 3470 | Values: 1435.1 1448.0 1549.8 1719.3 1760.3 6946.4 7539.4 7566.1 7811.9 7819.4 7549.8 7666.7 7674.7 7712.3 7725.7 2244.7 2294.7 2300.1 2305.7 2310.9 2231.5 2256.4 2262.4 2265.7 2274.1 2274.3 2297.4 2305.3 2335.7 2336.5 2225.3 2226.2 2226.3 2237.6 2238.3 2244.5 2246.5 2255.7 2255.7 2262.6 7656.1 7675.3 7709.9 7721.4 7738.7 4553.9 4612.7 4669.8 4679.6 4690.9 2842.7 2857.5 2966.5 2967.2 3005.8 906.8 907.8 914.8 939.4 955.1 10164.7 10653.4 10690.6 10702.1 10727.3 4173.1 4252.3 4399.2 4431.4 4465.5 9234.1 9238.4 9246.6 9262.9 9277.4 4755.8 4763.8 4789.2 4797.3 4808.0 3754.6 4187.9 4320.0 4320.5 4378.1 3656.6 3662.9 3736.7 3736.8 3776.8 1219.5 1237.7 1246.1 1247.4 1260.2 1006.3 1016.2 1185.9 1204.5 1231.3 7307.3 7315.4 7336.7 7368.8 7406.0 1020.8 1068.6 1070.7 1091.3 1096.7 5754.7 5770.6 5891.8 5920.4 5957.3 9056.5 9427.5 9485.4 9536.6 9543.3 9268.3 9431.4 9450.9 9506.4 9591.5 7255.0 7365.1 7391.3 7413.1 7451.4 6920.0 7137.4 7147.4 7153.9 7159.6 8435.5 8562.5 8669.3 8800.5 8822.1 8637.6 8667.4 8759.6 8843.0 8920.2 5921.9 6540.8 6631.9 6749.7 6768.5 7348.7 7366.6 7378.8 7436.0 7448.1 6584.3 6888.1 6898.0 6909.2 6987.2 6697.6 6768.1 6809.0 6855.2 6896.8 7126.5 7164.9 7223.7 7229.8 7233.3 6377.8 6423.5 6507.5 6514.7 6520.4 6377.7 6426.2 6436.6 6446.1 6460.4 15:08:52 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | [#4] prototype.html Cycles:180 Average:4619.88 Median:5321.60 stddev:1368.64 (25.7%) stddev-sans-first:1333.76 15:08:52 INFO - PROCESS | 3470 | Values: 313.2 315.4 315.9 324.9 328.3 5190.4 5361.3 5414.0 5450.8 5451.9 5241.3 5314.7 5320.6 5322.6 5322.9 3874.4 3971.5 4076.4 4106.0 4118.2 4056.5 4068.1 4068.4 4091.5 4099.2 4064.3 4070.1 4071.4 4074.9 4079.9 3826.0 4031.3 4047.5 4056.4 4074.4 3482.7 3510.3 3511.1 3512.8 3524.4 5017.9 5054.8 5062.5 5077.1 5107.6 4553.3 4649.9 4650.5 4665.4 4674.6 5523.3 5575.6 5582.2 5587.9 5598.5 3823.1 3866.5 3874.7 3874.8 3875.0 5638.8 5773.0 5869.9 5874.9 5889.3 3955.1 3955.3 3965.3 3976.6 3979.7 4032.2 4049.6 4053.3 4065.5 4072.1 4680.9 4682.2 4683.3 4687.8 4707.7 5449.3 5622.8 5625.7 5634.9 5644.1 1395.9 1407.7 1417.9 1418.8 1425.1 872.5 925.3 944.9 964.1 966.6 4788.5 4909.8 4936.5 4967.8 4982.3 5844.0 5856.3 5856.4 5867.3 5868.0 4782.2 4898.4 4940.9 4948.5 4955.4 3087.2 3106.6 3123.2 3128.6 3129.6 5396.7 5470.4 5478.8 5484.6 5484.9 5679.5 5927.6 5978.6 5982.5 5992.1 5448.1 5451.0 5452.0 5473.7 5498.5 5491.6 5772.8 5789.0 5794.0 5794.9 5730.6 5734.0 5746.7 5754.1 5767.5 5493.7 5502.7 5510.0 5528.3 5537.2 3944.2 3995.9 4017.6 4023.7 4034.8 5793.4 5796.9 5818.3 5819.3 5828.2 5552.3 5564.3 5582.3 5609.7 5626.3 5313.1 5520.7 5528.0 5554.9 5605.6 5439.9 5458.6 5468.2 5498.4 5559.5 5312.7 5365.0 5620.9 5637.9 5641.4 5470.9 5483.0 5488.2 5495.7 5525.9 15:08:52 INFO - PROCESS | 3470 | 15:08:52 INFO - PROCESS | 3470 | [#5] yui.html Cycles:180 Average:12846.89 Median:44597.16 stddev:14414.81 (32.3%) stddev-sans-first:14426.34 15:08:52 INFO - PROCESS | 3470 | Values: 691.6 722.6 724.2 781.3 792.7 11908.9 12088.5 12154.9 12168.9 12209.4 11413.5 11589.4 11637.3 11639.1 11656.9 794.5 800.3 828.4 831.8 836.6 835.1 838.3 841.1 841.3 842.0 860.4 862.5 864.5 864.8 867.0 843.9 847.2 848.7 849.0 852.2 628.8 631.7 632.9 633.8 634.9 12433.9 12586.3 12618.7 12627.2 12641.1 12469.6 12533.9 12714.6 12768.0 13131.0 10051.4 10072.2 10208.2 10411.4 10562.8 3270.0 3299.9 3332.5 3334.3 3343.9 45225.0 45687.0 46015.8 46208.1 46263.0 9990.6 9997.1 10062.2 10147.8 10231.4 17315.2 17332.1 17458.2 17497.7 17550.6 6959.6 6969.6 6970.5 7028.2 7036.1 3776.0 3839.4 3903.7 3971.6 3987.8 2802.7 2894.3 2896.2 2897.8 2902.0 503.8 509.7 513.2 518.9 526.4 594.3 606.0 642.4 649.6 651.8 7523.3 7837.1 7946.4 8286.5 8355.4 461.8 474.2 561.4 582.7 584.5 3918.9 4042.9 4273.0 4361.3 4372.7 48297.8 48685.0 49072.0 49186.3 50125.5 47542.0 48445.8 48453.0 48613.0 50380.2 44092.1 44100.6 44163.6 44267.0 44927.3 8467.4 8505.7 8648.6 8724.0 8769.4 28790.4 29642.3 29647.6 29689.1 29974.1 35613.5 38782.6 39137.0 39245.0 39481.2 11069.6 11182.0 11188.4 11234.9 11239.3 11776.4 11782.4 11955.0 12090.8 12180.4 11152.2 11516.7 11929.5 12062.2 12398.7 10487.4 10600.3 11444.7 11755.4 11844.3 9772.5 10403.7 10417.4 11478.6 11717.8 9012.2 9170.0 9218.3 9439.3 9748.2 8753.7 9023.6 9066.3 9400.4 9742.2 15:08:52 INFO - PROCESS | 3470 | -------- Summary: end -------- 15:08:52 INFO - PROCESS | 3470 | 15:08:53 INFO - TEST-INFO | 3470: exit 0 15:08:53 INFO - TEST-OK | dromaeo_css | took 1116090ms 15:08:53 INFO - TEST-START | kraken 15:08:53 INFO - operating with platform_type : linux_ 15:08:53 INFO - Initialising browser for kraken test... 15:08:53 INFO - TEST-INFO | started process 3702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTV6FA6/profile http://localhost:59510/getInfo.html) 15:08:56 INFO - PROCESS | 3702 | 15:08:56 INFO - PROCESS | 3702 | (process:3770): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:08:57 INFO - PROCESS | 3702 | 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] 15:08:57 INFO - PROCESS | 3702 | __metrics Screen width/height:1600/1200 15:08:57 INFO - PROCESS | 3702 | colorDepth:24 15:08:57 INFO - PROCESS | 3702 | Browser inner width/height: 1024/697 15:08:57 INFO - PROCESS | 3702 | __metrics 15:08:58 ERROR - PROCESS | 3702 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 15:08:59 INFO - TEST-INFO | 3702: exit 0 15:08:59 INFO - Browser initialized. 15:08:59 INFO - Running cycle 1/1 for kraken test... 15:08:59 INFO - TEST-INFO | started process 3821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTV6FA6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:09:01 INFO - PROCESS | 3821 | 15:09:01 INFO - PROCESS | 3821 | (process:3879): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:09:11 INFO - PROCESS | 3821 | RSS: Main: 163909632 15:09:11 INFO - PROCESS | 3821 | 15:09:13 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59510/tests/kraken/driver.html?testName=audio-beat-detection) 15:09:14 INFO - PROCESS | 3821 | RSS: Main: 168312832 15:09:14 INFO - PROCESS | 3821 | 15:09:17 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59510/tests/kraken/driver.html?testName=audio-dft) 15:09:18 INFO - PROCESS | 3821 | RSS: Main: 171683840 15:09:18 INFO - PROCESS | 3821 | 15:09:21 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59510/tests/kraken/driver.html?testName=audio-fft) 15:09:21 INFO - PROCESS | 3821 | RSS: Main: 163950592 15:09:21 INFO - PROCESS | 3821 | 15:09:23 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59510/tests/kraken/driver.html?testName=audio-oscillator) 15:09:24 INFO - PROCESS | 3821 | RSS: Main: 164220928 15:09:24 INFO - PROCESS | 3821 | 15:09:26 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:09:27 INFO - PROCESS | 3821 | RSS: Main: 164347904 15:09:27 INFO - PROCESS | 3821 | 15:09:30 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59510/tests/kraken/driver.html?testName=imaging-darkroom) 15:09:31 INFO - PROCESS | 3821 | RSS: Main: 164929536 15:09:31 INFO - PROCESS | 3821 | 15:09:34 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59510/tests/kraken/driver.html?testName=imaging-desaturate) 15:09:35 INFO - PROCESS | 3821 | RSS: Main: 163958784 15:09:35 INFO - PROCESS | 3821 | 15:09:38 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59510/tests/kraken/driver.html?testName=json-parse-financial) 15:09:38 INFO - PROCESS | 3821 | RSS: Main: 164847616 15:09:38 INFO - PROCESS | 3821 | 15:09:40 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:09:41 INFO - PROCESS | 3821 | RSS: Main: 165253120 15:09:41 INFO - PROCESS | 3821 | 15:09:43 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59510/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:09:43 INFO - PROCESS | 3821 | RSS: Main: 164950016 15:09:43 INFO - PROCESS | 3821 | 15:09:45 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:09:46 INFO - PROCESS | 3821 | RSS: Main: 165343232 15:09:46 INFO - PROCESS | 3821 | 15:09:49 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:09:50 INFO - PROCESS | 3821 | RSS: Main: 165584896 15:09:50 INFO - PROCESS | 3821 | 15:09:53 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:09:53 INFO - PROCESS | 3821 | RSS: Main: 165482496 15:09:53 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59510/tests/kraken/driver.html?testName=ai-astar) 15:09:55 INFO - PROCESS | 3821 | RSS: Main: 166838272 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | __start_tp_report 15:09:55 INFO - PROCESS | 3821 | _x_x_mozilla_page_load 15:09:55 INFO - PROCESS | 3821 | _x_x_mozilla_page_load_details 15:09:55 INFO - PROCESS | 3821 | |i|pagename|runs| 15:09:55 INFO - PROCESS | 3821 | |0;ai-astar;117;111;114;115;114;126;117;115;114;114 15:09:55 INFO - PROCESS | 3821 | |1;audio-beat-detection;159;133;162;188;137;168;156;136;187;140 15:09:55 INFO - PROCESS | 3821 | |2;audio-dft;163;163;162;170;166;164;162;162;166;164 15:09:55 INFO - PROCESS | 3821 | |3;audio-fft;78;79;74;151;75;75;74;73;154;77 15:09:55 INFO - PROCESS | 3821 | |4;audio-oscillator;94;98;141;93;92;93;143;95;94;144 15:09:55 INFO - PROCESS | 3821 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;117;119;118 15:09:55 INFO - PROCESS | 3821 | |6;imaging-darkroom;147;147;148;149;148;147;146;147;148;146 15:09:55 INFO - PROCESS | 3821 | |7;imaging-desaturate;96;95;96;96;97;96;96;96;96;96 15:09:55 INFO - PROCESS | 3821 | |8;json-parse-financial;66;66;66;65;65;65;65;64;66;64 15:09:55 INFO - PROCESS | 3821 | |9;json-stringify-tinderbox;63;64;64;64;64;64;63;64;64;65 15:09:55 INFO - PROCESS | 3821 | |10;stanford-crypto-aes;86;86;85;85;88;87;87;88;113;86 15:09:55 INFO - PROCESS | 3821 | |11;stanford-crypto-ccm;142;140;156;142;147;139;139;149;147;138 15:09:55 INFO - PROCESS | 3821 | |12;stanford-crypto-pbkdf2;176;172;173;177;172;170;169;171;171;188 15:09:55 INFO - PROCESS | 3821 | |13;stanford-crypto-sha256-iterative;72;71;72;74;73;72;71;71;74;73 15:09:55 INFO - PROCESS | 3821 | __end_tp_report 15:09:55 INFO - PROCESS | 3821 | __start_cc_report 15:09:55 INFO - PROCESS | 3821 | _x_x_mozilla_cycle_collect,931 15:09:55 INFO - PROCESS | 3821 | __end_cc_report 15:09:55 INFO - PROCESS | 3821 | __startTimestamp1460326195787__endTimestamp 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | ------- Summary: start ------- 15:09:55 INFO - PROCESS | 3821 | Number of tests: 14 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.00 stddev:4.00 (3.5%) stddev-sans-first:4.22 15:09:55 INFO - PROCESS | 3821 | Values: 117.0 111.0 114.0 115.0 114.0 126.0 117.0 115.0 114.0 114.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:160.50 stddev:20.32 (12.7%) stddev-sans-first:21.53 15:09:55 INFO - PROCESS | 3821 | Values: 159.0 133.0 162.0 188.0 137.0 168.0 156.0 136.0 187.0 140.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.53 (1.5%) stddev-sans-first:2.65 15:09:55 INFO - PROCESS | 3821 | Values: 163.0 163.0 162.0 170.0 166.0 164.0 162.0 162.0 166.0 164.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#3] audio-fft Cycles:10 Average:91.00 Median:75.00 stddev:32.48 (43.3%) stddev-sans-first:34.10 15:09:55 INFO - PROCESS | 3821 | Values: 78.0 79.0 74.0 151.0 75.0 75.0 74.0 73.0 154.0 77.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.50 stddev:23.50 (25.1%) stddev-sans-first:24.32 15:09:55 INFO - PROCESS | 3821 | Values: 94.0 98.0 141.0 93.0 92.0 93.0 143.0 95.0 94.0 144.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:09:55 INFO - PROCESS | 3821 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 119.0 118.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 15:09:55 INFO - PROCESS | 3821 | Values: 147.0 147.0 148.0 149.0 148.0 147.0 146.0 147.0 148.0 146.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 15:09:55 INFO - PROCESS | 3821 | Values: 96.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 15:09:55 INFO - PROCESS | 3821 | Values: 66.0 66.0 66.0 65.0 65.0 65.0 65.0 64.0 66.0 64.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 15:09:55 INFO - PROCESS | 3821 | Values: 63.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 65.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:86.50 stddev:8.46 (9.8%) stddev-sans-first:8.90 15:09:55 INFO - PROCESS | 3821 | Values: 86.0 86.0 85.0 85.0 88.0 87.0 87.0 88.0 113.0 86.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:144.50 stddev:5.74 (4.0%) stddev-sans-first:6.05 15:09:55 INFO - PROCESS | 3821 | Values: 142.0 140.0 156.0 142.0 147.0 139.0 139.0 149.0 147.0 138.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:172.50 stddev:5.55 (3.2%) stddev-sans-first:5.83 15:09:55 INFO - PROCESS | 3821 | Values: 176.0 172.0 173.0 177.0 172.0 170.0 169.0 171.0 171.0 188.0 15:09:55 INFO - PROCESS | 3821 | 15:09:55 INFO - PROCESS | 3821 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:1.16 (1.6%) stddev-sans-first:1.22 15:09:55 INFO - PROCESS | 3821 | Values: 72.0 71.0 72.0 74.0 73.0 72.0 71.0 71.0 74.0 73.0 15:09:55 INFO - PROCESS | 3821 | -------- Summary: end -------- 15:09:55 INFO - PROCESS | 3821 | 15:09:56 INFO - TEST-INFO | 3821: exit 0 15:09:56 INFO - TEST-OK | kraken | took 63354ms 15:09:56 INFO - SUITE-END | took 1179s 15:09:56 INFO - Completed test suite (00:19:39) 15:09:56 INFO - javascript benchmark 15:09:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.0556802335173, 2683.503551842908, 2734.4941185880602, 2744.2041807875717, 2751.1883994221703, 4752.287156926458, 4770.30830529573, 4782.713037217769, 4800.447948485925, 4800.5679488846, 4643.489216186225, 4751.714897106176, 4776.641751868607, 4807.471178170407, 4840.854774356766, 4344.066025804452, 4421.0, 4427.092446048552, 4434.645228381738, 4515.932261016087, 4348.869533913988, 4362.19299429605, 4410.955890441102, 4416.624586910117, 4470.061287129706, 4223.366495025755, 4321.373400856858, 4376.0591472833175, 4408.448943882015, 4420.04968931678, 4400.515943246241, 4419.204543182226, 4421.867343979686, 4431.490378606437, 4473.926257698162, 4339.435873336478, 4401.2517871961845, 4405.8237670493145, 4430.623397011258, 4452.955470445287, 4588.816447342102, 4714.222153344694, 4717.551832575899, 4725.031368569435, 4765.261384485376, 5062.417821950449, 5117.46266642001, 5125.692458452468, 5126.769295381717, 5157.6647517911215, 4963.950360496385, 5109.591232701375, 5161.870953226162, 5200.739963001834, 5222.503862133091, 4796.784144713496, 4806.206975848946, 4817.470078291385, 4848.442429120661, 4864.610831133501, 5232.712200828915, 5257.763400646903, 5270.0, 5272.6836389816735, 5276.683398995996, 4884.0476107158765, 4982.053409852117, 5051.090803655304, 5082.491750824888, 5103.719295438712, 4923.212286034289, 5016.724080175625, 5099.6685215460875, 5107.846764597068, 5162.819301324435, 5073.16292811682, 5098.260752190911, 5109.9744501278, 5162.380514338229, 5165.070287348238, 4957.628177886673, 5020.899582008413, 5069.391672999263, 5086.109930762176, 5159.355080614923, 4403.867883963486, 4415.811486077028, 4421.7346959181905, 4425.247707889602, 4458.910821783546, 3800.467934489174, 3842.3852183650483, 3846.5961074086817, 3854.9229015420096, 3871.2064026874423, 4339.522652508222, 4401.295792673157, 4451.998300382388, 4505.324201369821, 4526.343680166357, 5113.207452844815, 5120.462351453119, 5124.359455068116, 5169.81905633301, 5180.352455943007, 4341.240282950471, 4418.5802348776815, 4438.844640437569, 4452.532484089124, 4472.396226509444, 4626.560476754703, 4701.153792317347, 4707.411573553306, 4741.810327586858, 4756.048790241896, 4881.707097574086, 4912.975435122801, 4917.557419832232, 4927.310176575211, 4972.378452693486, 4993.425756038102, 5005.0, 5197.480251974772, 5210.97394513025, 5264.763085661078, 4809.975950120227, 4815.470298267258, 4819.734914579732, 4830.3237546744185, 4844.079624871263, 5012.298278241122, 5017.698938063728, 5020.221865610836, 5031.22016087507, 5067.797288108434, 5002.449730529566, 5063.3417655704525, 5104.106781313181, 5144.742762861767, 5210.739463026757, 4849.975750121227, 4875.488073752205, 4920.015996800583, 4932.3341348918875, 5048.7475626219275, 4927.876803079808, 4987.401511818605, 4988.45127036033, 4991.875203119951, 5035.16919708244, 4730.834420795256, 4888.755562221946, 4901.754912254444, 4914.066327397783, 4923.556879880828, 4889.975550122226, 4975.303457515878, 4996.225585034325, 5056.898862022813, 5059.291699162194, 4895.681780684244, 4908.361912951294, 4922.8769280768265, 4926.4088309403105, 4959.826406075915], "value": 4705.986170370039, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2369301443052, 589.1869220475743, 607.2712744706353, 637.2575949019392, 651.9641419721913, 31202.84398578007, 31996.360072798587, 32084.839575802118, 32119.839400802994, 32207.67792322076, 31567.52648710271, 32016.519752203734, 32084.518732219036, 32086.197845053885, 32132.518012229837, 7400.555966642005, 7542.472026958115, 7555.508891922035, 7559.3196612305155, 7573.545587264782, 7514.699412023512, 7560.546367217957, 7564.394848412114, 7631.694732210733, 7656.502327348732, 7613.771586852404, 7643.961780191091, 7644.426667999895, 7650.120236172828, 7680.923190768104, 7566.20554841742, 7623.504472209289, 7627.961860190719, 7646.541207527538, 7711.190325015848, 7556.848863022708, 7641.121271053845, 7670.501417407906, 7684.385249180053, 7690.192529784404, 32261.225632590435, 32662.836685816656, 32759.836200818845, 32776.836115819504, 32818.50772238418, 2518.874056297196, 2791.4835755385116, 3102.332998405331, 3284.490903909898, 3727.869524566627, 23289.3013209604, 23459.530809383887, 23589.764102358928, 23675.171369002, 23712.62873712632, 3266.7876588021704, 3328.6338502764675, 3337.93324133516, 3399.8130102844334, 3402.795832250048, 138460.0, 139522.3023884874, 139869.3006534961, 140038.0, 180136.0, 31061.844690776852, 31137.532937005963, 31220.531692024637, 31266.374672506878, 31356.686433135375, 31579.0, 32639.18402039968, 33467.16332091717, 33504.664953350155, 33705.325893482484, 12334.568290109803, 12407.93796031014, 12504.374781261082, 12561.057920655987, 12569.622911312676, 9733.124018838338, 9737.07497787709, 9758.609655613838, 9771.853422198672, 9776.266779991529, 7708.267714567107, 7752.108507521594, 7839.686412543549, 7844.901713760079, 7898.973133492609, 3071.754259659222, 3110.5225018116666, 3136.8745250190195, 3174.619045714483, 3184.1561986073707, 935.2331088507494, 942.2920806625813, 944.4286206844897, 980.4411485453223, 1034.3070143004206, 27049.729502704722, 27737.0, 28135.155945321672, 28190.71809281922, 28240.43519129647, 988.9109980101825, 1007.4459047523833, 1058.2803693488347, 1058.5501162006117, 1110.2846102771239, 14572.85427145715, 14732.337044833008, 14945.925270373797, 15074.321655525308, 15208.315625796866, 298353.0, 299528.0, 299959.0, 304786.0, 305082.0, 46687.0, 47228.29157562639, 47241.76379118083, 47525.76237118861, 47556.5244347559, 1207.0826172109084, 1211.2308683985557, 1251.0992085698283, 1253.2981530343036, 1265.044891107208, 25000.0, 26269.605955910294, 26663.0, 26812.0, 26996.865015674797, 39876.0, 40366.79816600898, 40398.19203615852, 40684.38973415342, 40700.59299407087, 265141.0, 266367.0, 267963.0, 269326.0, 269351.0, 24557.508849822545, 25190.748092519574, 25291.367715806515, 25382.746172538777, 25450.74549254558, 39651.60348396479, 40112.19775604413, 40949.1810163801, 40962.18075638411, 41633.79183104186, 34947.47578786269, 35311.82344088263, 35591.64408355884, 35754.463683045295, 36375.45436818397, 34695.479567805996, 35331.0, 35392.823035884656, 35481.82259088688, 35501.28997420089, 35059.824700877354, 35499.467507987916, 35912.64087359093, 37087.25825483421, 37198.44202336913, 28135.296617584725, 30018.0, 30177.0, 30367.696323036485, 30399.392012160075, 23443.41391465227, 23529.41176470602, 24236.515269694155, 24311.63532546978, 24342.51314973726], "value": 15256.133704823651, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.76514678326043, 379.6412390291175, 385.59319917487056, 386.1851493349033, 387.10385457665484, 15037.172955487458, 16178.514644560668, 16970.49088527343, 16970.66058678827, 16973.745393819103, 14507.347169377377, 15343.539693809204, 16735.246913888874, 16837.242324095416, 16858.241379137937, 4632.166210082184, 4767.499412561683, 4789.2816077588295, 4789.521047895218, 4813.951860481403, 3439.1574064354145, 4757.26262429324, 5073.467285934979, 5372.0, 5385.892282154355, 5304.602154838383, 5309.920351194735, 5321.228421878825, 5353.5984801139875, 5374.6237763356585, 4912.975435122819, 5242.108841496935, 5247.055530004598, 5255.1066318725525, 5360.356757189143, 5102.897942041175, 5108.872278193037, 5113.590912726973, 5986.910196347058, 6473.579217350904, 19903.402897913085, 19938.0, 20580.0, 20840.0, 20888.0, 1988.3140316590752, 2109.0825490911348, 2166.653335466318, 2272.2192140128523, 2283.0068920019844, 13490.055696101277, 14131.788023179557, 14308.856911430856, 14604.780928286084, 14723.631909202248, 1884.660761063008, 1937.5737337785665, 1945.737325461073, 1998.1108406758854, 2069.9379018629465, 76975.0, 77377.22622773757, 79055.20944790593, 79786.60106699487, 79954.20045799584, 15401.46094886696, 16205.594860128354, 16375.590610234602, 16455.094969776776, 16547.669046619, 28695.71304286972, 28746.99385521497, 28980.710192898223, 29061.85469072641, 29068.0, 8132.146124656826, 8461.957690211633, 8477.618507167192, 8620.95689521561, 8671.089535598798, 6947.062146610244, 6956.304369563104, 6972.616506092214, 7112.822179445452, 7128.215896251409, 7917.406194535433, 8008.719694810654, 8081.191880811872, 8116.2695357418115, 8261.545614991233, 1787.302951848754, 1829.9451016469527, 1851.6481868445221, 3289.5723555937575, 3342.1310459280276, 791.8930944322558, 853.0829358439702, 864.831357885219, 906.5784410249134, 932.1889955738416, 14233.78649320261, 14647.487337943121, 15370.692586148214, 15466.845331546765, 15654.9217253913, 826.8553003224412, 833.954132522705, 859.0507489224442, 859.5573279760928, 861.4486728493769, 8641.524716140673, 8714.346424018224, 8798.692045778367, 8971.641134354553, 9012.504312262758, 385312.0, 386654.0, 390029.0, 390248.0, 392037.0, 72480.47675709211, 73498.63250683712, 75220.24011666176, 75748.62125689337, 76319.23680763232, 920.6409500294891, 936.9016253293306, 937.0676177203726, 943.9339246252696, 945.716285114463, 13859.30703464843, 14004.929975350058, 14132.646683832987, 14134.222617756122, 14277.0, 33180.83409583033, 33188.83405582957, 34254.14364640904, 34587.48118778271, 34622.82688586541, 44977.55022449734, 47098.0, 47343.0, 47346.28980565363, 47440.2883956734, 7036.753713620204, 7630.694772209049, 7661.616919154131, 7839.9216007839195, 7860.4104692147175, 8754.91245087541, 11046.558137674725, 11099.836546584507, 11270.436478175894, 11548.48031838586, 10243.641472548425, 10248.436336001592, 10435.32170408921, 10513.89486105129, 10581.841272381074, 10329.638462654071, 10367.481625918825, 10415.270931034755, 10454.059134677611, 10739.731506712395, 10538.525766340379, 10614.988215555393, 10779.02988731018, 10780.514876830719, 10891.455427228766, 7357.2642735726, 7404.6667899945705, 7465.738699145504, 7618.466707330434, 7646.502977306457, 9979.60081596728, 10009.749756256151, 10052.899471005196, 10167.644132455329, 10213.234007449322], "value": 8750.910212558485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.0815478094014, 1447.971939922655, 1549.806274215723, 1719.3122750899647, 1760.2782859027793, 6946.374826265635, 7539.4345424093135, 7566.129895062069, 7811.882821757671, 7819.374450044004, 7549.7735067947915, 7666.655000524976, 7674.693012279516, 7712.305892469677, 7725.690972361099, 2244.7306323241232, 2294.701688780456, 2300.102959845653, 2305.700258966332, 2310.8960096795686, 2231.4867580456503, 2256.424611724008, 2262.3891549281684, 2265.728112626487, 2274.0676322707695, 2274.283600665793, 2297.3682237384687, 2305.3199306204624, 2335.684682567857, 2336.4859730859184, 2225.254539729193, 2226.198568515333, 2226.3209721035078, 2237.6307909195043, 2238.2837492002564, 2244.5062086340977, 2246.5057687308768, 2255.650374192003, 2255.6842042113954, 2262.558801033799, 7656.0812702475505, 7675.270849269311, 7709.884351734672, 7721.382289416833, 7738.690452381898, 4553.863384098482, 4612.746298953556, 4669.766511674403, 4679.60223381013, 4690.882727931795, 2842.6730925943575, 2857.4506213339478, 2966.4808658484894, 2967.1988563087843, 3005.834679092649, 906.8005038891433, 907.7685190276503, 914.8033172867865, 939.3612343606345, 955.1451450951429, 10164.745881352952, 10653.414062226575, 10690.572377104907, 10702.090322322612, 10727.302725322828, 4173.10278290163, 4252.340887162495, 4399.208142534375, 4431.379606855043, 4465.4864690561, 9234.122758337948, 9238.399504032217, 9246.583903724348, 9262.861057084148, 9277.443353398818, 4755.785989630475, 4763.833265835679, 4789.233722604366, 4797.304390863375, 4807.95192048082, 3754.5869954305003, 4187.874363769091, 4319.956800431955, 4320.524742278347, 4378.10248898975, 3656.634336566322, 3662.908427289339, 3736.663700266989, 3736.831842567091, 3776.811159442017, 1219.481720268882, 1237.6782036670531, 1246.1339369138361, 1247.376311844078, 1260.24385368778, 1006.3056491021172, 1016.2073582605432, 1185.8873407026492, 1204.4700331853956, 1231.2550906701317, 7307.3423391894985, 7315.378192853561, 7336.706531738778, 7368.815779605446, 7405.962970185223, 1020.806046851096, 1068.5618896252654, 1070.652038087609, 1091.307020042279, 1096.7477480179602, 5754.6547207167705, 5770.6249093808765, 5891.793787217427, 5920.407959204045, 5957.314908785458, 9056.50189239585, 9427.481488518197, 9485.383450075724, 9536.61853525865, 9543.284253681002, 9268.304877134107, 9431.386959847589, 9450.85823712645, 9506.429614223169, 9591.520423978773, 7255.0, 7365.079365079365, 7391.260873912674, 7413.110426748717, 7451.441141914378, 6920.0, 7137.393321567725, 7147.3924716397605, 7153.928460715534, 7159.57042577447, 8435.47476402957, 8562.52906090171, 8669.306455483673, 8800.47197168172, 8822.07368226327, 8637.56812159377, 8667.419254937693, 8759.649614015369, 8842.955785221033, 8920.152585504367, 5921.851953701192, 6540.803775886731, 6631.900521492085, 6749.696263668245, 6768.526203165731, 7348.742794002184, 7366.558006519626, 7378.778636640909, 7436.0, 7448.068991376078, 6584.341565843377, 6888.138982627172, 6898.0, 6909.2399836019, 6987.196472405535, 6697.564658297195, 6768.120144381199, 6809.0, 6855.211650660039, 6896.827579310558, 7126.5011449198055, 7164.928350716635, 7223.674934627849, 7229.819254518679, 7233.276672332725, 6377.808665740035, 6423.518236132215, 6507.544471886922, 6514.706838192198, 6520.413162815369, 6377.681115944277, 6426.228852537725, 6436.613803171825, 6446.065320528591, 6460.418562329413], "value": 4470.864282383567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2435169066704, 315.3755563983313, 315.91628218522095, 324.9382617302714, 328.26796244375026, 5190.377154741432, 5361.276227709263, 5414.0, 5450.781968721247, 5451.918221226685, 5241.3186285782895, 5314.724466128121, 5320.600954928376, 5322.600804939635, 5322.866928326794, 3874.3994680824376, 3971.543272523668, 4076.408920706496, 4106.0, 4118.155778065497, 4056.492938382702, 4068.105016896278, 4068.4304197412384, 4091.509018917734, 4099.159672267178, 4064.2887494688457, 4070.1249231415386, 4071.409645601386, 4074.8981275468054, 4079.8980025499304, 3826.0, 4031.314676504972, 4047.4738284023038, 4056.4118202860714, 4074.4295798588223, 3482.721382289411, 3510.3154884797473, 3511.087117349482, 3512.7892326460496, 3524.4360902255517, 5017.949820501784, 5054.823081192178, 5062.54437100659, 5077.0607437623785, 5107.591392688576, 4553.2942393929, 4649.907001859978, 4650.465196502378, 4665.393498845162, 4674.649401294882, 5523.309586301712, 5575.637583557056, 5582.162675598693, 5587.944120558783, 5598.524125449301, 3823.0693499782433, 3866.497355343787, 3874.748141370802, 3874.8062596870327, 3874.9612503874882, 5638.774449021993, 5772.971135144339, 5869.882602347929, 5874.882502349929, 5889.322727886305, 3955.0705584187695, 3955.3275943089743, 3965.325894597925, 3976.58245884178, 3979.7413168143976, 4032.1734044520804, 4049.5950404959267, 4053.2906741320153, 4065.4511640928686, 4072.083781149277, 4680.882977925511, 4682.227432473672, 4683.344331793552, 4687.765611719468, 4707.7175369477945, 5449.264349312792, 5622.831315060473, 5625.746841392147, 5634.915476267859, 5644.096944488944, 1395.9371828267751, 1407.7043820797746, 1417.8511256318145, 1418.822647169104, 1425.0594607558962, 872.5462759365095, 925.3106435705442, 944.9244060475284, 964.1178321835582, 966.5940305071887, 4788.545088216614, 4909.846186146253, 4936.456989731127, 4967.82612608557, 4982.2775697524385, 5843.970780146072, 5856.297244330707, 5856.355800861902, 5867.325257595346, 5868.0, 4782.163121453732, 4898.436679781871, 4940.925886111711, 4948.505149485023, 4955.40535135786, 3087.1818967973504, 3106.580611617448, 3123.1723593247807, 3128.6402063762503, 3129.6087989001376, 5396.731768034509, 5470.398256191816, 5478.753456094485, 5484.61607687466, 5484.945150548523, 5679.460451257124, 5927.555433342516, 5978.581499295007, 5982.46157845796, 5992.13114098462, 5448.128299472145, 5450.972745136249, 5452.0, 5473.67157970523, 5498.505134537991, 5491.643043202179, 5772.7690892363835, 5788.971055144697, 5793.971030144822, 5794.913076303943, 5730.627509211888, 5733.967885780599, 5746.655200687972, 5754.136879468113, 5767.452092051249, 5493.670379777226, 5502.669839809624, 5509.953108909294, 5528.318765398859, 5537.197106419627, 3944.1914407546956, 3995.940060899147, 4017.5580686125086, 4023.7384570002855, 4034.818433170573, 5793.362730099601, 5796.8550786229, 5818.301803783573, 5819.272590926134, 5828.242328497268, 5552.278203833475, 5564.304461942257, 5582.302212223472, 5609.74756135983, 5626.2967129108865, 5313.123334649739, 5520.723963801875, 5527.972360138174, 5554.944450555443, 5605.551555875439, 5439.891202175855, 5458.645188062763, 5468.207109969112, 5498.395176530658, 5559.527440167631, 5312.707801070824, 5365.0, 5620.859478512906, 5637.887242255214, 5641.361321947403, 5470.863228419322, 5483.040467918178, 5488.1767734838495, 5495.670259784426, 5525.944740552543], "value": 4182.731221679854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.6334342798317, 722.6314579564424, 724.1816747075803, 781.2968328504342, 792.6670798264728, 11908.940455297723, 12088.516459341627, 12154.878451215485, 12168.939155304233, 12209.38953052346, 11413.486393112309, 11589.42052897356, 11637.301761894292, 11639.127065470082, 11656.883431165686, 794.467706636552, 800.2877439079224, 828.4325237212498, 831.7795784117184, 836.6444261189001, 835.052215735142, 838.2748922182299, 841.0790184747691, 841.2680967558202, 842.0316635868738, 860.4192170285032, 862.4782006885838, 864.515871112176, 864.7665130414784, 866.9826603467927, 843.8607629741085, 847.1740053447901, 848.6647774129184, 849.0448245723561, 852.1606217875387, 628.8396458902996, 631.6683741035947, 632.9082283068975, 633.7686744338283, 634.8603307272439, 12433.875661243454, 12586.307753073577, 12618.74762504754, 12627.179233349894, 12641.051921105955, 12469.563565275263, 12533.93733031329, 12714.61856144317, 12767.957126859657, 13131.0, 10051.447170405625, 10072.194224462026, 10208.234382421348, 10411.375317480899, 10562.841557376645, 3269.9509507357407, 3299.851506682205, 3332.5334453176574, 3334.333133373311, 3343.9331213375594, 45225.0, 45687.0, 46015.76992115018, 46208.075838483375, 46263.0, 9990.550425230882, 9997.050280223368, 10062.24533160016, 10147.847782283272, 10231.386116832866, 17315.220815063352, 17332.133393330536, 17458.214380352914, 17497.737533937, 17550.561235968948, 6959.582425054412, 6969.6166710830375, 6970.546914450544, 7028.156621205386, 7036.085308909809, 3776.0182352587976, 3839.404892241707, 3903.7072219583647, 3971.6425521703186, 3987.8205480753436, 2802.691703912568, 2894.3487715263896, 2896.189067061226, 2897.826130432181, 2902.0133154727496, 503.8488453463946, 509.66634173375064, 513.2019709351994, 518.9014087323396, 526.368357970437, 594.3343455330058, 605.9638018987581, 642.4314481683743, 649.577774446604, 651.7588492257801, 7523.322900938832, 7837.09873364559, 7946.404019698546, 8286.544240066734, 8355.373346999, 461.78296200785576, 474.2483164184737, 561.4077148608258, 582.7144699097412, 584.4535359438938, 3918.8628398005935, 4042.939355909664, 4273.0, 4361.302191649321, 4372.650187984954, 48297.758511207925, 48685.0, 49072.0, 49186.26220606694, 50125.49874501281, 47542.0, 48445.757771211625, 48453.0, 48613.0, 50380.244296335586, 44092.118157636665, 44100.55899440964, 44163.55836441594, 44267.0, 44927.326090108676, 8467.407281490237, 8505.74482765518, 8648.610812513327, 8724.0, 8769.38614296993, 28790.42419151647, 29642.25894352572, 29647.555286671148, 29689.109326720234, 29974.100776976724, 35613.465798012534, 38782.6121738779, 39137.0, 39245.0, 39481.21037579175, 11069.5572177112, 11182.0, 11188.440577970907, 11234.943825280821, 11239.325640461599, 11776.411179440822, 11782.351970641697, 11955.043596512432, 12090.818637720617, 12180.390980451119, 11152.219344645797, 11516.712082198012, 11929.522819087486, 12062.215955962834, 12398.690032749253, 10487.37075775456, 10600.25798194119, 11444.713882153013, 11755.353455560027, 11844.28934263947, 9772.511374431393, 10403.687889363331, 10417.374957502574, 11478.598249061242, 11717.765644686888, 9012.188902998761, 9170.0, 9218.308626853148, 9439.339246252697, 9748.220142388735, 8753.6936207235, 9023.639054437748, 9066.274698024274, 9400.435973841591, 9742.171915387271], "value": 6015.219947488399, "unit": "score"}], "name": "dromaeo_css", "value": 6430.058655463226, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 114.0, 115.0, 114.0, 126.0, 117.0, 115.0, 114.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 133.0, 162.0, 188.0, 137.0, 168.0, 156.0, 136.0, 187.0, 140.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 170.0, 166.0, 164.0, 162.0, 162.0, 166.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 74.0, 151.0, 75.0, 75.0, 74.0, 73.0, 154.0, 77.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 141.0, 93.0, 92.0, 93.0, 143.0, 95.0, 94.0, 144.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 148.0, 147.0, 146.0, 147.0, 148.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 85.0, 88.0, 87.0, 87.0, 88.0, 113.0, 86.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 156.0, 142.0, 147.0, 139.0, 139.0, 149.0, 147.0, 138.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 173.0, 177.0, 172.0, 170.0, 169.0, 171.0, 171.0, 188.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 74.0, 73.0, 72.0, 71.0, 71.0, 74.0, 73.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1605.4000000000003, "alertThreshold": 2.0}]} 15:09:57 INFO - Return code: 0 15:09:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:09:57 ERROR - # TBPL SUCCESS # 15:09:57 INFO - Running post-action listener: _resource_record_post_action 15:09:57 INFO - Running post-run listener: _resource_record_post_run 15:09:58 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8028160; Write bytes: 421523456; Read time: 1796; Write time: 306044 15:09:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110612480; Read time: 60; Write time: 79120 15:09:58 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 6287360; Write bytes: 310910976; Read time: 1680; Write time: 226924 15:09:58 INFO - Running post-run listener: _upload_blobber_files 15:09:58 INFO - Blob upload gear active. 15:09:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:09:58 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 15:09:58 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'] 15:09:58 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 15:09:58 INFO - (blobuploader) - INFO - Open directory for files ... 15:09:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:09:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:59 INFO - (blobuploader) - INFO - Done attempting. 15:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:00 INFO - (blobuploader) - INFO - Done attempting. 15:10:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:10:00 INFO - Return code: 0 15:10:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:10:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:10:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b8b5bad5e92b5feba73b6af241947ad2bc2d490fcc3990ce477825311612fa9bb5522d074c77bd619027c0d6916e564dc1a3142ab9556f80d6b29f1e70a2d08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9ed169dfef76589b37dfe248d50c54a4622b2073787c05c975051f14c0b3eb77cd2b0637c7bd1f2be66cc7c0669b1fef3223a13f01b4d4cad58b273a8a3e1be"} 15:10:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:10:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:10:00 INFO - Contents: 15:10:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b8b5bad5e92b5feba73b6af241947ad2bc2d490fcc3990ce477825311612fa9bb5522d074c77bd619027c0d6916e564dc1a3142ab9556f80d6b29f1e70a2d08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9ed169dfef76589b37dfe248d50c54a4622b2073787c05c975051f14c0b3eb77cd2b0637c7bd1f2be66cc7c0669b1fef3223a13f01b4d4cad58b273a8a3e1be"} 15:10:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:10:00 INFO - Copying logs to upload dir... 15:10:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:10:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.167328 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-10 15:10:00.043403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 15:10:00.046694) ========= 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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 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/8b8b5bad5e92b5feba73b6af241947ad2bc2d490fcc3990ce477825311612fa9bb5522d074c77bd619027c0d6916e564dc1a3142ab9556f80d6b29f1e70a2d08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9ed169dfef76589b37dfe248d50c54a4622b2073787c05c975051f14c0b3eb77cd2b0637c7bd1f2be66cc7c0669b1fef3223a13f01b4d4cad58b273a8a3e1be"} build_url:https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011101 build_url: 'https://queue.taskcluster.net/v1/task/LP71fBZtStm2zmDOGtpLkw/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/8b8b5bad5e92b5feba73b6af241947ad2bc2d490fcc3990ce477825311612fa9bb5522d074c77bd619027c0d6916e564dc1a3142ab9556f80d6b29f1e70a2d08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9ed169dfef76589b37dfe248d50c54a4622b2073787c05c975051f14c0b3eb77cd2b0637c7bd1f2be66cc7c0669b1fef3223a13f01b4d4cad58b273a8a3e1be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 15:10:00.071264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:10:00.071581) ========= 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=db0483c52d987ecb441a263b000001ad-1460302054.453087-2019947187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:10:00.154189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 15:10:00.154503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 15:10:00.154790) ========= ========= Total master_lag: 0.26 =========