builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1460587515.7 results: success (0) buildid: 20160413141950 builduid: 128362089fea448eaa7634c752cc6aea revision: bc2373295e31d99f9b870a1253b6e01650df8f31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.698796) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.699309) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.699623) ========= 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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006463 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.724796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.725482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.762782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.763061) ========= 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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.811277) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.811564) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.811997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.812297) ========= 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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 15:45:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 224M=0s 2016-04-13 15:45:16 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.994573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.994886) ========= 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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016232 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:16.044938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:16.045414) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc2373295e31d99f9b870a1253b6e01650df8f31 --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 bc2373295e31d99f9b870a1253b6e01650df8f31 --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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 15:45:16,527 truncating revision to first 12 chars 2016-04-13 15:45:16,527 Setting DEBUG logging. 2016-04-13 15:45:16,527 attempt 1/10 2016-04-13 15:45:16,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc2373295e31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 15:45:16,757 unpacking tar archive at: mozilla-central-bc2373295e31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.512807 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:16.571746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:16.572049) ========= echo bc2373295e31d99f9b870a1253b6e01650df8f31 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bc2373295e31d99f9b870a1253b6e01650df8f31'] 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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bc2373295e31d99f9b870a1253b6e01650df8f31 program finished with exit code 0 elapsedTime=0.004307 script_repo_revision: 'bc2373295e31d99f9b870a1253b6e01650df8f31' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:16.622957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:16.623349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:16.633431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-13 15:45:16.633703) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:45:17 INFO - MultiFileLogger online at 20160413 15:45:17 in /builds/slave/test 15:45:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 15:45:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:45:17 INFO - {'append_to_log': False, 15:45:17 INFO - 'base_work_dir': '/builds/slave/test', 15:45:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:45:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:45:17 INFO - 'branch': 'Firefox-Non-PGO', 15:45:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:45:17 INFO - 'config_files': ('talos/linux_config.py',), 15:45:17 INFO - 'default_actions': ('clobber', 15:45:17 INFO - 'read-buildbot-config', 15:45:17 INFO - 'download-and-extract', 15:45:17 INFO - 'populate-webroot', 15:45:17 INFO - 'create-virtualenv', 15:45:17 INFO - 'install', 15:45:17 INFO - 'run-tests'), 15:45:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:45:17 INFO - 'download_minidump_stackwalk': True, 15:45:17 INFO - 'download_symbols': 'ondemand', 15:45:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:45:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:45:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:45:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:45:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:45:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:45:17 INFO - 'installer_path': 'installer.exe', 15:45:17 INFO - 'log_level': 'info', 15:45:17 INFO - 'log_name': 'talos', 15:45:17 INFO - 'log_to_console': True, 15:45:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:45:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:45:17 INFO - 'opt_config_files': (), 15:45:17 INFO - 'pip_index': False, 15:45:17 INFO - 'sps_profile': False, 15:45:17 INFO - 'sps_profile_interval': 0, 15:45:17 INFO - 'suite': 'dromaeojs', 15:45:17 INFO - 'system_bits': '32', 15:45:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:45:17 INFO - 'title': 'talos-linux64-ix-054', 15:45:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:45:17 INFO - 'use_talos_json': True, 15:45:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:45:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:45:17 INFO - 'work_dir': 'build'} 15:45:17 INFO - ##### 15:45:17 INFO - ##### Running clobber step. 15:45:17 INFO - ##### 15:45:17 INFO - Running pre-action listener: _resource_record_pre_action 15:45:17 INFO - Running main action method: clobber 15:45:17 INFO - rmtree: /builds/slave/test/build 15:45:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:45:18 INFO - Running post-action listener: _resource_record_post_action 15:45:18 INFO - ##### 15:45:18 INFO - ##### Running read-buildbot-config step. 15:45:18 INFO - ##### 15:45:18 INFO - Running pre-action listener: _resource_record_pre_action 15:45:18 INFO - Running main action method: read_buildbot_config 15:45:18 INFO - Using buildbot properties: 15:45:18 INFO - { 15:45:18 INFO - "project": "", 15:45:18 INFO - "product": "firefox", 15:45:18 INFO - "script_repo_revision": "production", 15:45:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:45:18 INFO - "repository": "", 15:45:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:45:18 INFO - "buildid": "20160413141950", 15:45:18 INFO - "pgo_build": "False", 15:45:18 INFO - "basedir": "/builds/slave/test", 15:45:18 INFO - "buildnumber": 473, 15:45:18 INFO - "slavename": "talos-linux64-ix-054", 15:45:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:45:18 INFO - "platform": "ubuntu64_hw", 15:45:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:45:18 INFO - "branch": "mozilla-central", 15:45:18 INFO - "repo_path": "mozilla-central", 15:45:18 INFO - "revision": "bc2373295e31d99f9b870a1253b6e01650df8f31", 15:45:18 INFO - "stage_platform": "linux64", 15:45:18 INFO - "builduid": "128362089fea448eaa7634c752cc6aea", 15:45:18 INFO - "slavebuilddir": "test" 15:45:18 INFO - } 15:45:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:45:18 INFO - Running post-action listener: _resource_record_post_action 15:45:18 INFO - ##### 15:45:18 INFO - ##### Running download-and-extract step. 15:45:18 INFO - ##### 15:45:18 INFO - Running pre-action listener: _resource_record_pre_action 15:45:18 INFO - Running main action method: download_and_extract 15:45:18 INFO - mkdir: /builds/slave/test/build/tests 15:45:18 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')]} 15:45:18 INFO - https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:45:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:45:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:45:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:19 INFO - Downloaded 1361 bytes. 15:45:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:45:19 INFO - Using the following test package requirements: 15:45:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:45:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:45:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:19 INFO - u'jsshell-linux-x86_64.zip'], 15:45:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:45:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:45:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:45:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:45:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:45:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:45: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')]} 15:45:19 INFO - https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:20 INFO - Downloaded 22202636 bytes. 15:45:20 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'] 15:45:20 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 15:45:21 INFO - Return code: 0 15:45:21 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 15:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:21 INFO - https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:45:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:45:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:45:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:29 INFO - Downloaded 22202636 bytes. 15:45:29 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'] 15:45:29 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 15:45:30 INFO - Return code: 0 15:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:30 INFO - https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:32 INFO - Downloaded 10841076 bytes. 15:45: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'] 15:45: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 15:45:32 INFO - Return code: 0 15:45: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')]} 15:45:32 INFO - https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:45:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:45:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:45:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fenUE7mTQtSDhnVbMV__VA/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 15:45:36 INFO - Downloaded 54167275 bytes. 15:45:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:45:36 INFO - mkdir: /builds/slave/test/properties 15:45:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:45:36 INFO - Writing to file /builds/slave/test/properties/build_url 15:45:36 INFO - Contents: 15:45:36 INFO - build_url:https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:45:36 INFO - Running post-action listener: _resource_record_post_action 15:45:36 INFO - Running post-action listener: set_extra_try_arguments 15:45:36 INFO - ##### 15:45:36 INFO - ##### Running populate-webroot step. 15:45:36 INFO - ##### 15:45:36 INFO - Running pre-action listener: _resource_record_pre_action 15:45:36 INFO - Running main action method: populate_webroot 15:45:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:45:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:45:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:45:36 INFO - '--tppagecycles', 15:45:36 INFO - '7'], 15:45:36 INFO - 'tests': ['tsvgm']}}, 15:45:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:45:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:45:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:45:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:45:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:36 INFO - 'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:36 INFO - 'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['damp', 'tps']}, 15:45:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:36 INFO - 'tests': ['damp', 'tps']}, 15:45:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['dromaeo_dom']}, 15:45:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:45:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['a11yr', 15:45:36 INFO - 'ts_paint', 15:45:36 INFO - 'tpaint', 15:45:36 INFO - 'sessionrestore', 15:45:36 INFO - 'sessionrestore_no_auto_restore', 15:45:36 INFO - 'tabpaint']}, 15:45:36 INFO - 'other-e10s': {'tests': ['a11yr', 15:45:36 INFO - 'ts_paint', 15:45:36 INFO - 'tpaint', 15:45:36 INFO - 'sessionrestore', 15:45:36 INFO - 'sessionrestore_no_auto_restore', 15:45:36 INFO - 'tabpaint']}, 15:45:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:45:36 INFO - 'ts_paint', 15:45:36 INFO - 'tpaint', 15:45:36 INFO - 'sessionrestore', 15:45:36 INFO - 'sessionrestore_no_auto_restore', 15:45:36 INFO - 'tabpaint']}, 15:45:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:45:36 INFO - 'ts_paint', 15:45:36 INFO - 'tpaint', 15:45:36 INFO - 'sessionrestore', 15:45:36 INFO - 'sessionrestore_no_auto_restore', 15:45:36 INFO - 'tabpaint']}, 15:45:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['a11yr', 15:45:36 INFO - 'ts_paint', 15:45:36 INFO - 'tpaint', 15:45:36 INFO - 'sessionrestore', 15:45:36 INFO - 'sessionrestore_no_auto_restore', 15:45:36 INFO - 'tabpaint']}, 15:45:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['a11yr', 15:45:36 INFO - 'ts_paint', 15:45:36 INFO - 'tpaint', 15:45:36 INFO - 'sessionrestore', 15:45:36 INFO - 'sessionrestore_no_auto_restore', 15:45:36 INFO - 'tabpaint']}, 15:45:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['tsvgx', 15:45:36 INFO - 'tsvgr_opacity', 15:45:36 INFO - 'tart', 15:45:36 INFO - 'tscrollx', 15:45:36 INFO - 'cart']}, 15:45:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:45:36 INFO - 'tsvgr_opacity', 15:45:36 INFO - 'tart', 15:45:36 INFO - 'tscrollx', 15:45:36 INFO - 'cart']}, 15:45:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:36 INFO - 'talos_options': ['--disable-e10s'], 15:45:36 INFO - 'tests': ['tp5o']}, 15:45:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:36 INFO - 'tests': ['tp5o']}, 15:45:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:36 INFO - 'talos_options': ['--disable-e10s', 15:45:36 INFO - '--xperf_path', 15:45:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:36 INFO - 'tests': ['tp5n']}, 15:45:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:36 INFO - 'talos_options': ['--xperf_path', 15:45:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:36 INFO - 'tests': ['tp5n']}}, 15:45:36 INFO - 'talos.zip': {'path': '', 15:45:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:45:36 INFO - Running post-action listener: _resource_record_post_action 15:45:36 INFO - ##### 15:45:36 INFO - ##### Running create-virtualenv step. 15:45:36 INFO - ##### 15:45:36 INFO - Running pre-action listener: _resource_record_pre_action 15:45:36 INFO - Running main action method: create_virtualenv 15:45:36 INFO - Creating virtualenv /builds/slave/test/build/venv 15:45:36 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 15:45:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:45:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:45:36 INFO - Using real prefix '/usr' 15:45:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:45:37 INFO - Installing distribute.............................................................................................................................................................................................done. 15:45:39 INFO - Installing pip.................done. 15:45:39 INFO - Return code: 0 15:45:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:45:39 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')]} 15:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:39 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')]} 15:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:39 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 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:39 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 15:45:39 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 15:45:39 INFO - Using env: {'DISPLAY': ':0', 15:45:39 INFO - 'HOME': '/home/cltbld', 15:45:39 INFO - 'LANG': 'en_US.UTF-8', 15:45:39 INFO - 'LANGUAGE': 'en_US:en', 15:45:39 INFO - 'LOGNAME': 'cltbld', 15:45:39 INFO - 'MAIL': '/var/mail/cltbld', 15:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:39 INFO - 'MOZ_NO_REMOTE': '1', 15:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:39 INFO - 'NO_EM_RESTART': '1', 15:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:39 INFO - 'PWD': '/builds/slave/test', 15:45:39 INFO - 'SHELL': '/bin/bash', 15:45:39 INFO - 'SHLVL': '1', 15:45:39 INFO - 'TERM': 'linux', 15:45:39 INFO - 'TMOUT': '86400', 15:45:39 INFO - 'USER': 'cltbld', 15:45:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:39 INFO - '_': '/tools/buildbot/bin/python'} 15:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:39 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 15:45:39 INFO - Cleaning up... 15:45:39 INFO - Return code: 0 15:45:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:45:39 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')]} 15:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:39 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')]} 15:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:39 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 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:39 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 15:45:39 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 15:45:39 INFO - Using env: {'DISPLAY': ':0', 15:45:39 INFO - 'HOME': '/home/cltbld', 15:45:39 INFO - 'LANG': 'en_US.UTF-8', 15:45:39 INFO - 'LANGUAGE': 'en_US:en', 15:45:39 INFO - 'LOGNAME': 'cltbld', 15:45:39 INFO - 'MAIL': '/var/mail/cltbld', 15:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:39 INFO - 'MOZ_NO_REMOTE': '1', 15:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:39 INFO - 'NO_EM_RESTART': '1', 15:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:39 INFO - 'PWD': '/builds/slave/test', 15:45:39 INFO - 'SHELL': '/bin/bash', 15:45:39 INFO - 'SHLVL': '1', 15:45:39 INFO - 'TERM': 'linux', 15:45:39 INFO - 'TMOUT': '86400', 15:45:39 INFO - 'USER': 'cltbld', 15:45:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:39 INFO - '_': '/tools/buildbot/bin/python'} 15:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:39 INFO - Downloading/unpacking psutil>=0.7.1 15:45:39 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 15:45:39 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 15:45:39 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 15:45:39 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 15:45:39 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 15:45:39 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 15:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:41 INFO - Installing collected packages: psutil 15:45:41 INFO - Running setup.py install for psutil 15:45:41 INFO - building 'psutil._psutil_linux' extension 15:45:41 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 15:45:42 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 15:45:42 INFO - building 'psutil._psutil_posix' extension 15:45:42 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 15:45:42 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 15:45:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:42 INFO - Successfully installed psutil 15:45:42 INFO - Cleaning up... 15:45:42 INFO - Return code: 0 15:45:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:45:42 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')]} 15:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:42 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')]} 15:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:42 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 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:42 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 15:45:42 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 15:45:42 INFO - Using env: {'DISPLAY': ':0', 15:45:42 INFO - 'HOME': '/home/cltbld', 15:45:42 INFO - 'LANG': 'en_US.UTF-8', 15:45:42 INFO - 'LANGUAGE': 'en_US:en', 15:45:42 INFO - 'LOGNAME': 'cltbld', 15:45:42 INFO - 'MAIL': '/var/mail/cltbld', 15:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:42 INFO - 'MOZ_NO_REMOTE': '1', 15:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:42 INFO - 'NO_EM_RESTART': '1', 15:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:42 INFO - 'PWD': '/builds/slave/test', 15:45:42 INFO - 'SHELL': '/bin/bash', 15:45:42 INFO - 'SHLVL': '1', 15:45:42 INFO - 'TERM': 'linux', 15:45:42 INFO - 'TMOUT': '86400', 15:45:42 INFO - 'USER': 'cltbld', 15:45:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:42 INFO - '_': '/tools/buildbot/bin/python'} 15:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:45:42 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 15:45:42 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 15:45:42 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 15:45:42 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 15:45:42 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 15:45:42 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 15:45:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:45:44 INFO - Installing collected packages: mozsystemmonitor 15:45:44 INFO - Running setup.py install for mozsystemmonitor 15:45:44 INFO - Successfully installed mozsystemmonitor 15:45:44 INFO - Cleaning up... 15:45:44 INFO - Return code: 0 15:45:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:45:44 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')]} 15:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:44 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')]} 15:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:44 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 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:44 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 15:45:44 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 15:45:44 INFO - Using env: {'DISPLAY': ':0', 15:45:44 INFO - 'HOME': '/home/cltbld', 15:45:44 INFO - 'LANG': 'en_US.UTF-8', 15:45:44 INFO - 'LANGUAGE': 'en_US:en', 15:45:44 INFO - 'LOGNAME': 'cltbld', 15:45:44 INFO - 'MAIL': '/var/mail/cltbld', 15:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:44 INFO - 'MOZ_NO_REMOTE': '1', 15:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:44 INFO - 'NO_EM_RESTART': '1', 15:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:44 INFO - 'PWD': '/builds/slave/test', 15:45:44 INFO - 'SHELL': '/bin/bash', 15:45:44 INFO - 'SHLVL': '1', 15:45:44 INFO - 'TERM': 'linux', 15:45:44 INFO - 'TMOUT': '86400', 15:45:44 INFO - 'USER': 'cltbld', 15:45:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:44 INFO - '_': '/tools/buildbot/bin/python'} 15:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:46 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:45:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:47 INFO - Downloading docopt-0.6.1.tar.gz 15:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:47 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:47 INFO - Running setup.py install for blobuploader 15:45:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:45:47 INFO - Running setup.py install for requests 15:45:47 INFO - Running setup.py install for docopt 15:45:48 INFO - Successfully installed blobuploader requests docopt 15:45:48 INFO - Cleaning up... 15:45:48 INFO - Return code: 0 15:45:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:48 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 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:48 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 15:45:48 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 15:45:48 INFO - Using env: {'DISPLAY': ':0', 15:45:48 INFO - 'HOME': '/home/cltbld', 15:45:48 INFO - 'LANG': 'en_US.UTF-8', 15:45:48 INFO - 'LANGUAGE': 'en_US:en', 15:45:48 INFO - 'LOGNAME': 'cltbld', 15:45:48 INFO - 'MAIL': '/var/mail/cltbld', 15:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:48 INFO - 'MOZ_NO_REMOTE': '1', 15:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:48 INFO - 'NO_EM_RESTART': '1', 15:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:48 INFO - 'PWD': '/builds/slave/test', 15:45:48 INFO - 'SHELL': '/bin/bash', 15:45:48 INFO - 'SHLVL': '1', 15:45:48 INFO - 'TERM': 'linux', 15:45:48 INFO - 'TMOUT': '86400', 15:45:48 INFO - 'USER': 'cltbld', 15:45:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:48 INFO - '_': '/tools/buildbot/bin/python'} 15:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:48 INFO - Running setup.py (path:/tmp/pip-0lxDpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:48 INFO - Running setup.py (path:/tmp/pip-aKsncM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:48 INFO - Running setup.py (path:/tmp/pip-rZ2gnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:48 INFO - Running setup.py (path:/tmp/pip-thoYkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:48 INFO - Running setup.py (path:/tmp/pip-qUiLIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:48 INFO - Running setup.py (path:/tmp/pip-02xGGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:48 INFO - Running setup.py (path:/tmp/pip-pw1n5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:48 INFO - Running setup.py (path:/tmp/pip-hkaavp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:48 INFO - Running setup.py (path:/tmp/pip-71RNc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:48 INFO - Running setup.py (path:/tmp/pip-UFsGT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:49 INFO - Running setup.py (path:/tmp/pip-kkOV2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:49 INFO - Running setup.py (path:/tmp/pip-V8KScf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:49 INFO - Running setup.py (path:/tmp/pip-JpNOzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:49 INFO - Running setup.py (path:/tmp/pip-Mss4ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:49 INFO - Running setup.py (path:/tmp/pip-N_YmpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:49 INFO - Running setup.py (path:/tmp/pip-HQoOnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:49 INFO - Running setup.py (path:/tmp/pip-Sb4NOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:49 INFO - Running setup.py install for manifestparser 15:45:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:45:49 INFO - Running setup.py install for mozcrash 15:45:49 INFO - Running setup.py install for mozdebug 15:45:49 INFO - Running setup.py install for mozdevice 15:45:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:45:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:45:49 INFO - Running setup.py install for mozfile 15:45:50 INFO - Running setup.py install for mozhttpd 15:45:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Running setup.py install for mozinfo 15:45:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Running setup.py install for mozInstall 15:45:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Running setup.py install for mozleak 15:45:50 INFO - Running setup.py install for mozlog 15:45:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Running setup.py install for moznetwork 15:45:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Running setup.py install for mozprocess 15:45:50 INFO - Running setup.py install for mozprofile 15:45:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:45:50 INFO - Running setup.py install for mozrunner 15:45:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:45:51 INFO - Running setup.py install for mozscreenshot 15:45:51 INFO - Running setup.py install for moztest 15:45:51 INFO - Running setup.py install for mozversion 15:45:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:45:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:51 INFO - Cleaning up... 15:45:51 INFO - Return code: 0 15:45:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:51 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 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:51 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 15:45:51 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 15:45:51 INFO - Using env: {'DISPLAY': ':0', 15:45:51 INFO - 'HOME': '/home/cltbld', 15:45:51 INFO - 'LANG': 'en_US.UTF-8', 15:45:51 INFO - 'LANGUAGE': 'en_US:en', 15:45:51 INFO - 'LOGNAME': 'cltbld', 15:45:51 INFO - 'MAIL': '/var/mail/cltbld', 15:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:51 INFO - 'MOZ_NO_REMOTE': '1', 15:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:51 INFO - 'NO_EM_RESTART': '1', 15:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:51 INFO - 'PWD': '/builds/slave/test', 15:45:51 INFO - 'SHELL': '/bin/bash', 15:45:51 INFO - 'SHLVL': '1', 15:45:51 INFO - 'TERM': 'linux', 15:45:51 INFO - 'TMOUT': '86400', 15:45:51 INFO - 'USER': 'cltbld', 15:45:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:51 INFO - '_': '/tools/buildbot/bin/python'} 15:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:51 INFO - Running setup.py (path:/tmp/pip-j7HHwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:51 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)) 15:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:51 INFO - Running setup.py (path:/tmp/pip-6dEOyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:51 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)) 15:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:51 INFO - Running setup.py (path:/tmp/pip-eUkimA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:51 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)) 15:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:51 INFO - Running setup.py (path:/tmp/pip-DcQhy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:51 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)) 15:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:51 INFO - Running setup.py (path:/tmp/pip-8DpVP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:51 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)) 15:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:51 INFO - Running setup.py (path:/tmp/pip-3fwdFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:52 INFO - Running setup.py (path:/tmp/pip-wEKcSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:52 INFO - Running setup.py (path:/tmp/pip-xavqU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:52 INFO - Running setup.py (path:/tmp/pip-1XhCa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:52 INFO - Running setup.py (path:/tmp/pip-L4lWgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:52 INFO - Running setup.py (path:/tmp/pip-ek6p_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:52 INFO - Running setup.py (path:/tmp/pip-kPscL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:52 INFO - Running setup.py (path:/tmp/pip-dgI9sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:52 INFO - Running setup.py (path:/tmp/pip-4A1MRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:52 INFO - Running setup.py (path:/tmp/pip-RFQICb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:52 INFO - Running setup.py (path:/tmp/pip-zDoV3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:52 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)) 15:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:52 INFO - Running setup.py (path:/tmp/pip-C_xcU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:52 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)) 15:45:52 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)) 15:45:52 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)) 15:45:52 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)) 15:45:52 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)) 15:45:52 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)) 15:45:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:54 INFO - Downloading blessings-1.6.tar.gz 15:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:54 INFO - Installing collected packages: blessings 15:45:54 INFO - Running setup.py install for blessings 15:45:54 INFO - Successfully installed blessings 15:45:54 INFO - Cleaning up... 15:45:54 INFO - Return code: 0 15:45:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:55 INFO - Reading from file tmpfile_stdout 15:45:55 INFO - Current package versions: 15:45:55 INFO - argparse == 1.2.1 15:45:55 INFO - blessings == 1.6 15:45:55 INFO - blobuploader == 1.2.4 15:45:55 INFO - docopt == 0.6.1 15:45:55 INFO - manifestparser == 1.1 15:45:55 INFO - mozInstall == 1.12 15:45:55 INFO - mozcrash == 0.17 15:45:55 INFO - mozdebug == 0.1 15:45:55 INFO - mozdevice == 0.48 15:45:55 INFO - mozfile == 1.2 15:45:55 INFO - mozhttpd == 0.7 15:45:55 INFO - mozinfo == 0.9 15:45:55 INFO - mozleak == 0.1 15:45:55 INFO - mozlog == 3.1 15:45:55 INFO - moznetwork == 0.27 15:45:55 INFO - mozprocess == 0.22 15:45:55 INFO - mozprofile == 0.28 15:45:55 INFO - mozrunner == 6.11 15:45:55 INFO - mozscreenshot == 0.1 15:45:55 INFO - mozsystemmonitor == 0.0 15:45:55 INFO - moztest == 0.7 15:45:55 INFO - mozversion == 1.4 15:45:55 INFO - psutil == 3.1.1 15:45:55 INFO - requests == 1.2.3 15:45:55 INFO - wsgiref == 0.1.2 15:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:55 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 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:55 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 15:45:55 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 15:45:55 INFO - Using env: {'DISPLAY': ':0', 15:45:55 INFO - 'HOME': '/home/cltbld', 15:45:55 INFO - 'LANG': 'en_US.UTF-8', 15:45:55 INFO - 'LANGUAGE': 'en_US:en', 15:45:55 INFO - 'LOGNAME': 'cltbld', 15:45:55 INFO - 'MAIL': '/var/mail/cltbld', 15:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:55 INFO - 'MOZ_NO_REMOTE': '1', 15:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:55 INFO - 'NO_EM_RESTART': '1', 15:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:55 INFO - 'PWD': '/builds/slave/test', 15:45:55 INFO - 'SHELL': '/bin/bash', 15:45:55 INFO - 'SHLVL': '1', 15:45:55 INFO - 'TERM': 'linux', 15:45:55 INFO - 'TMOUT': '86400', 15:45:55 INFO - 'USER': 'cltbld', 15:45:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:55 INFO - '_': '/tools/buildbot/bin/python'} 15:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 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)) 15:45:55 INFO - Cleaning up... 15:45:55 INFO - Return code: 0 15:45:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:55 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 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:55 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 15:45:55 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 15:45:55 INFO - Using env: {'DISPLAY': ':0', 15:45:55 INFO - 'HOME': '/home/cltbld', 15:45:55 INFO - 'LANG': 'en_US.UTF-8', 15:45:55 INFO - 'LANGUAGE': 'en_US:en', 15:45:55 INFO - 'LOGNAME': 'cltbld', 15:45:55 INFO - 'MAIL': '/var/mail/cltbld', 15:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:55 INFO - 'MOZ_NO_REMOTE': '1', 15:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:55 INFO - 'NO_EM_RESTART': '1', 15:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:55 INFO - 'PWD': '/builds/slave/test', 15:45:55 INFO - 'SHELL': '/bin/bash', 15:45:55 INFO - 'SHLVL': '1', 15:45:55 INFO - 'TERM': 'linux', 15:45:55 INFO - 'TMOUT': '86400', 15:45:55 INFO - 'USER': 'cltbld', 15:45:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:55 INFO - '_': '/tools/buildbot/bin/python'} 15:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:55 INFO - Downloading/unpacking jsonschema 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:57 INFO - Downloading/unpacking functools32 (from jsonschema) 15:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:57 INFO - warning: no files found matching '*.txt' 15:45:57 INFO - no previously-included directories found matching 'build' 15:45:57 INFO - no previously-included directories found matching 'dist' 15:45:57 INFO - no previously-included directories found matching '.git*' 15:45:57 INFO - Installing collected packages: jsonschema, functools32 15:45:57 INFO - Running setup.py install for functools32 15:45:57 INFO - warning: no files found matching '*.txt' 15:45:57 INFO - no previously-included directories found matching 'build' 15:45:57 INFO - no previously-included directories found matching 'dist' 15:45:57 INFO - no previously-included directories found matching '.git*' 15:45:57 INFO - Successfully installed jsonschema functools32 15:45:57 INFO - Cleaning up... 15:45:57 INFO - Return code: 0 15:45:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f74deff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', '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 15:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:45:57 INFO - Using env: {'DISPLAY': ':0', 15:45:57 INFO - 'HOME': '/home/cltbld', 15:45:57 INFO - 'LANG': 'en_US.UTF-8', 15:45:57 INFO - 'LANGUAGE': 'en_US:en', 15:45:57 INFO - 'LOGNAME': 'cltbld', 15:45:57 INFO - 'MAIL': '/var/mail/cltbld', 15:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:57 INFO - 'MOZ_NO_REMOTE': '1', 15:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:57 INFO - 'NO_EM_RESTART': '1', 15:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:57 INFO - 'PWD': '/builds/slave/test', 15:45:57 INFO - 'SHELL': '/bin/bash', 15:45:57 INFO - 'SHLVL': '1', 15:45:57 INFO - 'TERM': 'linux', 15:45:57 INFO - 'TMOUT': '86400', 15:45:57 INFO - 'USER': 'cltbld', 15:45:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:57 INFO - '_': '/tools/buildbot/bin/python'} 15:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:58 INFO - Downloading/unpacking flake8 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:46:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:46:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:46:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:46:00 INFO - no previously-included directories found matching 'docs/_build' 15:46:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:46:00 INFO - Running setup.py install for pep8 15:46:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:46:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:46:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:46:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:46:01 INFO - no previously-included directories found matching 'docs/_build' 15:46:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:46:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:46:01 INFO - Cleaning up... 15:46:01 INFO - Return code: 0 15:46:01 INFO - Running post-action listener: _resource_record_post_action 15:46:01 INFO - Running post-action listener: _start_resource_monitoring 15:46:01 INFO - Starting resource monitoring. 15:46:01 INFO - ##### 15:46:01 INFO - ##### Running install step. 15:46:01 INFO - ##### 15:46:01 INFO - Running pre-action listener: _resource_record_pre_action 15:46:01 INFO - Running main action method: install 15:46:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:46:01 INFO - Reading from file tmpfile_stdout 15:46:01 INFO - Detecting whether we're running mozinstall >=1.0... 15:46:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:46:01 INFO - Reading from file tmpfile_stdout 15:46:01 INFO - Output received: 15:46:01 INFO - Usage: mozinstall [options] installer 15:46:01 INFO - Options: 15:46:01 INFO - -h, --help show this help message and exit 15:46:01 INFO - -d DEST, --destination=DEST 15:46:01 INFO - Directory to install application into. [default: 15:46:01 INFO - "/builds/slave/test"] 15:46:01 INFO - --app=APP Application being installed. [default: firefox] 15:46:01 INFO - mkdir: /builds/slave/test/build/application 15:46:01 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'] 15:46:01 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 15:46:17 INFO - Reading from file tmpfile_stdout 15:46:17 INFO - Output received: 15:46:17 INFO - /builds/slave/test/build/application/firefox/firefox 15:46:17 INFO - Running post-action listener: _resource_record_post_action 15:46:17 INFO - ##### 15:46:17 INFO - ##### Running run-tests step. 15:46:17 INFO - ##### 15:46:17 INFO - Running pre-action listener: _resource_record_pre_action 15:46:17 INFO - Running main action method: run_tests 15:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:46:17 INFO - Python 2.7.3 15:46:17 INFO - Return code: 0 15:46:17 INFO - grabbing minidump binary from tooltool 15:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:17 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 0x1509410>, '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 0x150a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:46:17 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 15:46:17 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 15:46:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:46:17 INFO - Return code: 0 15:46:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:46:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:46:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:46:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:46:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:46:18 INFO - Return code: 0 15:46:18 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:46:18 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:46:18 INFO - Using env: {'DISPLAY': ':0', 15:46:18 INFO - 'HOME': '/home/cltbld', 15:46:18 INFO - 'LANG': 'en_US.UTF-8', 15:46:18 INFO - 'LANGUAGE': 'en_US:en', 15:46:18 INFO - 'LOGNAME': 'cltbld', 15:46:18 INFO - 'MAIL': '/var/mail/cltbld', 15:46:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:46:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:18 INFO - 'MOZ_NO_REMOTE': '1', 15:46:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:18 INFO - 'NO_EM_RESTART': '1', 15:46:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:46:18 INFO - 'PWD': '/builds/slave/test', 15:46:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:46:18 INFO - 'SHELL': '/bin/bash', 15:46:18 INFO - 'SHLVL': '1', 15:46:18 INFO - 'TERM': 'linux', 15:46:18 INFO - 'TMOUT': '86400', 15:46:18 INFO - 'USER': 'cltbld', 15:46:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414', 15:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:18 INFO - '_': '/tools/buildbot/bin/python'} 15:46:18 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:46:18 INFO - mozversion application_buildid: 20160413141950 15:46:18 INFO - mozversion application_changeset: bc2373295e31d99f9b870a1253b6e01650df8f31 15:46:18 INFO - mozversion application_display_name: Nightly 15:46:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:46:18 INFO - mozversion application_name: Firefox 15:46:18 INFO - mozversion application_remotingname: firefox 15:46:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:46:18 INFO - mozversion application_vendor: Mozilla 15:46:18 INFO - mozversion application_version: 48.0a1 15:46:18 INFO - mozversion platform_buildid: 20160413141950 15:46:18 INFO - mozversion platform_changeset: bc2373295e31d99f9b870a1253b6e01650df8f31 15:46:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:46:18 INFO - mozversion platform_version: 48.0a1 15:46:18 INFO - using testdate: 1460587578 15:46:18 INFO - actual date: 1460587578 15:46:18 INFO - starting webserver on 'localhost:36100' 15:46:18 INFO - SUITE-START | Running 2 tests 15:46:18 INFO - TEST-START | dromaeo_css 15:46:18 INFO - operating with platform_type : linux_ 15:46:18 INFO - Initialising browser for dromaeo_css test... 15:46:18 INFO - TEST-INFO | started process 7457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKn_iQt/profile http://localhost:36100/getInfo.html) 15:46:22 INFO - PROCESS | 7457 | __metrics Screen width/height:1600/1200 15:46:22 INFO - PROCESS | 7457 | colorDepth:24 15:46:22 INFO - PROCESS | 7457 | Browser inner width/height: 1024/697 15:46:22 INFO - PROCESS | 7457 | __metrics 15:46:24 ERROR - PROCESS | 7457 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:46:24 INFO - TEST-INFO | 7457: exit 0 15:46:24 INFO - Browser initialized. 15:46:24 INFO - Running cycle 1/1 for dromaeo_css test... 15:46:24 INFO - TEST-INFO | started process 7536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKn_iQt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:36 INFO - PROCESS | 7536 | RSS: Main: 154771456 15:46:36 INFO - PROCESS | 7536 | 15:47:28 INFO - PROCESS | 7536 | 1460587648232 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] 15:49:41 INFO - PROCESS | 7536 | Cycle 1(1): loaded http://localhost:36100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36100/tests/dromaeo/cssquery-ext.html) 15:49:42 INFO - PROCESS | 7536 | RSS: Main: 228380672 15:49:42 INFO - PROCESS | 7536 | 15:52:44 INFO - PROCESS | 7536 | Cycle 1(1): loaded http://localhost:36100/tests/dromaeo/cssquery-ext.html (next: http://localhost:36100/tests/dromaeo/cssquery-jquery.html) 15:52:45 INFO - PROCESS | 7536 | RSS: Main: 239017984 15:52:45 INFO - PROCESS | 7536 | 15:55:47 INFO - PROCESS | 7536 | Cycle 1(1): loaded http://localhost:36100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36100/tests/dromaeo/cssquery-mootools.html) 15:55:47 INFO - PROCESS | 7536 | RSS: Main: 231567360 15:55:47 INFO - PROCESS | 7536 | 15:58:50 INFO - PROCESS | 7536 | Cycle 1(1): loaded http://localhost:36100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36100/tests/dromaeo/cssquery-prototype.html) 15:58:50 INFO - PROCESS | 7536 | RSS: Main: 232210432 15:58:50 INFO - PROCESS | 7536 | 16:01:53 INFO - PROCESS | 7536 | Cycle 1(1): loaded http://localhost:36100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36100/tests/dromaeo/cssquery-yui.html) 16:01:53 INFO - PROCESS | 7536 | RSS: Main: 223862784 16:01:53 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | Cycle 1(1): loaded http://localhost:36100/tests/dromaeo/cssquery-yui.html (next: http://localhost:36100/tests/dromaeo/cssquery-dojo.html) 16:04:56 INFO - PROCESS | 7536 | RSS: Main: 290848768 16:04:56 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | __start_tp_report 16:04:56 INFO - PROCESS | 7536 | _x_x_mozilla_page_load 16:04:56 INFO - PROCESS | 7536 | _x_x_mozilla_page_load_details 16:04:56 INFO - PROCESS | 7536 | |i|pagename|runs| 16:04:56 INFO - PROCESS | 7536 | |0;dojo.html;2620.5545057340255;2683.4364783395486;2687.905923292684;2699.203734898206;2718.6465759451266;4514.097180563892;4640.767961601923;4730.290456431537;4732.3138144969;4733.526647335265;4701.623870090393;4713.552212539812;4789.832355867546;4797.664163508547;4810.302506136608;4268.253055715253;4341.218580655481;4375.6937014409;4434.290513517838;4482.66380021498;4419.182451246514;4449.332600109993;4460.353248778925;4468.463784345867;4486.97756511217;4268.253055715269;4278.101598664284;4348.804303806336;4364.323529852846;4387.714798538085;4301.526832048472;4342.196693611692;4346.956530434687;4348.4999225089205;4398.516163222043;4346.413234213373;4375.803088861009;4397.164538737629;4402.7798610069685;4432.578905004052;4510.526394728572;4580.290055041474;4658.045100754337;4679.15775160471;4698.671093023456;4992.525710057539;5004.174311238641;5010.799568017275;5013.774380152865;5016.423111342206;5004.649674522785;5039.09296326661;5041.1682072458;5041.647084704072;5097.3118628984985;4610.56199661035;4681.6722829401615;4746.644001699887;4796.232602783538;4802.471728109905;5140.46025167352;5149.665271757323;5153.201253805666;5205.29728486657;5214.165733482625;4781.784819683053;4920.950790492121;4921.483244259372;4922.064807686528;4961;5071.163258062452;5088.414832294334;5124.846254612367;5169.586433085344;5180.8963820723375;5043.5965122790085;5061.417936937226;5067.493250674903;5080.59355251579;5121.436641969381;4895.31465594817;4993.825216117419;5032.245163225472;5052.166392545262;5053.090443720165;4247.702660813713;4321.632661223831;4363.738175709467;4383.979580645478;4399.934000989988;3764.0589852536864;3779.640934111255;3786.678132358725;3820.8853734388013;3826.9808650956566;4239.130978149472;4397.054633253866;4404.4714634243455;4405.405270288534;4453.665975051819;5105.591552675777;5130.51260130287;5155.252488389237;5201.141811601119;5210.348706411699;4392.450943632046;4404.053128577371;4405.185040767468;4408.316710909814;4451.9554804451545;4441.133978874153;4595.035042641083;4611.746353950565;4612.238980568236;4641.907161856811;4749.335093086902;4770.856874293777;4774.40319960005;4783.234682450791;4811.9518804811505;5134.998675258438;5138.743062846768;5138.948610513997;5144.845654630367;5172.767225474788;4539.909201816011;4673.322368256516;4765.070811191785;4778.259369797687;4841.733704646278;5022.3219865317715;5039.722815245197;5042.84871453857;5062.670926389773;5088.2876397305145;5106.897862042812;5115.15599926023;5116.872078198075;5117.8720531987;5163.638545301793;4778.808847646055;4882.487338829514;4962.503749625009;4962.503749625153;4974.0797952378925;4933.55597996182;4950.430700469492;4957.529034741694;4959.900801984012;4962.801487940442;4871.48849370811;4909.214525675875;4911.803527858846;4917.188663870421;4926.679765815211;4808.230683090689;4920.1389756791705;5012.899742005213;5014.824481143142;5053.343065401475;4800.591949684316;4812;4814.301926220748;4827.324174615486;4868.9756551217015 16:04:56 INFO - PROCESS | 7536 | |1;ext.html;575.8675504633934;582.8018473718935;604.5979423683248;610.6153123532174;613.5858295650436;26375.6043659345;26992.32519187021;27003.45993080137;27022.459550808973;27038.188854334352;26620.201393958163;34895.65104348956;36035.63964360362;36102.2779544409;36213.0946726332;7629.8474030519355;7817.8827317590285;7820.687172513092;7823.960880195591;7826.960865195694;7238.203797582261;7669.961650191742;7798.415118866108;7798.883016754753;7802.024746906637;9802.6963663539;10257.794844103113;10258.948705256464;10259.974002599754;10261.665983422145;9681.56432960515;9819;9820.754481137958;9825.164860986824;9826.1156495915;7160.427165826722;9636.662716804949;9666.420014799134;9779.022097790235;10093.798124037477;33192.83403582991;33820.661793381994;33859;33918;33948.660513394796;3081.137281561144;3166.920826979344;3227.386796508656;3261.4781634938295;3612.0789198754414;28778.71221287802;29729.70270297291;29790.255243618867;29821.850890745623;30301.090967270797;3155.3373791503814;3175.4442972479956;3218.356328734239;3267.460868956643;3281.7210537104374;203975;204056;204871;205443;205502;52600.21099683508;52838.20742688863;53019;53112.203316950276;53300.466995330324;54826;55344.446555534734;55484;55501.722491387285;55511;13857.099288546213;14016.85983140176;14075.507357242448;14095.224762637949;14112;10439.739006524898;10516;10525;10542.472876356305;10549.419781912069;15896.284667190004;16999.575010624587;17401;17723.556911077325;17800.91099544494;5553.778168802857;5956.880862382728;6004.609700369462;6073.848153796191;6098.35967223444;806.6813608624677;880.3045593980684;920.3833431600843;924.5885580916562;1067.8665166854144;23818;25076.749232507806;26335.41614596351;26392.20823375302;26854;976.7606936300651;986.6743974488402;998.2114129837347;1001.9599216031277;1039.7712503249272;13550;14070;14221.715565688628;14255.714885702435;14337;318891;326439;328040;328148;329801;48004.75997620059;48286.27570586444;48417.515824842005;48420;48455;1158.1314014489133;1202.8436303280694;1204.722913729847;1222.7615614954998;1226.834377359045;24910.875445622656;26212.737872621794;26315;26350;26394;39419.60580394274;39958.2008359837;39980.2003959925;40054.59945400509;40094.1981160381;309470;313465;313760;314889;315851;22998;24728.752712473364;25274.873625631753;25462.962962963287;26313.473730525664;36418;36663.45004824983;36940.26119477649;37459.06352341213;37564.81217593895;31625;31998;32253;33898.66101338955;35147.121321967155;33598.49602255919;33738.662613373555;34435.31129377449;34440.65559344374;34744.82627586947;33534.161645959044;33570.16074598154;33930.49104263487;35864.46203307005;37099;27188.864055680388;28505.857470712515;30391.240218994702;30989.535156973114;31305.686943130277;24168.154114605903;24539.263822085366;25018.624720628843;25848.8707556461;27896.163115106578 16:04:56 INFO - PROCESS | 7536 | |2;jquery.html;376.83419295509975;380.2698818268925;389.5383969995556;392.06296950288817;400.67144941148234;15366.615834604127;16122.596935076628;16255.187240637964;16264;16286.674266514663;15160.241987900616;15972.201389930486;16593;16596.08721520316;16607.169641517936;5039.59683225342;5272.420033796279;5315.0432922074015;5317.627766056377;5324;3662.304162209172;5662.235598194253;5998.55010874184;6009.1286763419275;6011.969940150315;5107;5952.761889524414;5959.910601340962;5962.97018514909;5978.910316345258;5337.626366154371;5356.758945847446;5372.409035006166;5374.892502149935;5375.7849686012705;3356.7146792522667;3558.1104723819044;3558.5018097466377;3558.893233202982;4916.0905232532095;11916;12213.084018698544;12229.816552751716;12526.937365313206;18968.43094707161;1799.6940520111611;1846.639905218483;1921.9039048047541;1963.2245263120988;2023.9595208095755;9057.818843623156;9062.909370906273;9109.908900910972;9446;10279.537420816081;1742.7124524453577;1771.5128339706555;1782.5098098023018;1795.5152108930647;1819.5451137215696;63548.68225658889;66046;66417;66563.00155497719;67698;10237.283390162765;10284.485775711184;10326.277160598836;10335.379877207391;10354.17166626668;14522.782158267635;14621.488247911271;14637.780433293508;14651.12093274407;14676.486322978644;7030.564200782089;7329.644015856977;7339.853202935911;7368.415800581731;7393.334599886036;6666.799996000128;6726.058351830748;6769.864602708017;6835.213950395669;6864.073350097673;4314.158739045919;4324.13517296542;4381.058072514425;4386.12277544486;4415.66882483815;1674.2169589387506;1780.3234770787276;1828.387490190801;1842.4010903194508;1848.6210326882956;880.4629176202511;884.743903047227;919.5034681272039;978.5303054533864;979.6326377608397;15911.204439778196;16275.91862040706;16366.836331636769;16830.831691682928;17023.91488042552;837.5058715357968;878.3851304087165;879.366855863777;937.4796987671907;954.6515521834481;8445.028821685462;8800.16398442147;8823.117688231125;8833.734987950373;8976.102389760972;396567;400979;405158;407054;409726;77328.61335693399;81622.59188704018;82043;82064.58967705123;82488.17511824805;941.1905761045496;989.1147423056324;991.2615101749099;994.5782020779425;1005.1707341443339;15341.769873452131;15506;15580.844191557939;15603.843961560693;16117.63000144954;32996.67003329936;33198.5020224692;34317.65682343145;34394.14014649654;35027.299454011285;46552.301715473615;48771;48772.5122748768;48846;49413.50586494089;7616.35261002821;7643.617819109134;7743.5353878767455;7778.649960751666;7792.844143116992;8439.409241353047;10493.265471416928;11250.774984500427;11303.943480282545;11468.827967580326;9482;9552.665656701982;9954.054364835329;10006.249531285328;10195.949020254851;8317.334613231049;9439.480828554495;9884.456354900549;10014.599416023277;10197.337173083726;9984.35101718386;10048.544659088499;10101.69694909154;10311.948440257751;10355.637552685619;6469.935300647122;6835.3506416892305;6892;7015;7074.540154889915;9064.954675226581;9915.107640312406;10053.296269261082;10107.494625268855;10190.74523136898 16:04:56 INFO - PROCESS | 7536 | |3;mootools.html;1267.721101357702;1422.3812641500945;1451.3976699669638;1569.5919061044126;1775.272138423246;7392.260773922611;7690.384769218449;7707.576083315423;7717.652705628247;7735.535867847933;7510.136334321554;7657.961710191441;7670.769876903688;7672.769816905502;7675.424343174271;1901.5341241395877;2203.5703037907615;2224.5995720770215;2256.458449972003;2277.738060123082;2233.8436309458343;2240.7871252231093;2246.1801442473543;2253.4479052632128;2256.7856053674873;2220.356096731946;2274.6360582306834;2274.7042884425;2277.20297895736;2277.9658305125354;1877.558773688182;2104.3266154830535;2167.3389616167065;2172.250573552122;2174.239016344283;2171.1532502324108;2179.901904414305;2185.4208634711813;2185.8032777050144;2235.9552808943895;7577.469577129603;7587.81030474237;7656.80857978555;7662.1571627120975;7668.808279792994;4529.909401811945;4603.562661547147;4645.187092258841;4656.4877863434995;4716.292556116576;3000.429918315513;3013.1563162314587;3068.815871047744;3082.106189205128;3099.271671157299;928.4104593583123;939.8073394954018;943.3160958305174;951.7192428233687;955.7037318431309;10673.626423075155;10682.51928663212;10695.732606684818;10703.625373111903;10712.517936692868;4259.488861336597;4285.46431696038;4415.492218394926;4436.977815110969;4460.464744230713;8131.349492040623;8220.753377398687;8248.175182481704;8251.669933202726;8261.669533218605;4115.54728979812;4631.397918270603;4666.906661866744;4676.158291507561;4706.1764191267075;3857.633524815138;3861.2663593917064;3873.2640798248244;4176.9582304177175;4337.544557821383;3381.814000229962;3413.863445462154;3474.7220222382653;3491.266833964896;3533.0990597398013;1065.0999905080196;1082.6751974407646;1084.511969613677;1088.4612117001977;1095.3044816541553;787.4527203593448;830.1781236575868;837.0657907833208;845.7716416567492;849.3841964575633;5091.41448733393;5276.366835979707;5368.872536767244;5430;5523.364813046471;822.6627082895984;829.0548774397192;900.4192295969063;906.6237511432813;926.1525703980917;3611.2777444510675;3746.1758413149064;3836.712246581518;3861.517310336208;3923;9098.272138229058;9279.072092790802;9475.526223688788;9667.226621870233;9696.175825054808;9449;9462.810743785223;9525.523723813782;9530.52347382628;9579.856302155473;7008.859822803617;7012.789616311519;7068;7184.49708520409;7192.0290760747675;5074.289599456153;5099.56653684441;5155.922661160161;5202.869928251824;5286.81496147633;8623.956880215559;8695.478271303742;8718;8787.604557794786;8794.736157915273;8476.449030812977;8753.34349923771;8861.512616806138;8932.821343573221;8987.505687187006;5893.263342082239;6530.47756179514;6555.082288479522;6650.73397064112;6759.864802704017;7346.816329591803;7445.9255407445235;7485.850282994418;7503;7508.662110205163;6486;6692.564983276072;6698.966505167443;6782.1861376635115;6847.828804279933;6604.745098431283;6627.204735431779;6630.237522684953;6691.297413771484;6782.525223234326;6318.652474113968;6327.11420401135;6341;6349.777757778455;6365.586236894587;4345.217860785089;4482.6862119652615;4625.814967401401;4653.953460465352;4676.485586585405;4301.9354709678755;4386.517483076923;4440.156370289635;4464.995376040365;4531.342955271533 16:04:56 INFO - PROCESS | 7536 | |4;prototype.html;308.3309218994781;314.145524174246;320.43123455865833;324.0941568316555;324.7905101209721;5153.51041651043;5183.663061900978;5188.974055129728;5210.8697282567955;5218.425973142951;5097.5157360050825;5099.59203263739;5104.208847628614;5123.180291153416;5131.692098474095;3791.5829258781514;3888.1251718363424;4033.1731994940965;4045.4943132108488;4059.918801623966;4015.2973229684835;4019.6985226108013;4031.2945234583976;4033.475648165734;4039.8788036358956;3775.9433608495756;3996.6802655787615;4007.3788562772816;4009.6391324780766;4014.518257809067;3877.243937432202;3999.4400783890133;4035.233305671942;4035.7982100894837;4036.192761447722;3557.7509574329806;3560.964390356089;3563.0914116900285;3575.713942884563;3585.175409655768;4929.088118698052;4947.82682606107;4948.529889660476;4959.206526955706;4978.950210497885;4535.433070866142;4603.631709463235;4643.210654188796;4659.370984917026;4668.253079507263;5333.866653333659;5380.139177731544;5381.78472861089;5405.21624364465;5410.486003829669;3592.910177245564;3858.4791053207737;3870.632289932452;3872.2255548890334;3877.321468742987;5581.832545023656;5639.802606908779;5648.54811615074;5663.546916246732;5686.203931449559;3846.74996125251;3856.014152711356;3863.343231650626;3865.3235683755793;3867.207222519433;3921.941170882439;3931.2334094851803;3935.901602459904;3938.3501722215515;3952.9011774705286;4407.118576284756;4456.14806523825;4501.909961800811;4511.661625378044;4517.6837621366185;5354.598405119632;5361.892762144736;5376.301080859542;5383.892322153535;5392.299001129828;1349.9325033748469;1367.2548461088732;1369.9109557878905;1372.670559065817;1374.154894739728;897.3359713811732;904.326276923696;931.1991687149047;931.9068093190626;939.6945992552447;4723.409573803275;4730.716157030589;4743;4755.83354582588;4760.738159401197;5550.91673624896;5555.638883472561;5556.888862222733;5570.6657600544095;5570.880307028077;4614.953850461452;4728.290756386569;4753.667243292936;4757.714537127784;4767.928481072787;2936.1778701963485;2964.688707685705;2965.288330800592;2971.390864872696;2978.74680652147;5174.741262936838;5186.481351864783;5198.064348417245;5203.765830537559;5212.25389494516;5471.644343117685;5634.718264086861;5670.262865827416;5674.460926212003;5689.829305120853;5169.844904652867;5170.353705786777;5180.533751962342;5182.818601348935;5183.97408012965;5388.922215556982;5527;5528.281323427928;5535.169724541351;5557.083081291542;5351.090314646597;5372.1941708744;5374.435684253253;5401;5401.594880383908;4665.836695715634;5144.254083157846;5162.380514338153;5184.351956005499;5187.299714538489;3539.6549311261556;3797.6202379761803;3887.067103894988;3895.844166233319;3896.551896531935;5340.385855626652;5433.728313584226;5492.5605951524585;5530.751116199861;5541.476094074162;5419.674819510842;5423.728813559385;5432.185172224198;5432.511074003359;5456.61803673739;5430.375506816767;5431.8098866539485;5432.701201433801;5432.755526001419;5442.945570544244;5159.277701121771;5347.144456886879;5351.812686556108;5356.437574054668;5366.758495867617;5419.918701219406;5427.158790387496;5435.076037073628;5444.945550544602;5458.1266997280245;5192.547824783886;5333.759980800795;5339.78640854377;5349.411564727955;5352.143657014859 16:04:56 INFO - PROCESS | 7536 | |5;yui.html;647.1425361396151;660.940515353618;677.7153595489897;715.685098556635;774.4578794843609;11847.7630447391;11946.402679866016;12012.2792632442;12013.699657508567;12021.819672704916;11618;11646;11764;11765.588204412847;11865.466054027567;801.447001568917;816.979575510614;817.7056259746487;817.791463176889;818.6929901287017;639.1403562208822;767.4090949968521;792.2077922077922;804.1757198871145;805.5207151744703;835.1898658301468;835.3692961813853;835.3734698975768;835.6448509383519;836.2766207230732;822.5804839531881;831.3723139030024;832.1512057701111;832.5961908474385;833.0836080311669;485.8955324605192;494.80207916833194;496.12434053894907;597.3250227243187;614.3119705929344;11626.24429412094;11681.883181168165;11708.473118709679;11723.120765942589;11747.118966077493;11829.94085029578;12219;12393.194442361308;12607.180533265308;12843.614691559269;9743.317967742261;9765.804683906354;9842.704718858375;9938.254630902711;10092.697219083439;3331.2338162222823;3353.178471274529;3362.1090411041096;3405.1997780521556;3440.7591468597207;43782.56217437817;44352.556474435485;44424.77787611073;44468.77765611151;45370.546294536965;9888.604455821831;9944.850827237597;10035.849462258071;10225.181985441295;10238.436885971194;16369.953755780527;16559.6688066238;16588;16608.086555239577;16627.750583741254;6707.228668703064;7034.6482675866;7104.822379440556;7158.892616610755;7188.245234250433;3864.478295430081;3894.7857867816974;3902.083010492532;3960.782156981336;4068.8575899843363;2920.5473151661104;3011.5633233181065;3012.036148432481;3020.864061117255;3023.380207057548;503.7758197602032;510.5481648740891;517.647999360431;525.254139122447;526.4314540296547;571.8827640333722;585.2070444547662;603.0532064658531;604.4167378479788;627.4008322052429;7321.74373896911;7602.543847369176;7711;7759.961200193963;7777.222277772177;477.6799544305324;544.8120398462524;574.6611292041434;594.7293981238527;595.615827791081;3530;3566.8751593694096;3579.266250418658;3633.3823250047553;3717.1636381813873;52781;52876.47123528792;53492;53503;53565;45642.54357456383;45715;45831.5416845834;46059.53940460552;46380.7680961593;41945.37081943773;42268.788656056524;42601.14797704029;42776.3583546247;43486.13027739427;6839.22180233133;6897.413719833669;6900.551464154814;6924.757633482804;7011.8247043822275;26037;28131.296717582223;28837;28940.7105928938;29135.562966555943;35113.648863511036;35332;35386.29227415489;36132.4580131293;36511.81744091262;10326.122279606017;10339.431331276852;10359.896401036194;10394;10604;11714.1800073994;11725.179237453638;11773.47019384147;11836;11887.643370698894;10402.167826574007;10429.11352535043;10615;10679.5194216262;10794.730131746455;10960.616378426717;10994.780104398027;11053.28153670009;11072.280301780358;11384.14618903569;9977.800443991226;10713.89286107129;10720.517576708911;10734.83897741519;10741.516631751434;9025.368224224241;9062.086526699559;9390.859137113086;9478.289128315266;9752.804943900941;8708.825823483621;8713.651453941771;9479.289053321167;9576.76058098553;9663.9033609663 16:04:56 INFO - PROCESS | 7536 | __end_tp_report 16:04:56 INFO - PROCESS | 7536 | __start_cc_report 16:04:56 INFO - PROCESS | 7536 | _x_x_mozilla_cycle_collect,969 16:04:56 INFO - PROCESS | 7536 | __end_cc_report 16:04:56 INFO - PROCESS | 7536 | __startTimestamp1460588696952__endTimestamp 16:04:56 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | ------- Summary: start ------- 16:04:56 INFO - PROCESS | 7536 | Number of tests: 6 16:04:56 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | [#0] dojo.html Cycles:165 Average:4689.59 Median:4797.66 stddev:483.84 (10.1%) stddev-sans-first:457.29 16:04:56 INFO - PROCESS | 7536 | Values: 2620.6 2683.4 2687.9 2699.2 2718.6 4514.1 4640.8 4730.3 4732.3 4733.5 4701.6 4713.6 4789.8 4797.7 4810.3 4268.3 4341.2 4375.7 4434.3 4482.7 4419.2 4449.3 4460.4 4468.5 4487.0 4268.3 4278.1 4348.8 4364.3 4387.7 4301.5 4342.2 4347.0 4348.5 4398.5 4346.4 4375.8 4397.2 4402.8 4432.6 4510.5 4580.3 4658.0 4679.2 4698.7 4992.5 5004.2 5010.8 5013.8 5016.4 5004.6 5039.1 5041.2 5041.6 5097.3 4610.6 4681.7 4746.6 4796.2 4802.5 5140.5 5149.7 5153.2 5205.3 5214.2 4781.8 4921.0 4921.5 4922.1 4961.0 5071.2 5088.4 5124.8 5169.6 5180.9 5043.6 5061.4 5067.5 5080.6 5121.4 4895.3 4993.8 5032.2 5052.2 5053.1 4247.7 4321.6 4363.7 4384.0 4399.9 3764.1 3779.6 3786.7 3820.9 3827.0 4239.1 4397.1 4404.5 4405.4 4453.7 5105.6 5130.5 5155.3 5201.1 5210.3 4392.5 4404.1 4405.2 4408.3 4452.0 4441.1 4595.0 4611.7 4612.2 4641.9 4749.3 4770.9 4774.4 4783.2 4812.0 5135.0 5138.7 5138.9 5144.8 5172.8 4539.9 4673.3 4765.1 4778.3 4841.7 5022.3 5039.7 5042.8 5062.7 5088.3 5106.9 5115.2 5116.9 5117.9 5163.6 4778.8 4882.5 4962.5 4962.5 4974.1 4933.6 4950.4 4957.5 4959.9 4962.8 4871.5 4909.2 4911.8 4917.2 4926.7 4808.2 4920.1 5012.9 5014.8 5053.3 4800.6 4812.0 4814.3 4827.3 4869.0 16:04:56 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | [#1] ext.html Cycles:180 Average:43133.35 Median:164853.23 stddev:75303.59 (45.7%) stddev-sans-first:75447.04 16:04:56 INFO - PROCESS | 7536 | Values: 575.9 582.8 604.6 610.6 613.6 26375.6 26992.3 27003.5 27022.5 27038.2 26620.2 34895.7 36035.6 36102.3 36213.1 7629.8 7817.9 7820.7 7824.0 7827.0 7238.2 7670.0 7798.4 7798.9 7802.0 9802.7 10257.8 10258.9 10260.0 10261.7 9681.6 9819.0 9820.8 9825.2 9826.1 7160.4 9636.7 9666.4 9779.0 10093.8 33192.8 33820.7 33859.0 33918.0 33948.7 3081.1 3166.9 3227.4 3261.5 3612.1 28778.7 29729.7 29790.3 29821.9 30301.1 3155.3 3175.4 3218.4 3267.5 3281.7 203975.0 204056.0 204871.0 205443.0 205502.0 52600.2 52838.2 53019.0 53112.2 53300.5 54826.0 55344.4 55484.0 55501.7 55511.0 13857.1 14016.9 14075.5 14095.2 14112.0 10439.7 10516.0 10525.0 10542.5 10549.4 15896.3 16999.6 17401.0 17723.6 17800.9 5553.8 5956.9 6004.6 6073.8 6098.4 806.7 880.3 920.4 924.6 1067.9 23818.0 25076.7 26335.4 26392.2 26854.0 976.8 986.7 998.2 1002.0 1039.8 13550.0 14070.0 14221.7 14255.7 14337.0 318891.0 326439.0 328040.0 328148.0 329801.0 48004.8 48286.3 48417.5 48420.0 48455.0 1158.1 1202.8 1204.7 1222.8 1226.8 24910.9 26212.7 26315.0 26350.0 26394.0 39419.6 39958.2 39980.2 40054.6 40094.2 309470.0 313465.0 313760.0 314889.0 315851.0 22998.0 24728.8 25274.9 25463.0 26313.5 36418.0 36663.5 36940.3 37459.1 37564.8 31625.0 31998.0 32253.0 33898.7 35147.1 33598.5 33738.7 34435.3 34440.7 34744.8 33534.2 33570.2 33930.5 35864.5 37099.0 27188.9 28505.9 30391.2 30989.5 31305.7 24168.2 24539.3 25018.6 25848.9 27896.2 16:04:56 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | [#2] jquery.html Cycles:180 Average:24220.14 Median:4400.90 stddev:66660.00 (1514.7%) stddev-sans-first:66822.95 16:04:56 INFO - PROCESS | 7536 | Values: 376.8 380.3 389.5 392.1 400.7 15366.6 16122.6 16255.2 16264.0 16286.7 15160.2 15972.2 16593.0 16596.1 16607.2 5039.6 5272.4 5315.0 5317.6 5324.0 3662.3 5662.2 5998.6 6009.1 6012.0 5107.0 5952.8 5959.9 5963.0 5978.9 5337.6 5356.8 5372.4 5374.9 5375.8 3356.7 3558.1 3558.5 3558.9 4916.1 11916.0 12213.1 12229.8 12526.9 18968.4 1799.7 1846.6 1921.9 1963.2 2024.0 9057.8 9062.9 9109.9 9446.0 10279.5 1742.7 1771.5 1782.5 1795.5 1819.5 63548.7 66046.0 66417.0 66563.0 67698.0 10237.3 10284.5 10326.3 10335.4 10354.2 14522.8 14621.5 14637.8 14651.1 14676.5 7030.6 7329.6 7339.9 7368.4 7393.3 6666.8 6726.1 6769.9 6835.2 6864.1 4314.2 4324.1 4381.1 4386.1 4415.7 1674.2 1780.3 1828.4 1842.4 1848.6 880.5 884.7 919.5 978.5 979.6 15911.2 16275.9 16366.8 16830.8 17023.9 837.5 878.4 879.4 937.5 954.7 8445.0 8800.2 8823.1 8833.7 8976.1 396567.0 400979.0 405158.0 407054.0 409726.0 77328.6 81622.6 82043.0 82064.6 82488.2 941.2 989.1 991.3 994.6 1005.2 15341.8 15506.0 15580.8 15603.8 16117.6 32996.7 33198.5 34317.7 34394.1 35027.3 46552.3 48771.0 48772.5 48846.0 49413.5 7616.4 7643.6 7743.5 7778.6 7792.8 8439.4 10493.3 11250.8 11303.9 11468.8 9482.0 9552.7 9954.1 10006.2 10195.9 8317.3 9439.5 9884.5 10014.6 10197.3 9984.4 10048.5 10101.7 10311.9 10355.6 6469.9 6835.4 6892.0 7015.0 7074.5 9065.0 9915.1 10053.3 10107.5 10190.7 16:04:56 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | [#3] mootools.html Cycles:180 Average:5073.06 Median:5281.59 stddev:2797.80 (53.0%) stddev-sans-first:2791.03 16:04:56 INFO - PROCESS | 7536 | Values: 1267.7 1422.4 1451.4 1569.6 1775.3 7392.3 7690.4 7707.6 7717.7 7735.5 7510.1 7658.0 7670.8 7672.8 7675.4 1901.5 2203.6 2224.6 2256.5 2277.7 2233.8 2240.8 2246.2 2253.4 2256.8 2220.4 2274.6 2274.7 2277.2 2278.0 1877.6 2104.3 2167.3 2172.3 2174.2 2171.2 2179.9 2185.4 2185.8 2236.0 7577.5 7587.8 7656.8 7662.2 7668.8 4529.9 4603.6 4645.2 4656.5 4716.3 3000.4 3013.2 3068.8 3082.1 3099.3 928.4 939.8 943.3 951.7 955.7 10673.6 10682.5 10695.7 10703.6 10712.5 4259.5 4285.5 4415.5 4437.0 4460.5 8131.3 8220.8 8248.2 8251.7 8261.7 4115.5 4631.4 4666.9 4676.2 4706.2 3857.6 3861.3 3873.3 4177.0 4337.5 3381.8 3413.9 3474.7 3491.3 3533.1 1065.1 1082.7 1084.5 1088.5 1095.3 787.5 830.2 837.1 845.8 849.4 5091.4 5276.4 5368.9 5430.0 5523.4 822.7 829.1 900.4 906.6 926.2 3611.3 3746.2 3836.7 3861.5 3923.0 9098.3 9279.1 9475.5 9667.2 9696.2 9449.0 9462.8 9525.5 9530.5 9579.9 7008.9 7012.8 7068.0 7184.5 7192.0 5074.3 5099.6 5155.9 5202.9 5286.8 8624.0 8695.5 8718.0 8787.6 8794.7 8476.4 8753.3 8861.5 8932.8 8987.5 5893.3 6530.5 6555.1 6650.7 6759.9 7346.8 7445.9 7485.9 7503.0 7508.7 6486.0 6692.6 6699.0 6782.2 6847.8 6604.7 6627.2 6630.2 6691.3 6782.5 6318.7 6327.1 6341.0 6349.8 6365.6 4345.2 4482.7 4625.8 4654.0 4676.5 4301.9 4386.5 4440.2 4465.0 4531.3 16:04:56 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | [#4] prototype.html Cycles:180 Average:4462.32 Median:5137.97 stddev:1300.34 (25.3%) stddev-sans-first:1266.05 16:04:56 INFO - PROCESS | 7536 | Values: 308.3 314.1 320.4 324.1 324.8 5153.5 5183.7 5189.0 5210.9 5218.4 5097.5 5099.6 5104.2 5123.2 5131.7 3791.6 3888.1 4033.2 4045.5 4059.9 4015.3 4019.7 4031.3 4033.5 4039.9 3775.9 3996.7 4007.4 4009.6 4014.5 3877.2 3999.4 4035.2 4035.8 4036.2 3557.8 3561.0 3563.1 3575.7 3585.2 4929.1 4947.8 4948.5 4959.2 4979.0 4535.4 4603.6 4643.2 4659.4 4668.3 5333.9 5380.1 5381.8 5405.2 5410.5 3592.9 3858.5 3870.6 3872.2 3877.3 5581.8 5639.8 5648.5 5663.5 5686.2 3846.7 3856.0 3863.3 3865.3 3867.2 3921.9 3931.2 3935.9 3938.4 3952.9 4407.1 4456.1 4501.9 4511.7 4517.7 5354.6 5361.9 5376.3 5383.9 5392.3 1349.9 1367.3 1369.9 1372.7 1374.2 897.3 904.3 931.2 931.9 939.7 4723.4 4730.7 4743.0 4755.8 4760.7 5550.9 5555.6 5556.9 5570.7 5570.9 4615.0 4728.3 4753.7 4757.7 4767.9 2936.2 2964.7 2965.3 2971.4 2978.7 5174.7 5186.5 5198.1 5203.8 5212.3 5471.6 5634.7 5670.3 5674.5 5689.8 5169.8 5170.4 5180.5 5182.8 5184.0 5388.9 5527.0 5528.3 5535.2 5557.1 5351.1 5372.2 5374.4 5401.0 5401.6 4665.8 5144.3 5162.4 5184.4 5187.3 3539.7 3797.6 3887.1 3895.8 3896.6 5340.4 5433.7 5492.6 5530.8 5541.5 5419.7 5423.7 5432.2 5432.5 5456.6 5430.4 5431.8 5432.7 5432.8 5442.9 5159.3 5347.1 5351.8 5356.4 5366.8 5419.9 5427.2 5435.1 5444.9 5458.1 5192.5 5333.8 5339.8 5349.4 5352.1 16:04:56 INFO - PROCESS | 7536 | 16:04:56 INFO - PROCESS | 7536 | [#5] yui.html Cycles:180 Average:12475.52 Median:44446.78 stddev:14209.26 (32.0%) stddev-sans-first:14221.35 16:04:56 INFO - PROCESS | 7536 | Values: 647.1 660.9 677.7 715.7 774.5 11847.8 11946.4 12012.3 12013.7 12021.8 11618.0 11646.0 11764.0 11765.6 11865.5 801.4 817.0 817.7 817.8 818.7 639.1 767.4 792.2 804.2 805.5 835.2 835.4 835.4 835.6 836.3 822.6 831.4 832.2 832.6 833.1 485.9 494.8 496.1 597.3 614.3 11626.2 11681.9 11708.5 11723.1 11747.1 11829.9 12219.0 12393.2 12607.2 12843.6 9743.3 9765.8 9842.7 9938.3 10092.7 3331.2 3353.2 3362.1 3405.2 3440.8 43782.6 44352.6 44424.8 44468.8 45370.5 9888.6 9944.9 10035.8 10225.2 10238.4 16370.0 16559.7 16588.0 16608.1 16627.8 6707.2 7034.6 7104.8 7158.9 7188.2 3864.5 3894.8 3902.1 3960.8 4068.9 2920.5 3011.6 3012.0 3020.9 3023.4 503.8 510.5 517.6 525.3 526.4 571.9 585.2 603.1 604.4 627.4 7321.7 7602.5 7711.0 7760.0 7777.2 477.7 544.8 574.7 594.7 595.6 3530.0 3566.9 3579.3 3633.4 3717.2 52781.0 52876.5 53492.0 53503.0 53565.0 45642.5 45715.0 45831.5 46059.5 46380.8 41945.4 42268.8 42601.1 42776.4 43486.1 6839.2 6897.4 6900.6 6924.8 7011.8 26037.0 28131.3 28837.0 28940.7 29135.6 35113.6 35332.0 35386.3 36132.5 36511.8 10326.1 10339.4 10359.9 10394.0 10604.0 11714.2 11725.2 11773.5 11836.0 11887.6 10402.2 10429.1 10615.0 10679.5 10794.7 10960.6 10994.8 11053.3 11072.3 11384.1 9977.8 10713.9 10720.5 10734.8 10741.5 9025.4 9062.1 9390.9 9478.3 9752.8 8708.8 8713.7 9479.3 9576.8 9663.9 16:04:56 INFO - PROCESS | 7536 | -------- Summary: end -------- 16:04:56 INFO - PROCESS | 7536 | 16:04:57 INFO - TEST-INFO | 7536: exit 0 16:04:57 INFO - TEST-OK | dromaeo_css | took 1119363ms 16:04:57 INFO - TEST-START | kraken 16:04:57 INFO - operating with platform_type : linux_ 16:04:57 INFO - Initialising browser for kraken test... 16:04:57 INFO - TEST-INFO | started process 7711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9nFrzN/profile http://localhost:36100/getInfo.html) 16:05:01 INFO - PROCESS | 7711 | __metrics Screen width/height:1600/1200 16:05:01 INFO - PROCESS | 7711 | colorDepth:24 16:05:01 INFO - PROCESS | 7711 | Browser inner width/height: 1024/697 16:05:01 INFO - PROCESS | 7711 | __metrics 16:05:03 ERROR - PROCESS | 7711 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:05:03 INFO - TEST-INFO | 7711: exit 0 16:05:03 INFO - Browser initialized. 16:05:03 INFO - Running cycle 1/1 for kraken test... 16:05:03 INFO - TEST-INFO | started process 7790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9nFrzN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:15 INFO - PROCESS | 7790 | RSS: Main: 154677248 16:05:15 INFO - PROCESS | 7790 | 16:05:18 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36100/tests/kraken/driver.html?testName=audio-beat-detection) 16:05:19 INFO - PROCESS | 7790 | RSS: Main: 209629184 16:05:19 INFO - PROCESS | 7790 | 16:05:22 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36100/tests/kraken/driver.html?testName=audio-dft) 16:05:22 INFO - PROCESS | 7790 | RSS: Main: 195231744 16:05:22 INFO - PROCESS | 7790 | 16:05:25 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36100/tests/kraken/driver.html?testName=audio-fft) 16:05:26 INFO - PROCESS | 7790 | RSS: Main: 265494528 16:05:26 INFO - PROCESS | 7790 | 16:05:28 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36100/tests/kraken/driver.html?testName=audio-oscillator) 16:05:29 INFO - PROCESS | 7790 | RSS: Main: 174428160 16:05:29 INFO - PROCESS | 7790 | 16:05:31 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:05:32 INFO - PROCESS | 7790 | RSS: Main: 178319360 16:05:32 INFO - PROCESS | 7790 | 16:05:35 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36100/tests/kraken/driver.html?testName=imaging-darkroom) 16:05:35 INFO - PROCESS | 7790 | RSS: Main: 213991424 16:05:35 INFO - PROCESS | 7790 | 16:05:39 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36100/tests/kraken/driver.html?testName=imaging-desaturate) 16:05:39 INFO - PROCESS | 7790 | RSS: Main: 215207936 16:05:39 INFO - PROCESS | 7790 | 16:05:42 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36100/tests/kraken/driver.html?testName=json-parse-financial) 16:05:43 INFO - PROCESS | 7790 | RSS: Main: 215281664 16:05:43 INFO - PROCESS | 7790 | 16:05:45 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:05:45 INFO - PROCESS | 7790 | RSS: Main: 201846784 16:05:45 INFO - PROCESS | 7790 | 16:05:47 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36100/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:05:48 INFO - PROCESS | 7790 | RSS: Main: 205090816 16:05:48 INFO - PROCESS | 7790 | 16:05:50 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:05:50 INFO - PROCESS | 7790 | RSS: Main: 218169344 16:05:50 INFO - PROCESS | 7790 | 16:05:53 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:54 INFO - PROCESS | 7790 | RSS: Main: 223707136 16:05:54 INFO - PROCESS | 7790 | 16:05:57 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:57 INFO - PROCESS | 7790 | RSS: Main: 219123712 16:05:57 INFO - PROCESS | 7790 | 16:05:59 INFO - PROCESS | 7790 | Cycle 1(1): loaded http://localhost:36100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36100/tests/kraken/driver.html?testName=ai-astar) 16:06:00 INFO - PROCESS | 7790 | RSS: Main: 282112000 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | __start_tp_report 16:06:00 INFO - PROCESS | 7790 | _x_x_mozilla_page_load 16:06:00 INFO - PROCESS | 7790 | _x_x_mozilla_page_load_details 16:06:00 INFO - PROCESS | 7790 | |i|pagename|runs| 16:06:00 INFO - PROCESS | 7790 | |0;ai-astar;114;116;108;113;114;113;103;113;115;117 16:06:00 INFO - PROCESS | 7790 | |1;audio-beat-detection;166;135;152;176;131;163;155;131;185;138 16:06:00 INFO - PROCESS | 7790 | |2;audio-dft;161;161;161;162;162;163;161;161;163;164 16:06:00 INFO - PROCESS | 7790 | |3;audio-fft;84;73;91;114;73;73;73;107;101;73 16:06:00 INFO - PROCESS | 7790 | |4;audio-oscillator;94;94;146;94;94;95;148;93;94;138 16:06:00 INFO - PROCESS | 7790 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 16:06:00 INFO - PROCESS | 7790 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;147;145 16:06:00 INFO - PROCESS | 7790 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 16:06:00 INFO - PROCESS | 7790 | |8;json-parse-financial;63;64;63;62;62;63;64;79;62;61 16:06:00 INFO - PROCESS | 7790 | |9;json-stringify-tinderbox;64;63;64;63;63;63;63;63;64;63 16:06:00 INFO - PROCESS | 7790 | |10;stanford-crypto-aes;84;85;84;84;86;91;86;85;87;93 16:06:00 INFO - PROCESS | 7790 | |11;stanford-crypto-ccm;150;139;137;146;137;135;146;138;170;152 16:06:00 INFO - PROCESS | 7790 | |12;stanford-crypto-pbkdf2;182;181;176;185;184;184;183;174;175;182 16:06:00 INFO - PROCESS | 7790 | |13;stanford-crypto-sha256-iterative;81;73;72;74;71;71;73;72;71;72 16:06:00 INFO - PROCESS | 7790 | __end_tp_report 16:06:00 INFO - PROCESS | 7790 | __start_cc_report 16:06:00 INFO - PROCESS | 7790 | _x_x_mozilla_cycle_collect,1848 16:06:00 INFO - PROCESS | 7790 | __end_cc_report 16:06:00 INFO - PROCESS | 7790 | __startTimestamp1460588760046__endTimestamp 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | ------- Summary: start ------- 16:06:00 INFO - PROCESS | 7790 | Number of tests: 14 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:4.14 (3.6%) stddev-sans-first:4.36 16:06:00 INFO - PROCESS | 7790 | Values: 114.0 116.0 108.0 113.0 114.0 113.0 103.0 113.0 115.0 117.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:159.00 stddev:19.27 (12.1%) stddev-sans-first:19.88 16:06:00 INFO - PROCESS | 7790 | Values: 166.0 135.0 152.0 176.0 131.0 163.0 155.0 131.0 185.0 138.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 16:06:00 INFO - PROCESS | 7790 | Values: 161.0 161.0 161.0 162.0 162.0 163.0 161.0 161.0 163.0 164.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#3] audio-fft Cycles:10 Average:86.20 Median:73.00 stddev:16.07 (22.0%) stddev-sans-first:17.02 16:06:00 INFO - PROCESS | 7790 | Values: 84.0 73.0 91.0 114.0 73.0 73.0 73.0 107.0 101.0 73.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:24.29 (25.8%) stddev-sans-first:25.14 16:06:00 INFO - PROCESS | 7790 | Values: 94.0 94.0 146.0 94.0 94.0 95.0 148.0 93.0 94.0 138.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:06:00 INFO - PROCESS | 7790 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:06:00 INFO - PROCESS | 7790 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 145.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 16:06:00 INFO - PROCESS | 7790 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:63.00 stddev:5.25 (8.3%) stddev-sans-first:5.55 16:06:00 INFO - PROCESS | 7790 | Values: 63.0 64.0 63.0 62.0 62.0 63.0 64.0 79.0 62.0 61.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 16:06:00 INFO - PROCESS | 7790 | Values: 64.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 64.0 63.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:3.10 (3.6%) stddev-sans-first:3.15 16:06:00 INFO - PROCESS | 7790 | Values: 84.0 85.0 84.0 84.0 86.0 91.0 86.0 85.0 87.0 93.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:146.00 stddev:10.61 (7.3%) stddev-sans-first:11.10 16:06:00 INFO - PROCESS | 7790 | Values: 150.0 139.0 137.0 146.0 137.0 135.0 146.0 138.0 170.0 152.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:182.50 stddev:4.06 (2.2%) stddev-sans-first:4.28 16:06:00 INFO - PROCESS | 7790 | Values: 182.0 181.0 176.0 185.0 184.0 184.0 183.0 174.0 175.0 182.0 16:06:00 INFO - PROCESS | 7790 | 16:06:00 INFO - PROCESS | 7790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:72.50 stddev:2.98 (4.1%) stddev-sans-first:1.05 16:06:00 INFO - PROCESS | 7790 | Values: 81.0 73.0 72.0 74.0 71.0 71.0 73.0 72.0 71.0 72.0 16:06:00 INFO - PROCESS | 7790 | -------- Summary: end -------- 16:06:00 INFO - PROCESS | 7790 | 16:06:01 INFO - TEST-INFO | 7790: exit 0 16:06:01 INFO - TEST-OK | kraken | took 63382ms 16:06:01 INFO - SUITE-END | took 1182s 16:06:01 INFO - Completed test suite (00:19:42) 16:06:01 INFO - javascript benchmark 16:06:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.5545057340255, 2683.4364783395486, 2687.905923292684, 2699.203734898206, 2718.6465759451266, 4514.097180563892, 4640.767961601923, 4730.290456431537, 4732.3138144969, 4733.526647335265, 4701.623870090393, 4713.552212539812, 4789.832355867546, 4797.664163508547, 4810.302506136608, 4268.253055715253, 4341.218580655481, 4375.6937014409, 4434.290513517838, 4482.66380021498, 4419.182451246514, 4449.332600109993, 4460.353248778925, 4468.463784345867, 4486.97756511217, 4268.253055715269, 4278.101598664284, 4348.804303806336, 4364.323529852846, 4387.714798538085, 4301.526832048472, 4342.196693611692, 4346.956530434687, 4348.4999225089205, 4398.516163222043, 4346.413234213373, 4375.803088861009, 4397.164538737629, 4402.7798610069685, 4432.578905004052, 4510.526394728572, 4580.290055041474, 4658.045100754337, 4679.15775160471, 4698.671093023456, 4992.525710057539, 5004.174311238641, 5010.799568017275, 5013.774380152865, 5016.423111342206, 5004.649674522785, 5039.09296326661, 5041.1682072458, 5041.647084704072, 5097.3118628984985, 4610.56199661035, 4681.6722829401615, 4746.644001699887, 4796.232602783538, 4802.471728109905, 5140.46025167352, 5149.665271757323, 5153.201253805666, 5205.29728486657, 5214.165733482625, 4781.784819683053, 4920.950790492121, 4921.483244259372, 4922.064807686528, 4961.0, 5071.163258062452, 5088.414832294334, 5124.846254612367, 5169.586433085344, 5180.8963820723375, 5043.5965122790085, 5061.417936937226, 5067.493250674903, 5080.59355251579, 5121.436641969381, 4895.31465594817, 4993.825216117419, 5032.245163225472, 5052.166392545262, 5053.090443720165, 4247.702660813713, 4321.632661223831, 4363.738175709467, 4383.979580645478, 4399.934000989988, 3764.0589852536864, 3779.640934111255, 3786.678132358725, 3820.8853734388013, 3826.9808650956566, 4239.130978149472, 4397.054633253866, 4404.4714634243455, 4405.405270288534, 4453.665975051819, 5105.591552675777, 5130.51260130287, 5155.252488389237, 5201.141811601119, 5210.348706411699, 4392.450943632046, 4404.053128577371, 4405.185040767468, 4408.316710909814, 4451.9554804451545, 4441.133978874153, 4595.035042641083, 4611.746353950565, 4612.238980568236, 4641.907161856811, 4749.335093086902, 4770.856874293777, 4774.40319960005, 4783.234682450791, 4811.9518804811505, 5134.998675258438, 5138.743062846768, 5138.948610513997, 5144.845654630367, 5172.767225474788, 4539.909201816011, 4673.322368256516, 4765.070811191785, 4778.259369797687, 4841.733704646278, 5022.3219865317715, 5039.722815245197, 5042.84871453857, 5062.670926389773, 5088.2876397305145, 5106.897862042812, 5115.15599926023, 5116.872078198075, 5117.8720531987, 5163.638545301793, 4778.808847646055, 4882.487338829514, 4962.503749625009, 4962.503749625153, 4974.0797952378925, 4933.55597996182, 4950.430700469492, 4957.529034741694, 4959.900801984012, 4962.801487940442, 4871.48849370811, 4909.214525675875, 4911.803527858846, 4917.188663870421, 4926.679765815211, 4808.230683090689, 4920.1389756791705, 5012.899742005213, 5014.824481143142, 5053.343065401475, 4800.591949684316, 4812.0, 4814.301926220748, 4827.324174615486, 4868.9756551217015], "value": 4659.4351894670035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.8675504633934, 582.8018473718935, 604.5979423683248, 610.6153123532174, 613.5858295650436, 26375.6043659345, 26992.32519187021, 27003.45993080137, 27022.459550808973, 27038.188854334352, 26620.201393958163, 34895.65104348956, 36035.63964360362, 36102.2779544409, 36213.0946726332, 7629.8474030519355, 7817.8827317590285, 7820.687172513092, 7823.960880195591, 7826.960865195694, 7238.203797582261, 7669.961650191742, 7798.415118866108, 7798.883016754753, 7802.024746906637, 9802.6963663539, 10257.794844103113, 10258.948705256464, 10259.974002599754, 10261.665983422145, 9681.56432960515, 9819.0, 9820.754481137958, 9825.164860986824, 9826.1156495915, 7160.427165826722, 9636.662716804949, 9666.420014799134, 9779.022097790235, 10093.798124037477, 33192.83403582991, 33820.661793381994, 33859.0, 33918.0, 33948.660513394796, 3081.137281561144, 3166.920826979344, 3227.386796508656, 3261.4781634938295, 3612.0789198754414, 28778.71221287802, 29729.70270297291, 29790.255243618867, 29821.850890745623, 30301.090967270797, 3155.3373791503814, 3175.4442972479956, 3218.356328734239, 3267.460868956643, 3281.7210537104374, 203975.0, 204056.0, 204871.0, 205443.0, 205502.0, 52600.21099683508, 52838.20742688863, 53019.0, 53112.203316950276, 53300.466995330324, 54826.0, 55344.446555534734, 55484.0, 55501.722491387285, 55511.0, 13857.099288546213, 14016.85983140176, 14075.507357242448, 14095.224762637949, 14112.0, 10439.739006524898, 10516.0, 10525.0, 10542.472876356305, 10549.419781912069, 15896.284667190004, 16999.575010624587, 17401.0, 17723.556911077325, 17800.91099544494, 5553.778168802857, 5956.880862382728, 6004.609700369462, 6073.848153796191, 6098.35967223444, 806.6813608624677, 880.3045593980684, 920.3833431600843, 924.5885580916562, 1067.8665166854144, 23818.0, 25076.749232507806, 26335.41614596351, 26392.20823375302, 26854.0, 976.7606936300651, 986.6743974488402, 998.2114129837347, 1001.9599216031277, 1039.7712503249272, 13550.0, 14070.0, 14221.715565688628, 14255.714885702435, 14337.0, 318891.0, 326439.0, 328040.0, 328148.0, 329801.0, 48004.75997620059, 48286.27570586444, 48417.515824842005, 48420.0, 48455.0, 1158.1314014489133, 1202.8436303280694, 1204.722913729847, 1222.7615614954998, 1226.834377359045, 24910.875445622656, 26212.737872621794, 26315.0, 26350.0, 26394.0, 39419.60580394274, 39958.2008359837, 39980.2003959925, 40054.59945400509, 40094.1981160381, 309470.0, 313465.0, 313760.0, 314889.0, 315851.0, 22998.0, 24728.752712473364, 25274.873625631753, 25462.962962963287, 26313.473730525664, 36418.0, 36663.45004824983, 36940.26119477649, 37459.06352341213, 37564.81217593895, 31625.0, 31998.0, 32253.0, 33898.66101338955, 35147.121321967155, 33598.49602255919, 33738.662613373555, 34435.31129377449, 34440.65559344374, 34744.82627586947, 33534.161645959044, 33570.16074598154, 33930.49104263487, 35864.46203307005, 37099.0, 27188.864055680388, 28505.857470712515, 30391.240218994702, 30989.535156973114, 31305.686943130277, 24168.154114605903, 24539.263822085366, 25018.624720628843, 25848.8707556461, 27896.163115106578], "value": 16906.41012220084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.83419295509975, 380.2698818268925, 389.5383969995556, 392.06296950288817, 400.67144941148234, 15366.615834604127, 16122.596935076628, 16255.187240637964, 16264.0, 16286.674266514663, 15160.241987900616, 15972.201389930486, 16593.0, 16596.08721520316, 16607.169641517936, 5039.59683225342, 5272.420033796279, 5315.0432922074015, 5317.627766056377, 5324.0, 3662.304162209172, 5662.235598194253, 5998.55010874184, 6009.1286763419275, 6011.969940150315, 5107.0, 5952.761889524414, 5959.910601340962, 5962.97018514909, 5978.910316345258, 5337.626366154371, 5356.758945847446, 5372.409035006166, 5374.892502149935, 5375.7849686012705, 3356.7146792522667, 3558.1104723819044, 3558.5018097466377, 3558.893233202982, 4916.0905232532095, 11916.0, 12213.084018698544, 12229.816552751716, 12526.937365313206, 18968.43094707161, 1799.6940520111611, 1846.639905218483, 1921.9039048047541, 1963.2245263120988, 2023.9595208095755, 9057.818843623156, 9062.909370906273, 9109.908900910972, 9446.0, 10279.537420816081, 1742.7124524453577, 1771.5128339706555, 1782.5098098023018, 1795.5152108930647, 1819.5451137215696, 63548.68225658889, 66046.0, 66417.0, 66563.00155497719, 67698.0, 10237.283390162765, 10284.485775711184, 10326.277160598836, 10335.379877207391, 10354.17166626668, 14522.782158267635, 14621.488247911271, 14637.780433293508, 14651.12093274407, 14676.486322978644, 7030.564200782089, 7329.644015856977, 7339.853202935911, 7368.415800581731, 7393.334599886036, 6666.799996000128, 6726.058351830748, 6769.864602708017, 6835.213950395669, 6864.073350097673, 4314.158739045919, 4324.13517296542, 4381.058072514425, 4386.12277544486, 4415.66882483815, 1674.2169589387506, 1780.3234770787276, 1828.387490190801, 1842.4010903194508, 1848.6210326882956, 880.4629176202511, 884.743903047227, 919.5034681272039, 978.5303054533864, 979.6326377608397, 15911.204439778196, 16275.91862040706, 16366.836331636769, 16830.831691682928, 17023.91488042552, 837.5058715357968, 878.3851304087165, 879.366855863777, 937.4796987671907, 954.6515521834481, 8445.028821685462, 8800.16398442147, 8823.117688231125, 8833.734987950373, 8976.102389760972, 396567.0, 400979.0, 405158.0, 407054.0, 409726.0, 77328.61335693399, 81622.59188704018, 82043.0, 82064.58967705123, 82488.17511824805, 941.1905761045496, 989.1147423056324, 991.2615101749099, 994.5782020779425, 1005.1707341443339, 15341.769873452131, 15506.0, 15580.844191557939, 15603.843961560693, 16117.63000144954, 32996.67003329936, 33198.5020224692, 34317.65682343145, 34394.14014649654, 35027.299454011285, 46552.301715473615, 48771.0, 48772.5122748768, 48846.0, 49413.50586494089, 7616.35261002821, 7643.617819109134, 7743.5353878767455, 7778.649960751666, 7792.844143116992, 8439.409241353047, 10493.265471416928, 11250.774984500427, 11303.943480282545, 11468.827967580326, 9482.0, 9552.665656701982, 9954.054364835329, 10006.249531285328, 10195.949020254851, 8317.334613231049, 9439.480828554495, 9884.456354900549, 10014.599416023277, 10197.337173083726, 9984.35101718386, 10048.544659088499, 10101.69694909154, 10311.948440257751, 10355.637552685619, 6469.935300647122, 6835.3506416892305, 6892.0, 7015.0, 7074.540154889915, 9064.954675226581, 9915.107640312406, 10053.296269261082, 10107.494625268855, 10190.74523136898], "value": 7985.204444610792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.721101357702, 1422.3812641500945, 1451.3976699669638, 1569.5919061044126, 1775.272138423246, 7392.260773922611, 7690.384769218449, 7707.576083315423, 7717.652705628247, 7735.535867847933, 7510.136334321554, 7657.961710191441, 7670.769876903688, 7672.769816905502, 7675.424343174271, 1901.5341241395877, 2203.5703037907615, 2224.5995720770215, 2256.458449972003, 2277.738060123082, 2233.8436309458343, 2240.7871252231093, 2246.1801442473543, 2253.4479052632128, 2256.7856053674873, 2220.356096731946, 2274.6360582306834, 2274.7042884425, 2277.20297895736, 2277.9658305125354, 1877.558773688182, 2104.3266154830535, 2167.3389616167065, 2172.250573552122, 2174.239016344283, 2171.1532502324108, 2179.901904414305, 2185.4208634711813, 2185.8032777050144, 2235.9552808943895, 7577.469577129603, 7587.81030474237, 7656.80857978555, 7662.1571627120975, 7668.808279792994, 4529.909401811945, 4603.562661547147, 4645.187092258841, 4656.4877863434995, 4716.292556116576, 3000.429918315513, 3013.1563162314587, 3068.815871047744, 3082.106189205128, 3099.271671157299, 928.4104593583123, 939.8073394954018, 943.3160958305174, 951.7192428233687, 955.7037318431309, 10673.626423075155, 10682.51928663212, 10695.732606684818, 10703.625373111903, 10712.517936692868, 4259.488861336597, 4285.46431696038, 4415.492218394926, 4436.977815110969, 4460.464744230713, 8131.349492040623, 8220.753377398687, 8248.175182481704, 8251.669933202726, 8261.669533218605, 4115.54728979812, 4631.397918270603, 4666.906661866744, 4676.158291507561, 4706.1764191267075, 3857.633524815138, 3861.2663593917064, 3873.2640798248244, 4176.9582304177175, 4337.544557821383, 3381.814000229962, 3413.863445462154, 3474.7220222382653, 3491.266833964896, 3533.0990597398013, 1065.0999905080196, 1082.6751974407646, 1084.511969613677, 1088.4612117001977, 1095.3044816541553, 787.4527203593448, 830.1781236575868, 837.0657907833208, 845.7716416567492, 849.3841964575633, 5091.41448733393, 5276.366835979707, 5368.872536767244, 5430.0, 5523.364813046471, 822.6627082895984, 829.0548774397192, 900.4192295969063, 906.6237511432813, 926.1525703980917, 3611.2777444510675, 3746.1758413149064, 3836.712246581518, 3861.517310336208, 3923.0, 9098.272138229058, 9279.072092790802, 9475.526223688788, 9667.226621870233, 9696.175825054808, 9449.0, 9462.810743785223, 9525.523723813782, 9530.52347382628, 9579.856302155473, 7008.859822803617, 7012.789616311519, 7068.0, 7184.49708520409, 7192.0290760747675, 5074.289599456153, 5099.56653684441, 5155.922661160161, 5202.869928251824, 5286.81496147633, 8623.956880215559, 8695.478271303742, 8718.0, 8787.604557794786, 8794.736157915273, 8476.449030812977, 8753.34349923771, 8861.512616806138, 8932.821343573221, 8987.505687187006, 5893.263342082239, 6530.47756179514, 6555.082288479522, 6650.73397064112, 6759.864802704017, 7346.816329591803, 7445.9255407445235, 7485.850282994418, 7503.0, 7508.662110205163, 6486.0, 6692.564983276072, 6698.966505167443, 6782.1861376635115, 6847.828804279933, 6604.745098431283, 6627.204735431779, 6630.237522684953, 6691.297413771484, 6782.525223234326, 6318.652474113968, 6327.11420401135, 6341.0, 6349.777757778455, 6365.586236894587, 4345.217860785089, 4482.6862119652615, 4625.814967401401, 4653.953460465352, 4676.485586585405, 4301.9354709678755, 4386.517483076923, 4440.156370289635, 4464.995376040365, 4531.342955271533], "value": 4108.066659993627, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.3309218994781, 314.145524174246, 320.43123455865833, 324.0941568316555, 324.7905101209721, 5153.51041651043, 5183.663061900978, 5188.974055129728, 5210.8697282567955, 5218.425973142951, 5097.5157360050825, 5099.59203263739, 5104.208847628614, 5123.180291153416, 5131.692098474095, 3791.5829258781514, 3888.1251718363424, 4033.1731994940965, 4045.4943132108488, 4059.918801623966, 4015.2973229684835, 4019.6985226108013, 4031.2945234583976, 4033.475648165734, 4039.8788036358956, 3775.9433608495756, 3996.6802655787615, 4007.3788562772816, 4009.6391324780766, 4014.518257809067, 3877.243937432202, 3999.4400783890133, 4035.233305671942, 4035.7982100894837, 4036.192761447722, 3557.7509574329806, 3560.964390356089, 3563.0914116900285, 3575.713942884563, 3585.175409655768, 4929.088118698052, 4947.82682606107, 4948.529889660476, 4959.206526955706, 4978.950210497885, 4535.433070866142, 4603.631709463235, 4643.210654188796, 4659.370984917026, 4668.253079507263, 5333.866653333659, 5380.139177731544, 5381.78472861089, 5405.21624364465, 5410.486003829669, 3592.910177245564, 3858.4791053207737, 3870.632289932452, 3872.2255548890334, 3877.321468742987, 5581.832545023656, 5639.802606908779, 5648.54811615074, 5663.546916246732, 5686.203931449559, 3846.74996125251, 3856.014152711356, 3863.343231650626, 3865.3235683755793, 3867.207222519433, 3921.941170882439, 3931.2334094851803, 3935.901602459904, 3938.3501722215515, 3952.9011774705286, 4407.118576284756, 4456.14806523825, 4501.909961800811, 4511.661625378044, 4517.6837621366185, 5354.598405119632, 5361.892762144736, 5376.301080859542, 5383.892322153535, 5392.299001129828, 1349.9325033748469, 1367.2548461088732, 1369.9109557878905, 1372.670559065817, 1374.154894739728, 897.3359713811732, 904.326276923696, 931.1991687149047, 931.9068093190626, 939.6945992552447, 4723.409573803275, 4730.716157030589, 4743.0, 4755.83354582588, 4760.738159401197, 5550.91673624896, 5555.638883472561, 5556.888862222733, 5570.6657600544095, 5570.880307028077, 4614.953850461452, 4728.290756386569, 4753.667243292936, 4757.714537127784, 4767.928481072787, 2936.1778701963485, 2964.688707685705, 2965.288330800592, 2971.390864872696, 2978.74680652147, 5174.741262936838, 5186.481351864783, 5198.064348417245, 5203.765830537559, 5212.25389494516, 5471.644343117685, 5634.718264086861, 5670.262865827416, 5674.460926212003, 5689.829305120853, 5169.844904652867, 5170.353705786777, 5180.533751962342, 5182.818601348935, 5183.97408012965, 5388.922215556982, 5527.0, 5528.281323427928, 5535.169724541351, 5557.083081291542, 5351.090314646597, 5372.1941708744, 5374.435684253253, 5401.0, 5401.594880383908, 4665.836695715634, 5144.254083157846, 5162.380514338153, 5184.351956005499, 5187.299714538489, 3539.6549311261556, 3797.6202379761803, 3887.067103894988, 3895.844166233319, 3896.551896531935, 5340.385855626652, 5433.728313584226, 5492.5605951524585, 5530.751116199861, 5541.476094074162, 5419.674819510842, 5423.728813559385, 5432.185172224198, 5432.511074003359, 5456.61803673739, 5430.375506816767, 5431.8098866539485, 5432.701201433801, 5432.755526001419, 5442.945570544244, 5159.277701121771, 5347.144456886879, 5351.812686556108, 5356.437574054668, 5366.758495867617, 5419.918701219406, 5427.158790387496, 5435.076037073628, 5444.945550544602, 5458.1266997280245, 5192.547824783886, 5333.759980800795, 5339.78640854377, 5349.411564727955, 5352.143657014859], "value": 4049.997480843556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.1425361396151, 660.940515353618, 677.7153595489897, 715.685098556635, 774.4578794843609, 11847.7630447391, 11946.402679866016, 12012.2792632442, 12013.699657508567, 12021.819672704916, 11618.0, 11646.0, 11764.0, 11765.588204412847, 11865.466054027567, 801.447001568917, 816.979575510614, 817.7056259746487, 817.791463176889, 818.6929901287017, 639.1403562208822, 767.4090949968521, 792.2077922077922, 804.1757198871145, 805.5207151744703, 835.1898658301468, 835.3692961813853, 835.3734698975768, 835.6448509383519, 836.2766207230732, 822.5804839531881, 831.3723139030024, 832.1512057701111, 832.5961908474385, 833.0836080311669, 485.8955324605192, 494.80207916833194, 496.12434053894907, 597.3250227243187, 614.3119705929344, 11626.24429412094, 11681.883181168165, 11708.473118709679, 11723.120765942589, 11747.118966077493, 11829.94085029578, 12219.0, 12393.194442361308, 12607.180533265308, 12843.614691559269, 9743.317967742261, 9765.804683906354, 9842.704718858375, 9938.254630902711, 10092.697219083439, 3331.2338162222823, 3353.178471274529, 3362.1090411041096, 3405.1997780521556, 3440.7591468597207, 43782.56217437817, 44352.556474435485, 44424.77787611073, 44468.77765611151, 45370.546294536965, 9888.604455821831, 9944.850827237597, 10035.849462258071, 10225.181985441295, 10238.436885971194, 16369.953755780527, 16559.6688066238, 16588.0, 16608.086555239577, 16627.750583741254, 6707.228668703064, 7034.6482675866, 7104.822379440556, 7158.892616610755, 7188.245234250433, 3864.478295430081, 3894.7857867816974, 3902.083010492532, 3960.782156981336, 4068.8575899843363, 2920.5473151661104, 3011.5633233181065, 3012.036148432481, 3020.864061117255, 3023.380207057548, 503.7758197602032, 510.5481648740891, 517.647999360431, 525.254139122447, 526.4314540296547, 571.8827640333722, 585.2070444547662, 603.0532064658531, 604.4167378479788, 627.4008322052429, 7321.74373896911, 7602.543847369176, 7711.0, 7759.961200193963, 7777.222277772177, 477.6799544305324, 544.8120398462524, 574.6611292041434, 594.7293981238527, 595.615827791081, 3530.0, 3566.8751593694096, 3579.266250418658, 3633.3823250047553, 3717.1636381813873, 52781.0, 52876.47123528792, 53492.0, 53503.0, 53565.0, 45642.54357456383, 45715.0, 45831.5416845834, 46059.53940460552, 46380.7680961593, 41945.37081943773, 42268.788656056524, 42601.14797704029, 42776.3583546247, 43486.13027739427, 6839.22180233133, 6897.413719833669, 6900.551464154814, 6924.757633482804, 7011.8247043822275, 26037.0, 28131.296717582223, 28837.0, 28940.7105928938, 29135.562966555943, 35113.648863511036, 35332.0, 35386.29227415489, 36132.4580131293, 36511.81744091262, 10326.122279606017, 10339.431331276852, 10359.896401036194, 10394.0, 10604.0, 11714.1800073994, 11725.179237453638, 11773.47019384147, 11836.0, 11887.643370698894, 10402.167826574007, 10429.11352535043, 10615.0, 10679.5194216262, 10794.730131746455, 10960.616378426717, 10994.780104398027, 11053.28153670009, 11072.280301780358, 11384.14618903569, 9977.800443991226, 10713.89286107129, 10720.517576708911, 10734.83897741519, 10741.516631751434, 9025.368224224241, 9062.086526699559, 9390.859137113086, 9478.289128315266, 9752.804943900941, 8708.825823483621, 8713.651453941771, 9479.289053321167, 9576.76058098553, 9663.9033609663], "value": 5801.454510355561, "unit": "score"}], "name": "dromaeo_css", "value": 6269.374520397217, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 108.0, 113.0, 114.0, 113.0, 103.0, 113.0, 115.0, 117.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 135.0, 152.0, 176.0, 131.0, 163.0, 155.0, 131.0, 185.0, 138.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 161.0, 163.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 73.0, 91.0, 114.0, 73.0, 73.0, 73.0, 107.0, 101.0, 73.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 146.0, 94.0, 94.0, 95.0, 148.0, 93.0, 94.0, 138.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 62.0, 63.0, 64.0, 79.0, 62.0, 61.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 86.0, 91.0, 86.0, 85.0, 87.0, 93.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 139.0, 137.0, 146.0, 137.0, 135.0, 146.0, 138.0, 170.0, 152.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 176.0, 185.0, 184.0, 184.0, 183.0, 174.0, 175.0, 182.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 72.0, 74.0, 71.0, 71.0, 73.0, 72.0, 71.0, 72.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1593.6999999999998, "alertThreshold": 2.0}]} 16:06:01 INFO - Return code: 0 16:06:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:06:01 ERROR - # TBPL SUCCESS # 16:06:01 INFO - Running post-action listener: _resource_record_post_action 16:06:01 INFO - Running post-run listener: _resource_record_post_run 16:06:02 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 506580992; Read time: 0; Write time: 424640 16:06:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 142671872; Read time: 0; Write time: 144256 16:06:02 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284778496; Read time: 0; Write time: 194232 16:06:02 INFO - Running post-run listener: _upload_blobber_files 16:06:02 INFO - Blob upload gear active. 16:06:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:06: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 16:06: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'] 16:06: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 16:06:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:06:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:06:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:06:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:06:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:06:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:06:03 INFO - (blobuploader) - INFO - Done attempting. 16:06:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:06:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:06:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:06:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:06:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:06:04 INFO - (blobuploader) - INFO - Done attempting. 16:06:04 INFO - (blobuploader) - INFO - Iteration through files over. 16:06:04 INFO - Return code: 0 16:06:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:06:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:06:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48231930bb5dcb05d37173f833b6a0fed49b323350b86c5ac74b6a628ace53f391c99c9a00b9b61da3f926da0a48f5601a41e933366dc1f5ee377d6eb381f19b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8282d1a778ee61096757970f4fb0d502807e0c5227b0eebe8b230ab5e1094915c105e00a51a8605fde37825485c43a064b09cee8a7a90523709660aae3671231"} 16:06:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:06:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:06:04 INFO - Contents: 16:06:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48231930bb5dcb05d37173f833b6a0fed49b323350b86c5ac74b6a628ace53f391c99c9a00b9b61da3f926da0a48f5601a41e933366dc1f5ee377d6eb381f19b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8282d1a778ee61096757970f4fb0d502807e0c5227b0eebe8b230ab5e1094915c105e00a51a8605fde37825485c43a064b09cee8a7a90523709660aae3671231"} 16:06:04 INFO - Running post-run listener: copy_logs_to_upload_dir 16:06:04 INFO - Copying logs to upload dir... 16:06:04 INFO - mkdir: /builds/slave/test/build/upload/logs 16:06:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.613695 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-13 16:06:04.256876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:04.260196) ========= 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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48231930bb5dcb05d37173f833b6a0fed49b323350b86c5ac74b6a628ace53f391c99c9a00b9b61da3f926da0a48f5601a41e933366dc1f5ee377d6eb381f19b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8282d1a778ee61096757970f4fb0d502807e0c5227b0eebe8b230ab5e1094915c105e00a51a8605fde37825485c43a064b09cee8a7a90523709660aae3671231"} build_url:https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48231930bb5dcb05d37173f833b6a0fed49b323350b86c5ac74b6a628ace53f391c99c9a00b9b61da3f926da0a48f5601a41e933366dc1f5ee377d6eb381f19b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8282d1a778ee61096757970f4fb0d502807e0c5227b0eebe8b230ab5e1094915c105e00a51a8605fde37825485c43a064b09cee8a7a90523709660aae3671231"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:04.284823) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:04.285135) ========= 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=cbe409c6de289db6ac707de3000001d4-1460584892.896824-759603414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:04.370856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 16:06:04.371170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 16:06:04.371498) ========= ========= Total master_lag: 0.27 =========