builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1460419693.27 results: success (0) buildid: 20160411155045 builduid: a021bcc2bf3545b7806b9c588b416dd1 revision: 1801b99994e4f29cd49fa34d840f0c40ba8be304 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.267830) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.268427) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.268730) ========= 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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006443 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.294144) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.294770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.310868) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.311855) ========= 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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.363523) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.363789) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.364135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.364424) ========= 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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 17:08:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-11 17:08:13 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.533481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.533761) ========= 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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018017 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.582760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:13.583078) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1801b99994e4f29cd49fa34d840f0c40ba8be304 --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 1801b99994e4f29cd49fa34d840f0c40ba8be304 --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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 17:08:13,803 truncating revision to first 12 chars 2016-04-11 17:08:13,803 Setting DEBUG logging. 2016-04-11 17:08:13,803 attempt 1/10 2016-04-11 17:08:13,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1801b99994e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 17:08:14,074 unpacking tar archive at: mozilla-central-1801b99994e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564671 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:14.184100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:14.184902) ========= echo 1801b99994e4f29cd49fa34d840f0c40ba8be304 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1801b99994e4f29cd49fa34d840f0c40ba8be304'] 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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1801b99994e4f29cd49fa34d840f0c40ba8be304 program finished with exit code 0 elapsedTime=0.004662 script_repo_revision: '1801b99994e4f29cd49fa34d840f0c40ba8be304' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:14.241581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:14.242299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 17:08:14.256754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-11 17:08:14.257199) ========= /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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:08:14 INFO - MultiFileLogger online at 20160411 17:08:14 in /builds/slave/test 17:08:14 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 17:08:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:14 INFO - {'append_to_log': False, 17:08:14 INFO - 'base_work_dir': '/builds/slave/test', 17:08:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:08:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:14 INFO - 'branch': 'Firefox-Non-PGO', 17:08:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:14 INFO - 'config_files': ('talos/linux_config.py',), 17:08:14 INFO - 'default_actions': ('clobber', 17:08:14 INFO - 'read-buildbot-config', 17:08:14 INFO - 'download-and-extract', 17:08:14 INFO - 'populate-webroot', 17:08:14 INFO - 'create-virtualenv', 17:08:14 INFO - 'install', 17:08:14 INFO - 'run-tests'), 17:08:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:14 INFO - 'download_minidump_stackwalk': True, 17:08:14 INFO - 'download_symbols': 'ondemand', 17:08:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:14 INFO - 'installer_path': 'installer.exe', 17:08:14 INFO - 'log_level': 'info', 17:08:14 INFO - 'log_name': 'talos', 17:08:14 INFO - 'log_to_console': True, 17:08:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:08:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:08:14 INFO - 'opt_config_files': (), 17:08:14 INFO - 'pip_index': False, 17:08:14 INFO - 'sps_profile': False, 17:08:14 INFO - 'sps_profile_interval': 0, 17:08:14 INFO - 'suite': 'dromaeojs-e10s', 17:08:14 INFO - 'system_bits': '32', 17:08:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:14 INFO - 'title': 'talos-linux64-ix-069', 17:08:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:14 INFO - 'use_talos_json': True, 17:08:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:14 INFO - 'work_dir': 'build'} 17:08:14 INFO - ##### 17:08:14 INFO - ##### Running clobber step. 17:08:14 INFO - ##### 17:08:14 INFO - Running pre-action listener: _resource_record_pre_action 17:08:14 INFO - Running main action method: clobber 17:08:14 INFO - rmtree: /builds/slave/test/build 17:08:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:15 INFO - Running post-action listener: _resource_record_post_action 17:08:15 INFO - ##### 17:08:15 INFO - ##### Running read-buildbot-config step. 17:08:15 INFO - ##### 17:08:15 INFO - Running pre-action listener: _resource_record_pre_action 17:08:15 INFO - Running main action method: read_buildbot_config 17:08:15 INFO - Using buildbot properties: 17:08:15 INFO - { 17:08:15 INFO - "project": "", 17:08:15 INFO - "product": "firefox", 17:08:15 INFO - "script_repo_revision": "production", 17:08:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:08:15 INFO - "repository": "", 17:08:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:08:15 INFO - "buildid": "20160411155045", 17:08:15 INFO - "pgo_build": "False", 17:08:15 INFO - "basedir": "/builds/slave/test", 17:08:15 INFO - "buildnumber": 313, 17:08:15 INFO - "slavename": "talos-linux64-ix-069", 17:08:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:08:15 INFO - "platform": "ubuntu64_hw", 17:08:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:08:15 INFO - "branch": "mozilla-central", 17:08:15 INFO - "repo_path": "mozilla-central", 17:08:15 INFO - "revision": "1801b99994e4f29cd49fa34d840f0c40ba8be304", 17:08:15 INFO - "stage_platform": "linux64", 17:08:15 INFO - "builduid": "a021bcc2bf3545b7806b9c588b416dd1", 17:08:15 INFO - "slavebuilddir": "test" 17:08:15 INFO - } 17:08:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:08:15 INFO - Running post-action listener: _resource_record_post_action 17:08:15 INFO - ##### 17:08:15 INFO - ##### Running download-and-extract step. 17:08:15 INFO - ##### 17:08:15 INFO - Running pre-action listener: _resource_record_pre_action 17:08:15 INFO - Running main action method: download_and_extract 17:08:15 INFO - mkdir: /builds/slave/test/build/tests 17:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:15 INFO - https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:15 INFO - Downloaded 1361 bytes. 17:08:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:15 INFO - Using the following test package requirements: 17:08:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:08:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:08:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:15 INFO - u'jsshell-linux-x86_64.zip'], 17:08:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:08:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:08:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:08:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:08:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:08:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:15 INFO - https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:17 INFO - Downloaded 22190241 bytes. 17:08:17 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'] 17:08:17 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 17:08:18 INFO - Return code: 0 17:08:18 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 17:08: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')]} 17:08:18 INFO - https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:19 INFO - Downloaded 22190241 bytes. 17:08: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'] 17:08: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 17:08:21 INFO - Return code: 0 17:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:21 INFO - https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:22 INFO - Downloaded 10841046 bytes. 17:08:22 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'] 17:08:22 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 17:08:22 INFO - Return code: 0 17:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:22 INFO - https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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 17:08:24 INFO - Downloaded 54097441 bytes. 17:08:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:24 INFO - mkdir: /builds/slave/test/properties 17:08:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:24 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:24 INFO - Contents: 17:08:24 INFO - build_url:https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:25 INFO - Running post-action listener: _resource_record_post_action 17:08:25 INFO - Running post-action listener: set_extra_try_arguments 17:08:25 INFO - ##### 17:08:25 INFO - ##### Running populate-webroot step. 17:08:25 INFO - ##### 17:08:25 INFO - Running pre-action listener: _resource_record_pre_action 17:08:25 INFO - Running main action method: populate_webroot 17:08:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:25 INFO - '--tppagecycles', 17:08:25 INFO - '7'], 17:08:25 INFO - 'tests': ['tsvgm']}}, 17:08:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:08:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:08:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:25 INFO - 'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:25 INFO - 'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['damp', 'tps']}, 17:08:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:25 INFO - 'tests': ['damp', 'tps']}, 17:08:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['dromaeo_dom']}, 17:08:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['a11yr', 17:08:25 INFO - 'ts_paint', 17:08:25 INFO - 'tpaint', 17:08:25 INFO - 'sessionrestore', 17:08:25 INFO - 'sessionrestore_no_auto_restore', 17:08:25 INFO - 'tabpaint']}, 17:08:25 INFO - 'other-e10s': {'tests': ['a11yr', 17:08:25 INFO - 'ts_paint', 17:08:25 INFO - 'tpaint', 17:08:25 INFO - 'sessionrestore', 17:08:25 INFO - 'sessionrestore_no_auto_restore', 17:08:25 INFO - 'tabpaint']}, 17:08:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:08:25 INFO - 'ts_paint', 17:08:25 INFO - 'tpaint', 17:08:25 INFO - 'sessionrestore', 17:08:25 INFO - 'sessionrestore_no_auto_restore', 17:08:25 INFO - 'tabpaint']}, 17:08:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:08:25 INFO - 'ts_paint', 17:08:25 INFO - 'tpaint', 17:08:25 INFO - 'sessionrestore', 17:08:25 INFO - 'sessionrestore_no_auto_restore', 17:08:25 INFO - 'tabpaint']}, 17:08:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['a11yr', 17:08:25 INFO - 'ts_paint', 17:08:25 INFO - 'tpaint', 17:08:25 INFO - 'sessionrestore', 17:08:25 INFO - 'sessionrestore_no_auto_restore', 17:08:25 INFO - 'tabpaint']}, 17:08:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['a11yr', 17:08:25 INFO - 'ts_paint', 17:08:25 INFO - 'tpaint', 17:08:25 INFO - 'sessionrestore', 17:08:25 INFO - 'sessionrestore_no_auto_restore', 17:08:25 INFO - 'tabpaint']}, 17:08:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['tsvgx', 17:08:25 INFO - 'tsvgr_opacity', 17:08:25 INFO - 'tart', 17:08:25 INFO - 'tscrollx', 17:08:25 INFO - 'cart']}, 17:08:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:08:25 INFO - 'tsvgr_opacity', 17:08:25 INFO - 'tart', 17:08:25 INFO - 'tscrollx', 17:08:25 INFO - 'cart']}, 17:08:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:25 INFO - 'talos_options': ['--disable-e10s'], 17:08:25 INFO - 'tests': ['tp5o']}, 17:08:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:25 INFO - 'tests': ['tp5o']}, 17:08:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:25 INFO - 'talos_options': ['--disable-e10s', 17:08:25 INFO - '--xperf_path', 17:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:25 INFO - 'tests': ['tp5n']}, 17:08:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:25 INFO - 'talos_options': ['--xperf_path', 17:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:25 INFO - 'tests': ['tp5n']}}, 17:08:25 INFO - 'talos.zip': {'path': '', 17:08:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:25 INFO - Running post-action listener: _resource_record_post_action 17:08:25 INFO - ##### 17:08:25 INFO - ##### Running create-virtualenv step. 17:08:25 INFO - ##### 17:08:25 INFO - Running pre-action listener: _resource_record_pre_action 17:08:25 INFO - Running main action method: create_virtualenv 17:08:25 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:25 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 17:08:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:25 INFO - Using real prefix '/usr' 17:08:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:26 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:28 INFO - Installing pip.................done. 17:08:28 INFO - Return code: 0 17:08:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:28 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')]} 17:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:28 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')]} 17:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:28 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 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08:28 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 17:08:28 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 17:08:28 INFO - Using env: {'DISPLAY': ':0', 17:08:28 INFO - 'HOME': '/home/cltbld', 17:08:28 INFO - 'LANG': 'en_US.UTF-8', 17:08:28 INFO - 'LANGUAGE': 'en_US:en', 17:08:28 INFO - 'LOGNAME': 'cltbld', 17:08:28 INFO - 'MAIL': '/var/mail/cltbld', 17:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:28 INFO - 'MOZ_NO_REMOTE': '1', 17:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:28 INFO - 'NO_EM_RESTART': '1', 17:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:28 INFO - 'PWD': '/builds/slave/test', 17:08:28 INFO - 'SHELL': '/bin/bash', 17:08:28 INFO - 'SHLVL': '1', 17:08:28 INFO - 'TERM': 'linux', 17:08:28 INFO - 'TMOUT': '86400', 17:08:28 INFO - 'USER': 'cltbld', 17:08:28 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:28 INFO - '_': '/tools/buildbot/bin/python'} 17:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:28 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 17:08:28 INFO - Cleaning up... 17:08:28 INFO - Return code: 0 17:08:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:08:28 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')]} 17:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:28 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')]} 17:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:28 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 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08:28 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 17:08:28 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 17:08:28 INFO - Using env: {'DISPLAY': ':0', 17:08:28 INFO - 'HOME': '/home/cltbld', 17:08:28 INFO - 'LANG': 'en_US.UTF-8', 17:08:28 INFO - 'LANGUAGE': 'en_US:en', 17:08:28 INFO - 'LOGNAME': 'cltbld', 17:08:28 INFO - 'MAIL': '/var/mail/cltbld', 17:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:28 INFO - 'MOZ_NO_REMOTE': '1', 17:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:28 INFO - 'NO_EM_RESTART': '1', 17:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:28 INFO - 'PWD': '/builds/slave/test', 17:08:28 INFO - 'SHELL': '/bin/bash', 17:08:28 INFO - 'SHLVL': '1', 17:08:28 INFO - 'TERM': 'linux', 17:08:28 INFO - 'TMOUT': '86400', 17:08:28 INFO - 'USER': 'cltbld', 17:08:28 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:28 INFO - '_': '/tools/buildbot/bin/python'} 17:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:28 INFO - Downloading/unpacking psutil>=0.7.1 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:30 INFO - Installing collected packages: psutil 17:08:30 INFO - Running setup.py install for psutil 17:08:30 INFO - building 'psutil._psutil_linux' extension 17:08:30 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 17:08:30 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 17:08:30 INFO - building 'psutil._psutil_posix' extension 17:08:30 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 17:08:31 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 17:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:31 INFO - Successfully installed psutil 17:08:31 INFO - Cleaning up... 17:08:31 INFO - Return code: 0 17:08:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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', '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 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:08: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 mozsystemmonitor==0.0.0 17:08:31 INFO - Using env: {'DISPLAY': ':0', 17:08:31 INFO - 'HOME': '/home/cltbld', 17:08:31 INFO - 'LANG': 'en_US.UTF-8', 17:08:31 INFO - 'LANGUAGE': 'en_US:en', 17:08:31 INFO - 'LOGNAME': 'cltbld', 17:08:31 INFO - 'MAIL': '/var/mail/cltbld', 17:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:31 INFO - 'MOZ_NO_REMOTE': '1', 17:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:31 INFO - 'NO_EM_RESTART': '1', 17:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:31 INFO - 'PWD': '/builds/slave/test', 17:08:31 INFO - 'SHELL': '/bin/bash', 17:08:31 INFO - 'SHLVL': '1', 17:08:31 INFO - 'TERM': 'linux', 17:08:31 INFO - 'TMOUT': '86400', 17:08:31 INFO - 'USER': 'cltbld', 17:08:31 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:31 INFO - '_': '/tools/buildbot/bin/python'} 17:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08:31 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 17:08:31 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 17:08:31 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 17:08:31 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 17:08:31 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 17:08:31 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 17:08:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:08:33 INFO - Installing collected packages: mozsystemmonitor 17:08:33 INFO - Running setup.py install for mozsystemmonitor 17:08:33 INFO - Successfully installed mozsystemmonitor 17:08:33 INFO - Cleaning up... 17:08:33 INFO - Return code: 0 17:08:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08:33 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')]} 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:33 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')]} 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:33 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 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08:33 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 17:08:33 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 17:08:33 INFO - Using env: {'DISPLAY': ':0', 17:08:33 INFO - 'HOME': '/home/cltbld', 17:08:33 INFO - 'LANG': 'en_US.UTF-8', 17:08:33 INFO - 'LANGUAGE': 'en_US:en', 17:08:33 INFO - 'LOGNAME': 'cltbld', 17:08:33 INFO - 'MAIL': '/var/mail/cltbld', 17:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:33 INFO - 'MOZ_NO_REMOTE': '1', 17:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:33 INFO - 'NO_EM_RESTART': '1', 17:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:33 INFO - 'PWD': '/builds/slave/test', 17:08:33 INFO - 'SHELL': '/bin/bash', 17:08:33 INFO - 'SHLVL': '1', 17:08:33 INFO - 'TERM': 'linux', 17:08:33 INFO - 'TMOUT': '86400', 17:08:33 INFO - 'USER': 'cltbld', 17:08:33 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:33 INFO - '_': '/tools/buildbot/bin/python'} 17:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08:35 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 17:08:35 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 17:08:35 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 17:08:35 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 17:08:35 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 17:08:35 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 17:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:08:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:36 INFO - Downloading docopt-0.6.1.tar.gz 17:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:36 INFO - Running setup.py install for blobuploader 17:08:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:08:36 INFO - Running setup.py install for requests 17:08:36 INFO - Running setup.py install for docopt 17:08:36 INFO - Successfully installed blobuploader requests docopt 17:08:36 INFO - Cleaning up... 17:08:36 INFO - Return code: 0 17:08:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:36 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')]} 17:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:37 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 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08:37 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 17:08:37 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 17:08:37 INFO - Using env: {'DISPLAY': ':0', 17:08:37 INFO - 'HOME': '/home/cltbld', 17:08:37 INFO - 'LANG': 'en_US.UTF-8', 17:08:37 INFO - 'LANGUAGE': 'en_US:en', 17:08:37 INFO - 'LOGNAME': 'cltbld', 17:08:37 INFO - 'MAIL': '/var/mail/cltbld', 17:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:37 INFO - 'MOZ_NO_REMOTE': '1', 17:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:37 INFO - 'NO_EM_RESTART': '1', 17:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:37 INFO - 'PWD': '/builds/slave/test', 17:08:37 INFO - 'SHELL': '/bin/bash', 17:08:37 INFO - 'SHLVL': '1', 17:08:37 INFO - 'TERM': 'linux', 17:08:37 INFO - 'TMOUT': '86400', 17:08:37 INFO - 'USER': 'cltbld', 17:08:37 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:37 INFO - '_': '/tools/buildbot/bin/python'} 17:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:37 INFO - Running setup.py (path:/tmp/pip-bHW4gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:37 INFO - Running setup.py (path:/tmp/pip-oyo5cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:37 INFO - Running setup.py (path:/tmp/pip-BbU4H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:37 INFO - Running setup.py (path:/tmp/pip-aXMNM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:37 INFO - Running setup.py (path:/tmp/pip-EE5EQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:37 INFO - Running setup.py (path:/tmp/pip-eiqj9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:37 INFO - Running setup.py (path:/tmp/pip-hMA8Tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:37 INFO - Running setup.py (path:/tmp/pip-WSjaDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:37 INFO - Running setup.py (path:/tmp/pip-kaN9Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:37 INFO - Running setup.py (path:/tmp/pip-S0HXHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:37 INFO - Running setup.py (path:/tmp/pip-5zdsS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:38 INFO - Running setup.py (path:/tmp/pip-Vfrxti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:38 INFO - Running setup.py (path:/tmp/pip-oB2TLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:38 INFO - Running setup.py (path:/tmp/pip-LoMdXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:38 INFO - Running setup.py (path:/tmp/pip-UNaHNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:38 INFO - Running setup.py (path:/tmp/pip-urptQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:38 INFO - Running setup.py (path:/tmp/pip-RG5MPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:38 INFO - Running setup.py install for manifestparser 17:08:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:38 INFO - Running setup.py install for mozcrash 17:08:38 INFO - Running setup.py install for mozdebug 17:08:38 INFO - Running setup.py install for mozdevice 17:08:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:08:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:38 INFO - Running setup.py install for mozfile 17:08:38 INFO - Running setup.py install for mozhttpd 17:08:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozinfo 17:08:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozInstall 17:08:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozleak 17:08:39 INFO - Running setup.py install for mozlog 17:08:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for moznetwork 17:08:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozprocess 17:08:39 INFO - Running setup.py install for mozprofile 17:08:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozrunner 17:08:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozscreenshot 17:08:40 INFO - Running setup.py install for moztest 17:08:40 INFO - Running setup.py install for mozversion 17:08:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:40 INFO - Cleaning up... 17:08:40 INFO - Return code: 0 17:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:40 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 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08:40 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 17:08:40 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 17:08:40 INFO - Using env: {'DISPLAY': ':0', 17:08:40 INFO - 'HOME': '/home/cltbld', 17:08:40 INFO - 'LANG': 'en_US.UTF-8', 17:08:40 INFO - 'LANGUAGE': 'en_US:en', 17:08:40 INFO - 'LOGNAME': 'cltbld', 17:08:40 INFO - 'MAIL': '/var/mail/cltbld', 17:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:40 INFO - 'MOZ_NO_REMOTE': '1', 17:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:40 INFO - 'NO_EM_RESTART': '1', 17:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:40 INFO - 'PWD': '/builds/slave/test', 17:08:40 INFO - 'SHELL': '/bin/bash', 17:08:40 INFO - 'SHLVL': '1', 17:08:40 INFO - 'TERM': 'linux', 17:08:40 INFO - 'TMOUT': '86400', 17:08:40 INFO - 'USER': 'cltbld', 17:08:40 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:40 INFO - '_': '/tools/buildbot/bin/python'} 17:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:40 INFO - Running setup.py (path:/tmp/pip-kROvmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:40 INFO - Running setup.py (path:/tmp/pip-fPbJ5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:40 INFO - Running setup.py (path:/tmp/pip-geGMhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:40 INFO - Running setup.py (path:/tmp/pip-h8x2Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:40 INFO - Running setup.py (path:/tmp/pip-V21j8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:40 INFO - Running setup.py (path:/tmp/pip-c7mz14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:40 INFO - Running setup.py (path:/tmp/pip-EFQpQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:40 INFO - Running setup.py (path:/tmp/pip-YDTLDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:41 INFO - Running setup.py (path:/tmp/pip-GsCON1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:41 INFO - Running setup.py (path:/tmp/pip-LgJWup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:41 INFO - Running setup.py (path:/tmp/pip-7xvXcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:41 INFO - Running setup.py (path:/tmp/pip-QFlzOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:41 INFO - Running setup.py (path:/tmp/pip-4hiz8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:41 INFO - Running setup.py (path:/tmp/pip-O18LL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:41 INFO - Running setup.py (path:/tmp/pip-ikfcL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:41 INFO - Running setup.py (path:/tmp/pip-Br06mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:41 INFO - Running setup.py (path:/tmp/pip-YOTCHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:41 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)) 17:08:41 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)) 17:08:41 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)) 17:08:41 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)) 17:08:41 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)) 17:08:41 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)) 17:08:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:43 INFO - Downloading blessings-1.6.tar.gz 17:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:43 INFO - Installing collected packages: blessings 17:08:43 INFO - Running setup.py install for blessings 17:08:43 INFO - Successfully installed blessings 17:08:43 INFO - Cleaning up... 17:08:43 INFO - Return code: 0 17:08:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:44 INFO - Reading from file tmpfile_stdout 17:08:44 INFO - Current package versions: 17:08:44 INFO - argparse == 1.2.1 17:08:44 INFO - blessings == 1.6 17:08:44 INFO - blobuploader == 1.2.4 17:08:44 INFO - docopt == 0.6.1 17:08:44 INFO - manifestparser == 1.1 17:08:44 INFO - mozInstall == 1.12 17:08:44 INFO - mozcrash == 0.17 17:08:44 INFO - mozdebug == 0.1 17:08:44 INFO - mozdevice == 0.48 17:08:44 INFO - mozfile == 1.2 17:08:44 INFO - mozhttpd == 0.7 17:08:44 INFO - mozinfo == 0.9 17:08:44 INFO - mozleak == 0.1 17:08:44 INFO - mozlog == 3.1 17:08:44 INFO - moznetwork == 0.27 17:08:44 INFO - mozprocess == 0.22 17:08:44 INFO - mozprofile == 0.28 17:08:44 INFO - mozrunner == 6.11 17:08:44 INFO - mozscreenshot == 0.1 17:08:44 INFO - mozsystemmonitor == 0.0 17:08:44 INFO - moztest == 0.7 17:08:44 INFO - mozversion == 1.4 17:08:44 INFO - psutil == 3.1.1 17:08:44 INFO - requests == 1.2.3 17:08:44 INFO - wsgiref == 0.1.2 17:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:44 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 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08:44 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 17:08:44 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 17:08:44 INFO - Using env: {'DISPLAY': ':0', 17:08:44 INFO - 'HOME': '/home/cltbld', 17:08:44 INFO - 'LANG': 'en_US.UTF-8', 17:08:44 INFO - 'LANGUAGE': 'en_US:en', 17:08:44 INFO - 'LOGNAME': 'cltbld', 17:08:44 INFO - 'MAIL': '/var/mail/cltbld', 17:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:44 INFO - 'MOZ_NO_REMOTE': '1', 17:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:44 INFO - 'NO_EM_RESTART': '1', 17:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:44 INFO - 'PWD': '/builds/slave/test', 17:08:44 INFO - 'SHELL': '/bin/bash', 17:08:44 INFO - 'SHLVL': '1', 17:08:44 INFO - 'TERM': 'linux', 17:08:44 INFO - 'TMOUT': '86400', 17:08:44 INFO - 'USER': 'cltbld', 17:08:44 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:44 INFO - '_': '/tools/buildbot/bin/python'} 17:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 INFO - Cleaning up... 17:08:44 INFO - Return code: 0 17:08:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:08:44 INFO - Using env: {'DISPLAY': ':0', 17:08:44 INFO - 'HOME': '/home/cltbld', 17:08:44 INFO - 'LANG': 'en_US.UTF-8', 17:08:44 INFO - 'LANGUAGE': 'en_US:en', 17:08:44 INFO - 'LOGNAME': 'cltbld', 17:08:44 INFO - 'MAIL': '/var/mail/cltbld', 17:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:44 INFO - 'MOZ_NO_REMOTE': '1', 17:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:44 INFO - 'NO_EM_RESTART': '1', 17:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:44 INFO - 'PWD': '/builds/slave/test', 17:08:44 INFO - 'SHELL': '/bin/bash', 17:08:44 INFO - 'SHLVL': '1', 17:08:44 INFO - 'TERM': 'linux', 17:08:44 INFO - 'TMOUT': '86400', 17:08:44 INFO - 'USER': 'cltbld', 17:08:44 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:44 INFO - '_': '/tools/buildbot/bin/python'} 17:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:44 INFO - Downloading/unpacking jsonschema 17:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:08:46 INFO - Downloading/unpacking functools32 (from jsonschema) 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:46 INFO - Downloading functools32-3.2.3-2.tar.gz 17:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:08:46 INFO - warning: no files found matching '*.txt' 17:08:46 INFO - no previously-included directories found matching 'build' 17:08:46 INFO - no previously-included directories found matching 'dist' 17:08:46 INFO - no previously-included directories found matching '.git*' 17:08:46 INFO - Installing collected packages: jsonschema, functools32 17:08:46 INFO - Running setup.py install for functools32 17:08:46 INFO - warning: no files found matching '*.txt' 17:08:46 INFO - no previously-included directories found matching 'build' 17:08:46 INFO - no previously-included directories found matching 'dist' 17:08:46 INFO - no previously-included directories found matching '.git*' 17:08:46 INFO - Successfully installed jsonschema functools32 17:08:46 INFO - Cleaning up... 17:08:46 INFO - Return code: 0 17:08:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef90b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, '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': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', '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 17:08:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:08:46 INFO - Using env: {'DISPLAY': ':0', 17:08:46 INFO - 'HOME': '/home/cltbld', 17:08:46 INFO - 'LANG': 'en_US.UTF-8', 17:08:46 INFO - 'LANGUAGE': 'en_US:en', 17:08:46 INFO - 'LOGNAME': 'cltbld', 17:08:46 INFO - 'MAIL': '/var/mail/cltbld', 17:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:46 INFO - 'MOZ_NO_REMOTE': '1', 17:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:46 INFO - 'NO_EM_RESTART': '1', 17:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:46 INFO - 'PWD': '/builds/slave/test', 17:08:46 INFO - 'SHELL': '/bin/bash', 17:08:46 INFO - 'SHLVL': '1', 17:08:46 INFO - 'TERM': 'linux', 17:08:46 INFO - 'TMOUT': '86400', 17:08:46 INFO - 'USER': 'cltbld', 17:08:46 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:46 INFO - '_': '/tools/buildbot/bin/python'} 17:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:47 INFO - Downloading/unpacking flake8 17:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:08:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:08:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:08:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:49 INFO - no previously-included directories found matching 'docs/_build' 17:08:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:08:49 INFO - Running setup.py install for pep8 17:08:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:49 INFO - no previously-included directories found matching 'docs/_build' 17:08:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:08:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:08:50 INFO - Cleaning up... 17:08:50 INFO - Return code: 0 17:08:50 INFO - Running post-action listener: _resource_record_post_action 17:08:50 INFO - Running post-action listener: _start_resource_monitoring 17:08:50 INFO - Starting resource monitoring. 17:08:50 INFO - ##### 17:08:50 INFO - ##### Running install step. 17:08:50 INFO - ##### 17:08:50 INFO - Running pre-action listener: _resource_record_pre_action 17:08:50 INFO - Running main action method: install 17:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:50 INFO - Reading from file tmpfile_stdout 17:08:50 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:08:50 INFO - Reading from file tmpfile_stdout 17:08:50 INFO - Output received: 17:08:50 INFO - Usage: mozinstall [options] installer 17:08:50 INFO - Options: 17:08:50 INFO - -h, --help show this help message and exit 17:08:50 INFO - -d DEST, --destination=DEST 17:08:50 INFO - Directory to install application into. [default: 17:08:50 INFO - "/builds/slave/test"] 17:08:50 INFO - --app=APP Application being installed. [default: firefox] 17:08:50 INFO - mkdir: /builds/slave/test/build/application 17:08:50 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'] 17:08:50 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 17:09:06 INFO - Reading from file tmpfile_stdout 17:09:06 INFO - Output received: 17:09:06 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:06 INFO - Running post-action listener: _resource_record_post_action 17:09:06 INFO - ##### 17:09:06 INFO - ##### Running run-tests step. 17:09:06 INFO - ##### 17:09:06 INFO - Running pre-action listener: _resource_record_pre_action 17:09:06 INFO - Running main action method: run_tests 17:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:06 INFO - Python 2.7.3 17:09:06 INFO - Return code: 0 17:09:06 INFO - grabbing minidump binary from tooltool 17:09:06 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')]} 17:09:06 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 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:06 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 17:09:06 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 17:09:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:06 INFO - Return code: 0 17:09:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:09:07 INFO - Return code: 0 17:09:07 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/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 17:09:07 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/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 17:09:07 INFO - Using env: {'DISPLAY': ':0', 17:09:07 INFO - 'HOME': '/home/cltbld', 17:09:07 INFO - 'LANG': 'en_US.UTF-8', 17:09:07 INFO - 'LANGUAGE': 'en_US:en', 17:09:07 INFO - 'LOGNAME': 'cltbld', 17:09:07 INFO - 'MAIL': '/var/mail/cltbld', 17:09:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:07 INFO - 'MOZ_NO_REMOTE': '1', 17:09:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:07 INFO - 'NO_EM_RESTART': '1', 17:09:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:07 INFO - 'PWD': '/builds/slave/test', 17:09:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:07 INFO - 'SHELL': '/bin/bash', 17:09:07 INFO - 'SHLVL': '1', 17:09:07 INFO - 'TERM': 'linux', 17:09:07 INFO - 'TMOUT': '86400', 17:09:07 INFO - 'USER': 'cltbld', 17:09:07 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195', 17:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:07 INFO - '_': '/tools/buildbot/bin/python'} 17:09:07 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/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 17:09:07 INFO - mozversion application_buildid: 20160411155045 17:09:07 INFO - mozversion application_changeset: 1801b99994e4f29cd49fa34d840f0c40ba8be304 17:09:07 INFO - mozversion application_display_name: Nightly 17:09:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:07 INFO - mozversion application_name: Firefox 17:09:07 INFO - mozversion application_remotingname: firefox 17:09:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:09:07 INFO - mozversion application_vendor: Mozilla 17:09:07 INFO - mozversion application_version: 48.0a1 17:09:07 INFO - mozversion platform_buildid: 20160411155045 17:09:07 INFO - mozversion platform_changeset: 1801b99994e4f29cd49fa34d840f0c40ba8be304 17:09:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:09:07 INFO - mozversion platform_version: 48.0a1 17:09:07 INFO - using testdate: 1460419747 17:09:07 INFO - actual date: 1460419747 17:09:07 INFO - starting webserver on 'localhost:48730' 17:09:07 INFO - SUITE-START | Running 2 tests 17:09:07 INFO - TEST-START | dromaeo_css 17:09:07 INFO - operating with platform_type : linux_ 17:09:07 INFO - Initialising browser for dromaeo_css test... 17:09:07 INFO - TEST-INFO | started process 12919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1IECCj/profile http://localhost:48730/getInfo.html) 17:09:11 INFO - PROCESS | 12919 | 17:09:11 INFO - PROCESS | 12919 | (process:12988): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:12 INFO - PROCESS | 12919 | 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] 17:09:12 INFO - PROCESS | 12919 | __metrics Screen width/height:1600/1200 17:09:12 INFO - PROCESS | 12919 | colorDepth:24 17:09:12 INFO - PROCESS | 12919 | Browser inner width/height: 1024/697 17:09:12 INFO - PROCESS | 12919 | __metrics 17:09:13 ERROR - PROCESS | 12919 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 17:09:14 INFO - TEST-INFO | 12919: exit 0 17:09:14 INFO - Browser initialized. 17:09:14 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:14 INFO - TEST-INFO | started process 13039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1IECCj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:16 INFO - PROCESS | 13039 | 17:09:16 INFO - PROCESS | 13039 | (process:13097): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:26 INFO - PROCESS | 13039 | RSS: Main: 164814848 17:09:26 INFO - PROCESS | 13039 | 17:10:16 INFO - PROCESS | 13039 | 1460419816196 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] 17:12:28 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:48730/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48730/tests/dromaeo/cssquery-ext.html) 17:12:29 INFO - PROCESS | 13039 | RSS: Main: 169267200 17:12:29 INFO - PROCESS | 13039 | 17:15:31 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:48730/tests/dromaeo/cssquery-ext.html (next: http://localhost:48730/tests/dromaeo/cssquery-jquery.html) 17:15:31 INFO - PROCESS | 13039 | RSS: Main: 165175296 17:15:31 INFO - PROCESS | 13039 | 17:18:33 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:48730/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48730/tests/dromaeo/cssquery-mootools.html) 17:18:34 INFO - PROCESS | 13039 | RSS: Main: 166539264 17:18:34 INFO - PROCESS | 13039 | 17:21:36 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:48730/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48730/tests/dromaeo/cssquery-prototype.html) 17:21:36 INFO - PROCESS | 13039 | RSS: Main: 164200448 17:21:36 INFO - PROCESS | 13039 | 17:24:39 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:48730/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48730/tests/dromaeo/cssquery-yui.html) 17:24:40 INFO - PROCESS | 13039 | RSS: Main: 165789696 17:24:40 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:48730/tests/dromaeo/cssquery-yui.html (next: http://localhost:48730/tests/dromaeo/cssquery-dojo.html) 17:27:42 INFO - PROCESS | 13039 | RSS: Main: 168189952 17:27:42 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | __start_tp_report 17:27:42 INFO - PROCESS | 13039 | _x_x_mozilla_page_load 17:27:42 INFO - PROCESS | 13039 | _x_x_mozilla_page_load_details 17:27:42 INFO - PROCESS | 13039 | |i|pagename|runs| 17:27:42 INFO - PROCESS | 13039 | |0;dojo.html;2625.763681268686;2688.744569265919;2713.1182365731142;2730.508508468476;2736.2612094734422;4743.1699452595785;4762.49993750656;4769.976150119249;4788.97605511972;4798.568128868401;4688.296755486679;4741.0991911536785;4788.52114788521;4795.064962332347;4799.664023518355;4330.307150855863;4356.6514678825615;4401.119776044788;4412.073464572443;4446.421965144526;4430.3133014382665;4432.312991486308;4475.597196252336;4478.0596074824325;4530.841420550281;4294.592013758688;4299.441072660566;4345.587169218919;4362.17118747437;4367.475902891641;4339.913201735979;4340.500842403101;4353.020570371673;4360.21516127097;4388.100439409914;4336.089421221515;4337;4337.63130133939;4371.606555410029;4379.0366119453665;4631.444226692818;4708.811647534095;4728.621710263205;4744.383230180089;4747.881302967419;5099.056674515226;5100.821471248489;5115.974420127913;5129.974005198975;5166.276721259027;4951.455339912607;5057.974710126463;5142.974285128588;5146.819861304836;5188.429272779991;4779.569838714463;4799.976000120047;4801.351817504627;4808.519148085234;4843.685160464559;5246.422893481714;5246.527812496894;5250.632455728139;5253.684778913277;5285.471452854684;4858.416989961157;4994.150994330972;5038.3198268234055;5039.84880453587;5058.241263810458;5060.139776238048;5061.392632884003;5092.26162206478;5122.513361230752;5122.795088196431;5102;5108.897822043538;5112.6421150519855;5146.665466744649;5159.045576568272;4928.334674818925;4936.185529387682;5081.441041485434;5092.363454568179;5150.330457040561;4233.597808208216;4235.385869048971;4252.91494170121;4271.444712187458;4277.059047009653;3680.3375392429084;3694.0949467380665;3713.034611001105;3730.906727331784;3751;4427.313766366218;4458.08609235106;4462.397576327155;4480.798364073625;4490.371348011281;5165.612579056586;5168.173092305213;5189.377274727057;5192.402873669501;5220.321358223483;4539.591436770706;4580.129775342674;4590.334401511762;4592.655550833634;4627.282771170474;4454.844080457168;4555.544445555484;4598.0803839232285;4604.631629469634;4631.397918270671;4790.065937142223;4797.856064318076;4798.7840547175465;4803.375561176955;4851.296561998561;5080.060188865072;5104.846854594368;5109.514596113363;5117.948820511747;5166.4316925138955;4642.466116396523;4874.658773885794;4900.975495122501;4929.260610908393;4966.428860681068;4968.826091086795;4982.10322142018;4991.3511243538105;4999.350084488993;5044;4982.227754698028;5049.116404629101;5053.84838454847;5062;5099.821506247264;4798.1123492154065;4914.336564563881;4921.3356196912955;5012.273220382951;5043.646944713982;4899.4365647950945;4910.238912968495;4914.410270767531;4939.901201976012;4944.975275123601;4785.712857228577;4848.369711937426;4862.41651001882;4872.4153101628035;4896.167651499182;4907.705537667752;5002.599792016703;5015.3730783652045;5054.595632349477;5078.796848126181;4824.589909857561;4833.202521583899;4872.610191184767;4899.31409602663;4936.160852655129 17:27:42 INFO - PROCESS | 13039 | |1;ext.html;577.8266520043987;587.8530367408148;604.9062395328725;612.6446660936656;668.2949488289859;35391.11522211943;36046.8197659012;36426.63573364266;36481.452778208346;36485.27029459413;36209;36553.634463655355;36731.08172295687;36745.81627091867;36827.26345473089;7622.428317876168;7817.804554886116;7854.528728276293;7861.292483676468;7863.724769633064;7680.3087722105;7904.64429100689;7949.920500794976;7953.602319883983;7969.880451793228;7963.124056353797;8009.118996910335;8026.919730802705;8030.959845200795;8040.316573091294;7852.411069169807;7871.960640196791;7912.643931023118;7931.127575966639;7941;7914.406419518559;8033.357331413473;8037.437379383446;8040.557769322685;8053.677852885878;28044.298892527648;36800.815995920115;37331.81334093339;37333;37340.626593733985;2947.6735816368555;3028.1218446650446;3054.862531186102;3105.2702614885484;3184.4745616973173;23992.520149597083;24134.275971720876;24246.63630045533;24410.51178976428;24652.506949861083;3283.129970557804;3293.0170794912456;3389.8813541526174;3477.51314815926;3494.3710132176197;165464.17267913703;165890;166645;166800;166916;31493.8425307872;31882;31905.52141717876;31932;32065.198370040936;32883.67116328854;57785.422145778844;59327.406725933055;59780;60008.39991600115;13440.865591344156;13557.932210338886;13594.932025340007;13621.863781362257;13624.11443256205;10746.24776265654;10748.355098693946;10827.729306767236;10827.83758243627;10836.40399778004;18035.27858885656;18149.546261343574;18188.81811181898;18324.90837545804;18967;6996.475264355194;7005.54463959841;7280.720993759114;7296.124465064227;7314.926850731531;837.5519097282925;893.7363477773943;897.1925267259519;907.1971305394774;1010.3836659637615;26943.730562694123;28153.859230703714;28303.858480707877;28388;28447.71552284492;967.690339091498;979.8971108033696;984.7931934293736;1007.868977032981;1059.4384975962753;14464.783028254584;14842.257887105601;14940.626484337978;15213.087214767149;15219.543413697607;297204;302376;303684;304025;304731;46454.30318545225;48120.79698007578;48259.517404826205;48267.275990860166;48332;1230.0712961714028;1254.1659796235583;1266.3351740336398;1272.9809052864214;1273.40150129439;26433.471330573666;26566.335841604116;27069.1879243623;27663.72336276692;27684.44631107407;41705.58294417017;42175.7891210542;42349.78825105855;42477.15045699131;42479.787601063035;285995;287491;288800;289066;289555;24857.378565536008;25307.367315816515;38049;39195.216095678494;39427.40858887062;35576;35809;36357.27285454223;36590.8170459146;39375.606243937196;34722.65277347295;34870.65129348674;35106;35170.64829351674;35261.294774104885;34618.65381346154;34624.65375346315;34914.127146820516;35112;35201.64798351983;32395.35209295754;34702.82648586741;34737.82631086929;36198.09504762402;36798.63201367952;28218.153455396372;28947.85526072356;29015.709842901302;29047.854760726063;29195;22872.656910146696;23195.53608927846;23246;23263.53472930566;23403.76596234016 17:27:42 INFO - PROCESS | 13039 | |2;jquery.html;352.9752917295789;357.41562545238526;359.2222837556689;365.9688926441253;368.0889797750566;15504.92247538762;15696.529104126867;15889.761653575206;15904.84095159048;15905.44330948417;10301.639442619491;10836.837447438294;10839.374093885921;10918.617848375288;15768.21158942054;4582.427196600425;4612.469565999911;4741.596964258042;4747.501512341206;4761.761911904391;4659.254519276917;4684.5315468453055;4695.788689508963;4700.435947686283;4727.952720472786;4661.347411362412;4664.3936288282475;4690.108879312919;4695.718256904596;4713.434387873443;4933.33399991002;5250.369955605352;5268.868278293035;5269.604779641542;5294.788208471657;4964.826231081931;5076.416212135578;5077.796888124471;5080.923786143211;5131.640785145041;11643.825342619868;11841;11925.582604608797;11962.222455540448;12564.057695672862;1979.8515111366705;2243.7083179186766;2283.8058765004994;2319.3042087373888;2467.7902378297686;9155.404898681565;9598.90401095987;12236.694082647917;12364.752704945851;12787;1707.5218938697185;1737.800152982398;1758.5779412940801;1782.6702060118919;1829.8170182981596;59584;61257;65263;71315.64342178308;73381.63309183474;9651.372660777168;10000.199984001263;10091.344062635904;10107.64623238183;10213.642522511676;14162.221077840817;14234.644133896529;14260.572182834532;14284.714305714035;14401.639959000899;7269.818254543573;7296.270372962661;7309.780706578811;7397.741079062314;7436.144843342977;6889.311068893071;6945.201301850251;6972.616506092214;7014.053102831154;7034;4327.5239723630375;4376.256036473807;4385.101054283928;4464.330350447459;4468.932966005513;1801.3605170164665;1847.7782666080157;1875.840553552936;1904.2192700992528;1905.7903630600622;850.4897061763016;903.8553831386946;935.6257497001118;945.7493764152505;996.3025881882711;15806.9209653951;16630.6673866522;16803.15984200785;16830.074345911093;16885.32458701663;871.4466313890725;898.9280857531381;931.5901003558413;938.6855403439788;979.583676937313;9113.726588202364;9262.722118336325;9402.43585384879;9490.810183796286;9523.380980236263;380136;381145;401533;413051;419086;71951.64024179845;73176;75396.62301688566;75461.6226918862;75993.62003189948;926.2451102351562;965.6716716316486;968.970930872075;969.6509256667593;986.9901300987042;15334.38662453534;15379;15537.76693349578;15562.844371556592;15948.920255398649;33016.83491582527;34022.31955360829;34564;34610.653893460745;34724;47847.28229076497;48226;49273.26090108723;49535.752321238164;49818;7485.7754267372065;7816.296533312029;7922.864190148833;7968.561729104955;8090.150534193825;6235.75056997715;8703.390762646553;9828.901710982798;10033.645457863095;11520.654380368602;9758;10422.635207767691;10448.582056717647;10593.682189534326;10711.517981690688;8738.300935924983;9959.502024898582;10137.543810528396;10147.594096236364;10409;10117.190624749855;10148.898511014795;10526.368417894952;10689.251752377259;10733.355998640107;7823.882641760264;7853.057633083838;7879.881801773093;7904.565248911135;7955;7887.1718469562165;9548.85676714836;9802.754931126494;10028.849567256642;10129.442880641636 17:27:42 INFO - PROCESS | 13039 | |3;mootools.html;1424.3946322812806;1449.4202319072374;1543.9459618913334;1724.3016578285783;1729.4552216051943;6904.378605925465;7478.1026276846715;7542.057242844645;7765.611719414028;7794.220577942203;7521.623918804065;7529.736459223928;7550.471466997313;7572.204918483562;7572.318491335779;2271.772822717727;2298.6322188449853;2301.907923683059;2304.585174668559;2309;2175.771543987882;2180.5311857950537;2231.966520502194;2235.117128734157;2246.8539544929527;2250.651149071888;2269.6595510673365;2285.3600991722346;2294.105298933417;2316.6409206572926;2192.0793266827973;2197.5385169114425;2209.8011178993966;2209.933701988935;2212.1704360864674;2219.8668079915255;2221.2336743823357;2234.3743751749535;2241.9663705044436;2252.493189032471;7650.770476885702;7684.615769211517;7721.343685786715;7736.032995875516;7750.031246094239;4570.131674981742;4694.08465349257;4703.2004559225015;4714.858554243378;4756.334113224151;2762.6408566886375;2870.138958312498;2881.2652773542613;2889.5954566360724;2936.4420760055737;907.9001309855911;908.7818923458389;916.4089162490224;924.3529529329496;964.9421034737938;10411.479426028669;10481;10520.94739526305;10547.630832920811;10553.366797992145;4138.79306034697;4156.25187466259;4250.086231460251;4340.240457919851;4364.716293440916;9056.501892395981;9072.501012444247;9085.727428177166;9087.772805679911;9099.1810737034;4607.562281583244;4633.0733853229485;4636.4899861015265;4641.234196357631;4650.51169627191;3760.0975765816556;4262.957370426256;4271.060366719316;4303.63419109373;4451.799669014902;3583.749137560346;3591.1560783215923;3665.9816700916326;3692.667659910621;3700.148965737895;1191.9483886347666;1193.1886317304143;1210.842590463234;1215.1311812054423;1223.8470191226097;1177.093637898813;1181.0492553494519;1230.0528592983353;1233.6545767185203;1266.4554241675983;7140.250273721288;7247.4926755126635;7309.926900731031;7331.120265568166;7336.266373362621;439.41338313351395;446.792241607654;453.82754553269547;455.2556570008061;457.3300115331056;5622.718864056863;5676.801311954062;5688.5733569981585;5709.200711900337;5733.741981610838;8980.730578082668;9489.857652135086;9629.374090684083;9690.70927872165;9703.272254580934;9556.76108097303;9622.663206787729;9622.90377096234;9674.854877176847;9675.274354423305;6965.547239429421;7239.782806515813;7244.311790379906;7248.456365772483;7286.890696639554;7227.9880816686755;7285.890711639224;7352.264773522605;7354.117505899327;7365.747822870017;8781.956090219508;8862.822743544964;8997.865032024394;9014.774630634287;9048.095190480899;8718.869216961877;8932.910670893209;9020.233280171258;9108.269428808506;9169.945456272348;6104.8779024420155;6498.610083395011;6735.966320168368;6980.232174460703;7092.822679432849;7268.309510596485;7348.742794002184;7373.373263272468;7402.925970740439;7456.701731930879;6547.247066587403;6710.63091529951;6763.830904227237;6772.221194562491;6861.210960739579;6666.699998500176;6677.465802735866;6700.4639628830555;6758.290379510081;6854.931450685629;6959.26927672587;6988.615626140611;7079.39825114871;7095.645217738989;7108.324709152622;6350.682465876595;6408.935910640834;6420.839479013062;6433.324500927335;6446.774362897276;6584.670766461753;6651.33486651331;6662.533622646562;6666.699998500176;6748.021536877223 17:27:42 INFO - PROCESS | 13039 | |4;prototype.html;298.67593660877947;310.3637543036774;311.9329344190999;313.1904028087394;319.60209539123787;5268.183431568108;5414.675119492833;5460.044492213857;5460.31746031746;5471.863203419916;5335.7332133393365;5340.652857564256;5355.6786592804365;5372.677639341632;5375.247465354843;3886.8833934981994;4012.779297138656;4140.213359461693;4146.170765846843;4147.523034850986;4154.792260386984;4163.229802486535;4181.853635122771;4190.3923931029985;4197.622214000739;4150.149219410014;4167.916641667165;4174.144300418407;4186.769727664977;4195.538490766014;4046.817893194813;4177.4778152730905;4187.895302617444;4188.560201178878;4195.97902010488;3657.1165849587483;3668.724845636588;3681.2637472505608;3690.3541880170865;3691.261747650454;5081.415637201695;5109.3613298337705;5117.616178786606;5122.564582010496;5134.589232861362;4727.905441891143;4820.0841840050625;4826.131296366652;4831.130396528623;4849.951500484985;5488.368837583689;5570.220169176318;5638.577106716972;5647.774089036475;5651.8304450866535;3974.980125099356;3986.54154772202;4001.079751657106;4008.83964641414;4021.3163762160502;5683.658980461144;5903.49820265278;5907;5910.911336329916;5916.290045194562;4096.221717873595;4103;4122.9381559276635;4136.958630413717;4142.357934520154;4195.139996300751;4209.34755112958;4210.368444733253;4221.387898754663;4227.991703940604;4703.529647035269;4764.666473346832;4773.307870358779;4781.067691800135;4782.784774685148;5580.302462192226;5614.214010038598;5649.322081350264;5654.095344744821;5658.886822263532;1449.4057436451005;1474.336548553134;1475.2549962268986;1475.7933889255512;1479.5265515035085;920.7928216151313;951.9148171084969;978.83849164887;1005.6429967361481;1025.108155904368;4911.435184953776;4939.851804445872;4967.453580106186;4987.476314986874;4991.850244492671;5802.854928626733;5804.158397032491;5809.3609702932645;5812.447817457335;5818.127280907897;4846.491118432585;4928.99331407841;4932.778024988884;4968.254761785761;4987.975060124676;3077.39990701811;3085.691430856941;3097.411491816548;3107.7203051725455;3117.2986078132694;5387.568994480433;5415.214793854869;5416.241726158341;5419.214213938957;5423.674579525162;5733.512651424676;5873.236479257669;5915.740666719955;5944.405559444108;5970;5424.484673955968;5425.674459532441;5432.456754324615;5441.102218134043;5454;5613.971930140323;5750.338711048283;5753.539716822728;5783.624064435799;5908.172855800278;5756.568257380797;5788.363280039108;5799.202247303349;5822.505087067647;5830.18377427169;5516.696581688046;5521.365043019943;5527.115661494142;5530.336359636869;5552.916706249491;3789.943150852684;3984.581618929971;4003.6396724294955;4018.9196216076098;4028.415879697369;5764.665310549234;5788.571742616818;5812.994516891666;5814.505767009682;5837.620554663933;5602.411746766531;5617;5617.213590097472;5630.690312032878;5636.1545768133465;5411.2965314508865;5721.628094173865;5722.198892155185;5723.370429252862;5743.1385292206505;5303.806643505181;5583.860403489783;5584.190292407659;5613.045782216951;5644.322681278273;5459.918101228564;5683.8010669626365;5705.34388545306;5721.370649228498;5724.656520608777;5458.2904222450825;5526.104096611799;5540.501354878081;5549.889002219852;5557.360578629233 17:27:42 INFO - PROCESS | 13039 | |5;yui.html;647.6664517773345;713.224072060569;726.1121085178537;756.1153450462958;772.1236396689757;12510.437030333635;12542.81185782214;12613.558525451612;12663.11358204926;12822.551210707616;12132.514699412035;12174.208676436025;12235.816462753044;12262.816057759119;12306.876931230685;644.8226737647137;788.2826627768732;812.0823469479494;817.6198067898426;824.8102936324649;808.0908977400425;811;813.4387272781762;816.4652152839899;818.443458448255;852.8166444214523;855.6620135046653;856.4518708026868;856.7686724584389;858.5449711652834;844.3118858130634;845.6363763581658;846.6401779243859;848.4103548034119;849.4903058165113;626.2766504687094;628.6008384675764;628.8365025093462;629.0218709906094;630.4357599948066;12770.297633630147;12831.807522887164;12866.421011054525;12885.226886386847;12900.483980640764;12416.875831241752;12419.068569857207;12609.810852837214;13117.803232951514;13198.274094924775;10001.199904007663;10117.747056323577;10284.897151028468;10308;10401.219908506891;3379.831008449568;3422.469517224834;3436.9828150859084;3527.9294414111573;3535.08087897146;45036.3244551332;45486;45658.31512527315;47517.76241118772;47701.522984769705;10171.23715721309;10187;10188.796224075477;10324.793504130026;10399.272050956512;17539.73690394645;17704.822951770577;17743.911280443772;17791.46625601234;17810;6876.140482439695;7029.753958611424;7037.542559733601;7069.363757261871;7086.291370862976;3812.046988252937;3818.522684664417;3832.0994566276904;3836.9808150959066;3874.3994680823953;2689.9058532951253;2748.244232835986;2754.793390495721;2773.362126710868;2773.3898542320658;505.8887044850127;526.2973929803754;531.5242857642388;536.0806217337285;537.5189205660989;648.2545073165898;667.8764428580728;668.6890595872942;679.8878185099403;685.3865790117817;7923.366130709529;7959.243871832166;8066.395020373496;8209.630566624517;8332.083470818205;535.1865164949255;639.9072134540559;649.2728144478215;651.1274891645218;676.0737789228788;3838.8848334550007;3908.7459315144993;3912.3250147629974;3927.626875446828;4007.6393124618926;47620.7618961903;48926.51073489291;48993.51006489961;49074;49217.26174107391;43493.34759978603;43616;44676.77661611671;44704.77647611806;44710;38467.42298865519;39452.80273598614;39485.80257098696;39538;40043;7552.244775522404;7591.696332146652;7622;8158.510489370657;8219.095899450936;25717.485650287264;26059;27419.31451713723;27457.588136178372;27459.17622471329;34062;35647.64352356547;36898.63101368952;37002.62997369992;37876.431853521666;9778.315517913677;9787.951060244653;9895.752606184615;9983.800323993624;10086.94956525242;11830.940845295718;11964.401779911144;11982.468070743304;12085.879141208476;12189.878101219228;10253.74365640865;10712;10730.839037414602;10852.891471085188;11243.212975091992;11267.549298028314;11302.491387887729;11348.205625606459;11585.362805045803;11906.285622862655;10697.679069627924;10834.67495975122;11450.37022963745;11468.713282168013;11945.940270298594;9591.28065395112;9742.610295588098;9753.804923901624;10095.495225238856;10102.69691909244;9031.548422578977;9451.432914025181;9579.760505987406;9604.471754053595;9627.277954153327 17:27:42 INFO - PROCESS | 13039 | __end_tp_report 17:27:42 INFO - PROCESS | 13039 | __start_cc_report 17:27:42 INFO - PROCESS | 13039 | _x_x_mozilla_cycle_collect,405 17:27:42 INFO - PROCESS | 13039 | __end_cc_report 17:27:42 INFO - PROCESS | 13039 | __startTimestamp1460420862698__endTimestamp 17:27:42 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | ------- Summary: start ------- 17:27:42 INFO - PROCESS | 13039 | Number of tests: 6 17:27:42 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | [#0] dojo.html Cycles:165 Average:4714.81 Median:4833.20 stddev:492.86 (10.2%) stddev-sans-first:466.33 17:27:42 INFO - PROCESS | 13039 | Values: 2625.8 2688.7 2713.1 2730.5 2736.3 4743.2 4762.5 4770.0 4789.0 4798.6 4688.3 4741.1 4788.5 4795.1 4799.7 4330.3 4356.7 4401.1 4412.1 4446.4 4430.3 4432.3 4475.6 4478.1 4530.8 4294.6 4299.4 4345.6 4362.2 4367.5 4339.9 4340.5 4353.0 4360.2 4388.1 4336.1 4337.0 4337.6 4371.6 4379.0 4631.4 4708.8 4728.6 4744.4 4747.9 5099.1 5100.8 5116.0 5130.0 5166.3 4951.5 5058.0 5143.0 5146.8 5188.4 4779.6 4800.0 4801.4 4808.5 4843.7 5246.4 5246.5 5250.6 5253.7 5285.5 4858.4 4994.2 5038.3 5039.8 5058.2 5060.1 5061.4 5092.3 5122.5 5122.8 5102.0 5108.9 5112.6 5146.7 5159.0 4928.3 4936.2 5081.4 5092.4 5150.3 4233.6 4235.4 4252.9 4271.4 4277.1 3680.3 3694.1 3713.0 3730.9 3751.0 4427.3 4458.1 4462.4 4480.8 4490.4 5165.6 5168.2 5189.4 5192.4 5220.3 4539.6 4580.1 4590.3 4592.7 4627.3 4454.8 4555.5 4598.1 4604.6 4631.4 4790.1 4797.9 4798.8 4803.4 4851.3 5080.1 5104.8 5109.5 5117.9 5166.4 4642.5 4874.7 4901.0 4929.3 4966.4 4968.8 4982.1 4991.4 4999.4 5044.0 4982.2 5049.1 5053.8 5062.0 5099.8 4798.1 4914.3 4921.3 5012.3 5043.6 4899.4 4910.2 4914.4 4939.9 4945.0 4785.7 4848.4 4862.4 4872.4 4896.2 4907.7 5002.6 5015.4 5054.6 5078.8 4824.6 4833.2 4872.6 4899.3 4936.2 17:27:42 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | [#1] ext.html Cycles:180 Average:40616.16 Median:19107.67 stddev:68039.38 (356.1%) stddev-sans-first:68163.84 17:27:42 INFO - PROCESS | 13039 | Values: 577.8 587.9 604.9 612.6 668.3 35391.1 36046.8 36426.6 36481.5 36485.3 36209.0 36553.6 36731.1 36745.8 36827.3 7622.4 7817.8 7854.5 7861.3 7863.7 7680.3 7904.6 7949.9 7953.6 7969.9 7963.1 8009.1 8026.9 8031.0 8040.3 7852.4 7872.0 7912.6 7931.1 7941.0 7914.4 8033.4 8037.4 8040.6 8053.7 28044.3 36800.8 37331.8 37333.0 37340.6 2947.7 3028.1 3054.9 3105.3 3184.5 23992.5 24134.3 24246.6 24410.5 24652.5 3283.1 3293.0 3389.9 3477.5 3494.4 165464.2 165890.0 166645.0 166800.0 166916.0 31493.8 31882.0 31905.5 31932.0 32065.2 32883.7 57785.4 59327.4 59780.0 60008.4 13440.9 13557.9 13594.9 13621.9 13624.1 10746.2 10748.4 10827.7 10827.8 10836.4 18035.3 18149.5 18188.8 18324.9 18967.0 6996.5 7005.5 7280.7 7296.1 7314.9 837.6 893.7 897.2 907.2 1010.4 26943.7 28153.9 28303.9 28388.0 28447.7 967.7 979.9 984.8 1007.9 1059.4 14464.8 14842.3 14940.6 15213.1 15219.5 297204.0 302376.0 303684.0 304025.0 304731.0 46454.3 48120.8 48259.5 48267.3 48332.0 1230.1 1254.2 1266.3 1273.0 1273.4 26433.5 26566.3 27069.2 27663.7 27684.4 41705.6 42175.8 42349.8 42477.2 42479.8 285995.0 287491.0 288800.0 289066.0 289555.0 24857.4 25307.4 38049.0 39195.2 39427.4 35576.0 35809.0 36357.3 36590.8 39375.6 34722.7 34870.7 35106.0 35170.6 35261.3 34618.7 34624.7 34914.1 35112.0 35201.6 32395.4 34702.8 34737.8 36198.1 36798.6 28218.2 28947.9 29015.7 29047.9 29195.0 22872.7 23195.5 23246.0 23263.5 23403.8 17:27:42 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | [#2] jquery.html Cycles:180 Average:23791.61 Median:4660.30 stddev:65805.33 (1412.0%) stddev-sans-first:65966.39 17:27:42 INFO - PROCESS | 13039 | Values: 353.0 357.4 359.2 366.0 368.1 15504.9 15696.5 15889.8 15904.8 15905.4 10301.6 10836.8 10839.4 10918.6 15768.2 4582.4 4612.5 4741.6 4747.5 4761.8 4659.3 4684.5 4695.8 4700.4 4728.0 4661.3 4664.4 4690.1 4695.7 4713.4 4933.3 5250.4 5268.9 5269.6 5294.8 4964.8 5076.4 5077.8 5080.9 5131.6 11643.8 11841.0 11925.6 11962.2 12564.1 1979.9 2243.7 2283.8 2319.3 2467.8 9155.4 9598.9 12236.7 12364.8 12787.0 1707.5 1737.8 1758.6 1782.7 1829.8 59584.0 61257.0 65263.0 71315.6 73381.6 9651.4 10000.2 10091.3 10107.6 10213.6 14162.2 14234.6 14260.6 14284.7 14401.6 7269.8 7296.3 7309.8 7397.7 7436.1 6889.3 6945.2 6972.6 7014.1 7034.0 4327.5 4376.3 4385.1 4464.3 4468.9 1801.4 1847.8 1875.8 1904.2 1905.8 850.5 903.9 935.6 945.7 996.3 15806.9 16630.7 16803.2 16830.1 16885.3 871.4 898.9 931.6 938.7 979.6 9113.7 9262.7 9402.4 9490.8 9523.4 380136.0 381145.0 401533.0 413051.0 419086.0 71951.6 73176.0 75396.6 75461.6 75993.6 926.2 965.7 969.0 969.7 987.0 15334.4 15379.0 15537.8 15562.8 15948.9 33016.8 34022.3 34564.0 34610.7 34724.0 47847.3 48226.0 49273.3 49535.8 49818.0 7485.8 7816.3 7922.9 7968.6 8090.2 6235.8 8703.4 9828.9 10033.6 11520.7 9758.0 10422.6 10448.6 10593.7 10711.5 8738.3 9959.5 10137.5 10147.6 10409.0 10117.2 10148.9 10526.4 10689.3 10733.4 7823.9 7853.1 7879.9 7904.6 7955.0 7887.2 9548.9 9802.8 10028.8 10129.4 17:27:42 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | [#3] mootools.html Cycles:180 Average:5428.08 Median:6472.69 stddev:2878.79 (44.5%) stddev-sans-first:2871.14 17:27:42 INFO - PROCESS | 13039 | Values: 1424.4 1449.4 1543.9 1724.3 1729.5 6904.4 7478.1 7542.1 7765.6 7794.2 7521.6 7529.7 7550.5 7572.2 7572.3 2271.8 2298.6 2301.9 2304.6 2309.0 2175.8 2180.5 2232.0 2235.1 2246.9 2250.7 2269.7 2285.4 2294.1 2316.6 2192.1 2197.5 2209.8 2209.9 2212.2 2219.9 2221.2 2234.4 2242.0 2252.5 7650.8 7684.6 7721.3 7736.0 7750.0 4570.1 4694.1 4703.2 4714.9 4756.3 2762.6 2870.1 2881.3 2889.6 2936.4 907.9 908.8 916.4 924.4 964.9 10411.5 10481.0 10520.9 10547.6 10553.4 4138.8 4156.3 4250.1 4340.2 4364.7 9056.5 9072.5 9085.7 9087.8 9099.2 4607.6 4633.1 4636.5 4641.2 4650.5 3760.1 4263.0 4271.1 4303.6 4451.8 3583.7 3591.2 3666.0 3692.7 3700.1 1191.9 1193.2 1210.8 1215.1 1223.8 1177.1 1181.0 1230.1 1233.7 1266.5 7140.3 7247.5 7309.9 7331.1 7336.3 439.4 446.8 453.8 455.3 457.3 5622.7 5676.8 5688.6 5709.2 5733.7 8980.7 9489.9 9629.4 9690.7 9703.3 9556.8 9622.7 9622.9 9674.9 9675.3 6965.5 7239.8 7244.3 7248.5 7286.9 7228.0 7285.9 7352.3 7354.1 7365.7 8782.0 8862.8 8997.9 9014.8 9048.1 8718.9 8932.9 9020.2 9108.3 9169.9 6104.9 6498.6 6736.0 6980.2 7092.8 7268.3 7348.7 7373.4 7402.9 7456.7 6547.2 6710.6 6763.8 6772.2 6861.2 6666.7 6677.5 6700.5 6758.3 6854.9 6959.3 6988.6 7079.4 7095.6 7108.3 6350.7 6408.9 6420.8 6433.3 6446.8 6584.7 6651.3 6662.5 6666.7 6748.0 17:27:42 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | [#4] prototype.html Cycles:180 Average:4675.21 Median:5348.17 stddev:1362.07 (25.5%) stddev-sans-first:1325.69 17:27:42 INFO - PROCESS | 13039 | Values: 298.7 310.4 311.9 313.2 319.6 5268.2 5414.7 5460.0 5460.3 5471.9 5335.7 5340.7 5355.7 5372.7 5375.2 3886.9 4012.8 4140.2 4146.2 4147.5 4154.8 4163.2 4181.9 4190.4 4197.6 4150.1 4167.9 4174.1 4186.8 4195.5 4046.8 4177.5 4187.9 4188.6 4196.0 3657.1 3668.7 3681.3 3690.4 3691.3 5081.4 5109.4 5117.6 5122.6 5134.6 4727.9 4820.1 4826.1 4831.1 4850.0 5488.4 5570.2 5638.6 5647.8 5651.8 3975.0 3986.5 4001.1 4008.8 4021.3 5683.7 5903.5 5907.0 5910.9 5916.3 4096.2 4103.0 4122.9 4137.0 4142.4 4195.1 4209.3 4210.4 4221.4 4228.0 4703.5 4764.7 4773.3 4781.1 4782.8 5580.3 5614.2 5649.3 5654.1 5658.9 1449.4 1474.3 1475.3 1475.8 1479.5 920.8 951.9 978.8 1005.6 1025.1 4911.4 4939.9 4967.5 4987.5 4991.9 5802.9 5804.2 5809.4 5812.4 5818.1 4846.5 4929.0 4932.8 4968.3 4988.0 3077.4 3085.7 3097.4 3107.7 3117.3 5387.6 5415.2 5416.2 5419.2 5423.7 5733.5 5873.2 5915.7 5944.4 5970.0 5424.5 5425.7 5432.5 5441.1 5454.0 5614.0 5750.3 5753.5 5783.6 5908.2 5756.6 5788.4 5799.2 5822.5 5830.2 5516.7 5521.4 5527.1 5530.3 5552.9 3789.9 3984.6 4003.6 4018.9 4028.4 5764.7 5788.6 5813.0 5814.5 5837.6 5602.4 5617.0 5617.2 5630.7 5636.2 5411.3 5721.6 5722.2 5723.4 5743.1 5303.8 5583.9 5584.2 5613.0 5644.3 5459.9 5683.8 5705.3 5721.4 5724.7 5458.3 5526.1 5540.5 5549.9 5557.4 17:27:42 INFO - PROCESS | 13039 | 17:27:42 INFO - PROCESS | 13039 | [#5] yui.html Cycles:180 Average:12460.85 Median:39790.50 stddev:13656.15 (34.3%) stddev-sans-first:13665.64 17:27:42 INFO - PROCESS | 13039 | Values: 647.7 713.2 726.1 756.1 772.1 12510.4 12542.8 12613.6 12663.1 12822.6 12132.5 12174.2 12235.8 12262.8 12306.9 644.8 788.3 812.1 817.6 824.8 808.1 811.0 813.4 816.5 818.4 852.8 855.7 856.5 856.8 858.5 844.3 845.6 846.6 848.4 849.5 626.3 628.6 628.8 629.0 630.4 12770.3 12831.8 12866.4 12885.2 12900.5 12416.9 12419.1 12609.8 13117.8 13198.3 10001.2 10117.7 10284.9 10308.0 10401.2 3379.8 3422.5 3437.0 3527.9 3535.1 45036.3 45486.0 45658.3 47517.8 47701.5 10171.2 10187.0 10188.8 10324.8 10399.3 17539.7 17704.8 17743.9 17791.5 17810.0 6876.1 7029.8 7037.5 7069.4 7086.3 3812.0 3818.5 3832.1 3837.0 3874.4 2689.9 2748.2 2754.8 2773.4 2773.4 505.9 526.3 531.5 536.1 537.5 648.3 667.9 668.7 679.9 685.4 7923.4 7959.2 8066.4 8209.6 8332.1 535.2 639.9 649.3 651.1 676.1 3838.9 3908.7 3912.3 3927.6 4007.6 47620.8 48926.5 48993.5 49074.0 49217.3 43493.3 43616.0 44676.8 44704.8 44710.0 38467.4 39452.8 39485.8 39538.0 40043.0 7552.2 7591.7 7622.0 8158.5 8219.1 25717.5 26059.0 27419.3 27457.6 27459.2 34062.0 35647.6 36898.6 37002.6 37876.4 9778.3 9788.0 9895.8 9983.8 10086.9 11830.9 11964.4 11982.5 12085.9 12189.9 10253.7 10712.0 10730.8 10852.9 11243.2 11267.5 11302.5 11348.2 11585.4 11906.3 10697.7 10834.7 11450.4 11468.7 11945.9 9591.3 9742.6 9753.8 10095.5 10102.7 9031.5 9451.4 9579.8 9604.5 9627.3 17:27:42 INFO - PROCESS | 13039 | -------- Summary: end -------- 17:27:42 INFO - PROCESS | 13039 | 17:27:43 INFO - TEST-INFO | 13039: exit 0 17:27:43 INFO - TEST-OK | dromaeo_css | took 1115659ms 17:27:43 INFO - TEST-START | kraken 17:27:43 INFO - operating with platform_type : linux_ 17:27:43 INFO - Initialising browser for kraken test... 17:27:43 INFO - TEST-INFO | started process 13276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzfS92c/profile http://localhost:48730/getInfo.html) 17:27:47 INFO - PROCESS | 13276 | 17:27:47 INFO - PROCESS | 13276 | (process:13344): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:27:47 INFO - PROCESS | 13276 | 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] 17:27:48 INFO - PROCESS | 13276 | __metrics Screen width/height:1600/1200 17:27:48 INFO - PROCESS | 13276 | colorDepth:24 17:27:48 INFO - PROCESS | 13276 | Browser inner width/height: 1024/697 17:27:48 INFO - PROCESS | 13276 | __metrics 17:27:49 ERROR - PROCESS | 13276 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 17:27:50 INFO - TEST-INFO | 13276: exit 0 17:27:50 INFO - Browser initialized. 17:27:50 INFO - Running cycle 1/1 for kraken test... 17:27:50 INFO - TEST-INFO | started process 13395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzfS92c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:52 INFO - PROCESS | 13395 | 17:27:52 INFO - PROCESS | 13395 | (process:13457): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:28:02 INFO - PROCESS | 13395 | RSS: Main: 164421632 17:28:02 INFO - PROCESS | 13395 | 17:28:04 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48730/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:05 INFO - PROCESS | 13395 | RSS: Main: 168857600 17:28:05 INFO - PROCESS | 13395 | 17:28:08 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48730/tests/kraken/driver.html?testName=audio-dft) 17:28:09 INFO - PROCESS | 13395 | RSS: Main: 172183552 17:28:09 INFO - PROCESS | 13395 | 17:28:12 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48730/tests/kraken/driver.html?testName=audio-fft) 17:28:12 INFO - PROCESS | 13395 | RSS: Main: 163856384 17:28:12 INFO - PROCESS | 13395 | 17:28:15 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48730/tests/kraken/driver.html?testName=audio-oscillator) 17:28:15 INFO - PROCESS | 13395 | RSS: Main: 164298752 17:28:15 INFO - PROCESS | 13395 | 17:28:17 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48730/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:18 INFO - PROCESS | 13395 | RSS: Main: 164556800 17:28:18 INFO - PROCESS | 13395 | 17:28:21 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48730/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:22 INFO - PROCESS | 13395 | RSS: Main: 165085184 17:28:22 INFO - PROCESS | 13395 | 17:28:25 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48730/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:26 INFO - PROCESS | 13395 | RSS: Main: 162865152 17:28:26 INFO - PROCESS | 13395 | 17:28:29 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48730/tests/kraken/driver.html?testName=json-parse-financial) 17:28:30 INFO - PROCESS | 13395 | RSS: Main: 163995648 17:28:30 INFO - PROCESS | 13395 | 17:28:31 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48730/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:32 INFO - PROCESS | 13395 | RSS: Main: 164323328 17:28:32 INFO - PROCESS | 13395 | 17:28:34 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48730/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:34 INFO - PROCESS | 13395 | RSS: Main: 164184064 17:28:34 INFO - PROCESS | 13395 | 17:28:37 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48730/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:37 INFO - PROCESS | 13395 | RSS: Main: 164478976 17:28:37 INFO - PROCESS | 13395 | 17:28:40 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:41 INFO - PROCESS | 13395 | RSS: Main: 165113856 17:28:41 INFO - PROCESS | 13395 | 17:28:44 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:44 INFO - PROCESS | 13395 | RSS: Main: 164651008 17:28:44 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | Cycle 1(1): loaded http://localhost:48730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48730/tests/kraken/driver.html?testName=ai-astar) 17:28:46 INFO - PROCESS | 13395 | RSS: Main: 165949440 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | __start_tp_report 17:28:46 INFO - PROCESS | 13395 | _x_x_mozilla_page_load 17:28:46 INFO - PROCESS | 13395 | _x_x_mozilla_page_load_details 17:28:46 INFO - PROCESS | 13395 | |i|pagename|runs| 17:28:46 INFO - PROCESS | 13395 | |0;ai-astar;117;111;114;114;115;125;115;115;118;114 17:28:46 INFO - PROCESS | 13395 | |1;audio-beat-detection;166;133;160;200;134;151;171;133;200;135 17:28:46 INFO - PROCESS | 13395 | |2;audio-dft;161;162;164;177;163;163;164;163;164;162 17:28:46 INFO - PROCESS | 13395 | |3;audio-fft;73;74;74;175;78;74;77;75;157;78 17:28:46 INFO - PROCESS | 13395 | |4;audio-oscillator;93;95;154;95;94;94;143;95;95;138 17:28:46 INFO - PROCESS | 13395 | |5;imaging-gaussian-blur;117;117;118;118;118;117;118;118;118;118 17:28:46 INFO - PROCESS | 13395 | |6;imaging-darkroom;146;147;146;147;148;146;146;146;147;146 17:28:46 INFO - PROCESS | 13395 | |7;imaging-desaturate;96;96;96;96;96;96;95;97;97;97 17:28:46 INFO - PROCESS | 13395 | |8;json-parse-financial;65;65;66;65;66;69;65;65;65;65 17:28:46 INFO - PROCESS | 13395 | |9;json-stringify-tinderbox;63;63;64;64;64;64;67;63;63;63 17:28:46 INFO - PROCESS | 13395 | |10;stanford-crypto-aes;86;84;85;84;83;86;86;86;115;86 17:28:46 INFO - PROCESS | 13395 | |11;stanford-crypto-ccm;146;141;141;141;140;146;154;141;148;145 17:28:46 INFO - PROCESS | 13395 | |12;stanford-crypto-pbkdf2;173;175;179;173;178;173;172;175;171;174 17:28:46 INFO - PROCESS | 13395 | |13;stanford-crypto-sha256-iterative;72;72;77;72;72;75;75;71;72;74 17:28:46 INFO - PROCESS | 13395 | __end_tp_report 17:28:46 INFO - PROCESS | 13395 | __start_cc_report 17:28:46 INFO - PROCESS | 13395 | _x_x_mozilla_cycle_collect,924 17:28:46 INFO - PROCESS | 13395 | __end_cc_report 17:28:46 INFO - PROCESS | 13395 | __startTimestamp1460420926944__endTimestamp 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | ------- Summary: start ------- 17:28:46 INFO - PROCESS | 13395 | Number of tests: 14 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:3.74 (3.2%) stddev-sans-first:3.94 17:28:46 INFO - PROCESS | 13395 | Values: 117.0 111.0 114.0 114.0 115.0 125.0 115.0 115.0 118.0 114.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#1] audio-beat-detection Cycles:10 Average:158.30 Median:163.00 stddev:26.18 (16.1%) stddev-sans-first:27.62 17:28:46 INFO - PROCESS | 13395 | Values: 166.0 133.0 160.0 200.0 134.0 151.0 171.0 133.0 200.0 135.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:4.57 (2.8%) stddev-sans-first:4.69 17:28:46 INFO - PROCESS | 13395 | Values: 161.0 162.0 164.0 177.0 163.0 163.0 164.0 163.0 164.0 162.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#3] audio-fft Cycles:10 Average:93.50 Median:74.50 stddev:38.49 (51.7%) stddev-sans-first:40.10 17:28:46 INFO - PROCESS | 13395 | Values: 73.0 74.0 74.0 175.0 78.0 74.0 77.0 75.0 157.0 78.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:94.50 stddev:24.74 (26.2%) stddev-sans-first:25.50 17:28:46 INFO - PROCESS | 13395 | Values: 93.0 95.0 154.0 95.0 94.0 94.0 143.0 95.0 95.0 138.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:28:46 INFO - PROCESS | 13395 | Values: 117.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 17:28:46 INFO - PROCESS | 13395 | Values: 146.0 147.0 146.0 147.0 148.0 146.0 146.0 146.0 147.0 146.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:28:46 INFO - PROCESS | 13395 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 97.0 97.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 17:28:46 INFO - PROCESS | 13395 | Values: 65.0 65.0 66.0 65.0 66.0 69.0 65.0 65.0 65.0 65.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 17:28:46 INFO - PROCESS | 13395 | Values: 63.0 63.0 64.0 64.0 64.0 64.0 67.0 63.0 63.0 63.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.00 stddev:9.52 (11.1%) stddev-sans-first:10.06 17:28:46 INFO - PROCESS | 13395 | Values: 86.0 84.0 85.0 84.0 83.0 86.0 86.0 86.0 115.0 86.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:145.50 stddev:4.42 (3.0%) stddev-sans-first:4.65 17:28:46 INFO - PROCESS | 13395 | Values: 146.0 141.0 141.0 141.0 140.0 146.0 154.0 141.0 148.0 145.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.50 stddev:2.54 (1.5%) stddev-sans-first:2.65 17:28:46 INFO - PROCESS | 13395 | Values: 173.0 175.0 179.0 173.0 178.0 173.0 172.0 175.0 171.0 174.0 17:28:46 INFO - PROCESS | 13395 | 17:28:46 INFO - PROCESS | 13395 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:1.93 (2.6%) stddev-sans-first:2.00 17:28:46 INFO - PROCESS | 13395 | Values: 72.0 72.0 77.0 72.0 72.0 75.0 75.0 71.0 72.0 74.0 17:28:46 INFO - PROCESS | 13395 | -------- Summary: end -------- 17:28:46 INFO - PROCESS | 13395 | 17:28:47 INFO - TEST-INFO | 13395: exit 0 17:28:47 INFO - TEST-OK | kraken | took 64506ms 17:28:47 INFO - SUITE-END | took 1180s 17:28:48 INFO - Completed test suite (00:19:40) 17:28:48 INFO - javascript benchmark 17:28:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.763681268686, 2688.744569265919, 2713.1182365731142, 2730.508508468476, 2736.2612094734422, 4743.1699452595785, 4762.49993750656, 4769.976150119249, 4788.97605511972, 4798.568128868401, 4688.296755486679, 4741.0991911536785, 4788.52114788521, 4795.064962332347, 4799.664023518355, 4330.307150855863, 4356.6514678825615, 4401.119776044788, 4412.073464572443, 4446.421965144526, 4430.3133014382665, 4432.312991486308, 4475.597196252336, 4478.0596074824325, 4530.841420550281, 4294.592013758688, 4299.441072660566, 4345.587169218919, 4362.17118747437, 4367.475902891641, 4339.913201735979, 4340.500842403101, 4353.020570371673, 4360.21516127097, 4388.100439409914, 4336.089421221515, 4337.0, 4337.63130133939, 4371.606555410029, 4379.0366119453665, 4631.444226692818, 4708.811647534095, 4728.621710263205, 4744.383230180089, 4747.881302967419, 5099.056674515226, 5100.821471248489, 5115.974420127913, 5129.974005198975, 5166.276721259027, 4951.455339912607, 5057.974710126463, 5142.974285128588, 5146.819861304836, 5188.429272779991, 4779.569838714463, 4799.976000120047, 4801.351817504627, 4808.519148085234, 4843.685160464559, 5246.422893481714, 5246.527812496894, 5250.632455728139, 5253.684778913277, 5285.471452854684, 4858.416989961157, 4994.150994330972, 5038.3198268234055, 5039.84880453587, 5058.241263810458, 5060.139776238048, 5061.392632884003, 5092.26162206478, 5122.513361230752, 5122.795088196431, 5102.0, 5108.897822043538, 5112.6421150519855, 5146.665466744649, 5159.045576568272, 4928.334674818925, 4936.185529387682, 5081.441041485434, 5092.363454568179, 5150.330457040561, 4233.597808208216, 4235.385869048971, 4252.91494170121, 4271.444712187458, 4277.059047009653, 3680.3375392429084, 3694.0949467380665, 3713.034611001105, 3730.906727331784, 3751.0, 4427.313766366218, 4458.08609235106, 4462.397576327155, 4480.798364073625, 4490.371348011281, 5165.612579056586, 5168.173092305213, 5189.377274727057, 5192.402873669501, 5220.321358223483, 4539.591436770706, 4580.129775342674, 4590.334401511762, 4592.655550833634, 4627.282771170474, 4454.844080457168, 4555.544445555484, 4598.0803839232285, 4604.631629469634, 4631.397918270671, 4790.065937142223, 4797.856064318076, 4798.7840547175465, 4803.375561176955, 4851.296561998561, 5080.060188865072, 5104.846854594368, 5109.514596113363, 5117.948820511747, 5166.4316925138955, 4642.466116396523, 4874.658773885794, 4900.975495122501, 4929.260610908393, 4966.428860681068, 4968.826091086795, 4982.10322142018, 4991.3511243538105, 4999.350084488993, 5044.0, 4982.227754698028, 5049.116404629101, 5053.84838454847, 5062.0, 5099.821506247264, 4798.1123492154065, 4914.336564563881, 4921.3356196912955, 5012.273220382951, 5043.646944713982, 4899.4365647950945, 4910.238912968495, 4914.410270767531, 4939.901201976012, 4944.975275123601, 4785.712857228577, 4848.369711937426, 4862.41651001882, 4872.4153101628035, 4896.167651499182, 4907.705537667752, 5002.599792016703, 5015.3730783652045, 5054.595632349477, 5078.796848126181, 4824.589909857561, 4833.202521583899, 4872.610191184767, 4899.31409602663, 4936.160852655129], "value": 4683.610508143311, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8266520043987, 587.8530367408148, 604.9062395328725, 612.6446660936656, 668.2949488289859, 35391.11522211943, 36046.8197659012, 36426.63573364266, 36481.452778208346, 36485.27029459413, 36209.0, 36553.634463655355, 36731.08172295687, 36745.81627091867, 36827.26345473089, 7622.428317876168, 7817.804554886116, 7854.528728276293, 7861.292483676468, 7863.724769633064, 7680.3087722105, 7904.64429100689, 7949.920500794976, 7953.602319883983, 7969.880451793228, 7963.124056353797, 8009.118996910335, 8026.919730802705, 8030.959845200795, 8040.316573091294, 7852.411069169807, 7871.960640196791, 7912.643931023118, 7931.127575966639, 7941.0, 7914.406419518559, 8033.357331413473, 8037.437379383446, 8040.557769322685, 8053.677852885878, 28044.298892527648, 36800.815995920115, 37331.81334093339, 37333.0, 37340.626593733985, 2947.6735816368555, 3028.1218446650446, 3054.862531186102, 3105.2702614885484, 3184.4745616973173, 23992.520149597083, 24134.275971720876, 24246.63630045533, 24410.51178976428, 24652.506949861083, 3283.129970557804, 3293.0170794912456, 3389.8813541526174, 3477.51314815926, 3494.3710132176197, 165464.17267913703, 165890.0, 166645.0, 166800.0, 166916.0, 31493.8425307872, 31882.0, 31905.52141717876, 31932.0, 32065.198370040936, 32883.67116328854, 57785.422145778844, 59327.406725933055, 59780.0, 60008.39991600115, 13440.865591344156, 13557.932210338886, 13594.932025340007, 13621.863781362257, 13624.11443256205, 10746.24776265654, 10748.355098693946, 10827.729306767236, 10827.83758243627, 10836.40399778004, 18035.27858885656, 18149.546261343574, 18188.81811181898, 18324.90837545804, 18967.0, 6996.475264355194, 7005.54463959841, 7280.720993759114, 7296.124465064227, 7314.926850731531, 837.5519097282925, 893.7363477773943, 897.1925267259519, 907.1971305394774, 1010.3836659637615, 26943.730562694123, 28153.859230703714, 28303.858480707877, 28388.0, 28447.71552284492, 967.690339091498, 979.8971108033696, 984.7931934293736, 1007.868977032981, 1059.4384975962753, 14464.783028254584, 14842.257887105601, 14940.626484337978, 15213.087214767149, 15219.543413697607, 297204.0, 302376.0, 303684.0, 304025.0, 304731.0, 46454.30318545225, 48120.79698007578, 48259.517404826205, 48267.275990860166, 48332.0, 1230.0712961714028, 1254.1659796235583, 1266.3351740336398, 1272.9809052864214, 1273.40150129439, 26433.471330573666, 26566.335841604116, 27069.1879243623, 27663.72336276692, 27684.44631107407, 41705.58294417017, 42175.7891210542, 42349.78825105855, 42477.15045699131, 42479.787601063035, 285995.0, 287491.0, 288800.0, 289066.0, 289555.0, 24857.378565536008, 25307.367315816515, 38049.0, 39195.216095678494, 39427.40858887062, 35576.0, 35809.0, 36357.27285454223, 36590.8170459146, 39375.606243937196, 34722.65277347295, 34870.65129348674, 35106.0, 35170.64829351674, 35261.294774104885, 34618.65381346154, 34624.65375346315, 34914.127146820516, 35112.0, 35201.64798351983, 32395.35209295754, 34702.82648586741, 34737.82631086929, 36198.09504762402, 36798.63201367952, 28218.153455396372, 28947.85526072356, 29015.709842901302, 29047.854760726063, 29195.0, 22872.656910146696, 23195.53608927846, 23246.0, 23263.53472930566, 23403.76596234016], "value": 16682.312715729244, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.9752917295789, 357.41562545238526, 359.2222837556689, 365.9688926441253, 368.0889797750566, 15504.92247538762, 15696.529104126867, 15889.761653575206, 15904.84095159048, 15905.44330948417, 10301.639442619491, 10836.837447438294, 10839.374093885921, 10918.617848375288, 15768.21158942054, 4582.427196600425, 4612.469565999911, 4741.596964258042, 4747.501512341206, 4761.761911904391, 4659.254519276917, 4684.5315468453055, 4695.788689508963, 4700.435947686283, 4727.952720472786, 4661.347411362412, 4664.3936288282475, 4690.108879312919, 4695.718256904596, 4713.434387873443, 4933.33399991002, 5250.369955605352, 5268.868278293035, 5269.604779641542, 5294.788208471657, 4964.826231081931, 5076.416212135578, 5077.796888124471, 5080.923786143211, 5131.640785145041, 11643.825342619868, 11841.0, 11925.582604608797, 11962.222455540448, 12564.057695672862, 1979.8515111366705, 2243.7083179186766, 2283.8058765004994, 2319.3042087373888, 2467.7902378297686, 9155.404898681565, 9598.90401095987, 12236.694082647917, 12364.752704945851, 12787.0, 1707.5218938697185, 1737.800152982398, 1758.5779412940801, 1782.6702060118919, 1829.8170182981596, 59584.0, 61257.0, 65263.0, 71315.64342178308, 73381.63309183474, 9651.372660777168, 10000.199984001263, 10091.344062635904, 10107.64623238183, 10213.642522511676, 14162.221077840817, 14234.644133896529, 14260.572182834532, 14284.714305714035, 14401.639959000899, 7269.818254543573, 7296.270372962661, 7309.780706578811, 7397.741079062314, 7436.144843342977, 6889.311068893071, 6945.201301850251, 6972.616506092214, 7014.053102831154, 7034.0, 4327.5239723630375, 4376.256036473807, 4385.101054283928, 4464.330350447459, 4468.932966005513, 1801.3605170164665, 1847.7782666080157, 1875.840553552936, 1904.2192700992528, 1905.7903630600622, 850.4897061763016, 903.8553831386946, 935.6257497001118, 945.7493764152505, 996.3025881882711, 15806.9209653951, 16630.6673866522, 16803.15984200785, 16830.074345911093, 16885.32458701663, 871.4466313890725, 898.9280857531381, 931.5901003558413, 938.6855403439788, 979.583676937313, 9113.726588202364, 9262.722118336325, 9402.43585384879, 9490.810183796286, 9523.380980236263, 380136.0, 381145.0, 401533.0, 413051.0, 419086.0, 71951.64024179845, 73176.0, 75396.62301688566, 75461.6226918862, 75993.62003189948, 926.2451102351562, 965.6716716316486, 968.970930872075, 969.6509256667593, 986.9901300987042, 15334.38662453534, 15379.0, 15537.76693349578, 15562.844371556592, 15948.920255398649, 33016.83491582527, 34022.31955360829, 34564.0, 34610.653893460745, 34724.0, 47847.28229076497, 48226.0, 49273.26090108723, 49535.752321238164, 49818.0, 7485.7754267372065, 7816.296533312029, 7922.864190148833, 7968.561729104955, 8090.150534193825, 6235.75056997715, 8703.390762646553, 9828.901710982798, 10033.645457863095, 11520.654380368602, 9758.0, 10422.635207767691, 10448.582056717647, 10593.682189534326, 10711.517981690688, 8738.300935924983, 9959.502024898582, 10137.543810528396, 10147.594096236364, 10409.0, 10117.190624749855, 10148.898511014795, 10526.368417894952, 10689.251752377259, 10733.355998640107, 7823.882641760264, 7853.057633083838, 7879.881801773093, 7904.565248911135, 7955.0, 7887.1718469562165, 9548.85676714836, 9802.754931126494, 10028.849567256642, 10129.442880641636], "value": 7918.634530985718, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.3946322812806, 1449.4202319072374, 1543.9459618913334, 1724.3016578285783, 1729.4552216051943, 6904.378605925465, 7478.1026276846715, 7542.057242844645, 7765.611719414028, 7794.220577942203, 7521.623918804065, 7529.736459223928, 7550.471466997313, 7572.204918483562, 7572.318491335779, 2271.772822717727, 2298.6322188449853, 2301.907923683059, 2304.585174668559, 2309.0, 2175.771543987882, 2180.5311857950537, 2231.966520502194, 2235.117128734157, 2246.8539544929527, 2250.651149071888, 2269.6595510673365, 2285.3600991722346, 2294.105298933417, 2316.6409206572926, 2192.0793266827973, 2197.5385169114425, 2209.8011178993966, 2209.933701988935, 2212.1704360864674, 2219.8668079915255, 2221.2336743823357, 2234.3743751749535, 2241.9663705044436, 2252.493189032471, 7650.770476885702, 7684.615769211517, 7721.343685786715, 7736.032995875516, 7750.031246094239, 4570.131674981742, 4694.08465349257, 4703.2004559225015, 4714.858554243378, 4756.334113224151, 2762.6408566886375, 2870.138958312498, 2881.2652773542613, 2889.5954566360724, 2936.4420760055737, 907.9001309855911, 908.7818923458389, 916.4089162490224, 924.3529529329496, 964.9421034737938, 10411.479426028669, 10481.0, 10520.94739526305, 10547.630832920811, 10553.366797992145, 4138.79306034697, 4156.25187466259, 4250.086231460251, 4340.240457919851, 4364.716293440916, 9056.501892395981, 9072.501012444247, 9085.727428177166, 9087.772805679911, 9099.1810737034, 4607.562281583244, 4633.0733853229485, 4636.4899861015265, 4641.234196357631, 4650.51169627191, 3760.0975765816556, 4262.957370426256, 4271.060366719316, 4303.63419109373, 4451.799669014902, 3583.749137560346, 3591.1560783215923, 3665.9816700916326, 3692.667659910621, 3700.148965737895, 1191.9483886347666, 1193.1886317304143, 1210.842590463234, 1215.1311812054423, 1223.8470191226097, 1177.093637898813, 1181.0492553494519, 1230.0528592983353, 1233.6545767185203, 1266.4554241675983, 7140.250273721288, 7247.4926755126635, 7309.926900731031, 7331.120265568166, 7336.266373362621, 439.41338313351395, 446.792241607654, 453.82754553269547, 455.2556570008061, 457.3300115331056, 5622.718864056863, 5676.801311954062, 5688.5733569981585, 5709.200711900337, 5733.741981610838, 8980.730578082668, 9489.857652135086, 9629.374090684083, 9690.70927872165, 9703.272254580934, 9556.76108097303, 9622.663206787729, 9622.90377096234, 9674.854877176847, 9675.274354423305, 6965.547239429421, 7239.782806515813, 7244.311790379906, 7248.456365772483, 7286.890696639554, 7227.9880816686755, 7285.890711639224, 7352.264773522605, 7354.117505899327, 7365.747822870017, 8781.956090219508, 8862.822743544964, 8997.865032024394, 9014.774630634287, 9048.095190480899, 8718.869216961877, 8932.910670893209, 9020.233280171258, 9108.269428808506, 9169.945456272348, 6104.8779024420155, 6498.610083395011, 6735.966320168368, 6980.232174460703, 7092.822679432849, 7268.309510596485, 7348.742794002184, 7373.373263272468, 7402.925970740439, 7456.701731930879, 6547.247066587403, 6710.63091529951, 6763.830904227237, 6772.221194562491, 6861.210960739579, 6666.699998500176, 6677.465802735866, 6700.4639628830555, 6758.290379510081, 6854.931450685629, 6959.26927672587, 6988.615626140611, 7079.39825114871, 7095.645217738989, 7108.324709152622, 6350.682465876595, 6408.935910640834, 6420.839479013062, 6433.324500927335, 6446.774362897276, 6584.670766461753, 6651.33486651331, 6662.533622646562, 6666.699998500176, 6748.021536877223], "value": 4354.7767975504785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.67593660877947, 310.3637543036774, 311.9329344190999, 313.1904028087394, 319.60209539123787, 5268.183431568108, 5414.675119492833, 5460.044492213857, 5460.31746031746, 5471.863203419916, 5335.7332133393365, 5340.652857564256, 5355.6786592804365, 5372.677639341632, 5375.247465354843, 3886.8833934981994, 4012.779297138656, 4140.213359461693, 4146.170765846843, 4147.523034850986, 4154.792260386984, 4163.229802486535, 4181.853635122771, 4190.3923931029985, 4197.622214000739, 4150.149219410014, 4167.916641667165, 4174.144300418407, 4186.769727664977, 4195.538490766014, 4046.817893194813, 4177.4778152730905, 4187.895302617444, 4188.560201178878, 4195.97902010488, 3657.1165849587483, 3668.724845636588, 3681.2637472505608, 3690.3541880170865, 3691.261747650454, 5081.415637201695, 5109.3613298337705, 5117.616178786606, 5122.564582010496, 5134.589232861362, 4727.905441891143, 4820.0841840050625, 4826.131296366652, 4831.130396528623, 4849.951500484985, 5488.368837583689, 5570.220169176318, 5638.577106716972, 5647.774089036475, 5651.8304450866535, 3974.980125099356, 3986.54154772202, 4001.079751657106, 4008.83964641414, 4021.3163762160502, 5683.658980461144, 5903.49820265278, 5907.0, 5910.911336329916, 5916.290045194562, 4096.221717873595, 4103.0, 4122.9381559276635, 4136.958630413717, 4142.357934520154, 4195.139996300751, 4209.34755112958, 4210.368444733253, 4221.387898754663, 4227.991703940604, 4703.529647035269, 4764.666473346832, 4773.307870358779, 4781.067691800135, 4782.784774685148, 5580.302462192226, 5614.214010038598, 5649.322081350264, 5654.095344744821, 5658.886822263532, 1449.4057436451005, 1474.336548553134, 1475.2549962268986, 1475.7933889255512, 1479.5265515035085, 920.7928216151313, 951.9148171084969, 978.83849164887, 1005.6429967361481, 1025.108155904368, 4911.435184953776, 4939.851804445872, 4967.453580106186, 4987.476314986874, 4991.850244492671, 5802.854928626733, 5804.158397032491, 5809.3609702932645, 5812.447817457335, 5818.127280907897, 4846.491118432585, 4928.99331407841, 4932.778024988884, 4968.254761785761, 4987.975060124676, 3077.39990701811, 3085.691430856941, 3097.411491816548, 3107.7203051725455, 3117.2986078132694, 5387.568994480433, 5415.214793854869, 5416.241726158341, 5419.214213938957, 5423.674579525162, 5733.512651424676, 5873.236479257669, 5915.740666719955, 5944.405559444108, 5970.0, 5424.484673955968, 5425.674459532441, 5432.456754324615, 5441.102218134043, 5454.0, 5613.971930140323, 5750.338711048283, 5753.539716822728, 5783.624064435799, 5908.172855800278, 5756.568257380797, 5788.363280039108, 5799.202247303349, 5822.505087067647, 5830.18377427169, 5516.696581688046, 5521.365043019943, 5527.115661494142, 5530.336359636869, 5552.916706249491, 3789.943150852684, 3984.581618929971, 4003.6396724294955, 4018.9196216076098, 4028.415879697369, 5764.665310549234, 5788.571742616818, 5812.994516891666, 5814.505767009682, 5837.620554663933, 5602.411746766531, 5617.0, 5617.213590097472, 5630.690312032878, 5636.1545768133465, 5411.2965314508865, 5721.628094173865, 5722.198892155185, 5723.370429252862, 5743.1385292206505, 5303.806643505181, 5583.860403489783, 5584.190292407659, 5613.045782216951, 5644.322681278273, 5459.918101228564, 5683.8010669626365, 5705.34388545306, 5721.370649228498, 5724.656520608777, 5458.2904222450825, 5526.104096611799, 5540.501354878081, 5549.889002219852, 5557.360578629233], "value": 4238.265607528653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.6664517773345, 713.224072060569, 726.1121085178537, 756.1153450462958, 772.1236396689757, 12510.437030333635, 12542.81185782214, 12613.558525451612, 12663.11358204926, 12822.551210707616, 12132.514699412035, 12174.208676436025, 12235.816462753044, 12262.816057759119, 12306.876931230685, 644.8226737647137, 788.2826627768732, 812.0823469479494, 817.6198067898426, 824.8102936324649, 808.0908977400425, 811.0, 813.4387272781762, 816.4652152839899, 818.443458448255, 852.8166444214523, 855.6620135046653, 856.4518708026868, 856.7686724584389, 858.5449711652834, 844.3118858130634, 845.6363763581658, 846.6401779243859, 848.4103548034119, 849.4903058165113, 626.2766504687094, 628.6008384675764, 628.8365025093462, 629.0218709906094, 630.4357599948066, 12770.297633630147, 12831.807522887164, 12866.421011054525, 12885.226886386847, 12900.483980640764, 12416.875831241752, 12419.068569857207, 12609.810852837214, 13117.803232951514, 13198.274094924775, 10001.199904007663, 10117.747056323577, 10284.897151028468, 10308.0, 10401.219908506891, 3379.831008449568, 3422.469517224834, 3436.9828150859084, 3527.9294414111573, 3535.08087897146, 45036.3244551332, 45486.0, 45658.31512527315, 47517.76241118772, 47701.522984769705, 10171.23715721309, 10187.0, 10188.796224075477, 10324.793504130026, 10399.272050956512, 17539.73690394645, 17704.822951770577, 17743.911280443772, 17791.46625601234, 17810.0, 6876.140482439695, 7029.753958611424, 7037.542559733601, 7069.363757261871, 7086.291370862976, 3812.046988252937, 3818.522684664417, 3832.0994566276904, 3836.9808150959066, 3874.3994680823953, 2689.9058532951253, 2748.244232835986, 2754.793390495721, 2773.362126710868, 2773.3898542320658, 505.8887044850127, 526.2973929803754, 531.5242857642388, 536.0806217337285, 537.5189205660989, 648.2545073165898, 667.8764428580728, 668.6890595872942, 679.8878185099403, 685.3865790117817, 7923.366130709529, 7959.243871832166, 8066.395020373496, 8209.630566624517, 8332.083470818205, 535.1865164949255, 639.9072134540559, 649.2728144478215, 651.1274891645218, 676.0737789228788, 3838.8848334550007, 3908.7459315144993, 3912.3250147629974, 3927.626875446828, 4007.6393124618926, 47620.7618961903, 48926.51073489291, 48993.51006489961, 49074.0, 49217.26174107391, 43493.34759978603, 43616.0, 44676.77661611671, 44704.77647611806, 44710.0, 38467.42298865519, 39452.80273598614, 39485.80257098696, 39538.0, 40043.0, 7552.244775522404, 7591.696332146652, 7622.0, 8158.510489370657, 8219.095899450936, 25717.485650287264, 26059.0, 27419.31451713723, 27457.588136178372, 27459.17622471329, 34062.0, 35647.64352356547, 36898.63101368952, 37002.62997369992, 37876.431853521666, 9778.315517913677, 9787.951060244653, 9895.752606184615, 9983.800323993624, 10086.94956525242, 11830.940845295718, 11964.401779911144, 11982.468070743304, 12085.879141208476, 12189.878101219228, 10253.74365640865, 10712.0, 10730.839037414602, 10852.891471085188, 11243.212975091992, 11267.549298028314, 11302.491387887729, 11348.205625606459, 11585.362805045803, 11906.285622862655, 10697.679069627924, 10834.67495975122, 11450.37022963745, 11468.713282168013, 11945.940270298594, 9591.28065395112, 9742.610295588098, 9753.804923901624, 10095.495225238856, 10102.69691909244, 9031.548422578977, 9451.432914025181, 9579.760505987406, 9604.471754053595, 9627.277954153327], "value": 5963.779620474454, "unit": "score"}], "name": "dromaeo_css", "value": 6390.487262741214, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 114.0, 114.0, 115.0, 125.0, 115.0, 115.0, 118.0, 114.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 133.0, 160.0, 200.0, 134.0, 151.0, 171.0, 133.0, 200.0, 135.0], "value": 158.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 177.0, 163.0, 163.0, 164.0, 163.0, 164.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 175.0, 78.0, 74.0, 77.0, 75.0, 157.0, 78.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 154.0, 95.0, 94.0, 94.0, 143.0, 95.0, 95.0, 138.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 97.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 69.0, 65.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 67.0, 63.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 84.0, 83.0, 86.0, 86.0, 86.0, 115.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 141.0, 141.0, 141.0, 140.0, 146.0, 154.0, 141.0, 148.0, 145.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 179.0, 173.0, 178.0, 173.0, 172.0, 175.0, 171.0, 174.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 77.0, 72.0, 72.0, 75.0, 75.0, 71.0, 72.0, 74.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1611.2, "alertThreshold": 2.0}]} 17:28:48 INFO - Return code: 0 17:28:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:28:48 ERROR - # TBPL SUCCESS # 17:28:48 INFO - Running post-action listener: _resource_record_post_action 17:28:48 INFO - Running post-run listener: _resource_record_post_run 17:28:49 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537530368; Read time: 20; Write time: 1255656 17:28:49 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 241172480; Read time: 0; Write time: 713856 17:28:49 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296357888; Read time: 20; Write time: 541800 17:28:49 INFO - Running post-run listener: _upload_blobber_files 17:28:49 INFO - Blob upload gear active. 17:28:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:28:49 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 17:28:49 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'] 17:28:49 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 17:28:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:28:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:28:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:50 INFO - (blobuploader) - INFO - Done attempting. 17:28:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:28:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:28:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:51 INFO - (blobuploader) - INFO - Done attempting. 17:28:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:51 INFO - Return code: 0 17:28:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/22c36186d49eba86b089b1ca76ee22c5dc0abc0dbf48d4da37fc09d285e989369c7b4785a17a3ede4233417cdf902977cfd3836cf18edfaa9ed4bd0397f1d601", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83a1b9c90c9ff1d55701bae2cfd873cf04173dfb293234db5e720388c7fcd33a4cbd537ea3efd0c7298e2a1645a499e0de5f6287f86f33d757c94aa12ceb58ff"} 17:28:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:51 INFO - Contents: 17:28:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/22c36186d49eba86b089b1ca76ee22c5dc0abc0dbf48d4da37fc09d285e989369c7b4785a17a3ede4233417cdf902977cfd3836cf18edfaa9ed4bd0397f1d601", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83a1b9c90c9ff1d55701bae2cfd873cf04173dfb293234db5e720388c7fcd33a4cbd537ea3efd0c7298e2a1645a499e0de5f6287f86f33d757c94aa12ceb58ff"} 17:28:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:51 INFO - Copying logs to upload dir... 17:28:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.997721 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-11 17:28:51.251427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 17:28:51.254399) ========= 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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 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/22c36186d49eba86b089b1ca76ee22c5dc0abc0dbf48d4da37fc09d285e989369c7b4785a17a3ede4233417cdf902977cfd3836cf18edfaa9ed4bd0397f1d601", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83a1b9c90c9ff1d55701bae2cfd873cf04173dfb293234db5e720388c7fcd33a4cbd537ea3efd0c7298e2a1645a499e0de5f6287f86f33d757c94aa12ceb58ff"} build_url:https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/LyBUmQUJTDy2wD9-6OmCGA/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/22c36186d49eba86b089b1ca76ee22c5dc0abc0dbf48d4da37fc09d285e989369c7b4785a17a3ede4233417cdf902977cfd3836cf18edfaa9ed4bd0397f1d601", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83a1b9c90c9ff1d55701bae2cfd873cf04173dfb293234db5e720388c7fcd33a4cbd537ea3efd0c7298e2a1645a499e0de5f6287f86f33d757c94aa12ceb58ff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 17:28:51.279777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:28:51.280095) ========= 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=1861a34ebfea852630dec091000001fa-1460419065.380163-1221120195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004771 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:28:51.363966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 17:28:51.364303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 17:28:51.364616) ========= ========= Total master_lag: 0.29 =========