builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1460401215.09 results: success (0) buildid: 20160411024708 builduid: f1bc25edda414291a8d39c9aed0be10d revision: e847cfcb315f511f4928b03fd47dcf57aad05e1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.086287) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.086991) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.087620) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006460 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.149393) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.150063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.203258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.203587) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004745 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.267864) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.268405) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.268720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.268985) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 12:00:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.9M=0s 2016-04-11 12:00:17 (95.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103652 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.386208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.386512) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023353 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.436836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.440209) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e847cfcb315f511f4928b03fd47dcf57aad05e1e --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 e847cfcb315f511f4928b03fd47dcf57aad05e1e --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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 12:00:17,351 truncating revision to first 12 chars 2016-04-11 12:00:17,351 Setting DEBUG logging. 2016-04-11 12:00:17,351 attempt 1/10 2016-04-11 12:00:17,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e847cfcb315f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 12:00:17,842 unpacking tar archive at: mozilla-central-e847cfcb315f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.747627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.200669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.200992) ========= echo e847cfcb315f511f4928b03fd47dcf57aad05e1e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e847cfcb315f511f4928b03fd47dcf57aad05e1e'] 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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e847cfcb315f511f4928b03fd47dcf57aad05e1e program finished with exit code 0 elapsedTime=0.004718 script_repo_revision: 'e847cfcb315f511f4928b03fd47dcf57aad05e1e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.257077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.257389) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.270527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-11 12:00:16.270777) ========= /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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:00:18 INFO - MultiFileLogger online at 20160411 12:00:18 in /builds/slave/test 12:00: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 12:00:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:00:18 INFO - {'append_to_log': False, 12:00:18 INFO - 'base_work_dir': '/builds/slave/test', 12:00:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:00:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:00:18 INFO - 'branch': 'Firefox-Non-PGO', 12:00:18 INFO - 'buildbot_json_path': 'buildprops.json', 12:00:18 INFO - 'config_files': ('talos/linux_config.py',), 12:00:18 INFO - 'default_actions': ('clobber', 12:00:18 INFO - 'read-buildbot-config', 12:00:18 INFO - 'download-and-extract', 12:00:18 INFO - 'populate-webroot', 12:00:18 INFO - 'create-virtualenv', 12:00:18 INFO - 'install', 12:00:18 INFO - 'run-tests'), 12:00:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:00:18 INFO - 'download_minidump_stackwalk': True, 12:00:18 INFO - 'download_symbols': 'ondemand', 12:00:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:00:18 INFO - 'tooltool.py': '/tools/tooltool.py', 12:00:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:00:18 INFO - '/tools/misc-python/virtualenv.py')}, 12:00:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:00:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:00:18 INFO - 'installer_path': 'installer.exe', 12:00:18 INFO - 'log_level': 'info', 12:00:18 INFO - 'log_name': 'talos', 12:00:18 INFO - 'log_to_console': True, 12:00:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:00:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:00:18 INFO - 'opt_config_files': (), 12:00:18 INFO - 'pip_index': False, 12:00:18 INFO - 'sps_profile': False, 12:00:18 INFO - 'sps_profile_interval': 0, 12:00:18 INFO - 'suite': 'dromaeojs-e10s', 12:00:18 INFO - 'system_bits': '32', 12:00:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:00:18 INFO - 'title': 'talos-linux64-ix-023', 12:00:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:00:18 INFO - 'use_talos_json': True, 12:00:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:00:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:00:18 INFO - 'work_dir': 'build'} 12:00:18 INFO - ##### 12:00:18 INFO - ##### Running clobber step. 12:00:18 INFO - ##### 12:00:18 INFO - Running pre-action listener: _resource_record_pre_action 12:00:18 INFO - Running main action method: clobber 12:00:18 INFO - rmtree: /builds/slave/test/build 12:00:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:00:19 INFO - Running post-action listener: _resource_record_post_action 12:00:19 INFO - ##### 12:00:19 INFO - ##### Running read-buildbot-config step. 12:00:19 INFO - ##### 12:00:19 INFO - Running pre-action listener: _resource_record_pre_action 12:00:19 INFO - Running main action method: read_buildbot_config 12:00:19 INFO - Using buildbot properties: 12:00:19 INFO - { 12:00:19 INFO - "project": "", 12:00:19 INFO - "product": "firefox", 12:00:19 INFO - "script_repo_revision": "production", 12:00:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:00:19 INFO - "repository": "", 12:00:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:00:19 INFO - "buildid": "20160411024708", 12:00:19 INFO - "pgo_build": "False", 12:00:19 INFO - "basedir": "/builds/slave/test", 12:00:19 INFO - "buildnumber": 283, 12:00:19 INFO - "slavename": "talos-linux64-ix-023", 12:00:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:00:19 INFO - "platform": "ubuntu64_hw", 12:00:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:00:19 INFO - "branch": "mozilla-central", 12:00:19 INFO - "repo_path": "mozilla-central", 12:00:19 INFO - "revision": "e847cfcb315f511f4928b03fd47dcf57aad05e1e", 12:00:19 INFO - "stage_platform": "linux64", 12:00:19 INFO - "builduid": "f1bc25edda414291a8d39c9aed0be10d", 12:00:19 INFO - "slavebuilddir": "test" 12:00:19 INFO - } 12:00:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:00:19 INFO - Running post-action listener: _resource_record_post_action 12:00:19 INFO - ##### 12:00:19 INFO - ##### Running download-and-extract step. 12:00:19 INFO - ##### 12:00:19 INFO - Running pre-action listener: _resource_record_pre_action 12:00:19 INFO - Running main action method: download_and_extract 12:00:19 INFO - mkdir: /builds/slave/test/build/tests 12:00: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')]} 12:00:19 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:19 INFO - Downloaded 1361 bytes. 12:00:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:00:19 INFO - Using the following test package requirements: 12:00:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:00:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:00:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:19 INFO - u'jsshell-linux-x86_64.zip'], 12:00:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:00:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:00:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:00:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:00:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:00:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:00: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')]} 12:00:19 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:21 INFO - Downloaded 22190241 bytes. 12:00:21 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'] 12:00:21 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 12:00:22 INFO - Return code: 0 12:00:22 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 12:00:22 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')]} 12:00:22 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:28 INFO - Downloaded 22190241 bytes. 12:00: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'] 12:00: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 12:00:29 INFO - Return code: 0 12:00: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')]} 12:00:29 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:32 INFO - Downloaded 10841046 bytes. 12:00:32 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'] 12:00:32 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 12:00:32 INFO - Return code: 0 12:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:32 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:36 INFO - Downloaded 54095643 bytes. 12:00:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:00:36 INFO - mkdir: /builds/slave/test/properties 12:00:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:00:36 INFO - Writing to file /builds/slave/test/properties/build_url 12:00:36 INFO - Contents: 12:00:36 INFO - build_url:https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:00:37 INFO - Running post-action listener: _resource_record_post_action 12:00:37 INFO - Running post-action listener: set_extra_try_arguments 12:00:37 INFO - ##### 12:00:37 INFO - ##### Running populate-webroot step. 12:00:37 INFO - ##### 12:00:37 INFO - Running pre-action listener: _resource_record_pre_action 12:00:37 INFO - Running main action method: populate_webroot 12:00:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:00:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:00:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:00:37 INFO - '--tppagecycles', 12:00:37 INFO - '7'], 12:00:37 INFO - 'tests': ['tsvgm']}}, 12:00:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:00:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:00:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:00:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:00:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:37 INFO - 'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:37 INFO - 'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['damp', 'tps']}, 12:00:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:37 INFO - 'tests': ['damp', 'tps']}, 12:00:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['dromaeo_dom']}, 12:00:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:00:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['a11yr', 12:00:37 INFO - 'ts_paint', 12:00:37 INFO - 'tpaint', 12:00:37 INFO - 'sessionrestore', 12:00:37 INFO - 'sessionrestore_no_auto_restore', 12:00:37 INFO - 'tabpaint']}, 12:00:37 INFO - 'other-e10s': {'tests': ['a11yr', 12:00:37 INFO - 'ts_paint', 12:00:37 INFO - 'tpaint', 12:00:37 INFO - 'sessionrestore', 12:00:37 INFO - 'sessionrestore_no_auto_restore', 12:00:37 INFO - 'tabpaint']}, 12:00:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:00:37 INFO - 'ts_paint', 12:00:37 INFO - 'tpaint', 12:00:37 INFO - 'sessionrestore', 12:00:37 INFO - 'sessionrestore_no_auto_restore', 12:00:37 INFO - 'tabpaint']}, 12:00:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:00:37 INFO - 'ts_paint', 12:00:37 INFO - 'tpaint', 12:00:37 INFO - 'sessionrestore', 12:00:37 INFO - 'sessionrestore_no_auto_restore', 12:00:37 INFO - 'tabpaint']}, 12:00:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['a11yr', 12:00:37 INFO - 'ts_paint', 12:00:37 INFO - 'tpaint', 12:00:37 INFO - 'sessionrestore', 12:00:37 INFO - 'sessionrestore_no_auto_restore', 12:00:37 INFO - 'tabpaint']}, 12:00:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['a11yr', 12:00:37 INFO - 'ts_paint', 12:00:37 INFO - 'tpaint', 12:00:37 INFO - 'sessionrestore', 12:00:37 INFO - 'sessionrestore_no_auto_restore', 12:00:37 INFO - 'tabpaint']}, 12:00:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['tsvgx', 12:00:37 INFO - 'tsvgr_opacity', 12:00:37 INFO - 'tart', 12:00:37 INFO - 'tscrollx', 12:00:37 INFO - 'cart']}, 12:00:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:00:37 INFO - 'tsvgr_opacity', 12:00:37 INFO - 'tart', 12:00:37 INFO - 'tscrollx', 12:00:37 INFO - 'cart']}, 12:00:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:37 INFO - 'talos_options': ['--disable-e10s'], 12:00:37 INFO - 'tests': ['tp5o']}, 12:00:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:37 INFO - 'tests': ['tp5o']}, 12:00:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:37 INFO - 'talos_options': ['--disable-e10s', 12:00:37 INFO - '--xperf_path', 12:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:37 INFO - 'tests': ['tp5n']}, 12:00:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:37 INFO - 'talos_options': ['--xperf_path', 12:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:37 INFO - 'tests': ['tp5n']}}, 12:00:37 INFO - 'talos.zip': {'path': '', 12:00:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:00:37 INFO - Running post-action listener: _resource_record_post_action 12:00:37 INFO - ##### 12:00:37 INFO - ##### Running create-virtualenv step. 12:00:37 INFO - ##### 12:00:37 INFO - Running pre-action listener: _resource_record_pre_action 12:00:37 INFO - Running main action method: create_virtualenv 12:00:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:00:37 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 12:00:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:00:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:00:37 INFO - Using real prefix '/usr' 12:00:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:00:38 INFO - Installing distribute.............................................................................................................................................................................................done. 12:00:40 INFO - Installing pip.................done. 12:00:40 INFO - Return code: 0 12:00:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:40 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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:00:40 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 12:00:40 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 12:00:40 INFO - Using env: {'DISPLAY': ':0', 12:00:40 INFO - 'HOME': '/home/cltbld', 12:00:40 INFO - 'LANG': 'en_US.UTF-8', 12:00:40 INFO - 'LANGUAGE': 'en_US:en', 12:00:40 INFO - 'LOGNAME': 'cltbld', 12:00:40 INFO - 'MAIL': '/var/mail/cltbld', 12:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:40 INFO - 'MOZ_NO_REMOTE': '1', 12:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:40 INFO - 'NO_EM_RESTART': '1', 12:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:40 INFO - 'PWD': '/builds/slave/test', 12:00:40 INFO - 'SHELL': '/bin/bash', 12:00:40 INFO - 'SHLVL': '1', 12:00:40 INFO - 'TERM': 'linux', 12:00:40 INFO - 'TMOUT': '86400', 12:00:40 INFO - 'USER': 'cltbld', 12:00:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:40 INFO - '_': '/tools/buildbot/bin/python'} 12:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:40 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 12:00:40 INFO - Cleaning up... 12:00:40 INFO - Return code: 0 12:00:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:40 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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:00:40 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 12:00:40 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 12:00:40 INFO - Using env: {'DISPLAY': ':0', 12:00:40 INFO - 'HOME': '/home/cltbld', 12:00:40 INFO - 'LANG': 'en_US.UTF-8', 12:00:40 INFO - 'LANGUAGE': 'en_US:en', 12:00:40 INFO - 'LOGNAME': 'cltbld', 12:00:40 INFO - 'MAIL': '/var/mail/cltbld', 12:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:40 INFO - 'MOZ_NO_REMOTE': '1', 12:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:40 INFO - 'NO_EM_RESTART': '1', 12:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:40 INFO - 'PWD': '/builds/slave/test', 12:00:40 INFO - 'SHELL': '/bin/bash', 12:00:40 INFO - 'SHLVL': '1', 12:00:40 INFO - 'TERM': 'linux', 12:00:40 INFO - 'TMOUT': '86400', 12:00:40 INFO - 'USER': 'cltbld', 12:00:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:40 INFO - '_': '/tools/buildbot/bin/python'} 12:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:40 INFO - Downloading/unpacking psutil>=0.7.1 12:00:40 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 12:00:40 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 12:00:40 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 12:00:40 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 12:00:40 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 12:00:40 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 12:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:00:43 INFO - Installing collected packages: psutil 12:00:43 INFO - Running setup.py install for psutil 12:00:43 INFO - building 'psutil._psutil_linux' extension 12:00:43 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 12:00:43 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 12:00:43 INFO - building 'psutil._psutil_posix' extension 12:00:43 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 12:00:43 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 12:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:00:43 INFO - Successfully installed psutil 12:00:43 INFO - Cleaning up... 12:00:43 INFO - Return code: 0 12:00:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:00: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')]} 12:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00: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')]} 12:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00: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', '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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:00: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:00: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 mozsystemmonitor==0.0.0 12:00:43 INFO - Using env: {'DISPLAY': ':0', 12:00:43 INFO - 'HOME': '/home/cltbld', 12:00:43 INFO - 'LANG': 'en_US.UTF-8', 12:00:43 INFO - 'LANGUAGE': 'en_US:en', 12:00:43 INFO - 'LOGNAME': 'cltbld', 12:00:43 INFO - 'MAIL': '/var/mail/cltbld', 12:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:43 INFO - 'MOZ_NO_REMOTE': '1', 12:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:43 INFO - 'NO_EM_RESTART': '1', 12:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:43 INFO - 'PWD': '/builds/slave/test', 12:00:43 INFO - 'SHELL': '/bin/bash', 12:00:43 INFO - 'SHLVL': '1', 12:00:43 INFO - 'TERM': 'linux', 12:00:43 INFO - 'TMOUT': '86400', 12:00:43 INFO - 'USER': 'cltbld', 12:00:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:43 INFO - '_': '/tools/buildbot/bin/python'} 12:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:00:44 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 12:00:44 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 12:00:44 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 12:00:44 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 12:00:44 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 12:00:44 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 12:00:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:00:46 INFO - Installing collected packages: mozsystemmonitor 12:00:46 INFO - Running setup.py install for mozsystemmonitor 12:00:46 INFO - Successfully installed mozsystemmonitor 12:00:46 INFO - Cleaning up... 12:00:46 INFO - Return code: 0 12:00:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:00:46 INFO - Using env: {'DISPLAY': ':0', 12:00:46 INFO - 'HOME': '/home/cltbld', 12:00:46 INFO - 'LANG': 'en_US.UTF-8', 12:00:46 INFO - 'LANGUAGE': 'en_US:en', 12:00:46 INFO - 'LOGNAME': 'cltbld', 12:00:46 INFO - 'MAIL': '/var/mail/cltbld', 12:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:46 INFO - 'MOZ_NO_REMOTE': '1', 12:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:46 INFO - 'NO_EM_RESTART': '1', 12:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:46 INFO - 'PWD': '/builds/slave/test', 12:00:46 INFO - 'SHELL': '/bin/bash', 12:00:46 INFO - 'SHLVL': '1', 12:00:46 INFO - 'TERM': 'linux', 12:00:46 INFO - 'TMOUT': '86400', 12:00:46 INFO - 'USER': 'cltbld', 12:00:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:46 INFO - '_': '/tools/buildbot/bin/python'} 12:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:46 INFO - Downloading/unpacking blobuploader==1.2.4 12:00: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 12:00: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 12:00: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 12:00: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 12:00: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 12:00: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 12:00:49 INFO - Downloading blobuploader-1.2.4.tar.gz 12:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:00:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:00:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:50 INFO - Downloading docopt-0.6.1.tar.gz 12:00:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:00:50 INFO - Installing collected packages: blobuploader, requests, docopt 12:00:50 INFO - Running setup.py install for blobuploader 12:00:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:00:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:00:50 INFO - Running setup.py install for requests 12:00:50 INFO - Running setup.py install for docopt 12:00:50 INFO - Successfully installed blobuploader requests docopt 12:00:50 INFO - Cleaning up... 12:00:50 INFO - Return code: 0 12:00:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00: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')]} 12:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00: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')]} 12:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:50 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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:00:50 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 12:00:50 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 12:00:50 INFO - Using env: {'DISPLAY': ':0', 12:00:50 INFO - 'HOME': '/home/cltbld', 12:00:50 INFO - 'LANG': 'en_US.UTF-8', 12:00:50 INFO - 'LANGUAGE': 'en_US:en', 12:00:50 INFO - 'LOGNAME': 'cltbld', 12:00:50 INFO - 'MAIL': '/var/mail/cltbld', 12:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:50 INFO - 'MOZ_NO_REMOTE': '1', 12:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:50 INFO - 'NO_EM_RESTART': '1', 12:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:50 INFO - 'PWD': '/builds/slave/test', 12:00:50 INFO - 'SHELL': '/bin/bash', 12:00:50 INFO - 'SHLVL': '1', 12:00:50 INFO - 'TERM': 'linux', 12:00:50 INFO - 'TMOUT': '86400', 12:00:50 INFO - 'USER': 'cltbld', 12:00:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:50 INFO - '_': '/tools/buildbot/bin/python'} 12:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:00:51 INFO - Running setup.py (path:/tmp/pip-AP8h2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:00:51 INFO - Running setup.py (path:/tmp/pip-alYjpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:00:51 INFO - Running setup.py (path:/tmp/pip-rhyCdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:00:51 INFO - Running setup.py (path:/tmp/pip-_SRPUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:00:51 INFO - Running setup.py (path:/tmp/pip-09vtKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:00:51 INFO - Running setup.py (path:/tmp/pip-HDsW4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:00:51 INFO - Running setup.py (path:/tmp/pip-8GCBKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:00:51 INFO - Running setup.py (path:/tmp/pip-SK1VKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:00:51 INFO - Running setup.py (path:/tmp/pip-_v37G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:00:51 INFO - Running setup.py (path:/tmp/pip-uOip4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:00:51 INFO - Running setup.py (path:/tmp/pip-Tf9ICH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:00:51 INFO - Running setup.py (path:/tmp/pip-HvC2mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:00:51 INFO - Running setup.py (path:/tmp/pip-ZBTHSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:00:51 INFO - Running setup.py (path:/tmp/pip-rWuReI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:52 INFO - Running setup.py (path:/tmp/pip-TLgAZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:00:52 INFO - Running setup.py (path:/tmp/pip-uiNxLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:00:52 INFO - Running setup.py (path:/tmp/pip-VzElXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:00:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:00:52 INFO - Running setup.py install for manifestparser 12:00:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:00:52 INFO - Running setup.py install for mozcrash 12:00:52 INFO - Running setup.py install for mozdebug 12:00:52 INFO - Running setup.py install for mozdevice 12:00:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:00:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:00:52 INFO - Running setup.py install for mozfile 12:00:52 INFO - Running setup.py install for mozhttpd 12:00:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:00:52 INFO - Running setup.py install for mozinfo 12:00:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:00:52 INFO - Running setup.py install for mozInstall 12:00:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Running setup.py install for mozleak 12:00:53 INFO - Running setup.py install for mozlog 12:00:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Running setup.py install for moznetwork 12:00:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Running setup.py install for mozprocess 12:00:53 INFO - Running setup.py install for mozprofile 12:00:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Running setup.py install for mozrunner 12:00:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:00:53 INFO - Running setup.py install for mozscreenshot 12:00:53 INFO - Running setup.py install for moztest 12:00:53 INFO - Running setup.py install for mozversion 12:00:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:00:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:00:54 INFO - Cleaning up... 12:00:54 INFO - Return code: 0 12:00:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00: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')]} 12:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00: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')]} 12:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:54 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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:00:54 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 12:00:54 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 12:00:54 INFO - Using env: {'DISPLAY': ':0', 12:00:54 INFO - 'HOME': '/home/cltbld', 12:00:54 INFO - 'LANG': 'en_US.UTF-8', 12:00:54 INFO - 'LANGUAGE': 'en_US:en', 12:00:54 INFO - 'LOGNAME': 'cltbld', 12:00:54 INFO - 'MAIL': '/var/mail/cltbld', 12:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:54 INFO - 'MOZ_NO_REMOTE': '1', 12:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:54 INFO - 'NO_EM_RESTART': '1', 12:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:54 INFO - 'PWD': '/builds/slave/test', 12:00:54 INFO - 'SHELL': '/bin/bash', 12:00:54 INFO - 'SHLVL': '1', 12:00:54 INFO - 'TERM': 'linux', 12:00:54 INFO - 'TMOUT': '86400', 12:00:54 INFO - 'USER': 'cltbld', 12:00:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:54 INFO - '_': '/tools/buildbot/bin/python'} 12:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:00:54 INFO - Running setup.py (path:/tmp/pip-zgxDX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:00:54 INFO - Running setup.py (path:/tmp/pip-vxdydr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:00:54 INFO - Running setup.py (path:/tmp/pip-wLs9f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:00:54 INFO - Running setup.py (path:/tmp/pip-8YNLtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:00:54 INFO - Running setup.py (path:/tmp/pip-rkk91U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:00:54 INFO - Running setup.py (path:/tmp/pip-L0VQuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:00:54 INFO - Running setup.py (path:/tmp/pip-fTMY_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:00:54 INFO - Running setup.py (path:/tmp/pip-s8BouV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:00:54 INFO - Running setup.py (path:/tmp/pip-P7lEoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:00:54 INFO - Running setup.py (path:/tmp/pip-g4l9xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:00:54 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)) 12:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:00:54 INFO - Running setup.py (path:/tmp/pip-uH7hAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:00:55 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)) 12:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:00:55 INFO - Running setup.py (path:/tmp/pip-ej4mdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:00:55 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)) 12:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:00:55 INFO - Running setup.py (path:/tmp/pip-l3t9eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:00:55 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)) 12:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:00:55 INFO - Running setup.py (path:/tmp/pip-nyqIYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:00:55 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)) 12:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:55 INFO - Running setup.py (path:/tmp/pip-Baioih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:55 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)) 12:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:00:55 INFO - Running setup.py (path:/tmp/pip-BX7Hpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:00:55 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)) 12:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:00:55 INFO - Running setup.py (path:/tmp/pip-7k7lL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:00:55 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 12:00:55 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 12:00:55 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 12:00:55 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 12:00:55 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 12:00:55 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 12:00:57 INFO - Downloading blessings-1.6.tar.gz 12:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:00:58 INFO - Installing collected packages: blessings 12:00:58 INFO - Running setup.py install for blessings 12:00:58 INFO - Successfully installed blessings 12:00:58 INFO - Cleaning up... 12:00:58 INFO - Return code: 0 12:00:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:00:58 INFO - Reading from file tmpfile_stdout 12:00:58 INFO - Current package versions: 12:00:58 INFO - argparse == 1.2.1 12:00:58 INFO - blessings == 1.6 12:00:58 INFO - blobuploader == 1.2.4 12:00:58 INFO - docopt == 0.6.1 12:00:58 INFO - manifestparser == 1.1 12:00:58 INFO - mozInstall == 1.12 12:00:58 INFO - mozcrash == 0.17 12:00:58 INFO - mozdebug == 0.1 12:00:58 INFO - mozdevice == 0.48 12:00:58 INFO - mozfile == 1.2 12:00:58 INFO - mozhttpd == 0.7 12:00:58 INFO - mozinfo == 0.9 12:00:58 INFO - mozleak == 0.1 12:00:58 INFO - mozlog == 3.1 12:00:58 INFO - moznetwork == 0.27 12:00:58 INFO - mozprocess == 0.22 12:00:58 INFO - mozprofile == 0.28 12:00:58 INFO - mozrunner == 6.11 12:00:58 INFO - mozscreenshot == 0.1 12:00:58 INFO - mozsystemmonitor == 0.0 12:00:58 INFO - moztest == 0.7 12:00:58 INFO - mozversion == 1.4 12:00:58 INFO - psutil == 3.1.1 12:00:58 INFO - requests == 1.2.3 12:00:58 INFO - wsgiref == 0.1.2 12:00:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00:58 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')]} 12:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:58 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')]} 12:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:58 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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:00:58 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 12:00:58 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 12:00:58 INFO - Using env: {'DISPLAY': ':0', 12:00:58 INFO - 'HOME': '/home/cltbld', 12:00:58 INFO - 'LANG': 'en_US.UTF-8', 12:00:58 INFO - 'LANGUAGE': 'en_US:en', 12:00:58 INFO - 'LOGNAME': 'cltbld', 12:00:58 INFO - 'MAIL': '/var/mail/cltbld', 12:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:58 INFO - 'MOZ_NO_REMOTE': '1', 12:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:58 INFO - 'NO_EM_RESTART': '1', 12:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:58 INFO - 'PWD': '/builds/slave/test', 12:00:58 INFO - 'SHELL': '/bin/bash', 12:00:58 INFO - 'SHLVL': '1', 12:00:58 INFO - 'TERM': 'linux', 12:00:58 INFO - 'TMOUT': '86400', 12:00:58 INFO - 'USER': 'cltbld', 12:00:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:58 INFO - '_': '/tools/buildbot/bin/python'} 12:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 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)) 12:00:58 INFO - Cleaning up... 12:00:58 INFO - Return code: 0 12:00:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:00:58 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')]} 12:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:58 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')]} 12:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:58 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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:00:58 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 12:00:58 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 12:00:58 INFO - Using env: {'DISPLAY': ':0', 12:00:58 INFO - 'HOME': '/home/cltbld', 12:00:58 INFO - 'LANG': 'en_US.UTF-8', 12:00:58 INFO - 'LANGUAGE': 'en_US:en', 12:00:58 INFO - 'LOGNAME': 'cltbld', 12:00:58 INFO - 'MAIL': '/var/mail/cltbld', 12:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:58 INFO - 'MOZ_NO_REMOTE': '1', 12:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:58 INFO - 'NO_EM_RESTART': '1', 12:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:58 INFO - 'PWD': '/builds/slave/test', 12:00:58 INFO - 'SHELL': '/bin/bash', 12:00:58 INFO - 'SHLVL': '1', 12:00:58 INFO - 'TERM': 'linux', 12:00:58 INFO - 'TMOUT': '86400', 12:00:58 INFO - 'USER': 'cltbld', 12:00:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:58 INFO - '_': '/tools/buildbot/bin/python'} 12:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:58 INFO - Downloading/unpacking jsonschema 12:00:58 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 12:00:58 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 12:00:58 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 12:00:58 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 12:00:58 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 12:00:58 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 12:01:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:01:00 INFO - Downloading/unpacking functools32 (from jsonschema) 12:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:01 INFO - Downloading functools32-3.2.3-2.tar.gz 12:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:01:01 INFO - warning: no files found matching '*.txt' 12:01:01 INFO - no previously-included directories found matching 'build' 12:01:01 INFO - no previously-included directories found matching 'dist' 12:01:01 INFO - no previously-included directories found matching '.git*' 12:01:01 INFO - Installing collected packages: jsonschema, functools32 12:01:01 INFO - Running setup.py install for functools32 12:01:01 INFO - warning: no files found matching '*.txt' 12:01:01 INFO - no previously-included directories found matching 'build' 12:01:01 INFO - no previously-included directories found matching 'dist' 12:01:01 INFO - no previously-included directories found matching '.git*' 12:01:01 INFO - Successfully installed jsonschema functools32 12:01:01 INFO - Cleaning up... 12:01:01 INFO - Return code: 0 12:01:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:01:01 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')]} 12:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:01 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')]} 12:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:01 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 0x7fb5bae59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', '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 12:01:01 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 12:01:01 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 12:01:01 INFO - Using env: {'DISPLAY': ':0', 12:01:01 INFO - 'HOME': '/home/cltbld', 12:01:01 INFO - 'LANG': 'en_US.UTF-8', 12:01:01 INFO - 'LANGUAGE': 'en_US:en', 12:01:01 INFO - 'LOGNAME': 'cltbld', 12:01:01 INFO - 'MAIL': '/var/mail/cltbld', 12:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:01 INFO - 'MOZ_NO_REMOTE': '1', 12:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:01 INFO - 'NO_EM_RESTART': '1', 12:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:01 INFO - 'PWD': '/builds/slave/test', 12:01:01 INFO - 'SHELL': '/bin/bash', 12:01:01 INFO - 'SHLVL': '1', 12:01:01 INFO - 'TERM': 'linux', 12:01:01 INFO - 'TMOUT': '86400', 12:01:01 INFO - 'USER': 'cltbld', 12:01:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:01 INFO - '_': '/tools/buildbot/bin/python'} 12:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:01 INFO - Downloading/unpacking flake8 12:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:01:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:01:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:01:04 INFO - no previously-included directories found matching 'docs/_build' 12:01:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:01:04 INFO - Running setup.py install for pep8 12:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:01:04 INFO - no previously-included directories found matching 'docs/_build' 12:01:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:01:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:01:04 INFO - Cleaning up... 12:01:04 INFO - Return code: 0 12:01:04 INFO - Running post-action listener: _resource_record_post_action 12:01:04 INFO - Running post-action listener: _start_resource_monitoring 12:01:04 INFO - Starting resource monitoring. 12:01:04 INFO - ##### 12:01:04 INFO - ##### Running install step. 12:01:04 INFO - ##### 12:01:04 INFO - Running pre-action listener: _resource_record_pre_action 12:01:04 INFO - Running main action method: install 12:01:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:05 INFO - Reading from file tmpfile_stdout 12:01:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:01:05 INFO - Reading from file tmpfile_stdout 12:01:05 INFO - Output received: 12:01:05 INFO - Usage: mozinstall [options] installer 12:01:05 INFO - Options: 12:01:05 INFO - -h, --help show this help message and exit 12:01:05 INFO - -d DEST, --destination=DEST 12:01:05 INFO - Directory to install application into. [default: 12:01:05 INFO - "/builds/slave/test"] 12:01:05 INFO - --app=APP Application being installed. [default: firefox] 12:01:05 INFO - mkdir: /builds/slave/test/build/application 12:01:05 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'] 12:01:05 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 12:01:20 INFO - Reading from file tmpfile_stdout 12:01:20 INFO - Output received: 12:01:20 INFO - /builds/slave/test/build/application/firefox/firefox 12:01:20 INFO - Running post-action listener: _resource_record_post_action 12:01:20 INFO - ##### 12:01:20 INFO - ##### Running run-tests step. 12:01:20 INFO - ##### 12:01:20 INFO - Running pre-action listener: _resource_record_pre_action 12:01:20 INFO - Running main action method: run_tests 12:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:01:20 INFO - Python 2.7.3 12:01:20 INFO - Return code: 0 12:01:20 INFO - grabbing minidump binary from tooltool 12:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:20 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 0x2488410>, '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 0x2489310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24897a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:01:20 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 12:01:20 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 12:01:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:01:20 INFO - Return code: 0 12:01:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:01:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:01:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:01:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:01:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:01:21 INFO - Return code: 0 12:01:21 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/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 12:01:21 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/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 12:01:21 INFO - Using env: {'DISPLAY': ':0', 12:01:21 INFO - 'HOME': '/home/cltbld', 12:01:21 INFO - 'LANG': 'en_US.UTF-8', 12:01:21 INFO - 'LANGUAGE': 'en_US:en', 12:01:21 INFO - 'LOGNAME': 'cltbld', 12:01:21 INFO - 'MAIL': '/var/mail/cltbld', 12:01:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:01:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:21 INFO - 'MOZ_NO_REMOTE': '1', 12:01:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:21 INFO - 'NO_EM_RESTART': '1', 12:01:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:21 INFO - 'PWD': '/builds/slave/test', 12:01:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:01:21 INFO - 'SHELL': '/bin/bash', 12:01:21 INFO - 'SHLVL': '1', 12:01:21 INFO - 'TERM': 'linux', 12:01:21 INFO - 'TMOUT': '86400', 12:01:21 INFO - 'USER': 'cltbld', 12:01:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792', 12:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:21 INFO - '_': '/tools/buildbot/bin/python'} 12:01:21 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/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 12:01:22 INFO - mozversion application_buildid: 20160411024708 12:01:22 INFO - mozversion application_changeset: e847cfcb315f511f4928b03fd47dcf57aad05e1e 12:01:22 INFO - mozversion application_display_name: Nightly 12:01:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:01:22 INFO - mozversion application_name: Firefox 12:01:22 INFO - mozversion application_remotingname: firefox 12:01:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:01:22 INFO - mozversion application_vendor: Mozilla 12:01:22 INFO - mozversion application_version: 48.0a1 12:01:22 INFO - mozversion platform_buildid: 20160411024708 12:01:22 INFO - mozversion platform_changeset: e847cfcb315f511f4928b03fd47dcf57aad05e1e 12:01:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:01:22 INFO - mozversion platform_version: 48.0a1 12:01:22 INFO - using testdate: 1460401282 12:01:22 INFO - actual date: 1460401282 12:01:22 INFO - starting webserver on 'localhost:35318' 12:01:22 INFO - SUITE-START | Running 2 tests 12:01:22 INFO - TEST-START | dromaeo_css 12:01:22 INFO - operating with platform_type : linux_ 12:01:22 INFO - Initialising browser for dromaeo_css test... 12:01:22 INFO - TEST-INFO | started process 20357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb_Z78D/profile http://localhost:35318/getInfo.html) 12:01:25 INFO - PROCESS | 20357 | 12:01:25 INFO - PROCESS | 20357 | (process:20425): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:01:26 INFO - PROCESS | 20357 | 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] 12:01:26 INFO - PROCESS | 20357 | __metrics Screen width/height:1600/1200 12:01:26 INFO - PROCESS | 20357 | colorDepth:24 12:01:26 INFO - PROCESS | 20357 | Browser inner width/height: 1024/697 12:01:26 INFO - PROCESS | 20357 | __metrics 12:01:27 ERROR - PROCESS | 20357 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 12:01:28 INFO - TEST-INFO | 20357: exit 0 12:01:28 INFO - Browser initialized. 12:01:28 INFO - Running cycle 1/1 for dromaeo_css test... 12:01:28 INFO - TEST-INFO | started process 20476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb_Z78D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:01:29 INFO - PROCESS | 20476 | 12:01:30 INFO - PROCESS | 20476 | (process:20534): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:01:40 INFO - PROCESS | 20476 | RSS: Main: 163672064 12:01:40 INFO - PROCESS | 20476 | 12:02:29 INFO - PROCESS | 20476 | 1460401349585 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] 12:04:42 INFO - PROCESS | 20476 | Cycle 1(1): loaded http://localhost:35318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35318/tests/dromaeo/cssquery-ext.html) 12:04:43 INFO - PROCESS | 20476 | RSS: Main: 168468480 12:04:43 INFO - PROCESS | 20476 | 12:07:45 INFO - PROCESS | 20476 | Cycle 1(1): loaded http://localhost:35318/tests/dromaeo/cssquery-ext.html (next: http://localhost:35318/tests/dromaeo/cssquery-jquery.html) 12:07:45 INFO - PROCESS | 20476 | RSS: Main: 165089280 12:07:45 INFO - PROCESS | 20476 | 12:10:47 INFO - PROCESS | 20476 | Cycle 1(1): loaded http://localhost:35318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35318/tests/dromaeo/cssquery-mootools.html) 12:10:48 INFO - PROCESS | 20476 | RSS: Main: 165867520 12:10:48 INFO - PROCESS | 20476 | 12:13:50 INFO - PROCESS | 20476 | Cycle 1(1): loaded http://localhost:35318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35318/tests/dromaeo/cssquery-prototype.html) 12:13:50 INFO - PROCESS | 20476 | RSS: Main: 163520512 12:13:50 INFO - PROCESS | 20476 | 12:16:53 INFO - PROCESS | 20476 | Cycle 1(1): loaded http://localhost:35318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35318/tests/dromaeo/cssquery-yui.html) 12:16:54 INFO - PROCESS | 20476 | RSS: Main: 164392960 12:16:54 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | Cycle 1(1): loaded http://localhost:35318/tests/dromaeo/cssquery-yui.html (next: http://localhost:35318/tests/dromaeo/cssquery-dojo.html) 12:19:56 INFO - PROCESS | 20476 | RSS: Main: 166756352 12:19:56 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | __start_tp_report 12:19:56 INFO - PROCESS | 20476 | _x_x_mozilla_page_load 12:19:56 INFO - PROCESS | 20476 | _x_x_mozilla_page_load_details 12:19:56 INFO - PROCESS | 20476 | |i|pagename|runs| 12:19:56 INFO - PROCESS | 20476 | |0;dojo.html;2637.2220195042464;2697.6223328733977;2721.918342449726;2731.9043833465835;2736.4390299988504;4755.932473323781;4757.21505951518;4766.690165139264;4806.591439727623;4854.077725232203;4656.998745269766;4838.975805120978;4839.975800120995;4840.515948405157;4902.60779137669;4394.692371533986;4451.2655411857;4451.354553589727;4513.526079761627;4547.431571053618;4482.394876691654;4521.231390663579;4536.455625324949;4544.9318260225955;4547.704399214057;4356.172327257811;4377.190219809346;4412.955870441287;4455.997400584891;4518.299663552155;4378.8905277368;4398.978005109986;4411.669124815619;4430.424044874146;4446.110777844412;4382.255016647177;4398.966242932908;4420.07178492517;4423.137488189805;4423.380726698265;4570.65720070996;4712.034033023222;4742.027884283713;4788.545088216649;4814.855554333376;5034.798608055673;5045.747712614355;5046.09170349337;5060.165072762989;5106.719130447824;5056.898862022739;5078.5937125029905;5079.542841144278;5085.186370180753;5107.412647545542;4721.95278047222;4747.45404278509;4767.094252092161;4816.277558366203;4825.95174048262;5179.067767801832;5179.378474583074;5180.507851754077;5186.740662966837;5232.293640358579;4923.532264434944;4963;4967.801287948514;4983.327250821165;5006.849794506098;4926.605871530341;5095.261187127846;5135.15269980449;5162.896742065138;5180.430152683201;5014.824481143215;5021.924671129936;5022.522860328263;5036.143855544567;5081.974590127025;4988.825391111293;5005.649604527648;5013;5017.874553136201;5101.540861322499;4244.808983595745;4255.446791917093;4261.616454519108;4263.488381394252;4269.146170765859;3735.9439608405896;3772.434134879735;3776.3957766757185;3778.0554861284677;3784.924301513954;4526.094781043805;4543.4093567836635;4555.9772201138785;4561.064981678748;4573.405457290531;5152.381714194321;5191.065608190486;5210.010098081352;5241.161414173714;5259;4467.910641787211;4496.977515112403;4497.8200871964755;4500.662450316239;4531.682782205214;4557.1797076526545;4557.58857958315;4563.794629241692;4566.246569316092;4584.060267645124;4744.976275118672;4855.684380515326;4888.95111048885;4936.753162341796;4944.060628480577;5091.745412729275;5118.744062796771;5145.511176438233;5156.4070131935305;5160;4783.186858234039;4833.854984350475;4841.878953026062;4846.854594362175;4888.706677599355;5051.4695956924;5052.418971818288;5073.137566613758;5093.18509038552;5130;5099.184130539096;5105.846824595268;5120.820771272987;5137.974310128426;5182.507661772125;4780.545848144421;4986.15235409974;4988.9251661225835;4991.725455100004;4996.025774973845;4858.149823780895;4974.054929563371;4992.15133427311;5013.39839219296;5041.773120209673;4871.585915197248;4909.312696222603;4912.287718280901;4928.457869634409;4985.6260780442335;4921.827736029365;5014.272930425141;5020.24696295544;5038.219076043072;5056.216286475602;4836.226203807515;4858.368412106403;4867.1969125093965;4900.166971614763;4909.803607855646 12:19:56 INFO - PROCESS | 20476 | |1;ext.html;563.3521450332117;607.4866737606723;619.4208415131852;620.1751670278528;641.4099028893418;35608.82195589022;36609.63390366096;36694.81652591733;36798.44802327967;36906.815465922664;40115.598844011554;40923.59076409235;41001;41139.17721645565;41366.17267654645;7786.7663970080985;7913.841723165533;7934.404919631051;7956.602169891482;7956.840863182733;7853.607319634024;7901.328387087105;7954.482958607672;7962.3630109591095;7995.800104997364;7942.285194332509;8010.639521221559;8015.038195416558;8016.198380161995;8056.919430805705;7909.52542847431;7976.162502937166;7982.161873003338;7982.401319900972;8019;7840.098388685317;7915.248051435105;7932.444728868982;7955.164707705665;7962.243586859239;30857.228569285722;36897.63102368996;37095.62904370949;37359.81320093409;37393.439098413546;2915.489789286866;2989.252686828293;3112.7198552130417;3510.648935106469;3713.795741234231;22300.55398892013;23490.530189396115;23499;24417.877910610332;25089.996400143973;3338.432466480704;3375.8818441354433;3413.5391722117693;3429.1941393772445;3430.2281986553076;172884;175160;176125.11937440358;176262;176626;31607.84196079005;31921;31962.200944976095;32845.835770820995;33883.152921176676;31639.841800790848;31667;31757.364852702816;31797.682023179936;31922.2019449511;12536.874631253753;12815.231086134861;12834.55079072228;12877.806832897513;12886.162399444007;10782.353058816496;10828.133749300194;10829.891701082888;10830;10851.891481085246;8142.918570814334;8149.429539932266;8185.058718247477;8231.794205144919;8240;3105.0283070250102;3223.5003574446;3238.659940706239;3246.6266379366675;3260.4294248506417;989.1740396768779;996.8554559588964;1033.5194134727387;1035.8446233065101;1099.274478843959;28554.286142846595;28593.57109643357;28685.56971645427;28701;28919.277018074717;981.676046904534;1011.367895065584;1033.2973577966904;1051.6634676903318;1084.2139448899484;14842.628934276514;15150.772738408932;15291.847081529264;15463.304151313218;15553.844461555465;304930;307498;309480;310110;311623;47984;49251.50748492469;49528;49665.50334496681;49817;1210.8849659282355;1232.9321887296105;1248.825164476974;1264.0898553041795;1277.8594354620984;26586.601200981615;27856.16431507058;27947;28142.859285703442;28460;40938;41076.58923410847;41510.79244603758;41697.79151104225;41949;299407;301302;301662;303306;303543;25099.512277747144;25275.620865686662;25363.61954570646;25681.61477577875;25689.357766055997;41915.7904210477;42858;42974.355384668626;43105;43162.252152263856;34542.82728586341;35570.11074723153;36630.8168459156;36871;36909.446358305184;35559;35866.95130913902;36343.27313453769;36489.27021459503;36872.44691329686;35983.28033439264;35994;36629.90110296696;36955.44566831446;37081.81459092687;27793;29074;29437.558436623895;29621.5556766653;29631.25921851971;23153.421164471023;23562.52874942457;23599;23776;24025.75974240235 12:19:56 INFO - PROCESS | 20476 | |2;jquery.html;360.91698909250874;361.79196961746993;363.27526584464;377.42819628263186;380.1769169747497;16026.91986540067;16636.667266654676;17879.91060044698;17895;17907.820921790793;15964.76052859208;16468.258928348223;17109.74335384967;17206.311747530115;17209.397671081515;5049.899002019957;5173.198154286091;5221.269022336857;5223.555997740196;5227.607929405291;3607.2424790793966;5123;5383.623146379755;5755.136729490568;5756.971215143939;5645.604807663444;5646.632968857031;5681.488666020057;5695.686737229451;5723.084306510959;5425.565954723613;5846.356900740915;5872.5889187756875;5879.559033072536;5884.764609415618;4925.187344088221;5165.690058596496;5167.48325167484;5195.324607801;5206.0368831766245;18408.815911840844;18632.813671863245;18650.347237846745;18768;18885.905570472198;631.7473010795673;1958.6768183249746;2106.9157233710785;2322.932366356777;2580.287435703208;12748.80876786849;13157.210567365893;13258.53595124166;13563.254021028839;13645.044846860723;1783.7324401339772;1793.3185389552018;1794.291254954299;1810.5383127302584;1828.3417969530958;65795.3420465794;65865.3413465864;66764.66617666929;67653.98519022268;68142;9163.862542061874;9269.304802139866;9292.53537323131;9558.378705384128;9602.567884445216;12873.485060597659;13029.804552931713;13144.539941102206;13195;13275.070745047948;7115.1106111736035;7208.459365547605;7225.927740722631;7229.385502232264;7413.4810563261135;7095.219525852152;7128.643567821692;7196.784096477114;7306.96346518264;7314.341709246193;5912.142739302863;5959.314678811992;5998;6022.518198544193;6150.876982460326;1511.5465360391838;1644.9177541122897;1693.898366098038;1850.3355168557234;1855.7587513623143;817.8446095241885;904.5929331800716;983.7737320416344;991.7322322972757;1050.9579616815242;16668.333266669197;16920.830791691926;17037.78795399735;17090.40183593568;17107.144642767813;826.6858593734343;827.5407149032225;908.4367692030983;918.7932715139041;1015.9847602285971;7381.630918454056;8930.776730581787;9174.449533028039;10072.546735396925;10166.237532184969;391632;394081;397533;403969;417431;75376.24623753801;75622;76895;77389;79284;1013.7212266626736;1014.264658122855;1031.4481752262504;1038.1383451735041;1038.2057725839738;15415.383384664936;15631.84368156304;15640.061596304258;15725.370985160924;15827.287772050055;33255.16862078467;33880.32239355249;34874.30251394907;34935.825320873235;34979.49563752847;48081.278780817614;49733.75133124311;50218.748906255234;50279.49720502748;50512.24231636455;7303.598302093435;7702.537847729154;7810.453268271166;7860.960695196487;7876.4092693047105;8075.919240807517;9619.759506012406;10857.945710271713;11170.441477926233;11315.321080735182;9880.20958323318;9947.502624868872;9961.40231586107;10034;10314.381137131797;9795.265355098538;9949.950250248703;10053.296269261082;10117.241206909659;10227.897721022695;10306.072453479223;10369.377837329785;10421;10630.468476575985;10795.136389089012;7832.765017049498;7929.167437418988;8063.8790418144945;8066;8158.021037475303;10313.587456501957;10594;10775.245732798629;10796.89203107959;10828.404437755684 12:19:56 INFO - PROCESS | 20476 | |3;mootools.html;1434.340203506387;1472.948446804362;1600.8879378443507;1759.058903486635;1787.9910600446997;6871.759488417906;7380.704771809128;7528.9623551882305;7703.961480192598;7717.498362606434;7400.962995185017;7454.217307182736;7576.621168941545;7586.4689471737;7596.202398748121;2265.161890100661;2295.070496448941;2295.4146692593367;2297.7357603875603;2297.942551436219;2259.762724913885;2270.4550907782095;2291.301153148289;2309.7690230976937;2313.1094528606523;2246.079107565898;2251.583457060449;2253.5718213539376;2272.761360057195;2279.1567120165564;2214.413180507167;2221.5112675211426;2223.4219103033247;2231.263682984611;2233.698450709158;2203.3830527452337;2231.7656646052255;2233.251860626692;2236.3514580771557;2239.6192647250004;7687.077550693953;7697.769066928001;7746.767596972099;7762;7762.45662803604;4491.326301054835;4706.858794236178;4706.929396059062;4718.646101542398;4723.622110231173;2814.6622405311496;2912.4175164966878;2922.7369536741585;2936.1338405170527;2938.61797966263;931.1852129386787;932.3287233192091;940.1162906867522;952.7808604021045;973.634886917406;10525.578976840918;10560.155187584975;10583.10043646291;10617.628383006635;10654.09440197584;4112.856050038235;4184.727992680466;4247.129338485603;4303.4190384298345;4494.235979883428;9019.729408117766;9022.684206052889;9073.274138068939;9084.454932704059;9107.453552786854;4688.507706690748;4706.88232794176;4710.835120770825;4723.976380118077;4782.258749893772;3694.7413681042067;4263.872083837427;4324.654027677778;4324.870253892388;4368.890777730582;3551.893443196708;3580.480830279595;3665.2119794244363;3678.1356381250384;3687.446882967576;1172.6423440850451;1178.8231765235284;1179.6166245970094;1199.322382853685;1213.514594162342;952.7618095476131;974.4348277998744;977.7995510920244;1032.7521394865178;1217.0628615965834;6981.127359080115;7135.8572828544175;7218.566885986857;7228.783136505913;7257.673404696801;403.783975573067;429.628371458686;431.492995730016;431.69565456353195;433.46034187436845;5417.349918009864;5516.531094856982;5538.667679939216;5607.074832652648;5610.186522954149;9162.587683554257;9544.236461083097;9590.808183836423;9603.231741460666;9607.327487075838;9270.490123043297;9280.62877484893;9377.1091746284;9433.433993960385;9442.811143777086;7194.424446044304;7303.598302093435;7317.780466586011;7322.0847394075745;7346.816329591803;6966.268541803241;7086.503944724026;7213.422926165789;7217.6030318330895;7232.783016509513;8654.870176947477;8728.650853966024;8785.033646299029;8871.290296776113;8900;8541.871871921801;8880.378373513791;9033.41282816641;9043.18611324984;9130.132637399436;6047.183630209865;6815.318468153145;6940.6529673515115;7181.640917954186;7386.704531818882;7323.194448610755;7377.852442951218;7389.445791565761;7412.555246685216;7434.479586428898;6513.120728701565;6757.493188010821;6874.346937040973;6877.724891004304;6964.233934267328;6598.637074960923;6649.301823308483;6695.163104611924;6751.156105486814;6754.324567543206;7079.115110611174;7082.893756593759;7126.002359669546;7130.358267755927;7180.030695856201;6498.317676644074;6557.278699343164;6564.737410503526;6619.3049729779605;6639.502037347315;6556.442702370352;6603.900941485786;6618.404343609098;6623.768168114093;6626.403623673892 12:19:56 INFO - PROCESS | 20476 | |4;prototype.html;306.3153851142696;306.5830470560038;311.1396987330033;313.5923299710376;313.667512436817;5270.683758974459;5376.112941364675;5378.784848606061;5423.728813559326;5478.726063696819;5280.445553216915;5306.655067420625;5348.545373643245;5351.25082488451;5357.383900851403;3946.565877753445;4037.8182981765744;4184.079502509443;4189.6438802701805;4192.371144328345;4180.874573762777;4185;4185.079282557833;4208.789560521977;4211.810468528924;4174.186033723425;4189.539150693421;4191.350340697197;4198.097409057053;4198.517170525398;4034.838606455738;4190.706650534448;4199.727017743837;4199.790010499462;4204.348326009458;3670.3576874046935;3691.870784522556;3697.611750766158;3698.130939229279;3706.721995850322;5099.215274653879;5131.923021154648;5138.075146473633;5140.460251673595;5149.536541711226;4714.420669075864;4787.425508938914;4834.444038935497;4839.225723884197;4843.782029808632;5601.663900166003;5617.859553511154;5640.717964101819;5646.887062258732;5661.094224924033;4001.459802926626;4015.6185162409524;4018.9952511872034;4019.919601607981;4023.2154729827403;5623.8594035149035;5919.82240532789;5936.614120082181;5945.64326140433;5951;4115.032967252693;4155.792210389468;4159;4160.396742472324;4162.729422587583;4210.789460527023;4223.746575205498;4224.408582798411;4231.322988321854;4231.915361692749;4653.744044077541;4766.642501812378;4781.976090119597;4783.641226907996;4814.494478079821;5672.546196304368;5677.886442271131;5683.602147849693;5704.8859022819315;5735.541156707453;1445.6819499710048;1473.1602986297921;1474.9778753318708;1477.711846190004;1477.7413952558259;922.6632279218037;976.321456587679;977.9804403911882;1001.5342865567546;1019.56158851693;4919.458859525449;4967.652264341461;4974.850754477371;5000.2749601307605;5008.749562521859;5806.941930580725;5827.155062515912;5830.125481177857;5834.504067154339;5846.766129354864;4867.172580661296;4962.330085438492;4992.850214493571;5013.573846223039;5016.046951079284;3077.7845550811676;3101.4727496325677;3119.750419966397;3136.34136831268;3136.40408322418;5462.890742185214;5467.015937131275;5496.477834605706;5496.7526461309335;5504.53211477029;5752.856178595485;5956.463918247292;5967.5524335675;5975.26545908807;5978.701064946736;5412.621116521885;5437.510624043855;5464.808731694372;5469.617126801165;5479.945200548023;5569.498745112959;5759.424057594207;5767.307923049261;5808.186853840551;5882.970585147047;5769.192313076089;5778.364379918122;5810.418958104325;5814.273215848019;5834.241548598655;5555.861103472445;5560.110382338807;5568.470995255444;5571.3871474137;5572.275604171432;3933.92132157361;4003.3594624859884;4172.937405938853;4192.28731115705;4202.789860507023;5797.739101740516;5817.854553636193;5859.326177489644;5871.178035075008;5881.7647294109465;5526.281583394133;5690.089585666274;5699.344575373885;5704.60067795267;5705.800296989585;5583.664980101207;5617;5618.747156378055;5628.440962820129;5653.321601407857;5218.608604354613;5509.228707980806;5516.172574113915;5539.667619942817;5571.13647384656;5532.944670553243;5646.887062258814;5711.257536520226;5734.082546792493;5749.712514374348;5526.253955716088;5531.391546929915;5544.560393426879;5554.166874968787;5554.944450555443 12:19:56 INFO - PROCESS | 20476 | |5;yui.html;778.5523324088649;798.2655956520001;805.4724155678033;810.8783682447632;814.6212011414698;12296.385180740961;12394.442250098757;12423.440945157467;12527.310997895112;12630.1790383625;12200.755984880298;12287.139900206988;12299.815502767466;13555.728885422286;14016.15903045818;808.9595520223995;818.5988865455944;824.0523398092182;827.0075908909303;827.4497459189631;821.7288294862681;822.3503432288485;823.3413269384498;826.2109685250572;826.5454000299841;861.8621020636699;864.2394692670441;867.0808942520948;867.6312567158964;868.4181598329103;851.0765819086299;855.8459477294084;860.109786371106;861.8190180062195;864.4294765454802;624.2415465209747;625.4496043481753;626.2516293029831;626.8119564130789;627.2848952194502;12266.632001039983;12400.503979840796;12523.060770442253;12566.434510447052;12634.557790477289;12269;12394.938025309815;12408.56570020054;12515.37423128849;12563.685907852285;10269.486525673687;10271.897281027168;10334.638287659896;10452.634157804516;10477.26659133861;3279;3315.1049216711594;3325.8503367348526;3345.063382252973;3373.730101591867;46172.76913615411;46311.53688463106;46459;47044;47707.28439073417;9541.533410833861;9545.188658963927;9612.711618651452;9660.227181825438;9745.512724363753;16217.432389866299;16577.254023568967;16675.83324166767;16700.582485437717;16712.41506547265;6606.240282367493;6630.7679231226675;6637.004449332542;6642.435392991553;6780.118584583973;3882.5729169791302;3890.8054597270025;3964.623360780721;3985.143194213258;4004.3192657248337;2713.0639929224385;2807.9189512037606;2809.325761817149;2811.100447856707;2812.339100311425;518.7691477292644;529.0582762682432;529.8489930369826;532.0317023018147;539.3581637850945;552.4613501835678;578.2165166199823;605.9818205453755;614.2536817766346;662.6189940784069;7627.008488896408;7848.882266766003;7935.841283174304;8111.351091912633;8213.876791848126;647.3041480408485;648.2577448821073;649.5226008883467;660.9438197753149;669.5480550628306;3986.1828325193264;3998.3202855514633;4028.657564107025;4036.354183330653;4074.4499492568716;53936.46063539393;54194;54421.72789136108;54906.72546637321;55019.449805501434;40579.59420405817;42750.14499709989;42913;43265.567344326155;47864;43318.783406082766;44029.33955990663;44200.3369949451;44321.778391108484;44418.333724994154;8317.500949942782;8351.415400921876;8422.326213902996;8485.745427637181;8544.530050847263;28978;28990.855045724635;29079.418411632072;29933.70066299309;29978.25054373658;34277;37071.62928370682;39425.40861887017;39442;39581.208375832895;10215.284930054824;10509.789804204025;10626.203034772578;10708.411037392707;10799.244052916534;11993;12068.879311207127;12306.13857030035;12388.876111239133;12393.256404615751;10291.53688084023;10587.258891877495;10826.133909287395;11027.72430689207;11042.33745975212;10722;11418.0865530759;11528.942355288169;11542;11562.248453850472;10081.14310283634;10105.797884042426;10127.392356458637;10147.188224942134;10175.084242418217;8705.608247629;9013.504257265913;9022.819543609223;9214.723558293263;9259.53702314895;8949.686760963335;9281.767955801159;9362.157405833508;9660.71017869437;9795.461249631338 12:19:56 INFO - PROCESS | 20476 | __end_tp_report 12:19:56 INFO - PROCESS | 20476 | __start_cc_report 12:19:56 INFO - PROCESS | 20476 | _x_x_mozilla_cycle_collect,395 12:19:56 INFO - PROCESS | 20476 | __end_cc_report 12:19:56 INFO - PROCESS | 20476 | __startTimestamp1460402396626__endTimestamp 12:19:56 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | ------- Summary: start ------- 12:19:56 INFO - PROCESS | 20476 | Number of tests: 6 12:19:56 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | [#0] dojo.html Cycles:165 Average:4732.13 Median:4858.15 stddev:481.76 (9.9%) stddev-sans-first:454.34 12:19:56 INFO - PROCESS | 20476 | Values: 2637.2 2697.6 2721.9 2731.9 2736.4 4755.9 4757.2 4766.7 4806.6 4854.1 4657.0 4839.0 4840.0 4840.5 4902.6 4394.7 4451.3 4451.4 4513.5 4547.4 4482.4 4521.2 4536.5 4544.9 4547.7 4356.2 4377.2 4413.0 4456.0 4518.3 4378.9 4399.0 4411.7 4430.4 4446.1 4382.3 4399.0 4420.1 4423.1 4423.4 4570.7 4712.0 4742.0 4788.5 4814.9 5034.8 5045.7 5046.1 5060.2 5106.7 5056.9 5078.6 5079.5 5085.2 5107.4 4722.0 4747.5 4767.1 4816.3 4826.0 5179.1 5179.4 5180.5 5186.7 5232.3 4923.5 4963.0 4967.8 4983.3 5006.8 4926.6 5095.3 5135.2 5162.9 5180.4 5014.8 5021.9 5022.5 5036.1 5082.0 4988.8 5005.6 5013.0 5017.9 5101.5 4244.8 4255.4 4261.6 4263.5 4269.1 3735.9 3772.4 3776.4 3778.1 3784.9 4526.1 4543.4 4556.0 4561.1 4573.4 5152.4 5191.1 5210.0 5241.2 5259.0 4467.9 4497.0 4497.8 4500.7 4531.7 4557.2 4557.6 4563.8 4566.2 4584.1 4745.0 4855.7 4889.0 4936.8 4944.1 5091.7 5118.7 5145.5 5156.4 5160.0 4783.2 4833.9 4841.9 4846.9 4888.7 5051.5 5052.4 5073.1 5093.2 5130.0 5099.2 5105.8 5120.8 5138.0 5182.5 4780.5 4986.2 4988.9 4991.7 4996.0 4858.1 4974.1 4992.2 5013.4 5041.8 4871.6 4909.3 4912.3 4928.5 4985.6 4921.8 5014.3 5020.2 5038.2 5056.2 4836.2 4858.4 4867.2 4900.2 4909.8 12:19:56 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | [#1] ext.html Cycles:180 Average:40691.19 Median:3357.16 stddev:70717.48 (2106.5%) stddev-sans-first:70851.68 12:19:56 INFO - PROCESS | 20476 | Values: 563.4 607.5 619.4 620.2 641.4 35608.8 36609.6 36694.8 36798.4 36906.8 40115.6 40923.6 41001.0 41139.2 41366.2 7786.8 7913.8 7934.4 7956.6 7956.8 7853.6 7901.3 7954.5 7962.4 7995.8 7942.3 8010.6 8015.0 8016.2 8056.9 7909.5 7976.2 7982.2 7982.4 8019.0 7840.1 7915.2 7932.4 7955.2 7962.2 30857.2 36897.6 37095.6 37359.8 37393.4 2915.5 2989.3 3112.7 3510.6 3713.8 22300.6 23490.5 23499.0 24417.9 25090.0 3338.4 3375.9 3413.5 3429.2 3430.2 172884.0 175160.0 176125.1 176262.0 176626.0 31607.8 31921.0 31962.2 32845.8 33883.2 31639.8 31667.0 31757.4 31797.7 31922.2 12536.9 12815.2 12834.6 12877.8 12886.2 10782.4 10828.1 10829.9 10830.0 10851.9 8142.9 8149.4 8185.1 8231.8 8240.0 3105.0 3223.5 3238.7 3246.6 3260.4 989.2 996.9 1033.5 1035.8 1099.3 28554.3 28593.6 28685.6 28701.0 28919.3 981.7 1011.4 1033.3 1051.7 1084.2 14842.6 15150.8 15291.8 15463.3 15553.8 304930.0 307498.0 309480.0 310110.0 311623.0 47984.0 49251.5 49528.0 49665.5 49817.0 1210.9 1232.9 1248.8 1264.1 1277.9 26586.6 27856.2 27947.0 28142.9 28460.0 40938.0 41076.6 41510.8 41697.8 41949.0 299407.0 301302.0 301662.0 303306.0 303543.0 25099.5 25275.6 25363.6 25681.6 25689.4 41915.8 42858.0 42974.4 43105.0 43162.3 34542.8 35570.1 36630.8 36871.0 36909.4 35559.0 35867.0 36343.3 36489.3 36872.4 35983.3 35994.0 36629.9 36955.4 37081.8 27793.0 29074.0 29437.6 29621.6 29631.3 23153.4 23562.5 23599.0 23776.0 24025.8 12:19:56 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | [#2] jquery.html Cycles:180 Average:24507.28 Median:410700.00 stddev:66052.21 (16.1%) stddev-sans-first:66212.62 12:19:56 INFO - PROCESS | 20476 | Values: 360.9 361.8 363.3 377.4 380.2 16026.9 16636.7 17879.9 17895.0 17907.8 15964.8 16468.3 17109.7 17206.3 17209.4 5049.9 5173.2 5221.3 5223.6 5227.6 3607.2 5123.0 5383.6 5755.1 5757.0 5645.6 5646.6 5681.5 5695.7 5723.1 5425.6 5846.4 5872.6 5879.6 5884.8 4925.2 5165.7 5167.5 5195.3 5206.0 18408.8 18632.8 18650.3 18768.0 18885.9 631.7 1958.7 2106.9 2322.9 2580.3 12748.8 13157.2 13258.5 13563.3 13645.0 1783.7 1793.3 1794.3 1810.5 1828.3 65795.3 65865.3 66764.7 67654.0 68142.0 9163.9 9269.3 9292.5 9558.4 9602.6 12873.5 13029.8 13144.5 13195.0 13275.1 7115.1 7208.5 7225.9 7229.4 7413.5 7095.2 7128.6 7196.8 7307.0 7314.3 5912.1 5959.3 5998.0 6022.5 6150.9 1511.5 1644.9 1693.9 1850.3 1855.8 817.8 904.6 983.8 991.7 1051.0 16668.3 16920.8 17037.8 17090.4 17107.1 826.7 827.5 908.4 918.8 1016.0 7381.6 8930.8 9174.4 10072.5 10166.2 391632.0 394081.0 397533.0 403969.0 417431.0 75376.2 75622.0 76895.0 77389.0 79284.0 1013.7 1014.3 1031.4 1038.1 1038.2 15415.4 15631.8 15640.1 15725.4 15827.3 33255.2 33880.3 34874.3 34935.8 34979.5 48081.3 49733.8 50218.7 50279.5 50512.2 7303.6 7702.5 7810.5 7861.0 7876.4 8075.9 9619.8 10857.9 11170.4 11315.3 9880.2 9947.5 9961.4 10034.0 10314.4 9795.3 9950.0 10053.3 10117.2 10227.9 10306.1 10369.4 10421.0 10630.5 10795.1 7832.8 7929.2 8063.9 8066.0 8158.0 10313.6 10594.0 10775.2 10796.9 10828.4 12:19:56 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | [#3] mootools.html Cycles:180 Average:5416.75 Median:6618.85 stddev:2870.13 (43.4%) stddev-sans-first:2862.58 12:19:56 INFO - PROCESS | 20476 | Values: 1434.3 1472.9 1600.9 1759.1 1788.0 6871.8 7380.7 7529.0 7704.0 7717.5 7401.0 7454.2 7576.6 7586.5 7596.2 2265.2 2295.1 2295.4 2297.7 2297.9 2259.8 2270.5 2291.3 2309.8 2313.1 2246.1 2251.6 2253.6 2272.8 2279.2 2214.4 2221.5 2223.4 2231.3 2233.7 2203.4 2231.8 2233.3 2236.4 2239.6 7687.1 7697.8 7746.8 7762.0 7762.5 4491.3 4706.9 4706.9 4718.6 4723.6 2814.7 2912.4 2922.7 2936.1 2938.6 931.2 932.3 940.1 952.8 973.6 10525.6 10560.2 10583.1 10617.6 10654.1 4112.9 4184.7 4247.1 4303.4 4494.2 9019.7 9022.7 9073.3 9084.5 9107.5 4688.5 4706.9 4710.8 4724.0 4782.3 3694.7 4263.9 4324.7 4324.9 4368.9 3551.9 3580.5 3665.2 3678.1 3687.4 1172.6 1178.8 1179.6 1199.3 1213.5 952.8 974.4 977.8 1032.8 1217.1 6981.1 7135.9 7218.6 7228.8 7257.7 403.8 429.6 431.5 431.7 433.5 5417.3 5516.5 5538.7 5607.1 5610.2 9162.6 9544.2 9590.8 9603.2 9607.3 9270.5 9280.6 9377.1 9433.4 9442.8 7194.4 7303.6 7317.8 7322.1 7346.8 6966.3 7086.5 7213.4 7217.6 7232.8 8654.9 8728.7 8785.0 8871.3 8900.0 8541.9 8880.4 9033.4 9043.2 9130.1 6047.2 6815.3 6940.7 7181.6 7386.7 7323.2 7377.9 7389.4 7412.6 7434.5 6513.1 6757.5 6874.3 6877.7 6964.2 6598.6 6649.3 6695.2 6751.2 6754.3 7079.1 7082.9 7126.0 7130.4 7180.0 6498.3 6557.3 6564.7 6619.3 6639.5 6556.4 6603.9 6618.4 6623.8 6626.4 12:19:56 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | [#4] prototype.html Cycles:180 Average:4692.10 Median:5327.60 stddev:1363.24 (25.6%) stddev-sans-first:1326.72 12:19:56 INFO - PROCESS | 20476 | Values: 306.3 306.6 311.1 313.6 313.7 5270.7 5376.1 5378.8 5423.7 5478.7 5280.4 5306.7 5348.5 5351.3 5357.4 3946.6 4037.8 4184.1 4189.6 4192.4 4180.9 4185.0 4185.1 4208.8 4211.8 4174.2 4189.5 4191.4 4198.1 4198.5 4034.8 4190.7 4199.7 4199.8 4204.3 3670.4 3691.9 3697.6 3698.1 3706.7 5099.2 5131.9 5138.1 5140.5 5149.5 4714.4 4787.4 4834.4 4839.2 4843.8 5601.7 5617.9 5640.7 5646.9 5661.1 4001.5 4015.6 4019.0 4019.9 4023.2 5623.9 5919.8 5936.6 5945.6 5951.0 4115.0 4155.8 4159.0 4160.4 4162.7 4210.8 4223.7 4224.4 4231.3 4231.9 4653.7 4766.6 4782.0 4783.6 4814.5 5672.5 5677.9 5683.6 5704.9 5735.5 1445.7 1473.2 1475.0 1477.7 1477.7 922.7 976.3 978.0 1001.5 1019.6 4919.5 4967.7 4974.9 5000.3 5008.7 5806.9 5827.2 5830.1 5834.5 5846.8 4867.2 4962.3 4992.9 5013.6 5016.0 3077.8 3101.5 3119.8 3136.3 3136.4 5462.9 5467.0 5496.5 5496.8 5504.5 5752.9 5956.5 5967.6 5975.3 5978.7 5412.6 5437.5 5464.8 5469.6 5479.9 5569.5 5759.4 5767.3 5808.2 5883.0 5769.2 5778.4 5810.4 5814.3 5834.2 5555.9 5560.1 5568.5 5571.4 5572.3 3933.9 4003.4 4172.9 4192.3 4202.8 5797.7 5817.9 5859.3 5871.2 5881.8 5526.3 5690.1 5699.3 5704.6 5705.8 5583.7 5617.0 5618.7 5628.4 5653.3 5218.6 5509.2 5516.2 5539.7 5571.1 5532.9 5646.9 5711.3 5734.1 5749.7 5526.3 5531.4 5544.6 5554.2 5554.9 12:19:56 INFO - PROCESS | 20476 | 12:19:56 INFO - PROCESS | 20476 | [#5] yui.html Cycles:180 Average:12780.80 Median:44114.84 stddev:14512.77 (32.9%) stddev-sans-first:14525.49 12:19:56 INFO - PROCESS | 20476 | Values: 778.6 798.3 805.5 810.9 814.6 12296.4 12394.4 12423.4 12527.3 12630.2 12200.8 12287.1 12299.8 13555.7 14016.2 809.0 818.6 824.1 827.0 827.4 821.7 822.4 823.3 826.2 826.5 861.9 864.2 867.1 867.6 868.4 851.1 855.8 860.1 861.8 864.4 624.2 625.4 626.3 626.8 627.3 12266.6 12400.5 12523.1 12566.4 12634.6 12269.0 12394.9 12408.6 12515.4 12563.7 10269.5 10271.9 10334.6 10452.6 10477.3 3279.0 3315.1 3325.9 3345.1 3373.7 46172.8 46311.5 46459.0 47044.0 47707.3 9541.5 9545.2 9612.7 9660.2 9745.5 16217.4 16577.3 16675.8 16700.6 16712.4 6606.2 6630.8 6637.0 6642.4 6780.1 3882.6 3890.8 3964.6 3985.1 4004.3 2713.1 2807.9 2809.3 2811.1 2812.3 518.8 529.1 529.8 532.0 539.4 552.5 578.2 606.0 614.3 662.6 7627.0 7848.9 7935.8 8111.4 8213.9 647.3 648.3 649.5 660.9 669.5 3986.2 3998.3 4028.7 4036.4 4074.4 53936.5 54194.0 54421.7 54906.7 55019.4 40579.6 42750.1 42913.0 43265.6 47864.0 43318.8 44029.3 44200.3 44321.8 44418.3 8317.5 8351.4 8422.3 8485.7 8544.5 28978.0 28990.9 29079.4 29933.7 29978.3 34277.0 37071.6 39425.4 39442.0 39581.2 10215.3 10509.8 10626.2 10708.4 10799.2 11993.0 12068.9 12306.1 12388.9 12393.3 10291.5 10587.3 10826.1 11027.7 11042.3 10722.0 11418.1 11528.9 11542.0 11562.2 10081.1 10105.8 10127.4 10147.2 10175.1 8705.6 9013.5 9022.8 9214.7 9259.5 8949.7 9281.8 9362.2 9660.7 9795.5 12:19:56 INFO - PROCESS | 20476 | -------- Summary: end -------- 12:19:56 INFO - PROCESS | 20476 | 12:19:57 INFO - TEST-INFO | 20476: exit 0 12:19:57 INFO - TEST-OK | dromaeo_css | took 1115332ms 12:19:57 INFO - TEST-START | kraken 12:19:57 INFO - operating with platform_type : linux_ 12:19:57 INFO - Initialising browser for kraken test... 12:19:57 INFO - TEST-INFO | started process 20710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdEsylq/profile http://localhost:35318/getInfo.html) 12:20:01 INFO - PROCESS | 20710 | 12:20:01 INFO - PROCESS | 20710 | (process:20779): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:20:01 INFO - PROCESS | 20710 | 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] 12:20:02 INFO - PROCESS | 20710 | __metrics Screen width/height:1600/1200 12:20:02 INFO - PROCESS | 20710 | colorDepth:24 12:20:02 INFO - PROCESS | 20710 | Browser inner width/height: 1024/697 12:20:02 INFO - PROCESS | 20710 | __metrics 12:20:02 ERROR - PROCESS | 20710 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 12:20:03 INFO - TEST-INFO | 20710: exit 0 12:20:03 INFO - Browser initialized. 12:20:03 INFO - Running cycle 1/1 for kraken test... 12:20:03 INFO - TEST-INFO | started process 20830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdEsylq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:05 INFO - PROCESS | 20830 | 12:20:05 INFO - PROCESS | 20830 | (process:20888): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:20:15 INFO - PROCESS | 20830 | RSS: Main: 164392960 12:20:15 INFO - PROCESS | 20830 | 12:20:18 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35318/tests/kraken/driver.html?testName=audio-beat-detection) 12:20:19 INFO - PROCESS | 20830 | RSS: Main: 168861696 12:20:19 INFO - PROCESS | 20830 | 12:20:21 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35318/tests/kraken/driver.html?testName=audio-dft) 12:20:22 INFO - PROCESS | 20830 | RSS: Main: 172335104 12:20:22 INFO - PROCESS | 20830 | 12:20:25 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35318/tests/kraken/driver.html?testName=audio-fft) 12:20:26 INFO - PROCESS | 20830 | RSS: Main: 162971648 12:20:26 INFO - PROCESS | 20830 | 12:20:28 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35318/tests/kraken/driver.html?testName=audio-oscillator) 12:20:28 INFO - PROCESS | 20830 | RSS: Main: 163119104 12:20:28 INFO - PROCESS | 20830 | 12:20:31 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:20:31 INFO - PROCESS | 20830 | RSS: Main: 164380672 12:20:31 INFO - PROCESS | 20830 | 12:20:34 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35318/tests/kraken/driver.html?testName=imaging-darkroom) 12:20:35 INFO - PROCESS | 20830 | RSS: Main: 164720640 12:20:35 INFO - PROCESS | 20830 | 12:20:39 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35318/tests/kraken/driver.html?testName=imaging-desaturate) 12:20:39 INFO - PROCESS | 20830 | RSS: Main: 164724736 12:20:39 INFO - PROCESS | 20830 | 12:20:42 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35318/tests/kraken/driver.html?testName=json-parse-financial) 12:20:43 INFO - PROCESS | 20830 | RSS: Main: 165097472 12:20:43 INFO - PROCESS | 20830 | 12:20:45 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:20:45 INFO - PROCESS | 20830 | RSS: Main: 165507072 12:20:45 INFO - PROCESS | 20830 | 12:20:47 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35318/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:20:48 INFO - PROCESS | 20830 | RSS: Main: 165494784 12:20:48 INFO - PROCESS | 20830 | 12:20:50 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:20:51 INFO - PROCESS | 20830 | RSS: Main: 165765120 12:20:51 INFO - PROCESS | 20830 | 12:20:53 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:20:54 INFO - PROCESS | 20830 | RSS: Main: 165883904 12:20:54 INFO - PROCESS | 20830 | 12:20:57 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:20:58 INFO - PROCESS | 20830 | RSS: Main: 165904384 12:20:58 INFO - PROCESS | 20830 | 12:20:59 INFO - PROCESS | 20830 | Cycle 1(1): loaded http://localhost:35318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35318/tests/kraken/driver.html?testName=ai-astar) 12:21:00 INFO - PROCESS | 20830 | RSS: Main: 167473152 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | __start_tp_report 12:21:00 INFO - PROCESS | 20830 | _x_x_mozilla_page_load 12:21:00 INFO - PROCESS | 20830 | _x_x_mozilla_page_load_details 12:21:00 INFO - PROCESS | 20830 | |i|pagename|runs| 12:21:00 INFO - PROCESS | 20830 | |0;ai-astar;115;109;114;115;114;127;115;114;115;115 12:21:00 INFO - PROCESS | 20830 | |1;audio-beat-detection;164;132;158;189;133;165;160;136;193;139 12:21:00 INFO - PROCESS | 20830 | |2;audio-dft;163;162;164;167;166;162;162;162;165;162 12:21:00 INFO - PROCESS | 20830 | |3;audio-fft;72;77;75;161;74;75;78;73;171;73 12:21:00 INFO - PROCESS | 20830 | |4;audio-oscillator;94;94;139;93;95;94;141;93;94;144 12:21:00 INFO - PROCESS | 20830 | |5;imaging-gaussian-blur;118;118;118;119;118;118;118;118;118;117 12:21:00 INFO - PROCESS | 20830 | |6;imaging-darkroom;147;148;147;147;147;146;149;147;146;147 12:21:00 INFO - PROCESS | 20830 | |7;imaging-desaturate;96;96;96;96;96;96;97;96;96;96 12:21:00 INFO - PROCESS | 20830 | |8;json-parse-financial;66;64;65;66;70;73;64;66;64;65 12:21:00 INFO - PROCESS | 20830 | |9;json-stringify-tinderbox;63;63;64;63;64;66;64;64;64;64 12:21:00 INFO - PROCESS | 20830 | |10;stanford-crypto-aes;83;84;85;83;85;86;86;87;114;85 12:21:00 INFO - PROCESS | 20830 | |11;stanford-crypto-ccm;140;142;150;142;149;143;145;142;140;149 12:21:00 INFO - PROCESS | 20830 | |12;stanford-crypto-pbkdf2;179;176;174;172;173;177;176;169;172;177 12:21:00 INFO - PROCESS | 20830 | |13;stanford-crypto-sha256-iterative;71;74;73;73;73;72;73;73;71;72 12:21:00 INFO - PROCESS | 20830 | __end_tp_report 12:21:00 INFO - PROCESS | 20830 | __start_cc_report 12:21:00 INFO - PROCESS | 20830 | _x_x_mozilla_cycle_collect,932 12:21:00 INFO - PROCESS | 20830 | __end_cc_report 12:21:00 INFO - PROCESS | 20830 | __startTimestamp1460402460189__endTimestamp 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | ------- Summary: start ------- 12:21:00 INFO - PROCESS | 20830 | Number of tests: 14 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:4.50 (3.9%) stddev-sans-first:4.77 12:21:00 INFO - PROCESS | 20830 | Values: 115.0 109.0 114.0 115.0 114.0 127.0 115.0 114.0 115.0 115.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:162.00 stddev:22.13 (13.7%) stddev-sans-first:23.33 12:21:00 INFO - PROCESS | 20830 | Values: 164.0 132.0 158.0 189.0 133.0 165.0 160.0 136.0 193.0 139.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:1.90 (1.2%) stddev-sans-first:2.01 12:21:00 INFO - PROCESS | 20830 | Values: 163.0 162.0 164.0 167.0 166.0 162.0 162.0 162.0 165.0 162.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#3] audio-fft Cycles:10 Average:92.90 Median:74.50 stddev:38.64 (51.9%) stddev-sans-first:40.24 12:21:00 INFO - PROCESS | 20830 | Values: 72.0 77.0 75.0 161.0 74.0 75.0 78.0 73.0 171.0 73.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:94.00 stddev:22.97 (24.4%) stddev-sans-first:23.79 12:21:00 INFO - PROCESS | 20830 | Values: 94.0 94.0 139.0 93.0 95.0 94.0 141.0 93.0 94.0 144.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 12:21:00 INFO - PROCESS | 20830 | Values: 118.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 118.0 117.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 12:21:00 INFO - PROCESS | 20830 | Values: 147.0 148.0 147.0 147.0 147.0 146.0 149.0 147.0 146.0 147.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:21:00 INFO - PROCESS | 20830 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:2.95 (4.5%) stddev-sans-first:3.12 12:21:00 INFO - PROCESS | 20830 | Values: 66.0 64.0 65.0 66.0 70.0 73.0 64.0 66.0 64.0 65.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 12:21:00 INFO - PROCESS | 20830 | Values: 63.0 63.0 64.0 63.0 64.0 66.0 64.0 64.0 64.0 64.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:9.30 (10.9%) stddev-sans-first:9.70 12:21:00 INFO - PROCESS | 20830 | Values: 83.0 84.0 85.0 83.0 85.0 86.0 86.0 87.0 114.0 85.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:144.00 stddev:3.82 (2.7%) stddev-sans-first:3.74 12:21:00 INFO - PROCESS | 20830 | Values: 140.0 142.0 150.0 142.0 149.0 143.0 145.0 142.0 140.0 149.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:176.00 stddev:3.03 (1.7%) stddev-sans-first:2.74 12:21:00 INFO - PROCESS | 20830 | Values: 179.0 176.0 174.0 172.0 173.0 177.0 176.0 169.0 172.0 177.0 12:21:00 INFO - PROCESS | 20830 | 12:21:00 INFO - PROCESS | 20830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:0.87 12:21:00 INFO - PROCESS | 20830 | Values: 71.0 74.0 73.0 73.0 73.0 72.0 73.0 73.0 71.0 72.0 12:21:00 INFO - PROCESS | 20830 | -------- Summary: end -------- 12:21:00 INFO - PROCESS | 20830 | 12:21:01 INFO - TEST-INFO | 20830: exit 0 12:21:01 INFO - TEST-OK | kraken | took 63789ms 12:21:01 INFO - SUITE-END | took 1179s 12:21:01 INFO - Completed test suite (00:19:39) 12:21:01 INFO - javascript benchmark 12:21:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.2220195042464, 2697.6223328733977, 2721.918342449726, 2731.9043833465835, 2736.4390299988504, 4755.932473323781, 4757.21505951518, 4766.690165139264, 4806.591439727623, 4854.077725232203, 4656.998745269766, 4838.975805120978, 4839.975800120995, 4840.515948405157, 4902.60779137669, 4394.692371533986, 4451.2655411857, 4451.354553589727, 4513.526079761627, 4547.431571053618, 4482.394876691654, 4521.231390663579, 4536.455625324949, 4544.9318260225955, 4547.704399214057, 4356.172327257811, 4377.190219809346, 4412.955870441287, 4455.997400584891, 4518.299663552155, 4378.8905277368, 4398.978005109986, 4411.669124815619, 4430.424044874146, 4446.110777844412, 4382.255016647177, 4398.966242932908, 4420.07178492517, 4423.137488189805, 4423.380726698265, 4570.65720070996, 4712.034033023222, 4742.027884283713, 4788.545088216649, 4814.855554333376, 5034.798608055673, 5045.747712614355, 5046.09170349337, 5060.165072762989, 5106.719130447824, 5056.898862022739, 5078.5937125029905, 5079.542841144278, 5085.186370180753, 5107.412647545542, 4721.95278047222, 4747.45404278509, 4767.094252092161, 4816.277558366203, 4825.95174048262, 5179.067767801832, 5179.378474583074, 5180.507851754077, 5186.740662966837, 5232.293640358579, 4923.532264434944, 4963.0, 4967.801287948514, 4983.327250821165, 5006.849794506098, 4926.605871530341, 5095.261187127846, 5135.15269980449, 5162.896742065138, 5180.430152683201, 5014.824481143215, 5021.924671129936, 5022.522860328263, 5036.143855544567, 5081.974590127025, 4988.825391111293, 5005.649604527648, 5013.0, 5017.874553136201, 5101.540861322499, 4244.808983595745, 4255.446791917093, 4261.616454519108, 4263.488381394252, 4269.146170765859, 3735.9439608405896, 3772.434134879735, 3776.3957766757185, 3778.0554861284677, 3784.924301513954, 4526.094781043805, 4543.4093567836635, 4555.9772201138785, 4561.064981678748, 4573.405457290531, 5152.381714194321, 5191.065608190486, 5210.010098081352, 5241.161414173714, 5259.0, 4467.910641787211, 4496.977515112403, 4497.8200871964755, 4500.662450316239, 4531.682782205214, 4557.1797076526545, 4557.58857958315, 4563.794629241692, 4566.246569316092, 4584.060267645124, 4744.976275118672, 4855.684380515326, 4888.95111048885, 4936.753162341796, 4944.060628480577, 5091.745412729275, 5118.744062796771, 5145.511176438233, 5156.4070131935305, 5160.0, 4783.186858234039, 4833.854984350475, 4841.878953026062, 4846.854594362175, 4888.706677599355, 5051.4695956924, 5052.418971818288, 5073.137566613758, 5093.18509038552, 5130.0, 5099.184130539096, 5105.846824595268, 5120.820771272987, 5137.974310128426, 5182.507661772125, 4780.545848144421, 4986.15235409974, 4988.9251661225835, 4991.725455100004, 4996.025774973845, 4858.149823780895, 4974.054929563371, 4992.15133427311, 5013.39839219296, 5041.773120209673, 4871.585915197248, 4909.312696222603, 4912.287718280901, 4928.457869634409, 4985.6260780442335, 4921.827736029365, 5014.272930425141, 5020.24696295544, 5038.219076043072, 5056.216286475602, 4836.226203807515, 4858.368412106403, 4867.1969125093965, 4900.166971614763, 4909.803607855646], "value": 4702.1295865784505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3521450332117, 607.4866737606723, 619.4208415131852, 620.1751670278528, 641.4099028893418, 35608.82195589022, 36609.63390366096, 36694.81652591733, 36798.44802327967, 36906.815465922664, 40115.598844011554, 40923.59076409235, 41001.0, 41139.17721645565, 41366.17267654645, 7786.7663970080985, 7913.841723165533, 7934.404919631051, 7956.602169891482, 7956.840863182733, 7853.607319634024, 7901.328387087105, 7954.482958607672, 7962.3630109591095, 7995.800104997364, 7942.285194332509, 8010.639521221559, 8015.038195416558, 8016.198380161995, 8056.919430805705, 7909.52542847431, 7976.162502937166, 7982.161873003338, 7982.401319900972, 8019.0, 7840.098388685317, 7915.248051435105, 7932.444728868982, 7955.164707705665, 7962.243586859239, 30857.228569285722, 36897.63102368996, 37095.62904370949, 37359.81320093409, 37393.439098413546, 2915.489789286866, 2989.252686828293, 3112.7198552130417, 3510.648935106469, 3713.795741234231, 22300.55398892013, 23490.530189396115, 23499.0, 24417.877910610332, 25089.996400143973, 3338.432466480704, 3375.8818441354433, 3413.5391722117693, 3429.1941393772445, 3430.2281986553076, 172884.0, 175160.0, 176125.11937440358, 176262.0, 176626.0, 31607.84196079005, 31921.0, 31962.200944976095, 32845.835770820995, 33883.152921176676, 31639.841800790848, 31667.0, 31757.364852702816, 31797.682023179936, 31922.2019449511, 12536.874631253753, 12815.231086134861, 12834.55079072228, 12877.806832897513, 12886.162399444007, 10782.353058816496, 10828.133749300194, 10829.891701082888, 10830.0, 10851.891481085246, 8142.918570814334, 8149.429539932266, 8185.058718247477, 8231.794205144919, 8240.0, 3105.0283070250102, 3223.5003574446, 3238.659940706239, 3246.6266379366675, 3260.4294248506417, 989.1740396768779, 996.8554559588964, 1033.5194134727387, 1035.8446233065101, 1099.274478843959, 28554.286142846595, 28593.57109643357, 28685.56971645427, 28701.0, 28919.277018074717, 981.676046904534, 1011.367895065584, 1033.2973577966904, 1051.6634676903318, 1084.2139448899484, 14842.628934276514, 15150.772738408932, 15291.847081529264, 15463.304151313218, 15553.844461555465, 304930.0, 307498.0, 309480.0, 310110.0, 311623.0, 47984.0, 49251.50748492469, 49528.0, 49665.50334496681, 49817.0, 1210.8849659282355, 1232.9321887296105, 1248.825164476974, 1264.0898553041795, 1277.8594354620984, 26586.601200981615, 27856.16431507058, 27947.0, 28142.859285703442, 28460.0, 40938.0, 41076.58923410847, 41510.79244603758, 41697.79151104225, 41949.0, 299407.0, 301302.0, 301662.0, 303306.0, 303543.0, 25099.512277747144, 25275.620865686662, 25363.61954570646, 25681.61477577875, 25689.357766055997, 41915.7904210477, 42858.0, 42974.355384668626, 43105.0, 43162.252152263856, 34542.82728586341, 35570.11074723153, 36630.8168459156, 36871.0, 36909.446358305184, 35559.0, 35866.95130913902, 36343.27313453769, 36489.27021459503, 36872.44691329686, 35983.28033439264, 35994.0, 36629.90110296696, 36955.44566831446, 37081.81459092687, 27793.0, 29074.0, 29437.558436623895, 29621.5556766653, 29631.25921851971, 23153.421164471023, 23562.52874942457, 23599.0, 23776.0, 24025.75974240235], "value": 15947.595094400016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.91698909250874, 361.79196961746993, 363.27526584464, 377.42819628263186, 380.1769169747497, 16026.91986540067, 16636.667266654676, 17879.91060044698, 17895.0, 17907.820921790793, 15964.76052859208, 16468.258928348223, 17109.74335384967, 17206.311747530115, 17209.397671081515, 5049.899002019957, 5173.198154286091, 5221.269022336857, 5223.555997740196, 5227.607929405291, 3607.2424790793966, 5123.0, 5383.623146379755, 5755.136729490568, 5756.971215143939, 5645.604807663444, 5646.632968857031, 5681.488666020057, 5695.686737229451, 5723.084306510959, 5425.565954723613, 5846.356900740915, 5872.5889187756875, 5879.559033072536, 5884.764609415618, 4925.187344088221, 5165.690058596496, 5167.48325167484, 5195.324607801, 5206.0368831766245, 18408.815911840844, 18632.813671863245, 18650.347237846745, 18768.0, 18885.905570472198, 631.7473010795673, 1958.6768183249746, 2106.9157233710785, 2322.932366356777, 2580.287435703208, 12748.80876786849, 13157.210567365893, 13258.53595124166, 13563.254021028839, 13645.044846860723, 1783.7324401339772, 1793.3185389552018, 1794.291254954299, 1810.5383127302584, 1828.3417969530958, 65795.3420465794, 65865.3413465864, 66764.66617666929, 67653.98519022268, 68142.0, 9163.862542061874, 9269.304802139866, 9292.53537323131, 9558.378705384128, 9602.567884445216, 12873.485060597659, 13029.804552931713, 13144.539941102206, 13195.0, 13275.070745047948, 7115.1106111736035, 7208.459365547605, 7225.927740722631, 7229.385502232264, 7413.4810563261135, 7095.219525852152, 7128.643567821692, 7196.784096477114, 7306.96346518264, 7314.341709246193, 5912.142739302863, 5959.314678811992, 5998.0, 6022.518198544193, 6150.876982460326, 1511.5465360391838, 1644.9177541122897, 1693.898366098038, 1850.3355168557234, 1855.7587513623143, 817.8446095241885, 904.5929331800716, 983.7737320416344, 991.7322322972757, 1050.9579616815242, 16668.333266669197, 16920.830791691926, 17037.78795399735, 17090.40183593568, 17107.144642767813, 826.6858593734343, 827.5407149032225, 908.4367692030983, 918.7932715139041, 1015.9847602285971, 7381.630918454056, 8930.776730581787, 9174.449533028039, 10072.546735396925, 10166.237532184969, 391632.0, 394081.0, 397533.0, 403969.0, 417431.0, 75376.24623753801, 75622.0, 76895.0, 77389.0, 79284.0, 1013.7212266626736, 1014.264658122855, 1031.4481752262504, 1038.1383451735041, 1038.2057725839738, 15415.383384664936, 15631.84368156304, 15640.061596304258, 15725.370985160924, 15827.287772050055, 33255.16862078467, 33880.32239355249, 34874.30251394907, 34935.825320873235, 34979.49563752847, 48081.278780817614, 49733.75133124311, 50218.748906255234, 50279.49720502748, 50512.24231636455, 7303.598302093435, 7702.537847729154, 7810.453268271166, 7860.960695196487, 7876.4092693047105, 8075.919240807517, 9619.759506012406, 10857.945710271713, 11170.441477926233, 11315.321080735182, 9880.20958323318, 9947.502624868872, 9961.40231586107, 10034.0, 10314.381137131797, 9795.265355098538, 9949.950250248703, 10053.296269261082, 10117.241206909659, 10227.897721022695, 10306.072453479223, 10369.377837329785, 10421.0, 10630.468476575985, 10795.136389089012, 7832.765017049498, 7929.167437418988, 8063.8790418144945, 8066.0, 8158.021037475303, 10313.587456501957, 10594.0, 10775.245732798629, 10796.89203107959, 10828.404437755684], "value": 8339.850341930118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.340203506387, 1472.948446804362, 1600.8879378443507, 1759.058903486635, 1787.9910600446997, 6871.759488417906, 7380.704771809128, 7528.9623551882305, 7703.961480192598, 7717.498362606434, 7400.962995185017, 7454.217307182736, 7576.621168941545, 7586.4689471737, 7596.202398748121, 2265.161890100661, 2295.070496448941, 2295.4146692593367, 2297.7357603875603, 2297.942551436219, 2259.762724913885, 2270.4550907782095, 2291.301153148289, 2309.7690230976937, 2313.1094528606523, 2246.079107565898, 2251.583457060449, 2253.5718213539376, 2272.761360057195, 2279.1567120165564, 2214.413180507167, 2221.5112675211426, 2223.4219103033247, 2231.263682984611, 2233.698450709158, 2203.3830527452337, 2231.7656646052255, 2233.251860626692, 2236.3514580771557, 2239.6192647250004, 7687.077550693953, 7697.769066928001, 7746.767596972099, 7762.0, 7762.45662803604, 4491.326301054835, 4706.858794236178, 4706.929396059062, 4718.646101542398, 4723.622110231173, 2814.6622405311496, 2912.4175164966878, 2922.7369536741585, 2936.1338405170527, 2938.61797966263, 931.1852129386787, 932.3287233192091, 940.1162906867522, 952.7808604021045, 973.634886917406, 10525.578976840918, 10560.155187584975, 10583.10043646291, 10617.628383006635, 10654.09440197584, 4112.856050038235, 4184.727992680466, 4247.129338485603, 4303.4190384298345, 4494.235979883428, 9019.729408117766, 9022.684206052889, 9073.274138068939, 9084.454932704059, 9107.453552786854, 4688.507706690748, 4706.88232794176, 4710.835120770825, 4723.976380118077, 4782.258749893772, 3694.7413681042067, 4263.872083837427, 4324.654027677778, 4324.870253892388, 4368.890777730582, 3551.893443196708, 3580.480830279595, 3665.2119794244363, 3678.1356381250384, 3687.446882967576, 1172.6423440850451, 1178.8231765235284, 1179.6166245970094, 1199.322382853685, 1213.514594162342, 952.7618095476131, 974.4348277998744, 977.7995510920244, 1032.7521394865178, 1217.0628615965834, 6981.127359080115, 7135.8572828544175, 7218.566885986857, 7228.783136505913, 7257.673404696801, 403.783975573067, 429.628371458686, 431.492995730016, 431.69565456353195, 433.46034187436845, 5417.349918009864, 5516.531094856982, 5538.667679939216, 5607.074832652648, 5610.186522954149, 9162.587683554257, 9544.236461083097, 9590.808183836423, 9603.231741460666, 9607.327487075838, 9270.490123043297, 9280.62877484893, 9377.1091746284, 9433.433993960385, 9442.811143777086, 7194.424446044304, 7303.598302093435, 7317.780466586011, 7322.0847394075745, 7346.816329591803, 6966.268541803241, 7086.503944724026, 7213.422926165789, 7217.6030318330895, 7232.783016509513, 8654.870176947477, 8728.650853966024, 8785.033646299029, 8871.290296776113, 8900.0, 8541.871871921801, 8880.378373513791, 9033.41282816641, 9043.18611324984, 9130.132637399436, 6047.183630209865, 6815.318468153145, 6940.6529673515115, 7181.640917954186, 7386.704531818882, 7323.194448610755, 7377.852442951218, 7389.445791565761, 7412.555246685216, 7434.479586428898, 6513.120728701565, 6757.493188010821, 6874.346937040973, 6877.724891004304, 6964.233934267328, 6598.637074960923, 6649.301823308483, 6695.163104611924, 6751.156105486814, 6754.324567543206, 7079.115110611174, 7082.893756593759, 7126.002359669546, 7130.358267755927, 7180.030695856201, 6498.317676644074, 6557.278699343164, 6564.737410503526, 6619.3049729779605, 6639.502037347315, 6556.442702370352, 6603.900941485786, 6618.404343609098, 6623.768168114093, 6626.403623673892], "value": 4332.539131215144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.3153851142696, 306.5830470560038, 311.1396987330033, 313.5923299710376, 313.667512436817, 5270.683758974459, 5376.112941364675, 5378.784848606061, 5423.728813559326, 5478.726063696819, 5280.445553216915, 5306.655067420625, 5348.545373643245, 5351.25082488451, 5357.383900851403, 3946.565877753445, 4037.8182981765744, 4184.079502509443, 4189.6438802701805, 4192.371144328345, 4180.874573762777, 4185.0, 4185.079282557833, 4208.789560521977, 4211.810468528924, 4174.186033723425, 4189.539150693421, 4191.350340697197, 4198.097409057053, 4198.517170525398, 4034.838606455738, 4190.706650534448, 4199.727017743837, 4199.790010499462, 4204.348326009458, 3670.3576874046935, 3691.870784522556, 3697.611750766158, 3698.130939229279, 3706.721995850322, 5099.215274653879, 5131.923021154648, 5138.075146473633, 5140.460251673595, 5149.536541711226, 4714.420669075864, 4787.425508938914, 4834.444038935497, 4839.225723884197, 4843.782029808632, 5601.663900166003, 5617.859553511154, 5640.717964101819, 5646.887062258732, 5661.094224924033, 4001.459802926626, 4015.6185162409524, 4018.9952511872034, 4019.919601607981, 4023.2154729827403, 5623.8594035149035, 5919.82240532789, 5936.614120082181, 5945.64326140433, 5951.0, 4115.032967252693, 4155.792210389468, 4159.0, 4160.396742472324, 4162.729422587583, 4210.789460527023, 4223.746575205498, 4224.408582798411, 4231.322988321854, 4231.915361692749, 4653.744044077541, 4766.642501812378, 4781.976090119597, 4783.641226907996, 4814.494478079821, 5672.546196304368, 5677.886442271131, 5683.602147849693, 5704.8859022819315, 5735.541156707453, 1445.6819499710048, 1473.1602986297921, 1474.9778753318708, 1477.711846190004, 1477.7413952558259, 922.6632279218037, 976.321456587679, 977.9804403911882, 1001.5342865567546, 1019.56158851693, 4919.458859525449, 4967.652264341461, 4974.850754477371, 5000.2749601307605, 5008.749562521859, 5806.941930580725, 5827.155062515912, 5830.125481177857, 5834.504067154339, 5846.766129354864, 4867.172580661296, 4962.330085438492, 4992.850214493571, 5013.573846223039, 5016.046951079284, 3077.7845550811676, 3101.4727496325677, 3119.750419966397, 3136.34136831268, 3136.40408322418, 5462.890742185214, 5467.015937131275, 5496.477834605706, 5496.7526461309335, 5504.53211477029, 5752.856178595485, 5956.463918247292, 5967.5524335675, 5975.26545908807, 5978.701064946736, 5412.621116521885, 5437.510624043855, 5464.808731694372, 5469.617126801165, 5479.945200548023, 5569.498745112959, 5759.424057594207, 5767.307923049261, 5808.186853840551, 5882.970585147047, 5769.192313076089, 5778.364379918122, 5810.418958104325, 5814.273215848019, 5834.241548598655, 5555.861103472445, 5560.110382338807, 5568.470995255444, 5571.3871474137, 5572.275604171432, 3933.92132157361, 4003.3594624859884, 4172.937405938853, 4192.28731115705, 4202.789860507023, 5797.739101740516, 5817.854553636193, 5859.326177489644, 5871.178035075008, 5881.7647294109465, 5526.281583394133, 5690.089585666274, 5699.344575373885, 5704.60067795267, 5705.800296989585, 5583.664980101207, 5617.0, 5618.747156378055, 5628.440962820129, 5653.321601407857, 5218.608604354613, 5509.228707980806, 5516.172574113915, 5539.667619942817, 5571.13647384656, 5532.944670553243, 5646.887062258814, 5711.257536520226, 5734.082546792493, 5749.712514374348, 5526.253955716088, 5531.391546929915, 5544.560393426879, 5554.166874968787, 5554.944450555443], "value": 4253.8008495109725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.5523324088649, 798.2655956520001, 805.4724155678033, 810.8783682447632, 814.6212011414698, 12296.385180740961, 12394.442250098757, 12423.440945157467, 12527.310997895112, 12630.1790383625, 12200.755984880298, 12287.139900206988, 12299.815502767466, 13555.728885422286, 14016.15903045818, 808.9595520223995, 818.5988865455944, 824.0523398092182, 827.0075908909303, 827.4497459189631, 821.7288294862681, 822.3503432288485, 823.3413269384498, 826.2109685250572, 826.5454000299841, 861.8621020636699, 864.2394692670441, 867.0808942520948, 867.6312567158964, 868.4181598329103, 851.0765819086299, 855.8459477294084, 860.109786371106, 861.8190180062195, 864.4294765454802, 624.2415465209747, 625.4496043481753, 626.2516293029831, 626.8119564130789, 627.2848952194502, 12266.632001039983, 12400.503979840796, 12523.060770442253, 12566.434510447052, 12634.557790477289, 12269.0, 12394.938025309815, 12408.56570020054, 12515.37423128849, 12563.685907852285, 10269.486525673687, 10271.897281027168, 10334.638287659896, 10452.634157804516, 10477.26659133861, 3279.0, 3315.1049216711594, 3325.8503367348526, 3345.063382252973, 3373.730101591867, 46172.76913615411, 46311.53688463106, 46459.0, 47044.0, 47707.28439073417, 9541.533410833861, 9545.188658963927, 9612.711618651452, 9660.227181825438, 9745.512724363753, 16217.432389866299, 16577.254023568967, 16675.83324166767, 16700.582485437717, 16712.41506547265, 6606.240282367493, 6630.7679231226675, 6637.004449332542, 6642.435392991553, 6780.118584583973, 3882.5729169791302, 3890.8054597270025, 3964.623360780721, 3985.143194213258, 4004.3192657248337, 2713.0639929224385, 2807.9189512037606, 2809.325761817149, 2811.100447856707, 2812.339100311425, 518.7691477292644, 529.0582762682432, 529.8489930369826, 532.0317023018147, 539.3581637850945, 552.4613501835678, 578.2165166199823, 605.9818205453755, 614.2536817766346, 662.6189940784069, 7627.008488896408, 7848.882266766003, 7935.841283174304, 8111.351091912633, 8213.876791848126, 647.3041480408485, 648.2577448821073, 649.5226008883467, 660.9438197753149, 669.5480550628306, 3986.1828325193264, 3998.3202855514633, 4028.657564107025, 4036.354183330653, 4074.4499492568716, 53936.46063539393, 54194.0, 54421.72789136108, 54906.72546637321, 55019.449805501434, 40579.59420405817, 42750.14499709989, 42913.0, 43265.567344326155, 47864.0, 43318.783406082766, 44029.33955990663, 44200.3369949451, 44321.778391108484, 44418.333724994154, 8317.500949942782, 8351.415400921876, 8422.326213902996, 8485.745427637181, 8544.530050847263, 28978.0, 28990.855045724635, 29079.418411632072, 29933.70066299309, 29978.25054373658, 34277.0, 37071.62928370682, 39425.40861887017, 39442.0, 39581.208375832895, 10215.284930054824, 10509.789804204025, 10626.203034772578, 10708.411037392707, 10799.244052916534, 11993.0, 12068.879311207127, 12306.13857030035, 12388.876111239133, 12393.256404615751, 10291.53688084023, 10587.258891877495, 10826.133909287395, 11027.72430689207, 11042.33745975212, 10722.0, 11418.0865530759, 11528.942355288169, 11542.0, 11562.248453850472, 10081.14310283634, 10105.797884042426, 10127.392356458637, 10147.188224942134, 10175.084242418217, 8705.608247629, 9013.504257265913, 9022.819543609223, 9214.723558293263, 9259.53702314895, 8949.686760963335, 9281.767955801159, 9362.157405833508, 9660.71017869437, 9795.461249631338], "value": 6005.644901003859, "unit": "score"}], "name": "dromaeo_css", "value": 6407.832740174275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 115.0, 114.0, 127.0, 115.0, 114.0, 115.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 158.0, 189.0, 133.0, 165.0, 160.0, 136.0, 193.0, 139.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 167.0, 166.0, 162.0, 162.0, 162.0, 165.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 75.0, 161.0, 74.0, 75.0, 78.0, 73.0, 171.0, 73.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 139.0, 93.0, 95.0, 94.0, 141.0, 93.0, 94.0, 144.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 149.0, 147.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 66.0, 70.0, 73.0, 64.0, 66.0, 64.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 64.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 83.0, 85.0, 86.0, 86.0, 87.0, 114.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 150.0, 142.0, 149.0, 143.0, 145.0, 142.0, 140.0, 149.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 176.0, 174.0, 172.0, 173.0, 177.0, 176.0, 169.0, 172.0, 177.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 73.0, 73.0, 73.0, 72.0, 73.0, 73.0, 71.0, 72.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1607.1000000000001, "alertThreshold": 2.0}]} 12:21:01 INFO - Return code: 0 12:21:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:21:01 ERROR - # TBPL SUCCESS # 12:21:01 INFO - Running post-action listener: _resource_record_post_action 12:21:01 INFO - Running post-run listener: _resource_record_post_run 12:21:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 384700416; Read time: 0; Write time: 282524 12:21:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98893824; Read time: 0; Write time: 62152 12:21:02 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 285806592; Read time: 0; Write time: 220372 12:21:02 INFO - Running post-run listener: _upload_blobber_files 12:21:02 INFO - Blob upload gear active. 12:21:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:21:02 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 12:21:02 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'] 12:21:02 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 12:21:03 INFO - (blobuploader) - INFO - Open directory for files ... 12:21:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:21:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:05 INFO - (blobuploader) - INFO - Done attempting. 12:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:06 INFO - (blobuploader) - INFO - Done attempting. 12:21:06 INFO - (blobuploader) - INFO - Iteration through files over. 12:21:06 INFO - Return code: 0 12:21:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:21:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:21:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a97568a248aa3a9cf64c8e2c415c9157e463191a56ed04d771a52587531c557b248ae4fd633008cffcb397f161551912bd4ecd6808d9f055eb3df62968038c8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff5ab604cb00679fb2a21faf7d6ad6d622d744e8c3423c0532fe2cb952cd200ce9ab12396ab70ea8183f11c2e149a201d3b9f3d3e0db38a5005378fead524672"} 12:21:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:21:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:21:06 INFO - Contents: 12:21:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a97568a248aa3a9cf64c8e2c415c9157e463191a56ed04d771a52587531c557b248ae4fd633008cffcb397f161551912bd4ecd6808d9f055eb3df62968038c8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff5ab604cb00679fb2a21faf7d6ad6d622d744e8c3423c0532fe2cb952cd200ce9ab12396ab70ea8183f11c2e149a201d3b9f3d3e0db38a5005378fead524672"} 12:21:06 INFO - Running post-run listener: copy_logs_to_upload_dir 12:21:06 INFO - Copying logs to upload dir... 12:21:06 INFO - mkdir: /builds/slave/test/build/upload/logs 12:21:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.459592 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-11 12:21:04.743400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 12:21:04.746624) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 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/a97568a248aa3a9cf64c8e2c415c9157e463191a56ed04d771a52587531c557b248ae4fd633008cffcb397f161551912bd4ecd6808d9f055eb3df62968038c8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff5ab604cb00679fb2a21faf7d6ad6d622d744e8c3423c0532fe2cb952cd200ce9ab12396ab70ea8183f11c2e149a201d3b9f3d3e0db38a5005378fead524672"} build_url:https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/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/a97568a248aa3a9cf64c8e2c415c9157e463191a56ed04d771a52587531c557b248ae4fd633008cffcb397f161551912bd4ecd6808d9f055eb3df62968038c8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff5ab604cb00679fb2a21faf7d6ad6d622d744e8c3423c0532fe2cb952cd200ce9ab12396ab70ea8183f11c2e149a201d3b9f3d3e0db38a5005378fead524672"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 12:21:04.790750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:21:04.791145) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460400197.313956-1679767792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:21:04.863716) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 12:21:04.864441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 12:21:04.865054) ========= ========= Total master_lag: 0.33 =========