builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1460587513.84 results: success (0) buildid: 20160413141950 builduid: 128362089fea448eaa7634c752cc6aea revision: bc2373295e31d99f9b870a1253b6e01650df8f31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:13.844730) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:13.845205) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:13.845519) ========= 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=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004390 basedir: '/builds/slave/test' ========= master_lag: 0.11 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:13.959909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:13.960212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.238886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.239178) ========= 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=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020417 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.287590) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.287863) ========= 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:14.288227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.288525) ========= 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=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 15:45:14-- 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% 39.7M=0s 2016-04-13 15:45:14 (39.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.476629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.476961) ========= 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=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.184698 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.674700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:14.675139) ========= 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=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 15:45:14,802 truncating revision to first 12 chars 2016-04-13 15:45:14,802 Setting DEBUG logging. 2016-04-13 15:45:14,802 attempt 1/10 2016-04-13 15:45:14,802 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:15,031 unpacking tar archive at: mozilla-central-bc2373295e31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.486499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.172091) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.172469) ========= 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=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bc2373295e31d99f9b870a1253b6e01650df8f31 program finished with exit code 0 elapsedTime=0.003021 script_repo_revision: 'bc2373295e31d99f9b870a1253b6e01650df8f31' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.219528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.219829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 15:45:15.229835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-13 15:45:15.230138) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:45:15 INFO - MultiFileLogger online at 20160413 15:45:15 in /builds/slave/test 15:45:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:45:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:45:15 INFO - {'append_to_log': False, 15:45:15 INFO - 'base_work_dir': '/builds/slave/test', 15:45:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:45:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:45:15 INFO - 'branch': 'Firefox-Non-PGO', 15:45:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:45:15 INFO - 'config_files': ('talos/linux_config.py',), 15:45:15 INFO - 'default_actions': ('clobber', 15:45:15 INFO - 'read-buildbot-config', 15:45:15 INFO - 'download-and-extract', 15:45:15 INFO - 'populate-webroot', 15:45:15 INFO - 'create-virtualenv', 15:45:15 INFO - 'install', 15:45:15 INFO - 'run-tests'), 15:45:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:45:15 INFO - 'download_minidump_stackwalk': True, 15:45:15 INFO - 'download_symbols': 'ondemand', 15:45:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:45:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:45:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:45:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:45:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:45:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:45:15 INFO - 'installer_path': 'installer.exe', 15:45:15 INFO - 'log_level': 'info', 15:45:15 INFO - 'log_name': 'talos', 15:45:15 INFO - 'log_to_console': True, 15:45:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:45:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:45:15 INFO - 'opt_config_files': (), 15:45:15 INFO - 'pip_index': False, 15:45:15 INFO - 'sps_profile': False, 15:45:15 INFO - 'sps_profile_interval': 0, 15:45:15 INFO - 'suite': 'dromaeojs-e10s', 15:45:15 INFO - 'system_bits': '32', 15:45:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:45:15 INFO - 'title': 'talos-linux64-ix-028', 15:45:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:45:15 INFO - 'use_talos_json': True, 15:45:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:45:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:45:15 INFO - 'work_dir': 'build'} 15:45:15 INFO - ##### 15:45:15 INFO - ##### Running clobber step. 15:45:15 INFO - ##### 15:45:15 INFO - Running pre-action listener: _resource_record_pre_action 15:45:15 INFO - Running main action method: clobber 15:45:15 INFO - rmtree: /builds/slave/test/build 15:45:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:45:17 INFO - Running post-action listener: _resource_record_post_action 15:45:17 INFO - ##### 15:45:17 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 15:45:17 INFO - Using buildbot properties: 15:45:17 INFO - { 15:45:17 INFO - "project": "", 15:45:17 INFO - "product": "firefox", 15:45:17 INFO - "script_repo_revision": "production", 15:45:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:45:17 INFO - "repository": "", 15:45:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:45:17 INFO - "buildid": "20160413141950", 15:45:17 INFO - "pgo_build": "False", 15:45:17 INFO - "basedir": "/builds/slave/test", 15:45:17 INFO - "buildnumber": 321, 15:45:17 INFO - "slavename": "talos-linux64-ix-028", 15:45:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:45:17 INFO - "platform": "ubuntu64_hw", 15:45:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:45:17 INFO - "branch": "mozilla-central", 15:45:17 INFO - "repo_path": "mozilla-central", 15:45:17 INFO - "revision": "bc2373295e31d99f9b870a1253b6e01650df8f31", 15:45:17 INFO - "stage_platform": "linux64", 15:45:17 INFO - "builduid": "128362089fea448eaa7634c752cc6aea", 15:45:17 INFO - "slavebuilddir": "test" 15:45:17 INFO - } 15:45:17 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:17 INFO - Running post-action listener: _resource_record_post_action 15:45:17 INFO - ##### 15:45:17 INFO - ##### Running download-and-extract 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: download_and_extract 15:45:17 INFO - mkdir: /builds/slave/test/build/tests 15:45: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:45:17 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:17 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:17 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:17 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:17 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:18 INFO - Downloaded 1361 bytes. 15:45:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:45:18 INFO - Using the following test package requirements: 15:45:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:45:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:45:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:18 INFO - u'jsshell-linux-x86_64.zip'], 15:45:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:45:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:45:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:45:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:45:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:45:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:45:18 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:19 INFO - Downloaded 22202636 bytes. 15:45:19 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:19 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:20 INFO - Return code: 0 15:45:20 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:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:20 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:20 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:20 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:20 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:20 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:21 INFO - Downloaded 22202636 bytes. 15:45:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:45:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:45:23 INFO - Return code: 0 15:45:23 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:23 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:23 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:23 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:23 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:23 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:24 INFO - Downloaded 10841076 bytes. 15:45:24 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:24 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:25 INFO - Return code: 0 15:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:25 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:25 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:25 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:25 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:25 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:27 INFO - Downloaded 54167275 bytes. 15:45:27 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:27 INFO - mkdir: /builds/slave/test/properties 15:45:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:45:27 INFO - Writing to file /builds/slave/test/properties/build_url 15:45:27 INFO - Contents: 15:45:27 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:28 INFO - Running post-action listener: _resource_record_post_action 15:45:28 INFO - Running post-action listener: set_extra_try_arguments 15:45:28 INFO - ##### 15:45:28 INFO - ##### Running populate-webroot step. 15:45:28 INFO - ##### 15:45:28 INFO - Running pre-action listener: _resource_record_pre_action 15:45:28 INFO - Running main action method: populate_webroot 15:45:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:45:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:45:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:45:28 INFO - '--tppagecycles', 15:45:28 INFO - '7'], 15:45:28 INFO - 'tests': ['tsvgm']}}, 15:45:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:45:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:45:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:45:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:45:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:28 INFO - 'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:28 INFO - 'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['damp', 'tps']}, 15:45:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:28 INFO - 'tests': ['damp', 'tps']}, 15:45:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['dromaeo_dom']}, 15:45:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:45:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['a11yr', 15:45:28 INFO - 'ts_paint', 15:45:28 INFO - 'tpaint', 15:45:28 INFO - 'sessionrestore', 15:45:28 INFO - 'sessionrestore_no_auto_restore', 15:45:28 INFO - 'tabpaint']}, 15:45:28 INFO - 'other-e10s': {'tests': ['a11yr', 15:45:28 INFO - 'ts_paint', 15:45:28 INFO - 'tpaint', 15:45:28 INFO - 'sessionrestore', 15:45:28 INFO - 'sessionrestore_no_auto_restore', 15:45:28 INFO - 'tabpaint']}, 15:45:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:45:28 INFO - 'ts_paint', 15:45:28 INFO - 'tpaint', 15:45:28 INFO - 'sessionrestore', 15:45:28 INFO - 'sessionrestore_no_auto_restore', 15:45:28 INFO - 'tabpaint']}, 15:45:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:45:28 INFO - 'ts_paint', 15:45:28 INFO - 'tpaint', 15:45:28 INFO - 'sessionrestore', 15:45:28 INFO - 'sessionrestore_no_auto_restore', 15:45:28 INFO - 'tabpaint']}, 15:45:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['a11yr', 15:45:28 INFO - 'ts_paint', 15:45:28 INFO - 'tpaint', 15:45:28 INFO - 'sessionrestore', 15:45:28 INFO - 'sessionrestore_no_auto_restore', 15:45:28 INFO - 'tabpaint']}, 15:45:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['a11yr', 15:45:28 INFO - 'ts_paint', 15:45:28 INFO - 'tpaint', 15:45:28 INFO - 'sessionrestore', 15:45:28 INFO - 'sessionrestore_no_auto_restore', 15:45:28 INFO - 'tabpaint']}, 15:45:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['tsvgx', 15:45:28 INFO - 'tsvgr_opacity', 15:45:28 INFO - 'tart', 15:45:28 INFO - 'tscrollx', 15:45:28 INFO - 'cart']}, 15:45:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:45:28 INFO - 'tsvgr_opacity', 15:45:28 INFO - 'tart', 15:45:28 INFO - 'tscrollx', 15:45:28 INFO - 'cart']}, 15:45:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:28 INFO - 'talos_options': ['--disable-e10s'], 15:45:28 INFO - 'tests': ['tp5o']}, 15:45:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:28 INFO - 'tests': ['tp5o']}, 15:45:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:28 INFO - 'talos_options': ['--disable-e10s', 15:45:28 INFO - '--xperf_path', 15:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:28 INFO - 'tests': ['tp5n']}, 15:45:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:28 INFO - 'talos_options': ['--xperf_path', 15:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:28 INFO - 'tests': ['tp5n']}}, 15:45:28 INFO - 'talos.zip': {'path': '', 15:45:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:45:28 INFO - Running post-action listener: _resource_record_post_action 15:45:28 INFO - ##### 15:45:28 INFO - ##### Running create-virtualenv step. 15:45:28 INFO - ##### 15:45:28 INFO - Running pre-action listener: _resource_record_pre_action 15:45:28 INFO - Running main action method: create_virtualenv 15:45:28 INFO - Creating virtualenv /builds/slave/test/build/venv 15:45:28 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:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:45:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:45:28 INFO - Using real prefix '/usr' 15:45:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:45:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:45:31 INFO - Installing pip.................done. 15:45:31 INFO - Return code: 0 15:45:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:31 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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 15:45:31 INFO - 'HOME': '/home/cltbld', 15:45:31 INFO - 'LANG': 'en_US.UTF-8', 15:45:31 INFO - 'LANGUAGE': 'en_US:en', 15:45:31 INFO - 'LOGNAME': 'cltbld', 15:45:31 INFO - 'MAIL': '/var/mail/cltbld', 15:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:31 INFO - 'MOZ_NO_REMOTE': '1', 15:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:31 INFO - 'NO_EM_RESTART': '1', 15:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:31 INFO - 'PWD': '/builds/slave/test', 15:45:31 INFO - 'SHELL': '/bin/bash', 15:45:31 INFO - 'SHLVL': '1', 15:45:31 INFO - 'TERM': 'linux', 15:45:31 INFO - 'TMOUT': '86400', 15:45:31 INFO - 'USER': 'cltbld', 15:45:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 15:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:31 INFO - '_': '/tools/buildbot/bin/python'} 15:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:31 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:31 INFO - Cleaning up... 15:45:31 INFO - Return code: 0 15:45:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:31 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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 15:45:31 INFO - 'HOME': '/home/cltbld', 15:45:31 INFO - 'LANG': 'en_US.UTF-8', 15:45:31 INFO - 'LANGUAGE': 'en_US:en', 15:45:31 INFO - 'LOGNAME': 'cltbld', 15:45:31 INFO - 'MAIL': '/var/mail/cltbld', 15:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:31 INFO - 'MOZ_NO_REMOTE': '1', 15:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:31 INFO - 'NO_EM_RESTART': '1', 15:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:31 INFO - 'PWD': '/builds/slave/test', 15:45:31 INFO - 'SHELL': '/bin/bash', 15:45:31 INFO - 'SHLVL': '1', 15:45:31 INFO - 'TERM': 'linux', 15:45:31 INFO - 'TMOUT': '86400', 15:45:31 INFO - 'USER': 'cltbld', 15:45:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 15:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:31 INFO - '_': '/tools/buildbot/bin/python'} 15:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:32 INFO - Downloading/unpacking psutil>=0.7.1 15:45:32 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:32 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:32 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:32 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:32 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:32 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:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:34 INFO - Installing collected packages: psutil 15:45:34 INFO - Running setup.py install for psutil 15:45:34 INFO - building 'psutil._psutil_linux' extension 15:45:34 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:35 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:35 INFO - building 'psutil._psutil_posix' extension 15:45:35 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:35 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:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:35 INFO - Successfully installed psutil 15:45:35 INFO - Cleaning up... 15:45:35 INFO - Return code: 0 15:45:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:45:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:35 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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 15:45:35 INFO - 'HOME': '/home/cltbld', 15:45:35 INFO - 'LANG': 'en_US.UTF-8', 15:45:35 INFO - 'LANGUAGE': 'en_US:en', 15:45:35 INFO - 'LOGNAME': 'cltbld', 15:45:35 INFO - 'MAIL': '/var/mail/cltbld', 15:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:35 INFO - 'MOZ_NO_REMOTE': '1', 15:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:35 INFO - 'NO_EM_RESTART': '1', 15:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:35 INFO - 'PWD': '/builds/slave/test', 15:45:35 INFO - 'SHELL': '/bin/bash', 15:45:35 INFO - 'SHLVL': '1', 15:45:35 INFO - 'TERM': 'linux', 15:45:35 INFO - 'TMOUT': '86400', 15:45:35 INFO - 'USER': 'cltbld', 15:45:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 15:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:35 INFO - '_': '/tools/buildbot/bin/python'} 15:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:45:36 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:36 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:36 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:36 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:36 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:36 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:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:37 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:37 INFO - Installing collected packages: mozsystemmonitor 15:45:37 INFO - Running setup.py install for mozsystemmonitor 15:45:38 INFO - Successfully installed mozsystemmonitor 15:45:38 INFO - Cleaning up... 15:45:38 INFO - Return code: 0 15:45:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:45:38 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:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:38 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:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:38 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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 15:45:38 INFO - 'HOME': '/home/cltbld', 15:45:38 INFO - 'LANG': 'en_US.UTF-8', 15:45:38 INFO - 'LANGUAGE': 'en_US:en', 15:45:38 INFO - 'LOGNAME': 'cltbld', 15:45:38 INFO - 'MAIL': '/var/mail/cltbld', 15:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:38 INFO - 'MOZ_NO_REMOTE': '1', 15:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:38 INFO - 'NO_EM_RESTART': '1', 15:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:38 INFO - 'PWD': '/builds/slave/test', 15:45:38 INFO - 'SHELL': '/bin/bash', 15:45:38 INFO - 'SHLVL': '1', 15:45:38 INFO - 'TERM': 'linux', 15:45:38 INFO - 'TMOUT': '86400', 15:45:38 INFO - 'USER': 'cltbld', 15:45:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 15:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:38 INFO - '_': '/tools/buildbot/bin/python'} 15:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:45:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:40 INFO - Downloading docopt-0.6.1.tar.gz 15:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:40 INFO - Running setup.py install for blobuploader 15:45:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:45:40 INFO - Running setup.py install for requests 15:45:41 INFO - Running setup.py install for docopt 15:45:41 INFO - Successfully installed blobuploader requests docopt 15:45:41 INFO - Cleaning up... 15:45:41 INFO - Return code: 0 15:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:41 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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 15:45:41 INFO - 'HOME': '/home/cltbld', 15:45:41 INFO - 'LANG': 'en_US.UTF-8', 15:45:41 INFO - 'LANGUAGE': 'en_US:en', 15:45:41 INFO - 'LOGNAME': 'cltbld', 15:45:41 INFO - 'MAIL': '/var/mail/cltbld', 15:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:41 INFO - 'MOZ_NO_REMOTE': '1', 15:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:41 INFO - 'NO_EM_RESTART': '1', 15:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:41 INFO - 'PWD': '/builds/slave/test', 15:45:41 INFO - 'SHELL': '/bin/bash', 15:45:41 INFO - 'SHLVL': '1', 15:45:41 INFO - 'TERM': 'linux', 15:45:41 INFO - 'TMOUT': '86400', 15:45:41 INFO - 'USER': 'cltbld', 15:45:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 15:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:41 INFO - '_': '/tools/buildbot/bin/python'} 15:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:41 INFO - Running setup.py (path:/tmp/pip-rJIWqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:41 INFO - Running setup.py (path:/tmp/pip-1zbY4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:41 INFO - Running setup.py (path:/tmp/pip-g76r8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:41 INFO - Running setup.py (path:/tmp/pip-Tkcgt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:41 INFO - Running setup.py (path:/tmp/pip-e3834t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:42 INFO - Running setup.py (path:/tmp/pip-pyA2b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:42 INFO - Running setup.py (path:/tmp/pip-5ZSs7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:42 INFO - Running setup.py (path:/tmp/pip-iZmEGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:42 INFO - Running setup.py (path:/tmp/pip-conNlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:42 INFO - Running setup.py (path:/tmp/pip-EOtkYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:42 INFO - Running setup.py (path:/tmp/pip-dVmUZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:42 INFO - Running setup.py (path:/tmp/pip-oEVnjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:42 INFO - Running setup.py (path:/tmp/pip-UmsMca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:42 INFO - Running setup.py (path:/tmp/pip-kR3nhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:42 INFO - Running setup.py (path:/tmp/pip-PZM7om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:42 INFO - Running setup.py (path:/tmp/pip-JkI595-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:42 INFO - Running setup.py (path:/tmp/pip-006JBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:42 INFO - Running setup.py install for manifestparser 15:45:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Running setup.py install for mozcrash 15:45:43 INFO - Running setup.py install for mozdebug 15:45:43 INFO - Running setup.py install for mozdevice 15:45:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Running setup.py install for mozfile 15:45:43 INFO - Running setup.py install for mozhttpd 15:45:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Running setup.py install for mozinfo 15:45:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Running setup.py install for mozInstall 15:45:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Running setup.py install for mozleak 15:45:43 INFO - Running setup.py install for mozlog 15:45:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:45:43 INFO - Running setup.py install for moznetwork 15:45:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:45:44 INFO - Running setup.py install for mozprocess 15:45:44 INFO - Running setup.py install for mozprofile 15:45:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:45:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:45:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:45:44 INFO - Running setup.py install for mozrunner 15:45:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:45:44 INFO - Running setup.py install for mozscreenshot 15:45:44 INFO - Running setup.py install for moztest 15:45:44 INFO - Running setup.py install for mozversion 15:45:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:45:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:44 INFO - Cleaning up... 15:45:44 INFO - Return code: 0 15:45:44 INFO - Installing None 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', '-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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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', '-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:44 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: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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:44 INFO - Running setup.py (path:/tmp/pip-Y4H4Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:45 INFO - Running setup.py (path:/tmp/pip-hj_osy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:45 INFO - Running setup.py (path:/tmp/pip-D_FrpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:45 INFO - Running setup.py (path:/tmp/pip-w8xksp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:45 INFO - Running setup.py (path:/tmp/pip-iJGG4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:45 INFO - Running setup.py (path:/tmp/pip-Ar0Vi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:45 INFO - Running setup.py (path:/tmp/pip-pTCI0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:45 INFO - Running setup.py (path:/tmp/pip-zAka1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:45 INFO - Running setup.py (path:/tmp/pip-zkCRq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:45 INFO - Running setup.py (path:/tmp/pip-zZBEmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:45 INFO - Running setup.py (path:/tmp/pip-fOpO56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:45 INFO - Running setup.py (path:/tmp/pip-b_fj_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:45 INFO - Running setup.py (path:/tmp/pip-r62MOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:45 INFO - Running setup.py (path:/tmp/pip-yUI2iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:45 INFO - Running setup.py (path:/tmp/pip-oek82S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:46 INFO - Running setup.py (path:/tmp/pip-yfiv2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:46 INFO - Running setup.py (path:/tmp/pip-rp1C9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:46 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:46 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:46 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:46 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:46 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:46 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:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:48 INFO - Downloading blessings-1.6.tar.gz 15:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:48 INFO - Installing collected packages: blessings 15:45:48 INFO - Running setup.py install for blessings 15:45:48 INFO - Successfully installed blessings 15:45:48 INFO - Cleaning up... 15:45:48 INFO - Return code: 0 15:45:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:48 INFO - Reading from file tmpfile_stdout 15:45:48 INFO - Current package versions: 15:45:48 INFO - argparse == 1.2.1 15:45:48 INFO - blessings == 1.6 15:45:48 INFO - blobuploader == 1.2.4 15:45:48 INFO - docopt == 0.6.1 15:45:48 INFO - manifestparser == 1.1 15:45:48 INFO - mozInstall == 1.12 15:45:48 INFO - mozcrash == 0.17 15:45:48 INFO - mozdebug == 0.1 15:45:48 INFO - mozdevice == 0.48 15:45:48 INFO - mozfile == 1.2 15:45:48 INFO - mozhttpd == 0.7 15:45:48 INFO - mozinfo == 0.9 15:45:48 INFO - mozleak == 0.1 15:45:48 INFO - mozlog == 3.1 15:45:48 INFO - moznetwork == 0.27 15:45:48 INFO - mozprocess == 0.22 15:45:48 INFO - mozprofile == 0.28 15:45:48 INFO - mozrunner == 6.11 15:45:48 INFO - mozscreenshot == 0.1 15:45:48 INFO - mozsystemmonitor == 0.0 15:45:48 INFO - moztest == 0.7 15:45:48 INFO - mozversion == 1.4 15:45:48 INFO - psutil == 3.1.1 15:45:48 INFO - requests == 1.2.3 15:45:48 INFO - wsgiref == 0.1.2 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', '--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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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', '--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:48 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: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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 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 - 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:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 INFO - Cleaning up... 15:45:48 INFO - Return code: 0 15:45:48 INFO - Installing jsonschema 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', '--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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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', '--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:48 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: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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 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 - Downloading/unpacking jsonschema 15:45:48 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:48 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:48 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:48 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:48 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:48 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:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:50 INFO - Downloading/unpacking functools32 (from jsonschema) 15:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:51 INFO - warning: no files found matching '*.txt' 15:45:51 INFO - no previously-included directories found matching 'build' 15:45:51 INFO - no previously-included directories found matching 'dist' 15:45:51 INFO - no previously-included directories found matching '.git*' 15:45:51 INFO - Installing collected packages: jsonschema, functools32 15:45:51 INFO - Running setup.py install for functools32 15:45:51 INFO - warning: no files found matching '*.txt' 15:45:51 INFO - no previously-included directories found matching 'build' 15:45:51 INFO - no previously-included directories found matching 'dist' 15:45:51 INFO - no previously-included directories found matching '.git*' 15:45:51 INFO - Successfully installed jsonschema functools32 15:45:51 INFO - Cleaning up... 15:45:51 INFO - Return code: 0 15:45:51 INFO - Installing flake8 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', '--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 0x7f1c71b70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, '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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', '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', '--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:51 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: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': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 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 - Downloading/unpacking flake8 15:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:45:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:45:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:45:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:45:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:45:53 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:53 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:53 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:53 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:53 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:53 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 - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:45:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:54 INFO - no previously-included directories found matching 'docs/_build' 15:45:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:45:54 INFO - Running setup.py install for pep8 15:45:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:54 INFO - no previously-included directories found matching 'docs/_build' 15:45:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:45:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:45:54 INFO - Cleaning up... 15:45:54 INFO - Return code: 0 15:45:54 INFO - Running post-action listener: _resource_record_post_action 15:45:54 INFO - Running post-action listener: _start_resource_monitoring 15:45:54 INFO - Starting resource monitoring. 15:45:54 INFO - ##### 15:45:54 INFO - ##### Running install step. 15:45:54 INFO - ##### 15:45:54 INFO - Running pre-action listener: _resource_record_pre_action 15:45:54 INFO - Running main action method: install 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:54 INFO - Reading from file tmpfile_stdout 15:45:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:45:54 INFO - Reading from file tmpfile_stdout 15:45:54 INFO - Output received: 15:45:54 INFO - Usage: mozinstall [options] installer 15:45:54 INFO - Options: 15:45:54 INFO - -h, --help show this help message and exit 15:45:54 INFO - -d DEST, --destination=DEST 15:45:54 INFO - Directory to install application into. [default: 15:45:54 INFO - "/builds/slave/test"] 15:45:54 INFO - --app=APP Application being installed. [default: firefox] 15:45:54 INFO - mkdir: /builds/slave/test/build/application 15:45:54 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:45:54 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:10 INFO - Reading from file tmpfile_stdout 15:46:10 INFO - Output received: 15:46:10 INFO - /builds/slave/test/build/application/firefox/firefox 15:46:10 INFO - Running post-action listener: _resource_record_post_action 15:46:10 INFO - ##### 15:46:10 INFO - ##### Running run-tests step. 15:46:10 INFO - ##### 15:46:10 INFO - Running pre-action listener: _resource_record_pre_action 15:46:10 INFO - Running main action method: run_tests 15:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:46:10 INFO - Python 2.7.3 15:46:10 INFO - Return code: 0 15:46:10 INFO - grabbing minidump binary from tooltool 15:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:10 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 0xeae410>, '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 0xeaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:46:10 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:10 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:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:46:10 INFO - Return code: 0 15:46:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:46:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:46:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:46:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:46:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:46:11 INFO - Return code: 0 15:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:46:11 INFO - Using env: {'DISPLAY': ':0', 15:46:11 INFO - 'HOME': '/home/cltbld', 15:46:11 INFO - 'LANG': 'en_US.UTF-8', 15:46:11 INFO - 'LANGUAGE': 'en_US:en', 15:46:11 INFO - 'LOGNAME': 'cltbld', 15:46:11 INFO - 'MAIL': '/var/mail/cltbld', 15:46:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:46:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:11 INFO - 'MOZ_NO_REMOTE': '1', 15:46:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:11 INFO - 'NO_EM_RESTART': '1', 15:46:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:46:11 INFO - 'PWD': '/builds/slave/test', 15:46:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:46:11 INFO - 'SHELL': '/bin/bash', 15:46:11 INFO - 'SHLVL': '1', 15:46:11 INFO - 'TERM': 'linux', 15:46:11 INFO - 'TMOUT': '86400', 15:46:11 INFO - 'USER': 'cltbld', 15:46:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751', 15:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:11 INFO - '_': '/tools/buildbot/bin/python'} 15:46:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fenUE7mTQtSDhnVbMV__VA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:46:12 INFO - mozversion application_buildid: 20160413141950 15:46:12 INFO - mozversion application_changeset: bc2373295e31d99f9b870a1253b6e01650df8f31 15:46:12 INFO - mozversion application_display_name: Nightly 15:46:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:46:12 INFO - mozversion application_name: Firefox 15:46:12 INFO - mozversion application_remotingname: firefox 15:46:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:46:12 INFO - mozversion application_vendor: Mozilla 15:46:12 INFO - mozversion application_version: 48.0a1 15:46:12 INFO - mozversion platform_buildid: 20160413141950 15:46:12 INFO - mozversion platform_changeset: bc2373295e31d99f9b870a1253b6e01650df8f31 15:46:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:46:12 INFO - mozversion platform_version: 48.0a1 15:46:12 INFO - using testdate: 1460587572 15:46:12 INFO - actual date: 1460587572 15:46:12 INFO - starting webserver on 'localhost:58995' 15:46:12 INFO - SUITE-START | Running 2 tests 15:46:12 INFO - TEST-START | dromaeo_css 15:46:12 INFO - operating with platform_type : linux_ 15:46:12 INFO - Initialising browser for dromaeo_css test... 15:46:12 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppVS22Y/profile http://localhost:58995/getInfo.html) 15:46:17 INFO - PROCESS | 3311 | 15:46:17 INFO - PROCESS | 3311 | (process:3377): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:46:17 INFO - PROCESS | 3311 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:46:18 INFO - PROCESS | 3311 | __metrics Screen width/height:1600/1200 15:46:18 INFO - PROCESS | 3311 | colorDepth:24 15:46:18 INFO - PROCESS | 3311 | Browser inner width/height: 1024/697 15:46:18 INFO - PROCESS | 3311 | __metrics 15:46:18 ERROR - PROCESS | 3311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:46:19 INFO - TEST-INFO | 3311: exit 0 15:46:19 INFO - Browser initialized. 15:46:19 INFO - Running cycle 1/1 for dromaeo_css test... 15:46:19 INFO - TEST-INFO | started process 3428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppVS22Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:21 INFO - PROCESS | 3428 | 15:46:21 INFO - PROCESS | 3428 | (process:3487): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:46:31 INFO - PROCESS | 3428 | RSS: Main: 164507648 15:46:31 INFO - PROCESS | 3428 | 15:47:21 INFO - PROCESS | 3428 | 1460587641140 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:34 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:58995/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58995/tests/dromaeo/cssquery-ext.html) 15:49:35 INFO - PROCESS | 3428 | RSS: Main: 165511168 15:49:35 INFO - PROCESS | 3428 | 15:52:37 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:58995/tests/dromaeo/cssquery-ext.html (next: http://localhost:58995/tests/dromaeo/cssquery-jquery.html) 15:52:38 INFO - PROCESS | 3428 | RSS: Main: 164884480 15:52:38 INFO - PROCESS | 3428 | 15:55:40 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:58995/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58995/tests/dromaeo/cssquery-mootools.html) 15:55:40 INFO - PROCESS | 3428 | RSS: Main: 166076416 15:55:40 INFO - PROCESS | 3428 | 15:58:42 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:58995/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58995/tests/dromaeo/cssquery-prototype.html) 15:58:43 INFO - PROCESS | 3428 | RSS: Main: 164364288 15:58:43 INFO - PROCESS | 3428 | 16:01:45 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:58995/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58995/tests/dromaeo/cssquery-yui.html) 16:01:46 INFO - PROCESS | 3428 | RSS: Main: 166014976 16:01:46 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:58995/tests/dromaeo/cssquery-yui.html (next: http://localhost:58995/tests/dromaeo/cssquery-dojo.html) 16:04:48 INFO - PROCESS | 3428 | RSS: Main: 167702528 16:04:48 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | __start_tp_report 16:04:48 INFO - PROCESS | 3428 | _x_x_mozilla_page_load 16:04:48 INFO - PROCESS | 3428 | _x_x_mozilla_page_load_details 16:04:48 INFO - PROCESS | 3428 | |i|pagename|runs| 16:04:48 INFO - PROCESS | 3428 | |0;dojo.html;2615.215435369389;2642.4847154804816;2649.668791401075;2691.085031089428;2702.67567891853;4759.8810029749275;4778.569928706415;4797.544233297831;4806.639502037352;4845.927311090337;4740.194166991611;4763.35694681218;4791.712497250159;4811;4920.778564964577;4385.912281754371;4417.955820441803;4444.000099977496;4450.5104438511735;4515.300128480091;4417.9116417671785;4451;4509.0530988492455;4516.593506584407;4541.909161816761;4335.024619460628;4355.499117601485;4361.236783562864;4415.072834704716;4429.180601588717;4372.759498227596;4376.846810361654;4380.452443444569;4397.692161548693;4455.643548516111;4334.891627709332;4375.934360984587;4393.7363758174615;4429.357743127261;4431.822727090913;4712.952870471286;4726.291056341542;4730.195866702668;4731.053789242165;4774.236122220463;5187.48125187482;5193.169092945111;5202.817901373433;5214.296070030536;5241.161414173752;5219.582433405319;5232.790688372461;5237.3453318335205;5281.260623512711;5312.150055991023;4808.711477311373;4856.17445034345;4856.927146092811;4872.9756351218375;4900.362952816111;5345.545628621533;5346;5348.1442969124755;5348.3849357323625;5352.330958630171;4893.09477746618;4993.875153121128;5064.34163558735;5106.693598384035;5114.43741188469;5090.10923088458;5101.846944591668;5143.099957507496;5153.742312884416;5211.530962213419;5037.395512538519;5045.369328833895;5058.64589478733;5061.13960626687;5096.0317539668085;4970.676906001098;5125.1287281162295;5167.0957582422925;5179.2749015137915;5224.712640804716;4308.3968244445805;4359.934600980988;4360.803763830635;4362.694611377173;4395.362672412482;3713.405855063231;3765.755225910362;3769.9434508482395;3801.6768574671464;3835.6356146166067;4466.553344665507;4533.342665313511;4535.092981403666;4573.839915602938;4576.359309696645;5253.553447956967;5267.683938963674;5272.78908843642;5289.233061206103;5316.627836051439;4309.827606895752;4414.492333381702;4509.706869053501;4539.319102134707;4588.105319462673;4695.413073365829;4730.59789917854;4730.976345118322;4749.430068391815;4793.01743142655;4859.684120532154;4895.608351331956;4897.755112244445;4902.14212512816;4939.234418665041;4972.5027497249985;5102.183650615883;5176.145935920531;5255.080360936897;5298.788048478172;4883.291922671122;4902.1114575947895;4903.901921961612;4921.3356196912955;4922.1140194765285;5140.43455219918;5146.485351464824;5163.148080566664;5174.689518628894;5215.608829337891;4987.551120399182;5023.57299629521;5220.9738951305;5244.003639308519;5287.788488460418;4970.155073637418;5044.47033061538;5053.090443720165;5059.06407314648;5082.161443361804;5013.172826483589;5014.072396606493;5019.548240658358;5022.4977502249485;5100.846974590768;4802.73584952831;4920.991196804574;4972.975135124301;4990.900181996267;5054.039732450822;5045;5097.6941383517105;5114.4374118847645;5129.92305115431;5171.974140129275;4971.726555039508;4979.875503112451;4996.625253105959;5010.599152067753;5037.622178336713 16:04:48 INFO - PROCESS | 3428 | |1;ext.html;565.9264295641568;610.1640752169528;628.258654787351;629.9716512756926;655.547672106247;35798.642013579854;35828.104297392514;35957.46063809045;36002.63997360026;36039.63960360396;36813.63186368135;37372.439413408756;37446.43830342547;37585.812070939675;37677.623223767754;7577.583232922187;7724.9613751931165;7759.922400775977;7760.456768026241;7773.183815699355;7680.039995000625;7870.488418252824;7881.448298619099;7908.367330613566;7937.960310198441;7911.802204944894;8020.759377218693;8046.235607617296;8051.798705032392;8052.3558115350925;7802.921970780277;7958.363330933569;7997.480163789335;7997.6001199940065;8002.559859207741;7829.921700782977;7860.960695196487;7914.960425197894;7941.96029019857;7952.284294413531;29316.560251596242;37112.32994515253;37524.62475375239;37553.24893502115;37609;3050.0697287327357;3161.0832858471017;3171.5718378019133;3220.7745457817964;3260.8858689945973;24260.757392426025;25408.87295563529;25519.872400638065;25847.483050339077;26285.73714262852;3318.435865902778;3342.080927744865;3346.6151392589923;3393.253484233465;3445.242046749711;152943;153681;153734;154032;154192;31897.52153717696;32167.839160804047;32210.516842247383;32216.19459513484;32237.677623223935;58078.709606451695;60244.69877650584;60725.39274607286;60876;61018.0847287291;13853.653658658613;14007.579772606838;14016;14053.22707251111;14081;9665.806683866283;9718.902810971942;9755.707328780149;9787.412755234567;9798.069183427562;17854.375096871547;18032.909835451002;18036;18778.906105469385;18806.153723082494;6792.864142717217;7044.682989265495;7133.785986420416;7178.425919937908;7184.533005354635;820.0692214336771;862.2799962031773;947.2327414794039;961.7980224152866;976.3799987008159;27423;28098.85950570234;28325.858370708425;28442.146735597966;28647.283817904718;972.9783727086531;974.6637410093506;993.1359717046216;1011.868457100587;1030.6135199300263;14940.775888361683;15173.772393414107;15316.157611331484;15365.078095314317;15586.688266234612;151644;151988;152318;152640;354335;46358;46417.76791116023;47847.76076119597;47929.76035119872;48303.758481208075;1235.2958813476412;1271.9364031798373;1275.7703613349686;1278.2011242973142;1280.0975312404732;26720.732792671824;27600.861995689895;27715.307117321423;27811;28102.2974425641;41697;42286;42827.785861071745;42838;42916.1416771669;304239;309558;310143;310274;311871;25071.623925640764;26353.20940371792;26378.472430551665;26437.60343594809;26450.470990580467;41686;41912.58087419087;41922.79038604788;42497.787511063485;42977.3553396693;35992.28015439729;36273.63726362808;36636.81681591575;37239.813800930824;37508.062298442754;35507.64492355043;36198.09504762402;36265.81867090753;36542.8172859134;37111.628883710815;35737.10657233486;35875;35959.460608090376;36058.819705901304;36315;31559.844015598257;33148.66851331456;33349.66650333466;33350.332993339514;33404;25056.24831255065;25234.495310094062;26103.477930441666;26452.73547264503;26667.866660666572 16:04:48 INFO - PROCESS | 3428 | |2;jquery.html;378.9545254569452;383.9616038396161;388.87750358637027;392.7192057678759;404.092811637873;15583.185434821631;16579.005259684396;16995.74506382405;17054.914725426388;17142.485725428225;15521.456749013787;16427.83572164278;16913.83086169138;16918.40785572502;16927.49217523476;4627.8380256691025;4759;4793.257045158006;4796.856094317176;4808.3989501312335;3461.1174150591564;5158.303629010074;5442.863928401782;5461.972690136564;5472.863178420552;5392.649477783932;5394.595405344595;5446.673199608016;5447.509724124828;5456.208849716789;5301.151815709468;5379.973100134474;5475;5502.80740174094;5504.944950550504;4475.686701930867;5266.8419947401635;5303.867403314909;5306.7611957462;5319.388270348921;12443.128980971336;12452.191235059761;12552.309622970733;12615.116941814076;12654.936725316315;1817.7636907202111;1886.2077927270443;1888.5089876632037;1941.7669879614396;2054.558269971963;8912.64349426022;8995.640174393016;8999.415038022507;9316.8602470963;9443.858342124873;1610.7825443565087;1647.912377830638;1709.7862767154106;1753.281154726556;1795.3626462605848;63326;71469.6426517864;71886;72171;73231;9572.712818615453;9744.561494732754;9878.308518403643;10033.351307091727;10188.235882308856;13929.651758706113;13940.512082077079;13982.860171398155;13989.790153147711;14017.509387171604;7184.964075179695;7214.603196824225;7239.601821899741;7362.8527429451115;7402.703891844373;6697.129373181553;6747.122874026345;6776.627285499345;6963.373296403348;6996.860062798817;4214.199302132585;4225.070484493406;4299.699021068558;4414.448193975753;4470.262406702923;1730.9826901731074;1826.397948402504;1827.9725804112684;1902.4863286912457;1913.4787843664321;751.5115175136206;860.4493124400389;921.7004473546124;924.713338864954;932.4358762948455;16127.838721612634;16368.427105051265;16541.751873721903;16695.24871380791;16863.241154148094;775.135723668106;798.2775588092785;833.1959658929162;849.2208822516817;893.8748575199477;9091.090890910988;9242.537873106317;9307.953460232791;9329.766755831159;9498.382605130644;370454;378694;379600;382610;385586;74909.62545187239;75399;76089.23910760932;77999;79222;925.7639301977953;934.5514153206499;934.6868798952427;937.9390339627903;946.9905300946903;14529;14537.127772333693;14590;14688.339024744126;14725.410983560538;32166.35667286688;33093.66906330906;33728.49407258844;34006.82996585001;34777.30445391129;47357;47449.28826067543;47491.52508474871;47570.286445704034;47882.521174787806;6554.410103090745;6829;6839.6580170990255;6847.041414201916;7485.288897554724;8207.056188538394;10123.671555542414;11557.768844623228;11951.10366722482;11967.64097077089;9989.200863930722;10027.799444010932;10200.642977495752;10286.485675716034;10294.227932904912;9979.900200997898;10039.598416063276;10085.243606729671;10277.229207809294;10358.223133264884;10008.199344052604;10111.292209545261;10120.59517619287;10464.372137671764;10655.89344106549;7134.500584959003;7219.45854060937;7258.49190556656;7310.19587845326;7379.188289288281;8366.70716524943;10196;10383.740406489898;10427.530761115617;10452.32059916103 16:04:48 INFO - PROCESS | 3428 | |3;mootools.html;1447.0955652717053;1471.9990406523564;1620.6029522766923;1767.8320559546846;1777.271318759309;6731.899021514669;7569.65936532856;7598.278163574459;7899.091604465481;7917.999999999993;7651.966984457096;7663.118741344747;7761.534307941528;7764.029496312961;7782;2147.763745987944;2153.0526568309892;2161.556880839424;2173.1850556041486;2183.1813070098715;2091.205341970049;2097.1087287902656;2184.4648061224943;2192.397090800027;2193.320070778056;2111.915523379063;2144.4210063282903;2148.3340164548963;2163.632182528966;2176.1295481807247;2130.8614940028847;2132.317658349321;2140.4969832089446;2141.4325203821;2143.3677065265783;2115.545157791067;2139.17641707942;2147.3128598848375;2151.150295633232;2166.2418153646254;7848.293653571149;7880.80297992549;7922.881156782653;7927.405444591679;7943.086545047336;4611.861644150681;4716.52834716529;4733.715977041354;4753.619710423158;4765.189917713997;2970.9257268568244;3014.0807053848566;3094.458469767804;3127.2494601295753;3143.009951865178;951.6574033347989;974.3277138774223;988.3229987458542;999.0558921818885;999.1607050077897;10995.560177592886;10999.61501347449;11001.61494347694;11042.834357484644;11054.170937179662;4077.4699289092227;4158.896027599334;4319.589638984291;4364.061726728769;4479.081788233404;9360.906390936003;9381.765455863659;9389.436633801994;9396.436213827192;9402.905970940203;4769.523047695272;4796.040791841646;4800.807967681254;4803.735794531264;4806.8077276909235;3782.508273924372;4220.5146408163455;4262.637675797592;4288.52826189119;4384.386185933972;3634.727395445352;3678.209185025179;3773.094457330221;3797.0697179191275;3817.3701339279264;1219.3598360860442;1243.030436259719;1251.5807204586565;1254.5734450286946;1254.974900502003;789.3921680306247;843.8354520868372;845.3237410071918;845.7462761171624;854.1031916487663;5105.438401775802;5254.973725131426;5288;5387;5427.9185812212845;406.34172640322276;411.66449343784717;413.1386060064739;417.99164016719493;418.0927387568922;3447.620761716209;3459.636738142459;3467.86128554855;3513.1392808762016;3556.804375759358;9672.22622190223;9931.602735890629;9995.750106247257;10037.347572407916;10067.1442927352;9808.509574521246;9884.604615815431;9917.702468925943;9945.651902183388;9955.203583713286;7167.534110282919;7318;7366.521176123535;7386.852262954818;7419.332260096618;5055.87360315995;5060.240963855451;5098.617603679665;5162.741862906764;5263.7894484220205;8941.821163576562;9008.86486702713;9036.689679996494;9159.404638698463;9200.769980750534;9117.452952822852;9130.908690913006;9203.76990575241;9294.25645948336;9359.672411465566;5972.820815375546;6813.318668133147;6853.348931851466;6974.337437943387;7044.436445084279;7720.8455830884195;7723.691052357843;7724.343430808444;7751;7787.844243115219;6894.827629309308;7071.045408869737;7096.858062838817;7148.857022859618;7163.498555101093;6868.931310686829;6889.207741109836;6952.061471701458;6965.407940325129;6979.30206979298;6326.2092238470195;6476.222853257639;6561.671916404256;6563.835904102245;6633.469322454289;4624.190766615761;4669.883252918704;4672.719636821802;4731.337612734151;4735;4505.864824055284;4579.129965306581;4640.280756482751;4643.558861908114;4673.485916549245 16:04:48 INFO - PROCESS | 3428 | |4;prototype.html;292.58745169311277;302.26549484752053;308.1664098613251;310.73587450666923;315.6401702059654;5209;5377.247185394048;5381.542568881645;5460.235567020621;5517.862053448665;5374.3013408256875;5385.461453854613;5407.161889907061;5416.485433883785;5420.105682562373;4135.524414692304;4139.648129908961;4141.316682747351;4153.730007549515;4165.250254954107;4075.1238483725992;4097.672186225095;4164.583541645841;4176.081262122329;4184.7070705050655;4080.1635664688815;4084.83660653575;4101.856435024774;4129.504459464868;4134.2144992451485;4073;4099.590040995907;4102.651274641674;4163.042500224935;4163.854265100737;3415.163284995192;3567.250877315767;3568.6431356864364;3586.332355454726;3638.0904773806546;5148.279240906276;5155.61332900034;5161.458046905096;5163.1480805667015;5173.9741301293625;4714.010057887847;4717.150912835688;4718.976405117986;4730.337752714623;4741;5544.251526043973;5614.719264036782;5667.348254950651;5678.318601767773;5701.315842098975;3866.845326186949;3869.2454971280613;3872.3997780344093;3882.417637354391;3900.9804950975063;5867.885101830639;5926.377730338296;5927.496162826165;5946.762129514815;5963.045912653998;3879.4374815652136;3944.3097457944746;3950.6839452843706;3979.184267225212;4001.239764444746;4001.019495349762;4012.2376748417705;4013.5986401360215;4023.657989070903;4031.032552187454;4625.606823419979;4666.486686464486;4680.08738296029;4680.73620122565;4695.239285268024;5490;5504.587155963319;5611.719414029282;5656.745446454919;5692.943070569241;1398.7482253194319;1412.3714946848759;1412.4632639596887;1415.7451658701327;1417.666848290651;915.8809354783835;924.1497822003772;943.2312665177858;945.2201933404831;949.2216382566368;4982.07831551157;4986.925196122061;5002.674826136289;5003.124453220672;5027.681730058144;5839.299284085937;5850.678212698257;5861.9413805861395;5883.529317654577;5901.616394934315;4876.707397556158;4941.50584941503;4973.90052198954;4980.028894365636;5017.799288028438;3155.7850227662057;3161.668024857357;3170.2708377073404;3188.1232661018407;3198.2484116232667;5481.451854814487;5483.945160548423;5487.012337779238;5496.862578435571;5502.9174562381595;5778.3643799182055;5995.61028533144;6037.366076561985;6042.335343112254;6047.274327080779;5434.782608695687;5451.236826844245;5454.263674403905;5456.91814622781;5490.423505531861;5759.573054032844;5794.13088036781;5852.151438041546;5877.764889404376;5918.644881307136;5705.144228365778;5709.172170035405;5726.484616384545;5741.483266506035;5748.856278593069;5471.261379713687;5480.534154596904;5490.725463726878;5493.670379777226;5496.917546236889;3892.8053597320586;3979.5025621797276;4130.669546436338;4156.085661154541;4200.600942910419;5670.149477578396;5770.451807078321;5883.2057672215415;5943.108533719977;5987.101934709828;5753.165790960371;5770.769169233184;5770.942290577041;5775.249217601853;5784.479396854135;5740.454656807597;5746.885062298814;5751.511121554715;5763.452472015152;5765.336986246635;5520.227168196536;5540;5634.380218175916;5638.323401191883;5641.238432811518;5721.342045664802;5755.366909639853;5755.395683453345;5775.306963164448;5776.382612868403;5432.34811822568;5618.157276408408;5641.26663533738;5642.407547207648;5660.622538533743 16:04:48 INFO - PROCESS | 3428 | |5;yui.html;655.6262930129826;667.2726727866625;726.2773540327375;733.0946281342541;778.3578547698147;11813.468393922272;12177.939110304447;12196.81704774429;12219.511219551207;12276.140670153092;11280.210385273034;11360.147988900824;11390.658280251586;11405.258658187213;12050;635.9332270111641;799.5642374905661;810.1250649298772;810.2019510781876;811.5982588618613;789.538120199681;813.040612077748;816.677412422093;817.2807929022451;819.901611806584;853.6372041882206;854.6068808348167;855.9058503564603;858.5149390594325;858.772425307294;844.3920377328313;846.7502086884384;847.7965288330818;849.3247867944967;850.4302117581235;620.2556931682;623.9688015599202;624.3756243756244;624.6564389585756;625.4183609243402;11503.539858405653;11553.306801591847;11595.884041159565;11601.535938562447;11619.012383947374;12560.937195314056;12569.183003104768;12570;13055.86944130556;13185.406656700472;10051.497425128788;10349.223808214414;10365.170786337076;10549.73625659357;10759.408232547206;3371.898843034713;3411.96588034119;3416.8633254669785;3424.503447000196;3449.5170676105367;43370.56629433697;43435.78282108569;43511.34732979008;43955.560444395785;44095.33856992148;9467.242620590336;9495.287853411022;9601.711948641552;9648.855267170999;10005.749856253506;17036.403725869535;17151.142442878056;17169.82830171682;17175.65648687044;17211.397601083903;6680.398764111156;6696.799096027127;6766;6936.4797640177185;7002.964985175042;3709.517762690833;3804.771713697187;3849.3071247175776;3855.556610989716;3958.6635136013188;2825.011246063861;2919.0221275872395;2920.766338692942;2922.0941508132546;2923.0061778995246;534.5349545895018;546.2625455634861;550.9917351239735;551.9034169020406;552.9419410961872;499.36081815275776;603.1555821849446;607.0560278766472;608.7595399817047;619.7335145887312;7664.65509052094;7764.961175194087;7802.882956755539;7814.921850781533;7912.248336408032;572.2760707704757;581.6364772017489;584.8567101060182;593.3562085137673;595.1370512756434;3541.2386336937166;3573.7498375114014;3600.963990360063;3608.4948107265004;3676.099355657881;47354.5264547357;47625.76187119111;47903;48677.26984095242;49099.50900491021;43036;43430;43731.34402983958;43820;43874.561254387685;39726.60273397287;40171.39742903801;40201.798991005446;40306;40541.797291013354;6748.865022699617;6805.870087891728;6958.199807022257;6997.545159564612;7019.859602808017;27072.187834365002;27425.588616170375;28090.157295281173;28094.71905280921;28364.00725974581;33524.83237583796;33587.83206083954;36210.27579448344;36327.455088174225;36440.27119457543;8891.422057566237;8923.464592124494;9028.638854445748;9151.816963660556;9217.446953182562;10341.276110672181;10391.220658450799;10516.631917882838;10583.523741431809;10618.84071738909;9276.397034192756;9333.953330233306;9420.717378478657;9467.147956683932;9476.147146756824;10325.380477171093;10568.841467377842;10587.417692026704;10894.78210435771;11348.843719693232;10156.542955567165;10177.898221017991;10520.421376824348;10711.303765255234;10950.452477376259;9008;9008.90991090107;9184.219341355792;9322.254219662547;9456.574454149442;8876.156765107304;9172.633094676405;9233.676821311223;9258.629654813732;9328.906710933075 16:04:48 INFO - PROCESS | 3428 | __end_tp_report 16:04:48 INFO - PROCESS | 3428 | __start_cc_report 16:04:48 INFO - PROCESS | 3428 | _x_x_mozilla_cycle_collect,362 16:04:48 INFO - PROCESS | 3428 | __end_cc_report 16:04:48 INFO - PROCESS | 3428 | __startTimestamp1460588688715__endTimestamp 16:04:48 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | ------- Summary: start ------- 16:04:48 INFO - PROCESS | 3428 | Number of tests: 6 16:04:48 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | [#0] dojo.html Cycles:165 Average:4779.48 Median:4903.90 stddev:516.60 (10.5%) stddev-sans-first:489.49 16:04:48 INFO - PROCESS | 3428 | Values: 2615.2 2642.5 2649.7 2691.1 2702.7 4759.9 4778.6 4797.5 4806.6 4845.9 4740.2 4763.4 4791.7 4811.0 4920.8 4385.9 4418.0 4444.0 4450.5 4515.3 4417.9 4451.0 4509.1 4516.6 4541.9 4335.0 4355.5 4361.2 4415.1 4429.2 4372.8 4376.8 4380.5 4397.7 4455.6 4334.9 4375.9 4393.7 4429.4 4431.8 4713.0 4726.3 4730.2 4731.1 4774.2 5187.5 5193.2 5202.8 5214.3 5241.2 5219.6 5232.8 5237.3 5281.3 5312.2 4808.7 4856.2 4856.9 4873.0 4900.4 5345.5 5346.0 5348.1 5348.4 5352.3 4893.1 4993.9 5064.3 5106.7 5114.4 5090.1 5101.8 5143.1 5153.7 5211.5 5037.4 5045.4 5058.6 5061.1 5096.0 4970.7 5125.1 5167.1 5179.3 5224.7 4308.4 4359.9 4360.8 4362.7 4395.4 3713.4 3765.8 3769.9 3801.7 3835.6 4466.6 4533.3 4535.1 4573.8 4576.4 5253.6 5267.7 5272.8 5289.2 5316.6 4309.8 4414.5 4509.7 4539.3 4588.1 4695.4 4730.6 4731.0 4749.4 4793.0 4859.7 4895.6 4897.8 4902.1 4939.2 4972.5 5102.2 5176.1 5255.1 5298.8 4883.3 4902.1 4903.9 4921.3 4922.1 5140.4 5146.5 5163.1 5174.7 5215.6 4987.6 5023.6 5221.0 5244.0 5287.8 4970.2 5044.5 5053.1 5059.1 5082.2 5013.2 5014.1 5019.5 5022.5 5100.8 4802.7 4921.0 4973.0 4990.9 5054.0 5045.0 5097.7 5114.4 5129.9 5172.0 4971.7 4979.9 4996.6 5010.6 5037.6 16:04:48 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | [#1] ext.html Cycles:180 Average:38292.46 Median:35997.46 stddev:61276.74 (170.2%) stddev-sans-first:61383.17 16:04:48 INFO - PROCESS | 3428 | Values: 565.9 610.2 628.3 630.0 655.5 35798.6 35828.1 35957.5 36002.6 36039.6 36813.6 37372.4 37446.4 37585.8 37677.6 7577.6 7725.0 7759.9 7760.5 7773.2 7680.0 7870.5 7881.4 7908.4 7938.0 7911.8 8020.8 8046.2 8051.8 8052.4 7802.9 7958.4 7997.5 7997.6 8002.6 7829.9 7861.0 7915.0 7942.0 7952.3 29316.6 37112.3 37524.6 37553.2 37609.0 3050.1 3161.1 3171.6 3220.8 3260.9 24260.8 25408.9 25519.9 25847.5 26285.7 3318.4 3342.1 3346.6 3393.3 3445.2 152943.0 153681.0 153734.0 154032.0 154192.0 31897.5 32167.8 32210.5 32216.2 32237.7 58078.7 60244.7 60725.4 60876.0 61018.1 13853.7 14007.6 14016.0 14053.2 14081.0 9665.8 9718.9 9755.7 9787.4 9798.1 17854.4 18032.9 18036.0 18778.9 18806.2 6792.9 7044.7 7133.8 7178.4 7184.5 820.1 862.3 947.2 961.8 976.4 27423.0 28098.9 28325.9 28442.1 28647.3 973.0 974.7 993.1 1011.9 1030.6 14940.8 15173.8 15316.2 15365.1 15586.7 151644.0 151988.0 152318.0 152640.0 354335.0 46358.0 46417.8 47847.8 47929.8 48303.8 1235.3 1271.9 1275.8 1278.2 1280.1 26720.7 27600.9 27715.3 27811.0 28102.3 41697.0 42286.0 42827.8 42838.0 42916.1 304239.0 309558.0 310143.0 310274.0 311871.0 25071.6 26353.2 26378.5 26437.6 26450.5 41686.0 41912.6 41922.8 42497.8 42977.4 35992.3 36273.6 36636.8 37239.8 37508.1 35507.6 36198.1 36265.8 36542.8 37111.6 35737.1 35875.0 35959.5 36058.8 36315.0 31559.8 33148.7 33349.7 33350.3 33404.0 25056.2 25234.5 26103.5 26452.7 26667.9 16:04:48 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | [#2] jquery.html Cycles:180 Average:23471.48 Median:25992.42 stddev:62742.50 (241.4%) stddev-sans-first:62894.55 16:04:48 INFO - PROCESS | 3428 | Values: 379.0 384.0 388.9 392.7 404.1 15583.2 16579.0 16995.7 17054.9 17142.5 15521.5 16427.8 16913.8 16918.4 16927.5 4627.8 4759.0 4793.3 4796.9 4808.4 3461.1 5158.3 5442.9 5462.0 5472.9 5392.6 5394.6 5446.7 5447.5 5456.2 5301.2 5380.0 5475.0 5502.8 5504.9 4475.7 5266.8 5303.9 5306.8 5319.4 12443.1 12452.2 12552.3 12615.1 12654.9 1817.8 1886.2 1888.5 1941.8 2054.6 8912.6 8995.6 8999.4 9316.9 9443.9 1610.8 1647.9 1709.8 1753.3 1795.4 63326.0 71469.6 71886.0 72171.0 73231.0 9572.7 9744.6 9878.3 10033.4 10188.2 13929.7 13940.5 13982.9 13989.8 14017.5 7185.0 7214.6 7239.6 7362.9 7402.7 6697.1 6747.1 6776.6 6963.4 6996.9 4214.2 4225.1 4299.7 4414.4 4470.3 1731.0 1826.4 1828.0 1902.5 1913.5 751.5 860.4 921.7 924.7 932.4 16127.8 16368.4 16541.8 16695.2 16863.2 775.1 798.3 833.2 849.2 893.9 9091.1 9242.5 9308.0 9329.8 9498.4 370454.0 378694.0 379600.0 382610.0 385586.0 74909.6 75399.0 76089.2 77999.0 79222.0 925.8 934.6 934.7 937.9 947.0 14529.0 14537.1 14590.0 14688.3 14725.4 32166.4 33093.7 33728.5 34006.8 34777.3 47357.0 47449.3 47491.5 47570.3 47882.5 6554.4 6829.0 6839.7 6847.0 7485.3 8207.1 10123.7 11557.8 11951.1 11967.6 9989.2 10027.8 10200.6 10286.5 10294.2 9979.9 10039.6 10085.2 10277.2 10358.2 10008.2 10111.3 10120.6 10464.4 10655.9 7134.5 7219.5 7258.5 7310.2 7379.2 8366.7 10196.0 10383.7 10427.5 10452.3 16:04:48 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | [#3] mootools.html Cycles:180 Average:5218.55 Median:4805.27 stddev:2969.41 (61.8%) stddev-sans-first:2964.21 16:04:48 INFO - PROCESS | 3428 | Values: 1447.1 1472.0 1620.6 1767.8 1777.3 6731.9 7569.7 7598.3 7899.1 7918.0 7652.0 7663.1 7761.5 7764.0 7782.0 2147.8 2153.1 2161.6 2173.2 2183.2 2091.2 2097.1 2184.5 2192.4 2193.3 2111.9 2144.4 2148.3 2163.6 2176.1 2130.9 2132.3 2140.5 2141.4 2143.4 2115.5 2139.2 2147.3 2151.2 2166.2 7848.3 7880.8 7922.9 7927.4 7943.1 4611.9 4716.5 4733.7 4753.6 4765.2 2970.9 3014.1 3094.5 3127.2 3143.0 951.7 974.3 988.3 999.1 999.2 10995.6 10999.6 11001.6 11042.8 11054.2 4077.5 4158.9 4319.6 4364.1 4479.1 9360.9 9381.8 9389.4 9396.4 9402.9 4769.5 4796.0 4800.8 4803.7 4806.8 3782.5 4220.5 4262.6 4288.5 4384.4 3634.7 3678.2 3773.1 3797.1 3817.4 1219.4 1243.0 1251.6 1254.6 1255.0 789.4 843.8 845.3 845.7 854.1 5105.4 5255.0 5288.0 5387.0 5427.9 406.3 411.7 413.1 418.0 418.1 3447.6 3459.6 3467.9 3513.1 3556.8 9672.2 9931.6 9995.8 10037.3 10067.1 9808.5 9884.6 9917.7 9945.7 9955.2 7167.5 7318.0 7366.5 7386.9 7419.3 5055.9 5060.2 5098.6 5162.7 5263.8 8941.8 9008.9 9036.7 9159.4 9200.8 9117.5 9130.9 9203.8 9294.3 9359.7 5972.8 6813.3 6853.3 6974.3 7044.4 7720.8 7723.7 7724.3 7751.0 7787.8 6894.8 7071.0 7096.9 7148.9 7163.5 6868.9 6889.2 6952.1 6965.4 6979.3 6326.2 6476.2 6561.7 6563.8 6633.5 4624.2 4669.9 4672.7 4731.3 4735.0 4505.9 4579.1 4640.3 4643.6 4673.5 16:04:48 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | [#4] prototype.html Cycles:180 Average:4679.16 Median:5411.82 stddev:1392.44 (25.7%) stddev-sans-first:1356.86 16:04:48 INFO - PROCESS | 3428 | Values: 292.6 302.3 308.2 310.7 315.6 5209.0 5377.2 5381.5 5460.2 5517.9 5374.3 5385.5 5407.2 5416.5 5420.1 4135.5 4139.6 4141.3 4153.7 4165.3 4075.1 4097.7 4164.6 4176.1 4184.7 4080.2 4084.8 4101.9 4129.5 4134.2 4073.0 4099.6 4102.7 4163.0 4163.9 3415.2 3567.3 3568.6 3586.3 3638.1 5148.3 5155.6 5161.5 5163.1 5174.0 4714.0 4717.2 4719.0 4730.3 4741.0 5544.3 5614.7 5667.3 5678.3 5701.3 3866.8 3869.2 3872.4 3882.4 3901.0 5867.9 5926.4 5927.5 5946.8 5963.0 3879.4 3944.3 3950.7 3979.2 4001.2 4001.0 4012.2 4013.6 4023.7 4031.0 4625.6 4666.5 4680.1 4680.7 4695.2 5490.0 5504.6 5611.7 5656.7 5692.9 1398.7 1412.4 1412.5 1415.7 1417.7 915.9 924.1 943.2 945.2 949.2 4982.1 4986.9 5002.7 5003.1 5027.7 5839.3 5850.7 5861.9 5883.5 5901.6 4876.7 4941.5 4973.9 4980.0 5017.8 3155.8 3161.7 3170.3 3188.1 3198.2 5481.5 5483.9 5487.0 5496.9 5502.9 5778.4 5995.6 6037.4 6042.3 6047.3 5434.8 5451.2 5454.3 5456.9 5490.4 5759.6 5794.1 5852.2 5877.8 5918.6 5705.1 5709.2 5726.5 5741.5 5748.9 5471.3 5480.5 5490.7 5493.7 5496.9 3892.8 3979.5 4130.7 4156.1 4200.6 5670.1 5770.5 5883.2 5943.1 5987.1 5753.2 5770.8 5770.9 5775.2 5784.5 5740.5 5746.9 5751.5 5763.5 5765.3 5520.2 5540.0 5634.4 5638.3 5641.2 5721.3 5755.4 5755.4 5775.3 5776.4 5432.3 5618.2 5641.3 5642.4 5660.6 16:04:48 INFO - PROCESS | 3428 | 16:04:48 INFO - PROCESS | 3428 | [#5] yui.html Cycles:180 Average:12054.56 Median:45724.93 stddev:13452.33 (29.4%) stddev-sans-first:13462.83 16:04:48 INFO - PROCESS | 3428 | Values: 655.6 667.3 726.3 733.1 778.4 11813.5 12177.9 12196.8 12219.5 12276.1 11280.2 11360.1 11390.7 11405.3 12050.0 635.9 799.6 810.1 810.2 811.6 789.5 813.0 816.7 817.3 819.9 853.6 854.6 855.9 858.5 858.8 844.4 846.8 847.8 849.3 850.4 620.3 624.0 624.4 624.7 625.4 11503.5 11553.3 11595.9 11601.5 11619.0 12560.9 12569.2 12570.0 13055.9 13185.4 10051.5 10349.2 10365.2 10549.7 10759.4 3371.9 3412.0 3416.9 3424.5 3449.5 43370.6 43435.8 43511.3 43955.6 44095.3 9467.2 9495.3 9601.7 9648.9 10005.7 17036.4 17151.1 17169.8 17175.7 17211.4 6680.4 6696.8 6766.0 6936.5 7003.0 3709.5 3804.8 3849.3 3855.6 3958.7 2825.0 2919.0 2920.8 2922.1 2923.0 534.5 546.3 551.0 551.9 552.9 499.4 603.2 607.1 608.8 619.7 7664.7 7765.0 7802.9 7814.9 7912.2 572.3 581.6 584.9 593.4 595.1 3541.2 3573.7 3601.0 3608.5 3676.1 47354.5 47625.8 47903.0 48677.3 49099.5 43036.0 43430.0 43731.3 43820.0 43874.6 39726.6 40171.4 40201.8 40306.0 40541.8 6748.9 6805.9 6958.2 6997.5 7019.9 27072.2 27425.6 28090.2 28094.7 28364.0 33524.8 33587.8 36210.3 36327.5 36440.3 8891.4 8923.5 9028.6 9151.8 9217.4 10341.3 10391.2 10516.6 10583.5 10618.8 9276.4 9334.0 9420.7 9467.1 9476.1 10325.4 10568.8 10587.4 10894.8 11348.8 10156.5 10177.9 10520.4 10711.3 10950.5 9008.0 9008.9 9184.2 9322.3 9456.6 8876.2 9172.6 9233.7 9258.6 9328.9 16:04:48 INFO - PROCESS | 3428 | -------- Summary: end -------- 16:04:48 INFO - PROCESS | 3428 | 16:04:49 INFO - TEST-INFO | 3428: exit 0 16:04:49 INFO - TEST-OK | dromaeo_css | took 1117303ms 16:04:49 INFO - TEST-START | kraken 16:04:49 INFO - operating with platform_type : linux_ 16:04:49 INFO - Initialising browser for kraken test... 16:04:49 INFO - TEST-INFO | started process 3663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVf_eEY/profile http://localhost:58995/getInfo.html) 16:04:53 INFO - PROCESS | 3663 | 16:04:53 INFO - PROCESS | 3663 | (process:3731): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:04:53 INFO - PROCESS | 3663 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:04:53 INFO - PROCESS | 3663 | __metrics Screen width/height:1600/1200 16:04:53 INFO - PROCESS | 3663 | colorDepth:24 16:04:53 INFO - PROCESS | 3663 | Browser inner width/height: 1024/697 16:04:53 INFO - PROCESS | 3663 | __metrics 16:04:54 ERROR - PROCESS | 3663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:04:55 INFO - TEST-INFO | 3663: exit 0 16:04:55 INFO - Browser initialized. 16:04:55 INFO - Running cycle 1/1 for kraken test... 16:04:55 INFO - TEST-INFO | started process 3782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVf_eEY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:57 INFO - PROCESS | 3782 | 16:04:57 INFO - PROCESS | 3782 | (process:3841): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:05:07 INFO - PROCESS | 3782 | RSS: Main: 164200448 16:05:07 INFO - PROCESS | 3782 | 16:05:10 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58995/tests/kraken/driver.html?testName=audio-beat-detection) 16:05:10 INFO - PROCESS | 3782 | RSS: Main: 168345600 16:05:10 INFO - PROCESS | 3782 | 16:05:13 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58995/tests/kraken/driver.html?testName=audio-dft) 16:05:14 INFO - PROCESS | 3782 | RSS: Main: 171917312 16:05:14 INFO - PROCESS | 3782 | 16:05:17 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58995/tests/kraken/driver.html?testName=audio-fft) 16:05:17 INFO - PROCESS | 3782 | RSS: Main: 164638720 16:05:17 INFO - PROCESS | 3782 | 16:05:20 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58995/tests/kraken/driver.html?testName=audio-oscillator) 16:05:20 INFO - PROCESS | 3782 | RSS: Main: 165007360 16:05:20 INFO - PROCESS | 3782 | 16:05:22 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58995/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:05:23 INFO - PROCESS | 3782 | RSS: Main: 165437440 16:05:23 INFO - PROCESS | 3782 | 16:05:26 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58995/tests/kraken/driver.html?testName=imaging-darkroom) 16:05:27 INFO - PROCESS | 3782 | RSS: Main: 165675008 16:05:27 INFO - PROCESS | 3782 | 16:05:30 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58995/tests/kraken/driver.html?testName=imaging-desaturate) 16:05:31 INFO - PROCESS | 3782 | RSS: Main: 162930688 16:05:31 INFO - PROCESS | 3782 | 16:05:34 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58995/tests/kraken/driver.html?testName=json-parse-financial) 16:05:35 INFO - PROCESS | 3782 | RSS: Main: 163500032 16:05:35 INFO - PROCESS | 3782 | 16:05:36 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58995/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:05:37 INFO - PROCESS | 3782 | RSS: Main: 163635200 16:05:37 INFO - PROCESS | 3782 | 16:05:39 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58995/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:05:39 INFO - PROCESS | 3782 | RSS: Main: 163823616 16:05:39 INFO - PROCESS | 3782 | 16:05:42 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58995/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:05:42 INFO - PROCESS | 3782 | RSS: Main: 164139008 16:05:42 INFO - PROCESS | 3782 | 16:05:45 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:46 INFO - PROCESS | 3782 | RSS: Main: 164286464 16:05:46 INFO - PROCESS | 3782 | 16:05:49 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:49 INFO - PROCESS | 3782 | RSS: Main: 164007936 16:05:49 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:58995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58995/tests/kraken/driver.html?testName=ai-astar) 16:05:51 INFO - PROCESS | 3782 | RSS: Main: 165687296 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | __start_tp_report 16:05:51 INFO - PROCESS | 3782 | _x_x_mozilla_page_load 16:05:51 INFO - PROCESS | 3782 | _x_x_mozilla_page_load_details 16:05:51 INFO - PROCESS | 3782 | |i|pagename|runs| 16:05:51 INFO - PROCESS | 3782 | |0;ai-astar;120;110;115;115;115;127;117;114;114;116 16:05:51 INFO - PROCESS | 3782 | |1;audio-beat-detection;155;131;160;187;139;165;163;132;192;135 16:05:51 INFO - PROCESS | 3782 | |2;audio-dft;164;164;166;176;165;162;161;162;164;162 16:05:51 INFO - PROCESS | 3782 | |3;audio-fft;73;75;72;145;76;74;77;74;148;77 16:05:51 INFO - PROCESS | 3782 | |4;audio-oscillator;95;95;143;95;96;95;141;94;94;140 16:05:51 INFO - PROCESS | 3782 | |5;imaging-gaussian-blur;117;117;117;118;118;117;118;118;122;117 16:05:51 INFO - PROCESS | 3782 | |6;imaging-darkroom;147;146;147;147;148;147;147;146;147;147 16:05:51 INFO - PROCESS | 3782 | |7;imaging-desaturate;97;95;96;96;96;95;96;97;96;96 16:05:51 INFO - PROCESS | 3782 | |8;json-parse-financial;65;65;64;65;63;64;64;90;63;61 16:05:51 INFO - PROCESS | 3782 | |9;json-stringify-tinderbox;65;64;64;64;64;64;64;63;77;64 16:05:51 INFO - PROCESS | 3782 | |10;stanford-crypto-aes;84;86;94;88;87;98;94;88;87;87 16:05:51 INFO - PROCESS | 3782 | |11;stanford-crypto-ccm;152;157;142;142;140;158;139;139;183;141 16:05:51 INFO - PROCESS | 3782 | |12;stanford-crypto-pbkdf2;180;183;176;180;176;185;176;175;175;176 16:05:51 INFO - PROCESS | 3782 | |13;stanford-crypto-sha256-iterative;78;75;74;75;75;74;76;77;73;73 16:05:51 INFO - PROCESS | 3782 | __end_tp_report 16:05:51 INFO - PROCESS | 3782 | __start_cc_report 16:05:51 INFO - PROCESS | 3782 | _x_x_mozilla_cycle_collect,880 16:05:51 INFO - PROCESS | 3782 | __end_cc_report 16:05:51 INFO - PROCESS | 3782 | __startTimestamp1460588751942__endTimestamp 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | ------- Summary: start ------- 16:05:51 INFO - PROCESS | 3782 | Number of tests: 14 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#0] ai-astar Cycles:10 Average:116.30 Median:115.50 stddev:4.52 (3.9%) stddev-sans-first:4.59 16:05:51 INFO - PROCESS | 3782 | Values: 120.0 110.0 115.0 115.0 115.0 127.0 117.0 114.0 114.0 116.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:161.50 stddev:21.95 (13.6%) stddev-sans-first:23.28 16:05:51 INFO - PROCESS | 3782 | Values: 155.0 131.0 160.0 187.0 139.0 165.0 163.0 132.0 192.0 135.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:4.30 (2.6%) stddev-sans-first:4.56 16:05:51 INFO - PROCESS | 3782 | Values: 164.0 164.0 166.0 176.0 165.0 162.0 161.0 162.0 164.0 162.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#3] audio-fft Cycles:10 Average:89.10 Median:74.50 stddev:30.30 (40.7%) stddev-sans-first:31.58 16:05:51 INFO - PROCESS | 3782 | Values: 73.0 75.0 72.0 145.0 76.0 74.0 77.0 74.0 148.0 77.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:95.00 stddev:22.47 (23.7%) stddev-sans-first:23.27 16:05:51 INFO - PROCESS | 3782 | Values: 95.0 95.0 143.0 95.0 96.0 95.0 141.0 94.0 94.0 140.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 16:05:51 INFO - PROCESS | 3782 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 122.0 117.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:05:51 INFO - PROCESS | 3782 | Values: 147.0 146.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 16:05:51 INFO - PROCESS | 3782 | Values: 97.0 95.0 96.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:64.50 stddev:8.38 (13.0%) stddev-sans-first:8.88 16:05:51 INFO - PROCESS | 3782 | Values: 65.0 65.0 64.0 65.0 63.0 64.0 64.0 90.0 63.0 61.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:64.00 stddev:4.14 (6.5%) stddev-sans-first:4.39 16:05:51 INFO - PROCESS | 3782 | Values: 65.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 77.0 64.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:88.00 stddev:4.45 (5.1%) stddev-sans-first:4.28 16:05:51 INFO - PROCESS | 3782 | Values: 84.0 86.0 94.0 88.0 87.0 98.0 94.0 88.0 87.0 87.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:147.00 stddev:13.95 (9.5%) stddev-sans-first:14.76 16:05:51 INFO - PROCESS | 3782 | Values: 152.0 157.0 142.0 142.0 140.0 158.0 139.0 139.0 183.0 141.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:178.00 stddev:3.58 (2.0%) stddev-sans-first:3.74 16:05:51 INFO - PROCESS | 3782 | Values: 180.0 183.0 176.0 180.0 176.0 185.0 176.0 175.0 175.0 176.0 16:05:51 INFO - PROCESS | 3782 | 16:05:51 INFO - PROCESS | 3782 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:75.00 stddev:1.63 (2.2%) stddev-sans-first:1.32 16:05:51 INFO - PROCESS | 3782 | Values: 78.0 75.0 74.0 75.0 75.0 74.0 76.0 77.0 73.0 73.0 16:05:51 INFO - PROCESS | 3782 | -------- Summary: end -------- 16:05:51 INFO - PROCESS | 3782 | 16:05:52 INFO - TEST-INFO | 3782: exit 0 16:05:52 INFO - TEST-OK | kraken | took 63545ms 16:05:52 INFO - SUITE-END | took 1180s 16:05:53 INFO - Completed test suite (00:19:40) 16:05:53 INFO - javascript benchmark 16:05:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.215435369389, 2642.4847154804816, 2649.668791401075, 2691.085031089428, 2702.67567891853, 4759.8810029749275, 4778.569928706415, 4797.544233297831, 4806.639502037352, 4845.927311090337, 4740.194166991611, 4763.35694681218, 4791.712497250159, 4811.0, 4920.778564964577, 4385.912281754371, 4417.955820441803, 4444.000099977496, 4450.5104438511735, 4515.300128480091, 4417.9116417671785, 4451.0, 4509.0530988492455, 4516.593506584407, 4541.909161816761, 4335.024619460628, 4355.499117601485, 4361.236783562864, 4415.072834704716, 4429.180601588717, 4372.759498227596, 4376.846810361654, 4380.452443444569, 4397.692161548693, 4455.643548516111, 4334.891627709332, 4375.934360984587, 4393.7363758174615, 4429.357743127261, 4431.822727090913, 4712.952870471286, 4726.291056341542, 4730.195866702668, 4731.053789242165, 4774.236122220463, 5187.48125187482, 5193.169092945111, 5202.817901373433, 5214.296070030536, 5241.161414173752, 5219.582433405319, 5232.790688372461, 5237.3453318335205, 5281.260623512711, 5312.150055991023, 4808.711477311373, 4856.17445034345, 4856.927146092811, 4872.9756351218375, 4900.362952816111, 5345.545628621533, 5346.0, 5348.1442969124755, 5348.3849357323625, 5352.330958630171, 4893.09477746618, 4993.875153121128, 5064.34163558735, 5106.693598384035, 5114.43741188469, 5090.10923088458, 5101.846944591668, 5143.099957507496, 5153.742312884416, 5211.530962213419, 5037.395512538519, 5045.369328833895, 5058.64589478733, 5061.13960626687, 5096.0317539668085, 4970.676906001098, 5125.1287281162295, 5167.0957582422925, 5179.2749015137915, 5224.712640804716, 4308.3968244445805, 4359.934600980988, 4360.803763830635, 4362.694611377173, 4395.362672412482, 3713.405855063231, 3765.755225910362, 3769.9434508482395, 3801.6768574671464, 3835.6356146166067, 4466.553344665507, 4533.342665313511, 4535.092981403666, 4573.839915602938, 4576.359309696645, 5253.553447956967, 5267.683938963674, 5272.78908843642, 5289.233061206103, 5316.627836051439, 4309.827606895752, 4414.492333381702, 4509.706869053501, 4539.319102134707, 4588.105319462673, 4695.413073365829, 4730.59789917854, 4730.976345118322, 4749.430068391815, 4793.01743142655, 4859.684120532154, 4895.608351331956, 4897.755112244445, 4902.14212512816, 4939.234418665041, 4972.5027497249985, 5102.183650615883, 5176.145935920531, 5255.080360936897, 5298.788048478172, 4883.291922671122, 4902.1114575947895, 4903.901921961612, 4921.3356196912955, 4922.1140194765285, 5140.43455219918, 5146.485351464824, 5163.148080566664, 5174.689518628894, 5215.608829337891, 4987.551120399182, 5023.57299629521, 5220.9738951305, 5244.003639308519, 5287.788488460418, 4970.155073637418, 5044.47033061538, 5053.090443720165, 5059.06407314648, 5082.161443361804, 5013.172826483589, 5014.072396606493, 5019.548240658358, 5022.4977502249485, 5100.846974590768, 4802.73584952831, 4920.991196804574, 4972.975135124301, 4990.900181996267, 5054.039732450822, 5045.0, 5097.6941383517105, 5114.4374118847645, 5129.92305115431, 5171.974140129275, 4971.726555039508, 4979.875503112451, 4996.625253105959, 5010.599152067753, 5037.622178336713], "value": 4745.413765411726, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9264295641568, 610.1640752169528, 628.258654787351, 629.9716512756926, 655.547672106247, 35798.642013579854, 35828.104297392514, 35957.46063809045, 36002.63997360026, 36039.63960360396, 36813.63186368135, 37372.439413408756, 37446.43830342547, 37585.812070939675, 37677.623223767754, 7577.583232922187, 7724.9613751931165, 7759.922400775977, 7760.456768026241, 7773.183815699355, 7680.039995000625, 7870.488418252824, 7881.448298619099, 7908.367330613566, 7937.960310198441, 7911.802204944894, 8020.759377218693, 8046.235607617296, 8051.798705032392, 8052.3558115350925, 7802.921970780277, 7958.363330933569, 7997.480163789335, 7997.6001199940065, 8002.559859207741, 7829.921700782977, 7860.960695196487, 7914.960425197894, 7941.96029019857, 7952.284294413531, 29316.560251596242, 37112.32994515253, 37524.62475375239, 37553.24893502115, 37609.0, 3050.0697287327357, 3161.0832858471017, 3171.5718378019133, 3220.7745457817964, 3260.8858689945973, 24260.757392426025, 25408.87295563529, 25519.872400638065, 25847.483050339077, 26285.73714262852, 3318.435865902778, 3342.080927744865, 3346.6151392589923, 3393.253484233465, 3445.242046749711, 152943.0, 153681.0, 153734.0, 154032.0, 154192.0, 31897.52153717696, 32167.839160804047, 32210.516842247383, 32216.19459513484, 32237.677623223935, 58078.709606451695, 60244.69877650584, 60725.39274607286, 60876.0, 61018.0847287291, 13853.653658658613, 14007.579772606838, 14016.0, 14053.22707251111, 14081.0, 9665.806683866283, 9718.902810971942, 9755.707328780149, 9787.412755234567, 9798.069183427562, 17854.375096871547, 18032.909835451002, 18036.0, 18778.906105469385, 18806.153723082494, 6792.864142717217, 7044.682989265495, 7133.785986420416, 7178.425919937908, 7184.533005354635, 820.0692214336771, 862.2799962031773, 947.2327414794039, 961.7980224152866, 976.3799987008159, 27423.0, 28098.85950570234, 28325.858370708425, 28442.146735597966, 28647.283817904718, 972.9783727086531, 974.6637410093506, 993.1359717046216, 1011.868457100587, 1030.6135199300263, 14940.775888361683, 15173.772393414107, 15316.157611331484, 15365.078095314317, 15586.688266234612, 151644.0, 151988.0, 152318.0, 152640.0, 354335.0, 46358.0, 46417.76791116023, 47847.76076119597, 47929.76035119872, 48303.758481208075, 1235.2958813476412, 1271.9364031798373, 1275.7703613349686, 1278.2011242973142, 1280.0975312404732, 26720.732792671824, 27600.861995689895, 27715.307117321423, 27811.0, 28102.2974425641, 41697.0, 42286.0, 42827.785861071745, 42838.0, 42916.1416771669, 304239.0, 309558.0, 310143.0, 310274.0, 311871.0, 25071.623925640764, 26353.20940371792, 26378.472430551665, 26437.60343594809, 26450.470990580467, 41686.0, 41912.58087419087, 41922.79038604788, 42497.787511063485, 42977.3553396693, 35992.28015439729, 36273.63726362808, 36636.81681591575, 37239.813800930824, 37508.062298442754, 35507.64492355043, 36198.09504762402, 36265.81867090753, 36542.8172859134, 37111.628883710815, 35737.10657233486, 35875.0, 35959.460608090376, 36058.819705901304, 36315.0, 31559.844015598257, 33148.66851331456, 33349.66650333466, 33350.332993339514, 33404.0, 25056.24831255065, 25234.495310094062, 26103.477930441666, 26452.73547264503, 26667.866660666572], "value": 16666.650362763077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.9545254569452, 383.9616038396161, 388.87750358637027, 392.7192057678759, 404.092811637873, 15583.185434821631, 16579.005259684396, 16995.74506382405, 17054.914725426388, 17142.485725428225, 15521.456749013787, 16427.83572164278, 16913.83086169138, 16918.40785572502, 16927.49217523476, 4627.8380256691025, 4759.0, 4793.257045158006, 4796.856094317176, 4808.3989501312335, 3461.1174150591564, 5158.303629010074, 5442.863928401782, 5461.972690136564, 5472.863178420552, 5392.649477783932, 5394.595405344595, 5446.673199608016, 5447.509724124828, 5456.208849716789, 5301.151815709468, 5379.973100134474, 5475.0, 5502.80740174094, 5504.944950550504, 4475.686701930867, 5266.8419947401635, 5303.867403314909, 5306.7611957462, 5319.388270348921, 12443.128980971336, 12452.191235059761, 12552.309622970733, 12615.116941814076, 12654.936725316315, 1817.7636907202111, 1886.2077927270443, 1888.5089876632037, 1941.7669879614396, 2054.558269971963, 8912.64349426022, 8995.640174393016, 8999.415038022507, 9316.8602470963, 9443.858342124873, 1610.7825443565087, 1647.912377830638, 1709.7862767154106, 1753.281154726556, 1795.3626462605848, 63326.0, 71469.6426517864, 71886.0, 72171.0, 73231.0, 9572.712818615453, 9744.561494732754, 9878.308518403643, 10033.351307091727, 10188.235882308856, 13929.651758706113, 13940.512082077079, 13982.860171398155, 13989.790153147711, 14017.509387171604, 7184.964075179695, 7214.603196824225, 7239.601821899741, 7362.8527429451115, 7402.703891844373, 6697.129373181553, 6747.122874026345, 6776.627285499345, 6963.373296403348, 6996.860062798817, 4214.199302132585, 4225.070484493406, 4299.699021068558, 4414.448193975753, 4470.262406702923, 1730.9826901731074, 1826.397948402504, 1827.9725804112684, 1902.4863286912457, 1913.4787843664321, 751.5115175136206, 860.4493124400389, 921.7004473546124, 924.713338864954, 932.4358762948455, 16127.838721612634, 16368.427105051265, 16541.751873721903, 16695.24871380791, 16863.241154148094, 775.135723668106, 798.2775588092785, 833.1959658929162, 849.2208822516817, 893.8748575199477, 9091.090890910988, 9242.537873106317, 9307.953460232791, 9329.766755831159, 9498.382605130644, 370454.0, 378694.0, 379600.0, 382610.0, 385586.0, 74909.62545187239, 75399.0, 76089.23910760932, 77999.0, 79222.0, 925.7639301977953, 934.5514153206499, 934.6868798952427, 937.9390339627903, 946.9905300946903, 14529.0, 14537.127772333693, 14590.0, 14688.339024744126, 14725.410983560538, 32166.35667286688, 33093.66906330906, 33728.49407258844, 34006.82996585001, 34777.30445391129, 47357.0, 47449.28826067543, 47491.52508474871, 47570.286445704034, 47882.521174787806, 6554.410103090745, 6829.0, 6839.6580170990255, 6847.041414201916, 7485.288897554724, 8207.056188538394, 10123.671555542414, 11557.768844623228, 11951.10366722482, 11967.64097077089, 9989.200863930722, 10027.799444010932, 10200.642977495752, 10286.485675716034, 10294.227932904912, 9979.900200997898, 10039.598416063276, 10085.243606729671, 10277.229207809294, 10358.223133264884, 10008.199344052604, 10111.292209545261, 10120.59517619287, 10464.372137671764, 10655.89344106549, 7134.500584959003, 7219.45854060937, 7258.49190556656, 7310.19587845326, 7379.188289288281, 8366.70716524943, 10196.0, 10383.740406489898, 10427.530761115617, 10452.32059916103], "value": 7921.350272447549, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.0955652717053, 1471.9990406523564, 1620.6029522766923, 1767.8320559546846, 1777.271318759309, 6731.899021514669, 7569.65936532856, 7598.278163574459, 7899.091604465481, 7917.999999999993, 7651.966984457096, 7663.118741344747, 7761.534307941528, 7764.029496312961, 7782.0, 2147.763745987944, 2153.0526568309892, 2161.556880839424, 2173.1850556041486, 2183.1813070098715, 2091.205341970049, 2097.1087287902656, 2184.4648061224943, 2192.397090800027, 2193.320070778056, 2111.915523379063, 2144.4210063282903, 2148.3340164548963, 2163.632182528966, 2176.1295481807247, 2130.8614940028847, 2132.317658349321, 2140.4969832089446, 2141.4325203821, 2143.3677065265783, 2115.545157791067, 2139.17641707942, 2147.3128598848375, 2151.150295633232, 2166.2418153646254, 7848.293653571149, 7880.80297992549, 7922.881156782653, 7927.405444591679, 7943.086545047336, 4611.861644150681, 4716.52834716529, 4733.715977041354, 4753.619710423158, 4765.189917713997, 2970.9257268568244, 3014.0807053848566, 3094.458469767804, 3127.2494601295753, 3143.009951865178, 951.6574033347989, 974.3277138774223, 988.3229987458542, 999.0558921818885, 999.1607050077897, 10995.560177592886, 10999.61501347449, 11001.61494347694, 11042.834357484644, 11054.170937179662, 4077.4699289092227, 4158.896027599334, 4319.589638984291, 4364.061726728769, 4479.081788233404, 9360.906390936003, 9381.765455863659, 9389.436633801994, 9396.436213827192, 9402.905970940203, 4769.523047695272, 4796.040791841646, 4800.807967681254, 4803.735794531264, 4806.8077276909235, 3782.508273924372, 4220.5146408163455, 4262.637675797592, 4288.52826189119, 4384.386185933972, 3634.727395445352, 3678.209185025179, 3773.094457330221, 3797.0697179191275, 3817.3701339279264, 1219.3598360860442, 1243.030436259719, 1251.5807204586565, 1254.5734450286946, 1254.974900502003, 789.3921680306247, 843.8354520868372, 845.3237410071918, 845.7462761171624, 854.1031916487663, 5105.438401775802, 5254.973725131426, 5288.0, 5387.0, 5427.9185812212845, 406.34172640322276, 411.66449343784717, 413.1386060064739, 417.99164016719493, 418.0927387568922, 3447.620761716209, 3459.636738142459, 3467.86128554855, 3513.1392808762016, 3556.804375759358, 9672.22622190223, 9931.602735890629, 9995.750106247257, 10037.347572407916, 10067.1442927352, 9808.509574521246, 9884.604615815431, 9917.702468925943, 9945.651902183388, 9955.203583713286, 7167.534110282919, 7318.0, 7366.521176123535, 7386.852262954818, 7419.332260096618, 5055.87360315995, 5060.240963855451, 5098.617603679665, 5162.741862906764, 5263.7894484220205, 8941.821163576562, 9008.86486702713, 9036.689679996494, 9159.404638698463, 9200.769980750534, 9117.452952822852, 9130.908690913006, 9203.76990575241, 9294.25645948336, 9359.672411465566, 5972.820815375546, 6813.318668133147, 6853.348931851466, 6974.337437943387, 7044.436445084279, 7720.8455830884195, 7723.691052357843, 7724.343430808444, 7751.0, 7787.844243115219, 6894.827629309308, 7071.045408869737, 7096.858062838817, 7148.857022859618, 7163.498555101093, 6868.931310686829, 6889.207741109836, 6952.061471701458, 6965.407940325129, 6979.30206979298, 6326.2092238470195, 6476.222853257639, 6561.671916404256, 6563.835904102245, 6633.469322454289, 4624.190766615761, 4669.883252918704, 4672.719636821802, 4731.337612734151, 4735.0, 4505.864824055284, 4579.129965306581, 4640.280756482751, 4643.558861908114, 4673.485916549245], "value": 4125.235937960312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.58745169311277, 302.26549484752053, 308.1664098613251, 310.73587450666923, 315.6401702059654, 5209.0, 5377.247185394048, 5381.542568881645, 5460.235567020621, 5517.862053448665, 5374.3013408256875, 5385.461453854613, 5407.161889907061, 5416.485433883785, 5420.105682562373, 4135.524414692304, 4139.648129908961, 4141.316682747351, 4153.730007549515, 4165.250254954107, 4075.1238483725992, 4097.672186225095, 4164.583541645841, 4176.081262122329, 4184.7070705050655, 4080.1635664688815, 4084.83660653575, 4101.856435024774, 4129.504459464868, 4134.2144992451485, 4073.0, 4099.590040995907, 4102.651274641674, 4163.042500224935, 4163.854265100737, 3415.163284995192, 3567.250877315767, 3568.6431356864364, 3586.332355454726, 3638.0904773806546, 5148.279240906276, 5155.61332900034, 5161.458046905096, 5163.1480805667015, 5173.9741301293625, 4714.010057887847, 4717.150912835688, 4718.976405117986, 4730.337752714623, 4741.0, 5544.251526043973, 5614.719264036782, 5667.348254950651, 5678.318601767773, 5701.315842098975, 3866.845326186949, 3869.2454971280613, 3872.3997780344093, 3882.417637354391, 3900.9804950975063, 5867.885101830639, 5926.377730338296, 5927.496162826165, 5946.762129514815, 5963.045912653998, 3879.4374815652136, 3944.3097457944746, 3950.6839452843706, 3979.184267225212, 4001.239764444746, 4001.019495349762, 4012.2376748417705, 4013.5986401360215, 4023.657989070903, 4031.032552187454, 4625.606823419979, 4666.486686464486, 4680.08738296029, 4680.73620122565, 4695.239285268024, 5490.0, 5504.587155963319, 5611.719414029282, 5656.745446454919, 5692.943070569241, 1398.7482253194319, 1412.3714946848759, 1412.4632639596887, 1415.7451658701327, 1417.666848290651, 915.8809354783835, 924.1497822003772, 943.2312665177858, 945.2201933404831, 949.2216382566368, 4982.07831551157, 4986.925196122061, 5002.674826136289, 5003.124453220672, 5027.681730058144, 5839.299284085937, 5850.678212698257, 5861.9413805861395, 5883.529317654577, 5901.616394934315, 4876.707397556158, 4941.50584941503, 4973.90052198954, 4980.028894365636, 5017.799288028438, 3155.7850227662057, 3161.668024857357, 3170.2708377073404, 3188.1232661018407, 3198.2484116232667, 5481.451854814487, 5483.945160548423, 5487.012337779238, 5496.862578435571, 5502.9174562381595, 5778.3643799182055, 5995.61028533144, 6037.366076561985, 6042.335343112254, 6047.274327080779, 5434.782608695687, 5451.236826844245, 5454.263674403905, 5456.91814622781, 5490.423505531861, 5759.573054032844, 5794.13088036781, 5852.151438041546, 5877.764889404376, 5918.644881307136, 5705.144228365778, 5709.172170035405, 5726.484616384545, 5741.483266506035, 5748.856278593069, 5471.261379713687, 5480.534154596904, 5490.725463726878, 5493.670379777226, 5496.917546236889, 3892.8053597320586, 3979.5025621797276, 4130.669546436338, 4156.085661154541, 4200.600942910419, 5670.149477578396, 5770.451807078321, 5883.2057672215415, 5943.108533719977, 5987.101934709828, 5753.165790960371, 5770.769169233184, 5770.942290577041, 5775.249217601853, 5784.479396854135, 5740.454656807597, 5746.885062298814, 5751.511121554715, 5763.452472015152, 5765.336986246635, 5520.227168196536, 5540.0, 5634.380218175916, 5638.323401191883, 5641.238432811518, 5721.342045664802, 5755.366909639853, 5755.395683453345, 5775.306963164448, 5776.382612868403, 5432.34811822568, 5618.157276408408, 5641.26663533738, 5642.407547207648, 5660.622538533743], "value": 4227.345358751185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.6262930129826, 667.2726727866625, 726.2773540327375, 733.0946281342541, 778.3578547698147, 11813.468393922272, 12177.939110304447, 12196.81704774429, 12219.511219551207, 12276.140670153092, 11280.210385273034, 11360.147988900824, 11390.658280251586, 11405.258658187213, 12050.0, 635.9332270111641, 799.5642374905661, 810.1250649298772, 810.2019510781876, 811.5982588618613, 789.538120199681, 813.040612077748, 816.677412422093, 817.2807929022451, 819.901611806584, 853.6372041882206, 854.6068808348167, 855.9058503564603, 858.5149390594325, 858.772425307294, 844.3920377328313, 846.7502086884384, 847.7965288330818, 849.3247867944967, 850.4302117581235, 620.2556931682, 623.9688015599202, 624.3756243756244, 624.6564389585756, 625.4183609243402, 11503.539858405653, 11553.306801591847, 11595.884041159565, 11601.535938562447, 11619.012383947374, 12560.937195314056, 12569.183003104768, 12570.0, 13055.86944130556, 13185.406656700472, 10051.497425128788, 10349.223808214414, 10365.170786337076, 10549.73625659357, 10759.408232547206, 3371.898843034713, 3411.96588034119, 3416.8633254669785, 3424.503447000196, 3449.5170676105367, 43370.56629433697, 43435.78282108569, 43511.34732979008, 43955.560444395785, 44095.33856992148, 9467.242620590336, 9495.287853411022, 9601.711948641552, 9648.855267170999, 10005.749856253506, 17036.403725869535, 17151.142442878056, 17169.82830171682, 17175.65648687044, 17211.397601083903, 6680.398764111156, 6696.799096027127, 6766.0, 6936.4797640177185, 7002.964985175042, 3709.517762690833, 3804.771713697187, 3849.3071247175776, 3855.556610989716, 3958.6635136013188, 2825.011246063861, 2919.0221275872395, 2920.766338692942, 2922.0941508132546, 2923.0061778995246, 534.5349545895018, 546.2625455634861, 550.9917351239735, 551.9034169020406, 552.9419410961872, 499.36081815275776, 603.1555821849446, 607.0560278766472, 608.7595399817047, 619.7335145887312, 7664.65509052094, 7764.961175194087, 7802.882956755539, 7814.921850781533, 7912.248336408032, 572.2760707704757, 581.6364772017489, 584.8567101060182, 593.3562085137673, 595.1370512756434, 3541.2386336937166, 3573.7498375114014, 3600.963990360063, 3608.4948107265004, 3676.099355657881, 47354.5264547357, 47625.76187119111, 47903.0, 48677.26984095242, 49099.50900491021, 43036.0, 43430.0, 43731.34402983958, 43820.0, 43874.561254387685, 39726.60273397287, 40171.39742903801, 40201.798991005446, 40306.0, 40541.797291013354, 6748.865022699617, 6805.870087891728, 6958.199807022257, 6997.545159564612, 7019.859602808017, 27072.187834365002, 27425.588616170375, 28090.157295281173, 28094.71905280921, 28364.00725974581, 33524.83237583796, 33587.83206083954, 36210.27579448344, 36327.455088174225, 36440.27119457543, 8891.422057566237, 8923.464592124494, 9028.638854445748, 9151.816963660556, 9217.446953182562, 10341.276110672181, 10391.220658450799, 10516.631917882838, 10583.523741431809, 10618.84071738909, 9276.397034192756, 9333.953330233306, 9420.717378478657, 9467.147956683932, 9476.147146756824, 10325.380477171093, 10568.841467377842, 10587.417692026704, 10894.78210435771, 11348.843719693232, 10156.542955567165, 10177.898221017991, 10520.421376824348, 10711.303765255234, 10950.452477376259, 9008.0, 9008.90991090107, 9184.219341355792, 9322.254219662547, 9456.574454149442, 8876.156765107304, 9172.633094676405, 9233.676821311223, 9258.629654813732, 9328.906710933075], "value": 5740.677898983879, "unit": "score"}], "name": "dromaeo_css", "value": 6303.38739280379, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 110.0, 115.0, 115.0, 115.0, 127.0, 117.0, 114.0, 114.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 160.0, 187.0, 139.0, 165.0, 163.0, 132.0, 192.0, 135.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 176.0, 165.0, 162.0, 161.0, 162.0, 164.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 145.0, 76.0, 74.0, 77.0, 74.0, 148.0, 77.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 143.0, 95.0, 96.0, 95.0, 141.0, 94.0, 94.0, 140.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 122.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 63.0, 64.0, 64.0, 90.0, 63.0, 61.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 77.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 94.0, 88.0, 87.0, 98.0, 94.0, 88.0, 87.0, 87.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 157.0, 142.0, 142.0, 140.0, 158.0, 139.0, 139.0, 183.0, 141.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 176.0, 180.0, 176.0, 185.0, 176.0, 175.0, 175.0, 176.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 75.0, 75.0, 74.0, 76.0, 77.0, 73.0, 73.0], "value": 75.0, "unit": "score"}], "name": "kraken", "value": 1618.9999999999998, "alertThreshold": 2.0}]} 16:05:53 INFO - Return code: 0 16:05:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:05:53 ERROR - # TBPL SUCCESS # 16:05:53 INFO - Running post-action listener: _resource_record_post_action 16:05:53 INFO - Running post-run listener: _resource_record_post_run 16:05:54 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7680000; Write bytes: 403873792; Read time: 1692; Write time: 434148 16:05:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6049792; Read time: 0; Write time: 1228 16:05:54 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 5943296; Write bytes: 397824000; Read time: 1652; Write time: 432920 16:05:54 INFO - Running post-run listener: _upload_blobber_files 16:05:54 INFO - Blob upload gear active. 16:05:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:05:54 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:05:54 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:05:54 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:05:54 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:05:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:05:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:55 INFO - (blobuploader) - INFO - Done attempting. 16:05:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:05:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:05:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:56 INFO - (blobuploader) - INFO - Done attempting. 16:05:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:56 INFO - Return code: 0 16:05:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:05:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5bb886d9ef67d7a95ff33b1f7365b8ca3b39fb0738efbfeee336ee0df77ba37e150e36150b3309f25f860f8ee76420198290eccb9c997d3637d1adad642e1c94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1efa341f2942518a2a179d014e01578ec726ffd3354f52b4e1cc34d7dda7d9f8cd7ab4c42af8c9f694f67259ac45557281487b2ca7c4d683e9b22b41e3a84369"} 16:05:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:05:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:05:56 INFO - Contents: 16:05:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5bb886d9ef67d7a95ff33b1f7365b8ca3b39fb0738efbfeee336ee0df77ba37e150e36150b3309f25f860f8ee76420198290eccb9c997d3637d1adad642e1c94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1efa341f2942518a2a179d014e01578ec726ffd3354f52b4e1cc34d7dda7d9f8cd7ab4c42af8c9f694f67259ac45557281487b2ca7c4d683e9b22b41e3a84369"} 16:05:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:05:56 INFO - Copying logs to upload dir... 16:05:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:05:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.111428 ========= master_lag: 0.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-13 16:05:57.063980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-13 16:05:57.071441) ========= 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=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5bb886d9ef67d7a95ff33b1f7365b8ca3b39fb0738efbfeee336ee0df77ba37e150e36150b3309f25f860f8ee76420198290eccb9c997d3637d1adad642e1c94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1efa341f2942518a2a179d014e01578ec726ffd3354f52b4e1cc34d7dda7d9f8cd7ab4c42af8c9f694f67259ac45557281487b2ca7c4d683e9b22b41e3a84369"} 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.011366 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5bb886d9ef67d7a95ff33b1f7365b8ca3b39fb0738efbfeee336ee0df77ba37e150e36150b3309f25f860f8ee76420198290eccb9c997d3637d1adad642e1c94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1efa341f2942518a2a179d014e01578ec726ffd3354f52b4e1cc34d7dda7d9f8cd7ab4c42af8c9f694f67259ac45557281487b2ca7c4d683e9b22b41e3a84369"}' ========= master_lag: 2.73 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-13 16:05:59.814716) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-13 16:05:59.818210) ========= 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=836cfdc75598d54cb747368e000001a9-1460587403.847720-1213581751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004696 ========= master_lag: 2.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-13 16:06:01.912354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 16:06:01.912692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 16:06:02.274463) ========= ========= Total master_lag: 5.76 =========