builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1458645620.08 results: success (0) buildid: 20160322030037 builduid: 70c5d81b8a7f40fba92c0b1116c731ae revision: 3587b25bae302c1eed72968dbd7cef883e715948 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.084870) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.085348) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.085636) ========= 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=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005000 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.107192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.107503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.121688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.122034) ========= 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=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.172477) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.172810) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.173189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.173477) ========= 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=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-22 04:20:20-- 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% 45.9M=0s 2016-03-22 04:20:21 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203312 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.389355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.389682) ========= 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=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018800 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:20.439214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 04:20:20.439570) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3587b25bae302c1eed72968dbd7cef883e715948 --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 3587b25bae302c1eed72968dbd7cef883e715948 --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=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-22 04:20:21,181 truncating revision to first 12 chars 2016-03-22 04:20:21,181 Setting DEBUG logging. 2016-03-22 04:20:21,181 attempt 1/10 2016-03-22 04:20:21,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3587b25bae30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 04:20:21,787 unpacking tar archive at: mozilla-central-3587b25bae30/testing/mozharness/ program finished with exit code 0 elapsedTime=1.456781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 04:20:21.909040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:21.909416) ========= echo 3587b25bae302c1eed72968dbd7cef883e715948 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3587b25bae302c1eed72968dbd7cef883e715948'] 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=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3587b25bae302c1eed72968dbd7cef883e715948 program finished with exit code 0 elapsedTime=0.003795 script_repo_revision: '3587b25bae302c1eed72968dbd7cef883e715948' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:21.958813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:21.959114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 04:20:21.970085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-22 04:20:21.970379) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:20:22 INFO - MultiFileLogger online at 20160322 04:20:22 in /builds/slave/test 04:20:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:20:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:22 INFO - {'append_to_log': False, 04:20:22 INFO - 'base_work_dir': '/builds/slave/test', 04:20:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:20:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:22 INFO - 'branch': 'Firefox-Non-PGO', 04:20:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:22 INFO - 'config_files': ('talos/linux_config.py',), 04:20:22 INFO - 'default_actions': ('clobber', 04:20:22 INFO - 'read-buildbot-config', 04:20:22 INFO - 'download-and-extract', 04:20:22 INFO - 'populate-webroot', 04:20:22 INFO - 'create-virtualenv', 04:20:22 INFO - 'install', 04:20:22 INFO - 'run-tests'), 04:20:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:22 INFO - 'download_minidump_stackwalk': True, 04:20:22 INFO - 'download_symbols': 'ondemand', 04:20:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:22 INFO - 'installer_path': 'installer.exe', 04:20:22 INFO - 'log_level': 'info', 04:20:22 INFO - 'log_name': 'talos', 04:20:22 INFO - 'log_to_console': True, 04:20:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:20:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:20:22 INFO - 'opt_config_files': (), 04:20:22 INFO - 'pip_index': False, 04:20:22 INFO - 'sps_profile': False, 04:20:22 INFO - 'sps_profile_interval': 0, 04:20:22 INFO - 'suite': 'dromaeojs', 04:20:22 INFO - 'system_bits': '32', 04:20:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:22 INFO - 'title': 'talos-linux64-ix-017', 04:20:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:22 INFO - 'use_talos_json': True, 04:20:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:22 INFO - 'work_dir': 'build'} 04:20:22 INFO - ##### 04:20:22 INFO - ##### Running clobber step. 04:20:22 INFO - ##### 04:20:22 INFO - Running pre-action listener: _resource_record_pre_action 04:20:22 INFO - Running main action method: clobber 04:20:22 INFO - rmtree: /builds/slave/test/build 04:20:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:23 INFO - Running post-action listener: _resource_record_post_action 04:20:23 INFO - ##### 04:20:23 INFO - ##### Running read-buildbot-config step. 04:20:23 INFO - ##### 04:20:23 INFO - Running pre-action listener: _resource_record_pre_action 04:20:23 INFO - Running main action method: read_buildbot_config 04:20:23 INFO - Using buildbot properties: 04:20:23 INFO - { 04:20:23 INFO - "project": "", 04:20:23 INFO - "product": "firefox", 04:20:23 INFO - "script_repo_revision": "production", 04:20:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:20:23 INFO - "repository": "", 04:20:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:20:23 INFO - "buildid": "20160322030037", 04:20:23 INFO - "pgo_build": "False", 04:20:23 INFO - "basedir": "/builds/slave/test", 04:20:23 INFO - "buildnumber": 41, 04:20:23 INFO - "slavename": "talos-linux64-ix-017", 04:20:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:20:23 INFO - "platform": "ubuntu64_hw", 04:20:23 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:20:23 INFO - "branch": "mozilla-central", 04:20:23 INFO - "repo_path": "mozilla-central", 04:20:23 INFO - "revision": "3587b25bae302c1eed72968dbd7cef883e715948", 04:20:23 INFO - "stage_platform": "linux64", 04:20:23 INFO - "builduid": "70c5d81b8a7f40fba92c0b1116c731ae", 04:20:23 INFO - "slavebuilddir": "test" 04:20:23 INFO - } 04:20:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:20:23 INFO - Running post-action listener: _resource_record_post_action 04:20:23 INFO - ##### 04:20:23 INFO - ##### Running download-and-extract step. 04:20:23 INFO - ##### 04:20:23 INFO - Running pre-action listener: _resource_record_pre_action 04:20:23 INFO - Running main action method: download_and_extract 04:20:23 INFO - mkdir: /builds/slave/test/build/tests 04:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:23 INFO - https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:20:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:20:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:20:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:24 INFO - Downloaded 1361 bytes. 04:20:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:20:24 INFO - Using the following test package requirements: 04:20:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:20:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:20:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:24 INFO - u'jsshell-linux-x86_64.zip'], 04:20:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:20:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:20:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:20:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:20:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:20:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:20:24 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')]} 04:20:24 INFO - https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:20:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:20:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:29 INFO - Downloaded 21999893 bytes. 04:20:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:20:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:20:31 INFO - Return code: 0 04:20:31 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 04:20: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')]} 04:20:31 INFO - https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:20:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:20:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:42 INFO - Downloaded 21999893 bytes. 04:20:42 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'] 04:20:42 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 04:20:43 INFO - Return code: 0 04:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:43 INFO - https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:20:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:47 INFO - Downloaded 10847637 bytes. 04:20:47 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'] 04:20:47 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 04:20:47 INFO - Return code: 0 04:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:47 INFO - https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:20:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:20:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:20:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/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 04:20:49 INFO - Downloaded 54169203 bytes. 04:20:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:20:49 INFO - mkdir: /builds/slave/test/properties 04:20:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:49 INFO - Contents: 04:20:49 INFO - build_url:https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:20:50 INFO - Running post-action listener: _resource_record_post_action 04:20:50 INFO - Running post-action listener: set_extra_try_arguments 04:20:50 INFO - ##### 04:20:50 INFO - ##### Running populate-webroot step. 04:20:50 INFO - ##### 04:20:50 INFO - Running pre-action listener: _resource_record_pre_action 04:20:50 INFO - Running main action method: populate_webroot 04:20:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:20:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:20:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:20:50 INFO - '--tppagecycles', 04:20:50 INFO - '7'], 04:20:50 INFO - 'tests': ['tsvgm']}}, 04:20:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:20:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:20:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:20:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:20:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'tests': ['damp', 'tps']}, 04:20:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['damp', 'tps']}, 04:20:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:20:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:50 INFO - 'other': {'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore', 04:20:50 INFO - 'tabpaint']}, 04:20:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore', 04:20:50 INFO - 'tabpaint']}, 04:20:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore', 04:20:50 INFO - 'tabpaint']}, 04:20:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore', 04:20:50 INFO - 'tabpaint']}, 04:20:50 INFO - 'other_l64': {'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore', 04:20:50 INFO - 'tabpaint']}, 04:20:50 INFO - 'other_nol64': {'tests': ['a11yr', 04:20:50 INFO - 'ts_paint', 04:20:50 INFO - 'tpaint', 04:20:50 INFO - 'sessionrestore', 04:20:50 INFO - 'sessionrestore_no_auto_restore', 04:20:50 INFO - 'tabpaint']}, 04:20:50 INFO - 'svgr': {'tests': ['tsvgx', 04:20:50 INFO - 'tsvgr_opacity', 04:20:50 INFO - 'tart', 04:20:50 INFO - 'tscrollx', 04:20:50 INFO - 'cart']}, 04:20:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['tsvgx', 04:20:50 INFO - 'tsvgr_opacity', 04:20:50 INFO - 'tart', 04:20:50 INFO - 'tscrollx', 04:20:50 INFO - 'cart']}, 04:20:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'tests': ['tp5o']}, 04:20:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--e10s'], 04:20:50 INFO - 'tests': ['tp5o']}, 04:20:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--xperf_path', 04:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:50 INFO - 'tests': ['tp5n']}, 04:20:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:50 INFO - 'talos_options': ['--e10s', 04:20:50 INFO - '--xperf_path', 04:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:50 INFO - 'tests': ['tp5n']}}, 04:20:50 INFO - 'talos.zip': {'path': '', 04:20:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:20:50 INFO - Running post-action listener: _resource_record_post_action 04:20:50 INFO - ##### 04:20:50 INFO - ##### Running create-virtualenv step. 04:20:50 INFO - ##### 04:20:50 INFO - Running pre-action listener: _resource_record_pre_action 04:20:50 INFO - Running main action method: create_virtualenv 04:20:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20:50 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 04:20:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:50 INFO - Using real prefix '/usr' 04:20:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:53 INFO - Installing pip.................done. 04:20:53 INFO - Return code: 0 04:20:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20:53 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')]} 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 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')]} 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:20:53 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 04:20:53 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 04:20:53 INFO - Using env: {'DISPLAY': ':0', 04:20:53 INFO - 'HOME': '/home/cltbld', 04:20:53 INFO - 'LANG': 'en_US.UTF-8', 04:20:53 INFO - 'LANGUAGE': 'en_US:en', 04:20:53 INFO - 'LOGNAME': 'cltbld', 04:20:53 INFO - 'MAIL': '/var/mail/cltbld', 04:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:53 INFO - 'MOZ_NO_REMOTE': '1', 04:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:53 INFO - 'NO_EM_RESTART': '1', 04:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:53 INFO - 'PWD': '/builds/slave/test', 04:20:53 INFO - 'SHELL': '/bin/bash', 04:20:53 INFO - 'SHLVL': '1', 04:20:53 INFO - 'TERM': 'linux', 04:20:53 INFO - 'TMOUT': '86400', 04:20:53 INFO - 'USER': 'cltbld', 04:20:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:53 INFO - '_': '/tools/buildbot/bin/python'} 04:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:53 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 04:20:53 INFO - Cleaning up... 04:20:53 INFO - Return code: 0 04:20:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:20:53 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')]} 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 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')]} 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:20:53 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 04:20:53 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 04:20:53 INFO - Using env: {'DISPLAY': ':0', 04:20:53 INFO - 'HOME': '/home/cltbld', 04:20:53 INFO - 'LANG': 'en_US.UTF-8', 04:20:53 INFO - 'LANGUAGE': 'en_US:en', 04:20:53 INFO - 'LOGNAME': 'cltbld', 04:20:53 INFO - 'MAIL': '/var/mail/cltbld', 04:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:53 INFO - 'MOZ_NO_REMOTE': '1', 04:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:53 INFO - 'NO_EM_RESTART': '1', 04:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:53 INFO - 'PWD': '/builds/slave/test', 04:20:53 INFO - 'SHELL': '/bin/bash', 04:20:53 INFO - 'SHLVL': '1', 04:20:53 INFO - 'TERM': 'linux', 04:20:53 INFO - 'TMOUT': '86400', 04:20:53 INFO - 'USER': 'cltbld', 04:20:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:53 INFO - '_': '/tools/buildbot/bin/python'} 04:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:53 INFO - Downloading/unpacking psutil>=0.7.1 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:57 INFO - Installing collected packages: psutil 04:20:57 INFO - Running setup.py install for psutil 04:20:57 INFO - building 'psutil._psutil_linux' extension 04:20:57 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 04:20:57 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 04:20:57 INFO - building 'psutil._psutil_posix' extension 04:20:57 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 04:20:57 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 04:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:57 INFO - Successfully installed psutil 04:20:57 INFO - Cleaning up... 04:20:57 INFO - Return code: 0 04:20:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:20:57 INFO - Using env: {'DISPLAY': ':0', 04:20:57 INFO - 'HOME': '/home/cltbld', 04:20:57 INFO - 'LANG': 'en_US.UTF-8', 04:20:57 INFO - 'LANGUAGE': 'en_US:en', 04:20:57 INFO - 'LOGNAME': 'cltbld', 04:20:57 INFO - 'MAIL': '/var/mail/cltbld', 04:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:57 INFO - 'MOZ_NO_REMOTE': '1', 04:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:57 INFO - 'NO_EM_RESTART': '1', 04:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:57 INFO - 'PWD': '/builds/slave/test', 04:20:57 INFO - 'SHELL': '/bin/bash', 04:20:57 INFO - 'SHLVL': '1', 04:20:57 INFO - 'TERM': 'linux', 04:20:57 INFO - 'TMOUT': '86400', 04:20:57 INFO - 'USER': 'cltbld', 04:20:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:57 INFO - '_': '/tools/buildbot/bin/python'} 04:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:21:01 INFO - Installing collected packages: mozsystemmonitor 04:21:01 INFO - Running setup.py install for mozsystemmonitor 04:21:01 INFO - Successfully installed mozsystemmonitor 04:21:01 INFO - Cleaning up... 04:21:01 INFO - Return code: 0 04:21:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:21:01 INFO - Using env: {'DISPLAY': ':0', 04:21:01 INFO - 'HOME': '/home/cltbld', 04:21:01 INFO - 'LANG': 'en_US.UTF-8', 04:21:01 INFO - 'LANGUAGE': 'en_US:en', 04:21:01 INFO - 'LOGNAME': 'cltbld', 04:21:01 INFO - 'MAIL': '/var/mail/cltbld', 04:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:01 INFO - 'MOZ_NO_REMOTE': '1', 04:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:01 INFO - 'NO_EM_RESTART': '1', 04:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:01 INFO - 'PWD': '/builds/slave/test', 04:21:01 INFO - 'SHELL': '/bin/bash', 04:21:01 INFO - 'SHLVL': '1', 04:21:01 INFO - 'TERM': 'linux', 04:21:01 INFO - 'TMOUT': '86400', 04:21:01 INFO - 'USER': 'cltbld', 04:21:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:01 INFO - '_': '/tools/buildbot/bin/python'} 04:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:05 INFO - Downloading docopt-0.6.1.tar.gz 04:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:05 INFO - Running setup.py install for blobuploader 04:21:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:05 INFO - Running setup.py install for requests 04:21:05 INFO - Running setup.py install for docopt 04:21:05 INFO - Successfully installed blobuploader requests docopt 04:21:05 INFO - Cleaning up... 04:21:05 INFO - Return code: 0 04:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:05 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')]} 04:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:05 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')]} 04:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:05 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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:21:05 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 04:21:05 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 04:21:05 INFO - Using env: {'DISPLAY': ':0', 04:21:05 INFO - 'HOME': '/home/cltbld', 04:21:05 INFO - 'LANG': 'en_US.UTF-8', 04:21:05 INFO - 'LANGUAGE': 'en_US:en', 04:21:05 INFO - 'LOGNAME': 'cltbld', 04:21:05 INFO - 'MAIL': '/var/mail/cltbld', 04:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:05 INFO - 'MOZ_NO_REMOTE': '1', 04:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:05 INFO - 'NO_EM_RESTART': '1', 04:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:05 INFO - 'PWD': '/builds/slave/test', 04:21:05 INFO - 'SHELL': '/bin/bash', 04:21:05 INFO - 'SHLVL': '1', 04:21:05 INFO - 'TERM': 'linux', 04:21:05 INFO - 'TMOUT': '86400', 04:21:05 INFO - 'USER': 'cltbld', 04:21:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:05 INFO - '_': '/tools/buildbot/bin/python'} 04:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:06 INFO - Running setup.py (path:/tmp/pip-51pwHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:06 INFO - Running setup.py (path:/tmp/pip-99lYy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:06 INFO - Running setup.py (path:/tmp/pip-aUF8i3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:06 INFO - Running setup.py (path:/tmp/pip-UUJdpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:06 INFO - Running setup.py (path:/tmp/pip-qQW4QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:06 INFO - Running setup.py (path:/tmp/pip-9IXi4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:06 INFO - Running setup.py (path:/tmp/pip-85n8eM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:06 INFO - Running setup.py (path:/tmp/pip-FSg9yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:06 INFO - Running setup.py (path:/tmp/pip-ku0wjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:06 INFO - Running setup.py (path:/tmp/pip-W2Fu08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:06 INFO - Running setup.py (path:/tmp/pip-h5zH9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:06 INFO - Running setup.py (path:/tmp/pip-nOoIKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:06 INFO - Running setup.py (path:/tmp/pip-RSr56F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:06 INFO - Running setup.py (path:/tmp/pip-9Q9iOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:07 INFO - Running setup.py (path:/tmp/pip-Vf7ggg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:07 INFO - Running setup.py (path:/tmp/pip-i3mhHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:07 INFO - Running setup.py (path:/tmp/pip-jkRniJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:07 INFO - Running setup.py install for manifestparser 04:21:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:07 INFO - Running setup.py install for mozcrash 04:21:07 INFO - Running setup.py install for mozdebug 04:21:07 INFO - Running setup.py install for mozdevice 04:21:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:07 INFO - Running setup.py install for mozfile 04:21:07 INFO - Running setup.py install for mozhttpd 04:21:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:07 INFO - Running setup.py install for mozinfo 04:21:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:07 INFO - Running setup.py install for mozInstall 04:21:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Running setup.py install for mozleak 04:21:08 INFO - Running setup.py install for mozlog 04:21:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Running setup.py install for moznetwork 04:21:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Running setup.py install for mozprocess 04:21:08 INFO - Running setup.py install for mozprofile 04:21:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Running setup.py install for mozrunner 04:21:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:08 INFO - Running setup.py install for mozscreenshot 04:21:08 INFO - Running setup.py install for moztest 04:21:08 INFO - Running setup.py install for mozversion 04:21:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:09 INFO - Cleaning up... 04:21:09 INFO - Return code: 0 04:21:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:09 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')]} 04:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:09 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')]} 04:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:09 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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:21:09 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 04:21:09 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 04:21:09 INFO - Using env: {'DISPLAY': ':0', 04:21:09 INFO - 'HOME': '/home/cltbld', 04:21:09 INFO - 'LANG': 'en_US.UTF-8', 04:21:09 INFO - 'LANGUAGE': 'en_US:en', 04:21:09 INFO - 'LOGNAME': 'cltbld', 04:21:09 INFO - 'MAIL': '/var/mail/cltbld', 04:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:09 INFO - 'MOZ_NO_REMOTE': '1', 04:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:09 INFO - 'NO_EM_RESTART': '1', 04:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:09 INFO - 'PWD': '/builds/slave/test', 04:21:09 INFO - 'SHELL': '/bin/bash', 04:21:09 INFO - 'SHLVL': '1', 04:21:09 INFO - 'TERM': 'linux', 04:21:09 INFO - 'TMOUT': '86400', 04:21:09 INFO - 'USER': 'cltbld', 04:21:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:09 INFO - '_': '/tools/buildbot/bin/python'} 04:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:09 INFO - Running setup.py (path:/tmp/pip-UI8ZQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:09 INFO - Running setup.py (path:/tmp/pip-kUhNAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:09 INFO - Running setup.py (path:/tmp/pip-2a12lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:09 INFO - Running setup.py (path:/tmp/pip-TOWWvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:09 INFO - Running setup.py (path:/tmp/pip-jkB7qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:09 INFO - Running setup.py (path:/tmp/pip-Zwqljm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:09 INFO - Running setup.py (path:/tmp/pip-Bs5ap7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:09 INFO - Running setup.py (path:/tmp/pip-AzakgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:09 INFO - Running setup.py (path:/tmp/pip-Ht5Y3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:09 INFO - Running setup.py (path:/tmp/pip-5glQCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:09 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)) 04:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:09 INFO - Running setup.py (path:/tmp/pip-vi5J2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:10 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)) 04:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:10 INFO - Running setup.py (path:/tmp/pip-hKEBww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:10 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)) 04:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:10 INFO - Running setup.py (path:/tmp/pip-2KUIbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:10 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)) 04:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:10 INFO - Running setup.py (path:/tmp/pip-bIiZef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:10 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)) 04:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:10 INFO - Running setup.py (path:/tmp/pip-9NRhJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:10 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)) 04:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:10 INFO - Running setup.py (path:/tmp/pip-DqSW0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:10 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)) 04:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:10 INFO - Running setup.py (path:/tmp/pip-oFXiBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:10 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)) 04:21:10 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)) 04:21:10 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)) 04:21:10 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)) 04:21:10 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)) 04:21:10 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)) 04:21:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:10 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 04:21:10 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 04:21:10 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 04:21:10 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 04:21:10 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 04:21:10 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 04:21:13 INFO - Downloading blessings-1.6.tar.gz 04:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:13 INFO - Installing collected packages: blessings 04:21:13 INFO - Running setup.py install for blessings 04:21:13 INFO - Successfully installed blessings 04:21:13 INFO - Cleaning up... 04:21:13 INFO - Return code: 0 04:21:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:13 INFO - Reading from file tmpfile_stdout 04:21:13 INFO - Current package versions: 04:21:13 INFO - argparse == 1.2.1 04:21:13 INFO - blessings == 1.6 04:21:13 INFO - blobuploader == 1.2.4 04:21:13 INFO - docopt == 0.6.1 04:21:13 INFO - manifestparser == 1.1 04:21:13 INFO - mozInstall == 1.12 04:21:13 INFO - mozcrash == 0.17 04:21:13 INFO - mozdebug == 0.1 04:21:13 INFO - mozdevice == 0.48 04:21:13 INFO - mozfile == 1.2 04:21:13 INFO - mozhttpd == 0.7 04:21:13 INFO - mozinfo == 0.9 04:21:13 INFO - mozleak == 0.1 04:21:13 INFO - mozlog == 3.1 04:21:13 INFO - moznetwork == 0.27 04:21:13 INFO - mozprocess == 0.22 04:21:13 INFO - mozprofile == 0.28 04:21:13 INFO - mozrunner == 6.11 04:21:13 INFO - mozscreenshot == 0.1 04:21:13 INFO - mozsystemmonitor == 0.0 04:21:13 INFO - moztest == 0.7 04:21:13 INFO - mozversion == 1.4 04:21:13 INFO - psutil == 3.1.1 04:21:13 INFO - requests == 1.2.3 04:21:13 INFO - wsgiref == 0.1.2 04:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:13 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')]} 04:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:13 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')]} 04:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:13 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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:21:13 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 04:21:13 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 04:21:13 INFO - Using env: {'DISPLAY': ':0', 04:21:13 INFO - 'HOME': '/home/cltbld', 04:21:13 INFO - 'LANG': 'en_US.UTF-8', 04:21:13 INFO - 'LANGUAGE': 'en_US:en', 04:21:13 INFO - 'LOGNAME': 'cltbld', 04:21:13 INFO - 'MAIL': '/var/mail/cltbld', 04:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:13 INFO - 'MOZ_NO_REMOTE': '1', 04:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:13 INFO - 'NO_EM_RESTART': '1', 04:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:13 INFO - 'PWD': '/builds/slave/test', 04:21:13 INFO - 'SHELL': '/bin/bash', 04:21:13 INFO - 'SHLVL': '1', 04:21:13 INFO - 'TERM': 'linux', 04:21:13 INFO - 'TMOUT': '86400', 04:21:13 INFO - 'USER': 'cltbld', 04:21:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:13 INFO - '_': '/tools/buildbot/bin/python'} 04:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 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)) 04:21:13 INFO - Cleaning up... 04:21:13 INFO - Return code: 0 04:21:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:13 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')]} 04:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:13 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')]} 04:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:13 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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:21:13 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 04:21:13 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 04:21:13 INFO - Using env: {'DISPLAY': ':0', 04:21:13 INFO - 'HOME': '/home/cltbld', 04:21:13 INFO - 'LANG': 'en_US.UTF-8', 04:21:13 INFO - 'LANGUAGE': 'en_US:en', 04:21:13 INFO - 'LOGNAME': 'cltbld', 04:21:13 INFO - 'MAIL': '/var/mail/cltbld', 04:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:13 INFO - 'MOZ_NO_REMOTE': '1', 04:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:13 INFO - 'NO_EM_RESTART': '1', 04:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:13 INFO - 'PWD': '/builds/slave/test', 04:21:13 INFO - 'SHELL': '/bin/bash', 04:21:13 INFO - 'SHLVL': '1', 04:21:13 INFO - 'TERM': 'linux', 04:21:13 INFO - 'TMOUT': '86400', 04:21:13 INFO - 'USER': 'cltbld', 04:21:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:13 INFO - '_': '/tools/buildbot/bin/python'} 04:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:13 INFO - Downloading/unpacking jsonschema 04:21:13 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 04:21:13 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 04:21:13 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 04:21:13 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 04:21:13 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 04:21:13 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 04:21:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:17 INFO - Downloading/unpacking functools32 (from jsonschema) 04:21:17 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 04:21:17 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 04:21:17 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 04:21:17 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 04:21:17 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 04:21:17 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 04:21:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:17 INFO - warning: no files found matching '*.txt' 04:21:17 INFO - no previously-included directories found matching 'build' 04:21:17 INFO - no previously-included directories found matching 'dist' 04:21:17 INFO - no previously-included directories found matching '.git*' 04:21:17 INFO - Installing collected packages: jsonschema, functools32 04:21:17 INFO - Running setup.py install for functools32 04:21:17 INFO - warning: no files found matching '*.txt' 04:21:17 INFO - no previously-included directories found matching 'build' 04:21:17 INFO - no previously-included directories found matching 'dist' 04:21:17 INFO - no previously-included directories found matching '.git*' 04:21:17 INFO - Successfully installed jsonschema functools32 04:21:17 INFO - Cleaning up... 04:21:17 INFO - Return code: 0 04:21:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:17 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 0x7fa126a7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f187d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, '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': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', '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 04:21:17 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 04:21:17 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 04:21:17 INFO - Using env: {'DISPLAY': ':0', 04:21:17 INFO - 'HOME': '/home/cltbld', 04:21:17 INFO - 'LANG': 'en_US.UTF-8', 04:21:17 INFO - 'LANGUAGE': 'en_US:en', 04:21:17 INFO - 'LOGNAME': 'cltbld', 04:21:17 INFO - 'MAIL': '/var/mail/cltbld', 04:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:17 INFO - 'MOZ_NO_REMOTE': '1', 04:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:17 INFO - 'NO_EM_RESTART': '1', 04:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:17 INFO - 'PWD': '/builds/slave/test', 04:21:17 INFO - 'SHELL': '/bin/bash', 04:21:17 INFO - 'SHLVL': '1', 04:21:17 INFO - 'TERM': 'linux', 04:21:17 INFO - 'TMOUT': '86400', 04:21:17 INFO - 'USER': 'cltbld', 04:21:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:17 INFO - '_': '/tools/buildbot/bin/python'} 04:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:18 INFO - Downloading/unpacking flake8 04:21:18 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 04:21:18 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 04:21:18 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 04:21:18 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 04:21:18 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 04:21:18 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 04:21:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:21:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:21:21 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 04:21:21 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 04:21:21 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 04:21:21 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 04:21:21 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 04:21:21 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 04:21:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:21:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:21:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:23 INFO - no previously-included directories found matching 'docs/_build' 04:21:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:21:23 INFO - Running setup.py install for pep8 04:21:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:23 INFO - no previously-included directories found matching 'docs/_build' 04:21:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:21:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:21:23 INFO - Cleaning up... 04:21:23 INFO - Return code: 0 04:21:23 INFO - Running post-action listener: _resource_record_post_action 04:21:23 INFO - Running post-action listener: _start_resource_monitoring 04:21:23 INFO - Starting resource monitoring. 04:21:23 INFO - ##### 04:21:23 INFO - ##### Running install step. 04:21:23 INFO - ##### 04:21:23 INFO - Running pre-action listener: _resource_record_pre_action 04:21:23 INFO - Running main action method: install 04:21:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:23 INFO - Reading from file tmpfile_stdout 04:21:23 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:23 INFO - Reading from file tmpfile_stdout 04:21:23 INFO - Output received: 04:21:23 INFO - Usage: mozinstall [options] installer 04:21:23 INFO - Options: 04:21:23 INFO - -h, --help show this help message and exit 04:21:23 INFO - -d DEST, --destination=DEST 04:21:23 INFO - Directory to install application into. [default: 04:21:23 INFO - "/builds/slave/test"] 04:21:23 INFO - --app=APP Application being installed. [default: firefox] 04:21:23 INFO - mkdir: /builds/slave/test/build/application 04:21:23 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'] 04:21:23 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 04:21:39 INFO - Reading from file tmpfile_stdout 04:21:39 INFO - Output received: 04:21:39 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:39 INFO - Running post-action listener: _resource_record_post_action 04:21:39 INFO - ##### 04:21:39 INFO - ##### Running run-tests step. 04:21:39 INFO - ##### 04:21:39 INFO - Running pre-action listener: _resource_record_pre_action 04:21:39 INFO - Running main action method: run_tests 04:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:39 INFO - Python 2.7.3 04:21:39 INFO - Return code: 0 04:21:39 INFO - grabbing minidump binary from tooltool 04:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:39 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 0x1fa7640>, '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 0x1fa8540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa89d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:39 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 04:21:39 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 04:21:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:39 INFO - Return code: 0 04:21:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:21:40 INFO - Return code: 0 04:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:21:40 INFO - Using env: {'DISPLAY': ':0', 04:21:40 INFO - 'HOME': '/home/cltbld', 04:21:40 INFO - 'LANG': 'en_US.UTF-8', 04:21:40 INFO - 'LANGUAGE': 'en_US:en', 04:21:40 INFO - 'LOGNAME': 'cltbld', 04:21:40 INFO - 'MAIL': '/var/mail/cltbld', 04:21:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:40 INFO - 'MOZ_NO_REMOTE': '1', 04:21:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:40 INFO - 'NO_EM_RESTART': '1', 04:21:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:40 INFO - 'PWD': '/builds/slave/test', 04:21:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:40 INFO - 'SHELL': '/bin/bash', 04:21:40 INFO - 'SHLVL': '1', 04:21:40 INFO - 'TERM': 'linux', 04:21:40 INFO - 'TMOUT': '86400', 04:21:40 INFO - 'USER': 'cltbld', 04:21:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210', 04:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:40 INFO - '_': '/tools/buildbot/bin/python'} 04:21:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:21:40 INFO - mozversion application_buildid: 20160322030037 04:21:40 INFO - mozversion application_changeset: 3587b25bae302c1eed72968dbd7cef883e715948 04:21:40 INFO - mozversion application_display_name: Nightly 04:21:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:40 INFO - mozversion application_name: Firefox 04:21:40 INFO - mozversion application_remotingname: firefox 04:21:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:21:40 INFO - mozversion application_vendor: Mozilla 04:21:40 INFO - mozversion application_version: 48.0a1 04:21:40 INFO - mozversion platform_buildid: 20160322030037 04:21:40 INFO - mozversion platform_changeset: 3587b25bae302c1eed72968dbd7cef883e715948 04:21:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:21:40 INFO - mozversion platform_version: 48.0a1 04:21:40 INFO - using testdate: 1458645700 04:21:40 INFO - actual date: 1458645700 04:21:40 INFO - starting webserver on 'localhost:53281' 04:21:40 INFO - SUITE-START | Running 2 tests 04:21:40 INFO - TEST-START | dromaeo_css 04:21:40 INFO - operating with platform_type : linux_ 04:21:40 INFO - Initialising browser for dromaeo_css test... 04:21:40 INFO - TEST-INFO | started process 5260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTqZDjs/profile http://localhost:53281/getInfo.html) 04:21:45 INFO - PROCESS | 5260 | __metrics Screen width/height:1600/1200 04:21:45 INFO - PROCESS | 5260 | colorDepth:24 04:21:45 INFO - PROCESS | 5260 | Browser inner width/height: 1024/697 04:21:45 INFO - PROCESS | 5260 | __metrics 04:21:45 ERROR - PROCESS | 5260 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:21:45 INFO - PROCESS | 5260 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:21:46 INFO - TEST-INFO | 5260: exit 0 04:21:46 INFO - Browser initialized. 04:21:46 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:46 INFO - TEST-INFO | started process 5357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTqZDjs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:58 INFO - PROCESS | 5357 | RSS: Main: 158261248 04:21:58 INFO - PROCESS | 5357 | 04:22:49 INFO - PROCESS | 5357 | 1458645769718 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] 04:25:01 INFO - PROCESS | 5357 | Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53281/tests/dromaeo/cssquery-ext.html) 04:25:02 INFO - PROCESS | 5357 | RSS: Main: 230670336 04:25:02 INFO - PROCESS | 5357 | 04:28:04 INFO - PROCESS | 5357 | Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-ext.html (next: http://localhost:53281/tests/dromaeo/cssquery-jquery.html) 04:28:05 INFO - PROCESS | 5357 | RSS: Main: 248147968 04:28:05 INFO - PROCESS | 5357 | 04:31:07 INFO - PROCESS | 5357 | Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53281/tests/dromaeo/cssquery-mootools.html) 04:31:07 INFO - PROCESS | 5357 | RSS: Main: 246784000 04:31:07 INFO - PROCESS | 5357 | 04:34:09 INFO - PROCESS | 5357 | Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53281/tests/dromaeo/cssquery-prototype.html) 04:34:10 INFO - PROCESS | 5357 | RSS: Main: 227332096 04:34:10 INFO - PROCESS | 5357 | 04:37:12 INFO - PROCESS | 5357 | Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53281/tests/dromaeo/cssquery-yui.html) 04:37:13 INFO - PROCESS | 5357 | RSS: Main: 204595200 04:37:13 INFO - PROCESS | 5357 | 04:40:15 INFO - PROCESS | 5357 | Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-yui.html (next: http://localhost:53281/tests/dromaeo/cssquery-dojo.html) 04:40:16 INFO - PROCESS | 5357 | RSS: Main: 274378752 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - PROCESS | 5357 | __start_tp_report 04:40:16 INFO - PROCESS | 5357 | _x_x_mozilla_page_load 04:40:16 INFO - PROCESS | 5357 | _x_x_mozilla_page_load_details 04:40:16 INFO - PROCESS | 5357 | |i|pagename|runs| 04:40:16 INFO - PROCESS | 5357 | |0;dojo.html;2574.240599023288;2633.9473210535803;2671.998000749719;2674.197740677796;2680.2495301315635;4591.517890621487;4616.976915115424;4652.651051171168;4674.4624368197665;4678.5789278964885;4646.163690535702;4653.39505864238;4657.627389808816;4657.860264192072;4663.3238180463895;4260.7656578888145;4326.675499337554;4350.695451318393;4409.933850992222;4438.245498265286;4229.894252643678;4305.397244385788;4368.082702632451;4369.1916995355805;4384.364267181257;4244.639205667522;4304.3543468479975;4333.631641310492;4340.934885976713;4367.301231802928;4293.355996600504;4303.526612072669;4313.892152696177;4350.543192964757;4358.302671572533;4195.8741237762915;4297.527272000078;4308.3968244445805;4316.417283666696;4351.19502891966;4481.686281960264;4515.254982927813;4535.297028960516;4576.336431217488;4599.609033232179;4961.355023846912;4966.130927087781;4984.127777638935;5006.824761133343;5028.069807085664;4827;4933.851984440473;4956.355673762424;4962.1812400953795;4973.900521989576;4621.8844528886375;4649.511801260886;4684.039771846763;4685.9531404686195;4685.99251161002;5125.56432703217;5126.564242039469;5128.025675121715;5130.281760553451;5134.024535338273;4816.518348165156;4916.213405855046;4929.926051109236;4930.8767280818265;4964.826231081967;4949.604031677457;4985.975070124626;4986.227134794112;5033.421156566968;5047.823326183566;4932.482089380635;4950.529699678525;4959.181735013683;4963.950360496421;5002.049610573979;4843.982763619609;4935.333729946483;4940.011997600494;4945.727984960861;5001.149804533238;4158.209940111429;4187;4211.199872024366;4222.155568886235;4249.702520823575;3674.65090816372;3675.46705727668;3684.6315368463474;3703.925921481555;3726.5341832270965;4263.360495925636;4292.48490181174;4375.496817865923;4379.386885835986;4413.337999300131;5009.5491405773655;5010.398752149766;5012.348394708664;5030.220315851049;5063.797448102108;4342.457192850894;4343.9348409773875;4350.0212452198;4371.169477799208;4386.978065109718;4349.978250108729;4422.823087076546;4472.396226509444;4476.328550717353;4489.259272220047;4724.267738500538;4732.432108146975;4735.14767341868;4742.051589682008;4763.476017638057;4915.852524424273;4943.678660887031;4948.703077815343;4948.8762780930765;4998.6750861193905;4701.435827700561;4731.503192164911;4750.263709125091;4833.685810422311;4844.103840789465;4887.291342755351;4902.779374928065;4909.0672772173175;4917.28699338601;4953.826616068421;4968.329275547755;4979;4979.477154898684;4984.177610694195;5030.572401345927;4749.358836557159;4789.137955168103;4819.734914579732;4854.5873600744335;4871.732054736882;4794.376731024944;4797.160496913096;4804.903901922012;4814.831480898151;4851.636127290538;4641.883952901205;4756.429228492603;4762.190427627381;4770.689905156154;4815.398075240595;4802.73584952831;4821.783019764049;4885.169521181337;4894.779734911866;4983.875403114951;4771.212749896228;4772.904541909212;4785.856424307276;4788.018456216398;4832.033593281428 04:40:16 INFO - PROCESS | 5357 | |1;ext.html;537.736509110536;540.4541413172695;562.3224015061851;563.5238223700972;576.8240686590589;26898.462030759398;27620.34277943325;34772.130696732595;35657.2868542629;35793.82103089488;37436.251274974486;37656;37710.4343434848;37779.81110094453;37911.431328530096;7750.496217745843;7950.324222441071;7951.602419879012;7960.681572737112;7963;7837.6864925402915;7967.561784101872;7974.641141148662;7978.720744773934;7980.720674776384;7921.128675845653;7965.800854978614;8037.437379383446;8055.879161812578;8057.919420805805;7930.841383172333;7957.801054973614;8000.399970002273;8016.118226995026;8027.518348899055;7818.14000459949;7862.842743145162;7867.527948323119;7885.408594355446;7947.920520794776;37546.43680344797;38140;38211.80894095512;38223.426648600296;38269.42595861064;3309;3338.582677165354;3716.312482190803;3718.1076541629814;3825.8087095645105;27451.31371715723;27654;28013.299667508476;28171.29571760702;29126.708732912823;3153.716165545089;3171.57183780189;3177.8728850845937;3183.856726447292;3231.1922019495128;241556;249110.9999999982;250167;250489;250837;43489.347659785126;44016.3397549037;44102;60071.39928600658;60676.393236067954;44639.77680111579;44894.102117958115;44896;45001;45037;11974.58088966882;12084.879151208552;12126.757464850654;12141.696457588454;12148.149629525848;9053.68312109073;9054.954725226464;9198.908010919939;9206.63173473067;9213.170814626716;15037.548873533811;15335;15466.381344746309;15482.22588870552;15678.137702426477;6137.232845894263;6275;6340.461060809791;6401.935980640227;6408.67956602168;894.6376717429451;934.5700977550267;952.1716106986966;989.5992123190119;1014.2291858187831;26269.737302627113;27390.38497108128;27547.586786198222;27661.308467288076;28156.155315340573;957.6648173139484;979.3878825733916;997.7705127820642;1029.5984566019258;1080.0711388206137;13832.30838458073;14317.35571899267;14527.955322972608;14674.926625366805;14711.117332959842;286218;290734;293024;293673;294090;46681;46961.53865382783;47146.5285347149;47245.76377118092;47279;1067.3275836223129;1116.9776604467866;1208.510553225945;1235.975280494385;1247.9188852724544;24171.033158673457;27159.1852244433;27187.72812271852;27437.725622744314;27640.308992275353;37957.240855182186;38451.615483844806;38532;38537.614623853406;38571.614283857925;178893;180869;181874;181937;182555;27181.59227611548;31809.363812724077;33619.663803361655;33725.83137084299;34193.82903085568;38909;43801.34297985469;43813.12373752571;44167;44682.3297650529;30952.84523577368;32134.67865321317;33188.668113318556;33407.49888751622;33505.49741753924;32623.213670261237;32915;33006.50490242696;33176.33647326992;33504;33127.33745325128;33127.503087453224;33278.667213328525;33499.16252093717;33527.83236083901;29119.272018199714;29227;29524;31784;32210;24663.753362466145;24771.13301034455;24912.003519859;24914.677473353393;25267.610281434696 04:40:16 INFO - PROCESS | 5357 | |2;jquery.html;349.32580120367686;353.4556782554866;357.88368780146453;362.09295714235833;362.912900903783;15456.69086618267;15828.525144245677;16369.345226190953;16715.414960476384;17024.82975170248;16287.674246515062;16649.25078371473;16776.245068971893;16793.496195114167;16799;4877.731724755137;4941.802327906879;5044.142495775709;5047.141985862394;5048.444671086178;5005.54950054495;5031.949680503185;5043.041822053798;5080.1617733074;5081.898362032757;4840.733759643218;5002.399712034561;5011.649184557083;5017.49825017499;5020.874478138057;4971.602271818246;4984.476629953839;4989;5028.874278143057;5029.270755740416;4494.483134439516;4502.707324023961;4507.706999045052;4508.256137737302;4508.661850361236;19093.809061909342;20002.599948001105;20138.798612013838;20139.6979045313;20188.39434816958;1947.6591596470562;2038.4190505705803;2126.851120421571;2127.095984206706;2145.980659186889;12823.807642885364;12899.09706320558;13033.804492932613;13264.53574124901;13340.666483337896;1773.326136068286;1780.3501721871553;1811.550759392494;1855.137361127069;1863.9068046597752;56733.71633141808;57223;57852.42147578512;57949.42050579483;58272.41727582712;9760.267979901535;9857;10107.747306317255;10135.64525241613;10315.84526232107;12649.810252846215;12758.106932514635;12760.425780839885;12776.169548979287;12778.552750653682;6824.93175068243;6866.382025617719;6916.965415172892;7010.053642758265;7024.754133605299;6467.288598254188;6476.125723027425;6550.148480697479;6570.342965703391;6591;6150.661713605705;6172.197614310111;6177.722002509898;6185.381461853779;6197.659128747962;1711.5977745229861;1743.69485340065;1747.6668647355668;1756.306259027677;1788.4277031350102;861.7070196133219;926.5506229478698;928.6888892221182;961.4423634292094;1009.2834087797746;16420.917895410446;16728.140378784017;16929.746053809202;16949.15254237283;17271.481855544353;893.3210759822582;907.2061945797427;919.9218066464292;925.842606756853;934.4346670264528;9495.620175192915;9754.122129008281;9961.203103751683;9976.201903847676;10115;421924;426151;431374;455995;456606;38852;49305;51224;57927.4207257922;61778.69110654508;968.1770495079127;973.6640858903667;979.0258692600908;991.965281215154;992.6228033347426;15134.545963621109;15321.845436475194;15333.6166595836;15409.922950385624;15794.447194348142;31592.052238432883;32037.87867424629;32831;33365;34328.82835585806;44371.33442998422;44706.77646611746;44971.77514112408;45640;45995.77002114968;7118.181409138016;7140.9285907140265;7297.379722723628;7321.377682897013;7349.04462419882;10811.13510919109;10888.61889833852;11121.944390277997;11215.383153926286;11421.600243991421;9557.761055973657;9623.951880240555;9759.414435133915;10019.098281154731;10468.842967355344;9920.107190352903;9925.553350099408;9955.50222488887;10039.548220329956;10049.849252261369;9810.272096603245;9911.058449447291;10200.489975501343;10486.737831554272;10658.307210031324;6823.420009299265;6851.931480685129;6908.654567271516;6957.512974091765;7001.054857594363;7662.616869156632;9466.100720431548;9475.52622368865;9482.620695172393;9631.181349585364 04:40:16 INFO - PROCESS | 5357 | |3;mootools.html;1263.7346157306965;1432.4771458417677;1438.9784153237704;1586.4606033948462;1745.2408202431934;6300.590461619991;7019.333163349486;7162.96418517908;7166.60583667898;7187.640617969107;6949.200841903183;7121.572705637665;7128.251533588963;7129;7136.821579460516;1931.2661188748257;2190.1786829938774;2210.789974952385;2236.854604450714;2242.125571027301;2209.602271591113;2213.2032468311395;2215.5679642469727;2220.289507357646;2220.888955552224;2175;2251.448395143192;2253.1212826997485;2253.9098436062536;2255.661650752384;2159.8380121490873;2176.8258539316816;2186.0381432169875;2208.3595757230382;2212.225720997654;2070.7411573553304;2100.1809294375207;2113.5244569971633;2118.0998075817715;2121.6075026120216;7300.123985121766;7369.078865141857;7380.594067326295;7389.630518474109;7393.112826460859;4548.863534093983;4640.303954406832;4676.69601475903;4677.906441871178;4681.5318468153255;2882.2506148401567;2958.6597541282813;3027.076741593813;3097.349556593118;3105.1460848266684;887.9245264152555;895.8969718482393;906.854903215489;931.1945167430192;959.5633986536109;9417.576209070608;9428.10433008863;9466.810663786755;9525;9539;3952.7430717003303;4052.878413647595;4133.607307305801;4141.503019637603;4141.627253547195;7883.526988380716;7913.802154946057;7930.841383172305;7953.32396746283;7953.32396746283;3799.126200973736;4500.054988452462;4527.026689261825;4527.615152712056;4531.546845315442;3943.5662077171487;3998.34027385484;4010.6991975601363;4014.0767623446186;4027.7583344998807;3348.11275012122;3440.8623655053516;3448.517207590939;3454.7236221102253;3505.631908649606;1025.9435731034864;1054.894510548939;1056.6777132974362;1059.523214553454;1072.9463526823627;1177.6996865799167;1187.1808452167977;1206.0592737664635;1227.9508819647115;1247.457356050121;6943.201531823804;7027.613481258478;7051.5063945523325;7054.6472676365975;7076.823079422953;458.86463493269565;467.96346093403275;472.34344261476576;475.3701345716939;478.7606196901549;5459.863503412446;5460.426655201226;5495;5497.505224529731;5528.032594295983;8614.827703445895;8760.211580957744;8955;8956.641734330553;9090.045545217788;8825.07336729647;8873.467591944504;8918.910810891937;8975.77560560978;8983.910160898438;6784.626845523544;6898;6955.860882782417;6993.755218567326;7011.088558487364;6530.9020364693615;6551.639659818756;6573.704183311666;6578.046183303299;6616.4045235929;7444.627768611439;7711.691532338644;7711.922880771345;7719.961400192963;7893.921060789318;7753.534787912743;7871.094824095302;7966.1237263902085;8074.878876816735;8088.150744171778;5791.652500849962;6131.540134489842;6203.4416902479;6395.904061438989;6482.448991835747;6783.728650853911;6795.72817087311;6842.418394436529;6850.246472887879;6858.211305699709;6026.909596356146;6071.210742603434;6085.4523092921845;6129.540284478771;6198.132261483306;6139.539534534839;6208.472279856082;6223;6269.937300626935;6328.430441260309;6612.801615951529;6664.900026499703;6677.6661166940485;6681.532292739462;6681.665916704243;6062.757489700362;6157.784477543264;6168.321484636776;6169.84575385619;6177.227846519185;6112.205413296243;6233.812985610439;6236.407541283571;6238.906416403667;6239.4696450800375 04:40:16 INFO - PROCESS | 5357 | |4;prototype.html;311.7505995203836;312.96087989001376;316.1952830047528;316.6247996124591;322;5219.45195754446;5222.373315202176;5286;5297.682139071659;5303.469653034699;5185.144451165563;5203.583713302936;5215.217717342391;5219.191025391061;5226.529612334889;3921.509811273591;3947.4868267125235;4027.7784721840285;4051.513818341803;4067.5322337931148;4000.6999475039343;4052.29084910141;4053.3109371406786;4067.5525692173987;4070.043539768152;4006.278869803434;4006.9599304007024;4007.2386246613196;4014.3978403239457;4017.216642754664;3865.5361356637245;3946.7039972001926;4017.6384125428704;4086.509618845728;4127.484064491939;3636.1455058061333;3644.0889777555612;3652.3060618482405;3657.4513822926506;3662.926741465182;5038.722870242135;5061.316722242487;5063.468335824722;5064.34163558735;5067.873303167414;4741.786619602126;4743.881402964919;4750.073735621555;4752.904941901177;4759.928601070987;5515.365732940683;5517.917231241535;5521.696306703129;5524.972375138139;5528.668279903219;3978.2242462719782;3982.900427489307;3990.2219067281603;3990.780507072139;3995.420664003703;5597.216389705403;5807.2160258365;5820.388859169769;5847.181394604759;5889.823305300805;3898.7465814721954;3916.373380259202;3933.704972127102;3935.2719746846924;3936.901577460529;3994.7802870842384;3995.6603688686205;3996.100877302642;3997.340438827619;3999.7800120993043;4588.38056862326;4591.885202869955;4594.954050459452;4601.079784043138;4606.470255920545;5525.668459892419;5526.972365138229;5534.335879694462;5535.972320138373;5536.031194540939;1362.5367375092517;1398.084254813099;1398.3288021749618;1398.6713122416224;1400.3208443904698;877.0659247901093;909.0636644256426;937.3953799799227;938.8826396700413;949.8812648418948;4819.638527110411;4896.534829191221;4904.2643603459765;4933.235348520985;4937.35814344133;5750.568707346965;5760.6255593386295;5767.942320576824;5769.596128271065;5775.191473193756;4916.164252077156;4918.139325618003;4923.803047878117;4925;4925.38432695913;3050.328927635961;3092.8453577321043;3096.040227529473;3097.3340731742783;3098.2254436390904;5469.753861076261;5471.589630777628;5471.699056551928;5473.945260547343;5474.7262636868;5707.543396528268;5916.615419997686;5963.731632076567;5996.880062398727;6014.368491308437;5468.890622187613;5490.039243132515;5490.149026900836;5499.065158922913;5510.366307874646;5774.133879918046;5778.797742079007;5779.971100144472;5780.335261444988;5783.045797443543;5663.235463212413;5674;5674.319081710056;5675.545956323402;5677.943220567741;5483.150111732688;5487.807926722705;5493.890122197454;5497.780088796403;5500.174973753808;3803.410471376941;3961.900952476096;3964.0882597002274;3973.7019723520275;3991.082051128315;5642.520385767091;5679.914801278067;5683.602147849776;5685.090385538294;5686.800961966312;5494.642848215013;5501.037318469172;5501.229827824188;5501.504864562208;5506;5487.506124448819;5492.47821456961;5492.642978206404;5493.340799103973;5498.762778374834;5401.6218864679095;5404.378496472956;5405.216243644571;5405.86485337854;5408.9459105410015;5378.462153784591;5483.670979741229;5540.612157148961;5545.3622833374675;5546.639468434701;5389.380221274603;5412.75642596092;5426.186072089218;5427.348718153847;5431.755570999236 04:40:16 INFO - PROCESS | 5357 | |5;yui.html;668.2882729892667;692.3906961873552;719.5862379131997;744.7467860927284;784.1217836023654;12198;12333.136680432362;12507.874921250796;12614.81077783834;12688.80966785499;12245.510179592828;12312.507499700001;12321.5071397144;12323.691907702312;12330.938345308283;624.9250089989208;766.7278116268728;782.1240210963729;782.5734974438916;782.6869252299098;676.1413005483033;682.9214640316353;683.2313647146959;684.3737979748524;684.4866350237322;660.6036378173081;825.4387016828554;826.1284345016036;826.330672155553;827.8634025385804;817.464560712734;828.7348048624382;829.2371018662844;829.2992421403904;830.0495932157706;606.1544145916466;606.2966958328318;606.6663335165686;606.9635821850659;607.696151924038;12131.93934030333;12172.513099476011;12209.145359824815;12220.572279970158;12222.511099556006;11792.174547781658;12120;12394.504219831197;12492.500299987989;12551.686207844785;10063.949680251626;10168.59325626974;10185.694429167137;10220.386776793417;10294.330868493524;3298.571185745862;3335.1328654549748;3347.163209197701;3432.3135372925267;3460.8788692395647;42041;42051.36922946158;42083.579164208575;42175.36736948918;42177.78911105425;9715.514224288898;9728.951355243178;9840.261980351503;10012.599496020077;10068.446235456973;16919.830801691827;16989.745153822703;16999.40502082421;17016.48950531486;17026;6935.930640693629;6970.616616086062;6976.232614412411;7019.789406317818;7211.062561866924;3711.9072023199637;3738.3271011218244;3754.0990162360836;3794.829232684536;3823.8661646842784;2986.2683642507723;3016.2007068126527;3035.9241018974703;3051.67957364478;3052;440.37246923134404;523.4895976422957;569.473237255537;572.4361503918636;572.5362456410321;501.8494451664486;572.0635648330349;581.2734082397004;601.9488343490852;608.0939400293531;7109.466789990772;7146.464015198881;7182.60495672743;7313.524620899624;7380.630968451556;429.8237722533746;572.0703856233621;584.0946532874028;605.1497645807648;605.3643674142133;3472.930541389158;3564.982175089108;3584.390653588896;3615.258871931248;3651.94522082169;51107.744461277456;52683.209751853756;53395;53736.73131634395;53769.1934620981;44910;45512.77243613761;45514.77242613766;46311.768441157576;46313.5368646316;42153.57846421497;42722.35916461256;42798;43341.56658433438;43954.12091758147;7970.572653758939;8054.597270136587;8078.798030049295;8333.624986875726;8350.248477637042;30741.23146921345;32031;32076.358472829947;32172;33394.16514587155;39717;40048.79975600103;40620.79689601533;40639.39040914448;40754.592454076264;10306;10489.580416783549;10598.574396802991;10643.787124257316;10842.728931776453;8831.867521987047;11206.578619486669;11396.202265841312;11740.58907938218;11996.64010079699;10145.797084058426;10215.591376344863;10517.684469465928;10828.079613232963;11216.270942388719;11483.942580287045;11514.078873690252;11529;11804.041139982652;11852.051835852939;10301.433421161608;10506.684799456028;10794.676159715222;11003.119750420108;11258.887411125785;9600.471974041495;9998;10078.697639070839;10224.548505673396;10435.37387756737;9292.349535532448;9490.193333566724;9669.274804389559;9820.55807488679;9840.311178217456 04:40:16 INFO - PROCESS | 5357 | __end_tp_report 04:40:16 INFO - PROCESS | 5357 | __start_cc_report 04:40:16 INFO - PROCESS | 5357 | _x_x_mozilla_cycle_collect,1005 04:40:16 INFO - PROCESS | 5357 | __end_cc_report 04:40:16 INFO - PROCESS | 5357 | __startTimestamp1458646816241__endTimestamp 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - PROCESS | 5357 | ------- Summary: start ------- 04:40:16 INFO - PROCESS | 5357 | Number of tests: 6 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - PROCESS | 5357 | [#0] dojo.html Cycles:165 Average:4609.54 Median:4749.36 stddev:470.23 (9.9%) stddev-sans-first:443.74 04:40:16 INFO - PROCESS | 5357 | Values: 2574.2 2633.9 2672.0 2674.2 2680.2 4591.5 4617.0 4652.7 4674.5 4678.6 4646.2 4653.4 4657.6 4657.9 4663.3 4260.8 4326.7 4350.7 4409.9 4438.2 4229.9 4305.4 4368.1 4369.2 4384.4 4244.6 4304.4 4333.6 4340.9 4367.3 4293.4 4303.5 4313.9 4350.5 4358.3 4195.9 4297.5 4308.4 4316.4 4351.2 4481.7 4515.3 4535.3 4576.3 4599.6 4961.4 4966.1 4984.1 5006.8 5028.1 4827.0 4933.9 4956.4 4962.2 4973.9 4621.9 4649.5 4684.0 4686.0 4686.0 5125.6 5126.6 5128.0 5130.3 5134.0 4816.5 4916.2 4929.9 4930.9 4964.8 4949.6 4986.0 4986.2 5033.4 5047.8 4932.5 4950.5 4959.2 4964.0 5002.0 4844.0 4935.3 4940.0 4945.7 5001.1 4158.2 4187.0 4211.2 4222.2 4249.7 3674.7 3675.5 3684.6 3703.9 3726.5 4263.4 4292.5 4375.5 4379.4 4413.3 5009.5 5010.4 5012.3 5030.2 5063.8 4342.5 4343.9 4350.0 4371.2 4387.0 4350.0 4422.8 4472.4 4476.3 4489.3 4724.3 4732.4 4735.1 4742.1 4763.5 4915.9 4943.7 4948.7 4948.9 4998.7 4701.4 4731.5 4750.3 4833.7 4844.1 4887.3 4902.8 4909.1 4917.3 4953.8 4968.3 4979.0 4979.5 4984.2 5030.6 4749.4 4789.1 4819.7 4854.6 4871.7 4794.4 4797.2 4804.9 4814.8 4851.6 4641.9 4756.4 4762.2 4770.7 4815.4 4802.7 4821.8 4885.2 4894.8 4983.9 4771.2 4772.9 4785.9 4788.0 4832.0 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - PROCESS | 5357 | [#1] ext.html Cycles:180 Average:39699.79 Median:33959.83 stddev:63884.41 (188.1%) stddev-sans-first:63995.96 04:40:16 INFO - PROCESS | 5357 | Values: 537.7 540.5 562.3 563.5 576.8 26898.5 27620.3 34772.1 35657.3 35793.8 37436.3 37656.0 37710.4 37779.8 37911.4 7750.5 7950.3 7951.6 7960.7 7963.0 7837.7 7967.6 7974.6 7978.7 7980.7 7921.1 7965.8 8037.4 8055.9 8057.9 7930.8 7957.8 8000.4 8016.1 8027.5 7818.1 7862.8 7867.5 7885.4 7947.9 37546.4 38140.0 38211.8 38223.4 38269.4 3309.0 3338.6 3716.3 3718.1 3825.8 27451.3 27654.0 28013.3 28171.3 29126.7 3153.7 3171.6 3177.9 3183.9 3231.2 241556.0 249111.0 250167.0 250489.0 250837.0 43489.3 44016.3 44102.0 60071.4 60676.4 44639.8 44894.1 44896.0 45001.0 45037.0 11974.6 12084.9 12126.8 12141.7 12148.1 9053.7 9055.0 9198.9 9206.6 9213.2 15037.5 15335.0 15466.4 15482.2 15678.1 6137.2 6275.0 6340.5 6401.9 6408.7 894.6 934.6 952.2 989.6 1014.2 26269.7 27390.4 27547.6 27661.3 28156.2 957.7 979.4 997.8 1029.6 1080.1 13832.3 14317.4 14528.0 14674.9 14711.1 286218.0 290734.0 293024.0 293673.0 294090.0 46681.0 46961.5 47146.5 47245.8 47279.0 1067.3 1117.0 1208.5 1236.0 1247.9 24171.0 27159.2 27187.7 27437.7 27640.3 37957.2 38451.6 38532.0 38537.6 38571.6 178893.0 180869.0 181874.0 181937.0 182555.0 27181.6 31809.4 33619.7 33725.8 34193.8 38909.0 43801.3 43813.1 44167.0 44682.3 30952.8 32134.7 33188.7 33407.5 33505.5 32623.2 32915.0 33006.5 33176.3 33504.0 33127.3 33127.5 33278.7 33499.2 33527.8 29119.3 29227.0 29524.0 31784.0 32210.0 24663.8 24771.1 24912.0 24914.7 25267.6 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - PROCESS | 5357 | [#2] jquery.html Cycles:180 Average:24280.23 Median:251123.00 stddev:71545.18 (28.5%) stddev-sans-first:71723.31 04:40:16 INFO - PROCESS | 5357 | Values: 349.3 353.5 357.9 362.1 362.9 15456.7 15828.5 16369.3 16715.4 17024.8 16287.7 16649.3 16776.2 16793.5 16799.0 4877.7 4941.8 5044.1 5047.1 5048.4 5005.5 5031.9 5043.0 5080.2 5081.9 4840.7 5002.4 5011.6 5017.5 5020.9 4971.6 4984.5 4989.0 5028.9 5029.3 4494.5 4502.7 4507.7 4508.3 4508.7 19093.8 20002.6 20138.8 20139.7 20188.4 1947.7 2038.4 2126.9 2127.1 2146.0 12823.8 12899.1 13033.8 13264.5 13340.7 1773.3 1780.4 1811.6 1855.1 1863.9 56733.7 57223.0 57852.4 57949.4 58272.4 9760.3 9857.0 10107.7 10135.6 10315.8 12649.8 12758.1 12760.4 12776.2 12778.6 6824.9 6866.4 6917.0 7010.1 7024.8 6467.3 6476.1 6550.1 6570.3 6591.0 6150.7 6172.2 6177.7 6185.4 6197.7 1711.6 1743.7 1747.7 1756.3 1788.4 861.7 926.6 928.7 961.4 1009.3 16420.9 16728.1 16929.7 16949.2 17271.5 893.3 907.2 919.9 925.8 934.4 9495.6 9754.1 9961.2 9976.2 10115.0 421924.0 426151.0 431374.0 455995.0 456606.0 38852.0 49305.0 51224.0 57927.4 61778.7 968.2 973.7 979.0 992.0 992.6 15134.5 15321.8 15333.6 15409.9 15794.4 31592.1 32037.9 32831.0 33365.0 34328.8 44371.3 44706.8 44971.8 45640.0 45995.8 7118.2 7140.9 7297.4 7321.4 7349.0 10811.1 10888.6 11121.9 11215.4 11421.6 9557.8 9624.0 9759.4 10019.1 10468.8 9920.1 9925.6 9955.5 10039.5 10049.8 9810.3 9911.1 10200.5 10486.7 10658.3 6823.4 6851.9 6908.7 6957.5 7001.1 7662.6 9466.1 9475.5 9482.6 9631.2 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - PROCESS | 5357 | [#3] mootools.html Cycles:180 Average:5063.43 Median:6169.08 stddev:2592.13 (42.0%) stddev-sans-first:2583.66 04:40:16 INFO - PROCESS | 5357 | Values: 1263.7 1432.5 1439.0 1586.5 1745.2 6300.6 7019.3 7163.0 7166.6 7187.6 6949.2 7121.6 7128.3 7129.0 7136.8 1931.3 2190.2 2210.8 2236.9 2242.1 2209.6 2213.2 2215.6 2220.3 2220.9 2175.0 2251.4 2253.1 2253.9 2255.7 2159.8 2176.8 2186.0 2208.4 2212.2 2070.7 2100.2 2113.5 2118.1 2121.6 7300.1 7369.1 7380.6 7389.6 7393.1 4548.9 4640.3 4676.7 4677.9 4681.5 2882.3 2958.7 3027.1 3097.3 3105.1 887.9 895.9 906.9 931.2 959.6 9417.6 9428.1 9466.8 9525.0 9539.0 3952.7 4052.9 4133.6 4141.5 4141.6 7883.5 7913.8 7930.8 7953.3 7953.3 3799.1 4500.1 4527.0 4527.6 4531.5 3943.6 3998.3 4010.7 4014.1 4027.8 3348.1 3440.9 3448.5 3454.7 3505.6 1025.9 1054.9 1056.7 1059.5 1072.9 1177.7 1187.2 1206.1 1228.0 1247.5 6943.2 7027.6 7051.5 7054.6 7076.8 458.9 468.0 472.3 475.4 478.8 5459.9 5460.4 5495.0 5497.5 5528.0 8614.8 8760.2 8955.0 8956.6 9090.0 8825.1 8873.5 8918.9 8975.8 8983.9 6784.6 6898.0 6955.9 6993.8 7011.1 6530.9 6551.6 6573.7 6578.0 6616.4 7444.6 7711.7 7711.9 7720.0 7893.9 7753.5 7871.1 7966.1 8074.9 8088.2 5791.7 6131.5 6203.4 6395.9 6482.4 6783.7 6795.7 6842.4 6850.2 6858.2 6026.9 6071.2 6085.5 6129.5 6198.1 6139.5 6208.5 6223.0 6269.9 6328.4 6612.8 6664.9 6677.7 6681.5 6681.7 6062.8 6157.8 6168.3 6169.8 6177.2 6112.2 6233.8 6236.4 6238.9 6239.5 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - PROCESS | 5357 | [#4] prototype.html Cycles:180 Average:4594.93 Median:5224.45 stddev:1354.35 (25.9%) stddev-sans-first:1319.44 04:40:16 INFO - PROCESS | 5357 | Values: 311.8 313.0 316.2 316.6 322.0 5219.5 5222.4 5286.0 5297.7 5303.5 5185.1 5203.6 5215.2 5219.2 5226.5 3921.5 3947.5 4027.8 4051.5 4067.5 4000.7 4052.3 4053.3 4067.6 4070.0 4006.3 4007.0 4007.2 4014.4 4017.2 3865.5 3946.7 4017.6 4086.5 4127.5 3636.1 3644.1 3652.3 3657.5 3662.9 5038.7 5061.3 5063.5 5064.3 5067.9 4741.8 4743.9 4750.1 4752.9 4759.9 5515.4 5517.9 5521.7 5525.0 5528.7 3978.2 3982.9 3990.2 3990.8 3995.4 5597.2 5807.2 5820.4 5847.2 5889.8 3898.7 3916.4 3933.7 3935.3 3936.9 3994.8 3995.7 3996.1 3997.3 3999.8 4588.4 4591.9 4595.0 4601.1 4606.5 5525.7 5527.0 5534.3 5536.0 5536.0 1362.5 1398.1 1398.3 1398.7 1400.3 877.1 909.1 937.4 938.9 949.9 4819.6 4896.5 4904.3 4933.2 4937.4 5750.6 5760.6 5767.9 5769.6 5775.2 4916.2 4918.1 4923.8 4925.0 4925.4 3050.3 3092.8 3096.0 3097.3 3098.2 5469.8 5471.6 5471.7 5473.9 5474.7 5707.5 5916.6 5963.7 5996.9 6014.4 5468.9 5490.0 5490.1 5499.1 5510.4 5774.1 5778.8 5780.0 5780.3 5783.0 5663.2 5674.0 5674.3 5675.5 5677.9 5483.2 5487.8 5493.9 5497.8 5500.2 3803.4 3961.9 3964.1 3973.7 3991.1 5642.5 5679.9 5683.6 5685.1 5686.8 5494.6 5501.0 5501.2 5501.5 5506.0 5487.5 5492.5 5492.6 5493.3 5498.8 5401.6 5404.4 5405.2 5405.9 5408.9 5378.5 5483.7 5540.6 5545.4 5546.6 5389.4 5412.8 5426.2 5427.3 5431.8 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - PROCESS | 5357 | [#5] yui.html Cycles:180 Average:12749.19 Median:42067.47 stddev:14407.53 (34.2%) stddev-sans-first:14419.38 04:40:16 INFO - PROCESS | 5357 | Values: 668.3 692.4 719.6 744.7 784.1 12198.0 12333.1 12507.9 12614.8 12688.8 12245.5 12312.5 12321.5 12323.7 12330.9 624.9 766.7 782.1 782.6 782.7 676.1 682.9 683.2 684.4 684.5 660.6 825.4 826.1 826.3 827.9 817.5 828.7 829.2 829.3 830.0 606.2 606.3 606.7 607.0 607.7 12131.9 12172.5 12209.1 12220.6 12222.5 11792.2 12120.0 12394.5 12492.5 12551.7 10063.9 10168.6 10185.7 10220.4 10294.3 3298.6 3335.1 3347.2 3432.3 3460.9 42041.0 42051.4 42083.6 42175.4 42177.8 9715.5 9729.0 9840.3 10012.6 10068.4 16919.8 16989.7 16999.4 17016.5 17026.0 6935.9 6970.6 6976.2 7019.8 7211.1 3711.9 3738.3 3754.1 3794.8 3823.9 2986.3 3016.2 3035.9 3051.7 3052.0 440.4 523.5 569.5 572.4 572.5 501.8 572.1 581.3 601.9 608.1 7109.5 7146.5 7182.6 7313.5 7380.6 429.8 572.1 584.1 605.1 605.4 3472.9 3565.0 3584.4 3615.3 3651.9 51107.7 52683.2 53395.0 53736.7 53769.2 44910.0 45512.8 45514.8 46311.8 46313.5 42153.6 42722.4 42798.0 43341.6 43954.1 7970.6 8054.6 8078.8 8333.6 8350.2 30741.2 32031.0 32076.4 32172.0 33394.2 39717.0 40048.8 40620.8 40639.4 40754.6 10306.0 10489.6 10598.6 10643.8 10842.7 8831.9 11206.6 11396.2 11740.6 11996.6 10145.8 10215.6 10517.7 10828.1 11216.3 11483.9 11514.1 11529.0 11804.0 11852.1 10301.4 10506.7 10794.7 11003.1 11258.9 9600.5 9998.0 10078.7 10224.5 10435.4 9292.3 9490.2 9669.3 9820.6 9840.3 04:40:16 INFO - PROCESS | 5357 | -------- Summary: end -------- 04:40:16 INFO - PROCESS | 5357 | 04:40:16 INFO - TEST-INFO | 5357: exit 0 04:40:16 INFO - TEST-OK | dromaeo_css | took 1116244ms 04:40:16 INFO - TEST-START | kraken 04:40:16 INFO - operating with platform_type : linux_ 04:40:16 INFO - Initialising browser for kraken test... 04:40:16 INFO - TEST-INFO | started process 5534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWpYlxO/profile http://localhost:53281/getInfo.html) 04:40:21 INFO - PROCESS | 5534 | __metrics Screen width/height:1600/1200 04:40:21 INFO - PROCESS | 5534 | colorDepth:24 04:40:21 INFO - PROCESS | 5534 | Browser inner width/height: 1024/697 04:40:21 INFO - PROCESS | 5534 | __metrics 04:40:21 ERROR - PROCESS | 5534 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:40:22 INFO - PROCESS | 5534 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:40:22 INFO - TEST-INFO | 5534: exit 0 04:40:22 INFO - Browser initialized. 04:40:22 INFO - Running cycle 1/1 for kraken test... 04:40:22 INFO - TEST-INFO | started process 5617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWpYlxO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:34 INFO - PROCESS | 5617 | RSS: Main: 157880320 04:40:34 INFO - PROCESS | 5617 | 04:40:37 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53281/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:37 INFO - PROCESS | 5617 | RSS: Main: 199467008 04:40:37 INFO - PROCESS | 5617 | 04:40:40 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53281/tests/kraken/driver.html?testName=audio-dft) 04:40:41 INFO - PROCESS | 5617 | RSS: Main: 188854272 04:40:41 INFO - PROCESS | 5617 | 04:40:44 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53281/tests/kraken/driver.html?testName=audio-fft) 04:40:44 INFO - PROCESS | 5617 | RSS: Main: 173096960 04:40:44 INFO - PROCESS | 5617 | 04:40:46 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53281/tests/kraken/driver.html?testName=audio-oscillator) 04:40:47 INFO - PROCESS | 5617 | RSS: Main: 175841280 04:40:47 INFO - PROCESS | 5617 | 04:40:49 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:50 INFO - PROCESS | 5617 | RSS: Main: 177303552 04:40:50 INFO - PROCESS | 5617 | 04:40:53 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53281/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:53 INFO - PROCESS | 5617 | RSS: Main: 176578560 04:40:53 INFO - PROCESS | 5617 | 04:40:57 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53281/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:57 INFO - PROCESS | 5617 | RSS: Main: 177262592 04:40:57 INFO - PROCESS | 5617 | 04:41:00 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53281/tests/kraken/driver.html?testName=json-parse-financial) 04:41:01 INFO - PROCESS | 5617 | RSS: Main: 178073600 04:41:01 INFO - PROCESS | 5617 | 04:41:03 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:03 INFO - PROCESS | 5617 | RSS: Main: 188391424 04:41:03 INFO - PROCESS | 5617 | 04:41:05 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:06 INFO - PROCESS | 5617 | RSS: Main: 184188928 04:41:06 INFO - PROCESS | 5617 | 04:41:08 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:08 INFO - PROCESS | 5617 | RSS: Main: 194904064 04:41:08 INFO - PROCESS | 5617 | 04:41:11 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:11 INFO - PROCESS | 5617 | RSS: Main: 202936320 04:41:11 INFO - PROCESS | 5617 | 04:41:14 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:15 INFO - PROCESS | 5617 | RSS: Main: 201928704 04:41:15 INFO - PROCESS | 5617 | 04:41:16 INFO - PROCESS | 5617 | Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53281/tests/kraken/driver.html?testName=ai-astar) 04:41:17 INFO - PROCESS | 5617 | RSS: Main: 261611520 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | __start_tp_report 04:41:17 INFO - PROCESS | 5617 | _x_x_mozilla_page_load 04:41:17 INFO - PROCESS | 5617 | _x_x_mozilla_page_load_details 04:41:17 INFO - PROCESS | 5617 | |i|pagename|runs| 04:41:17 INFO - PROCESS | 5617 | |0;ai-astar;110;112;106;111;112;112;100;112;112;113 04:41:17 INFO - PROCESS | 5617 | |1;audio-beat-detection;147;125;150;161;131;154;149;130;174;130 04:41:17 INFO - PROCESS | 5617 | |2;audio-dft;161;162;162;162;161;160;160;163;163;161 04:41:17 INFO - PROCESS | 5617 | |3;audio-fft;74;76;104;96;73;72;76;110;93;72 04:41:17 INFO - PROCESS | 5617 | |4;audio-oscillator;94;93;135;94;94;93;140;94;94;138 04:41:17 INFO - PROCESS | 5617 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;116;116;117 04:41:17 INFO - PROCESS | 5617 | |6;imaging-darkroom;145;145;146;145;145;145;145;146;145;145 04:41:17 INFO - PROCESS | 5617 | |7;imaging-desaturate;96;95;95;103;95;94;95;95;96;95 04:41:17 INFO - PROCESS | 5617 | |8;json-parse-financial;70;71;69;70;71;69;70;80;68;68 04:41:17 INFO - PROCESS | 5617 | |9;json-stringify-tinderbox;64;64;64;64;65;65;65;64;64;64 04:41:17 INFO - PROCESS | 5617 | |10;stanford-crypto-aes;82;82;83;90;81;81;80;81;82;80 04:41:17 INFO - PROCESS | 5617 | |11;stanford-crypto-ccm;131;122;132;116;118;117;116;115;121;130 04:41:17 INFO - PROCESS | 5617 | |12;stanford-crypto-pbkdf2;140;139;141;140;139;131;143;143;150;138 04:41:17 INFO - PROCESS | 5617 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;67;66;66;66;66 04:41:17 INFO - PROCESS | 5617 | __end_tp_report 04:41:17 INFO - PROCESS | 5617 | __start_cc_report 04:41:17 INFO - PROCESS | 5617 | _x_x_mozilla_cycle_collect,1129 04:41:17 INFO - PROCESS | 5617 | __end_cc_report 04:41:17 INFO - PROCESS | 5617 | __startTimestamp1458646877092__endTimestamp 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | ------- Summary: start ------- 04:41:17 INFO - PROCESS | 5617 | Number of tests: 14 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:4.03 (3.6%) stddev-sans-first:4.27 04:41:17 INFO - PROCESS | 5617 | Values: 110.0 112.0 106.0 111.0 112.0 112.0 100.0 112.0 112.0 113.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:149.50 stddev:15.88 (10.6%) stddev-sans-first:16.83 04:41:17 INFO - PROCESS | 5617 | Values: 147.0 125.0 150.0 161.0 131.0 154.0 149.0 130.0 174.0 130.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 04:41:17 INFO - PROCESS | 5617 | Values: 161.0 162.0 162.0 162.0 161.0 160.0 160.0 163.0 163.0 161.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.00 stddev:14.66 (19.5%) stddev-sans-first:15.04 04:41:17 INFO - PROCESS | 5617 | Values: 74.0 76.0 104.0 96.0 73.0 72.0 76.0 110.0 93.0 72.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:94.00 stddev:21.27 (22.6%) stddev-sans-first:22.04 04:41:17 INFO - PROCESS | 5617 | Values: 94.0 93.0 135.0 94.0 94.0 93.0 140.0 94.0 94.0 138.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:41:17 INFO - PROCESS | 5617 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:41:17 INFO - PROCESS | 5617 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:2.56 (2.7%) stddev-sans-first:2.71 04:41:17 INFO - PROCESS | 5617 | Values: 96.0 95.0 95.0 103.0 95.0 94.0 95.0 95.0 96.0 95.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#8] json-parse-financial Cycles:10 Average:70.60 Median:70.00 stddev:3.47 (5.0%) stddev-sans-first:3.67 04:41:17 INFO - PROCESS | 5617 | Values: 70.0 71.0 69.0 70.0 71.0 69.0 70.0 80.0 68.0 68.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:41:17 INFO - PROCESS | 5617 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 65.0 64.0 64.0 64.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:2.90 (3.5%) stddev-sans-first:3.07 04:41:17 INFO - PROCESS | 5617 | Values: 82.0 82.0 83.0 90.0 81.0 81.0 80.0 81.0 82.0 80.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:121.50 stddev:6.73 (5.5%) stddev-sans-first:6.26 04:41:17 INFO - PROCESS | 5617 | Values: 131.0 122.0 132.0 116.0 118.0 117.0 116.0 115.0 121.0 130.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.40 Median:140.50 stddev:4.77 (3.4%) stddev-sans-first:5.05 04:41:17 INFO - PROCESS | 5617 | Values: 140.0 139.0 141.0 140.0 139.0 131.0 143.0 143.0 150.0 138.0 04:41:17 INFO - PROCESS | 5617 | 04:41:17 INFO - PROCESS | 5617 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:41:17 INFO - PROCESS | 5617 | Values: 67.0 67.0 67.0 66.0 67.0 67.0 66.0 66.0 66.0 66.0 04:41:17 INFO - PROCESS | 5617 | -------- Summary: end -------- 04:41:17 INFO - PROCESS | 5617 | 04:41:18 INFO - TEST-INFO | 5617: exit 0 04:41:18 INFO - TEST-OK | kraken | took 61124ms 04:41:18 INFO - SUITE-END | took 1177s 04:41:18 INFO - Completed test suite (00:19:37) 04:41:18 INFO - javascript benchmark 04:41:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2574.240599023288, 2633.9473210535803, 2671.998000749719, 2674.197740677796, 2680.2495301315635, 4591.517890621487, 4616.976915115424, 4652.651051171168, 4674.4624368197665, 4678.5789278964885, 4646.163690535702, 4653.39505864238, 4657.627389808816, 4657.860264192072, 4663.3238180463895, 4260.7656578888145, 4326.675499337554, 4350.695451318393, 4409.933850992222, 4438.245498265286, 4229.894252643678, 4305.397244385788, 4368.082702632451, 4369.1916995355805, 4384.364267181257, 4244.639205667522, 4304.3543468479975, 4333.631641310492, 4340.934885976713, 4367.301231802928, 4293.355996600504, 4303.526612072669, 4313.892152696177, 4350.543192964757, 4358.302671572533, 4195.8741237762915, 4297.527272000078, 4308.3968244445805, 4316.417283666696, 4351.19502891966, 4481.686281960264, 4515.254982927813, 4535.297028960516, 4576.336431217488, 4599.609033232179, 4961.355023846912, 4966.130927087781, 4984.127777638935, 5006.824761133343, 5028.069807085664, 4827.0, 4933.851984440473, 4956.355673762424, 4962.1812400953795, 4973.900521989576, 4621.8844528886375, 4649.511801260886, 4684.039771846763, 4685.9531404686195, 4685.99251161002, 5125.56432703217, 5126.564242039469, 5128.025675121715, 5130.281760553451, 5134.024535338273, 4816.518348165156, 4916.213405855046, 4929.926051109236, 4930.8767280818265, 4964.826231081967, 4949.604031677457, 4985.975070124626, 4986.227134794112, 5033.421156566968, 5047.823326183566, 4932.482089380635, 4950.529699678525, 4959.181735013683, 4963.950360496421, 5002.049610573979, 4843.982763619609, 4935.333729946483, 4940.011997600494, 4945.727984960861, 5001.149804533238, 4158.209940111429, 4187.0, 4211.199872024366, 4222.155568886235, 4249.702520823575, 3674.65090816372, 3675.46705727668, 3684.6315368463474, 3703.925921481555, 3726.5341832270965, 4263.360495925636, 4292.48490181174, 4375.496817865923, 4379.386885835986, 4413.337999300131, 5009.5491405773655, 5010.398752149766, 5012.348394708664, 5030.220315851049, 5063.797448102108, 4342.457192850894, 4343.9348409773875, 4350.0212452198, 4371.169477799208, 4386.978065109718, 4349.978250108729, 4422.823087076546, 4472.396226509444, 4476.328550717353, 4489.259272220047, 4724.267738500538, 4732.432108146975, 4735.14767341868, 4742.051589682008, 4763.476017638057, 4915.852524424273, 4943.678660887031, 4948.703077815343, 4948.8762780930765, 4998.6750861193905, 4701.435827700561, 4731.503192164911, 4750.263709125091, 4833.685810422311, 4844.103840789465, 4887.291342755351, 4902.779374928065, 4909.0672772173175, 4917.28699338601, 4953.826616068421, 4968.329275547755, 4979.0, 4979.477154898684, 4984.177610694195, 5030.572401345927, 4749.358836557159, 4789.137955168103, 4819.734914579732, 4854.5873600744335, 4871.732054736882, 4794.376731024944, 4797.160496913096, 4804.903901922012, 4814.831480898151, 4851.636127290538, 4641.883952901205, 4756.429228492603, 4762.190427627381, 4770.689905156154, 4815.398075240595, 4802.73584952831, 4821.783019764049, 4885.169521181337, 4894.779734911866, 4983.875403114951, 4771.212749896228, 4772.904541909212, 4785.856424307276, 4788.018456216398, 4832.033593281428], "unit": "score", "name": "dojo.html", "value": 4580.358670543866}, {"lowerIsBetter": false, "replicates": [537.736509110536, 540.4541413172695, 562.3224015061851, 563.5238223700972, 576.8240686590589, 26898.462030759398, 27620.34277943325, 34772.130696732595, 35657.2868542629, 35793.82103089488, 37436.251274974486, 37656.0, 37710.4343434848, 37779.81110094453, 37911.431328530096, 7750.496217745843, 7950.324222441071, 7951.602419879012, 7960.681572737112, 7963.0, 7837.6864925402915, 7967.561784101872, 7974.641141148662, 7978.720744773934, 7980.720674776384, 7921.128675845653, 7965.800854978614, 8037.437379383446, 8055.879161812578, 8057.919420805805, 7930.841383172333, 7957.801054973614, 8000.399970002273, 8016.118226995026, 8027.518348899055, 7818.14000459949, 7862.842743145162, 7867.527948323119, 7885.408594355446, 7947.920520794776, 37546.43680344797, 38140.0, 38211.80894095512, 38223.426648600296, 38269.42595861064, 3309.0, 3338.582677165354, 3716.312482190803, 3718.1076541629814, 3825.8087095645105, 27451.31371715723, 27654.0, 28013.299667508476, 28171.29571760702, 29126.708732912823, 3153.716165545089, 3171.57183780189, 3177.8728850845937, 3183.856726447292, 3231.1922019495128, 241556.0, 249110.9999999982, 250167.0, 250489.0, 250837.0, 43489.347659785126, 44016.3397549037, 44102.0, 60071.39928600658, 60676.393236067954, 44639.77680111579, 44894.102117958115, 44896.0, 45001.0, 45037.0, 11974.58088966882, 12084.879151208552, 12126.757464850654, 12141.696457588454, 12148.149629525848, 9053.68312109073, 9054.954725226464, 9198.908010919939, 9206.63173473067, 9213.170814626716, 15037.548873533811, 15335.0, 15466.381344746309, 15482.22588870552, 15678.137702426477, 6137.232845894263, 6275.0, 6340.461060809791, 6401.935980640227, 6408.67956602168, 894.6376717429451, 934.5700977550267, 952.1716106986966, 989.5992123190119, 1014.2291858187831, 26269.737302627113, 27390.38497108128, 27547.586786198222, 27661.308467288076, 28156.155315340573, 957.6648173139484, 979.3878825733916, 997.7705127820642, 1029.5984566019258, 1080.0711388206137, 13832.30838458073, 14317.35571899267, 14527.955322972608, 14674.926625366805, 14711.117332959842, 286218.0, 290734.0, 293024.0, 293673.0, 294090.0, 46681.0, 46961.53865382783, 47146.5285347149, 47245.76377118092, 47279.0, 1067.3275836223129, 1116.9776604467866, 1208.510553225945, 1235.975280494385, 1247.9188852724544, 24171.033158673457, 27159.1852244433, 27187.72812271852, 27437.725622744314, 27640.308992275353, 37957.240855182186, 38451.615483844806, 38532.0, 38537.614623853406, 38571.614283857925, 178893.0, 180869.0, 181874.0, 181937.0, 182555.0, 27181.59227611548, 31809.363812724077, 33619.663803361655, 33725.83137084299, 34193.82903085568, 38909.0, 43801.34297985469, 43813.12373752571, 44167.0, 44682.3297650529, 30952.84523577368, 32134.67865321317, 33188.668113318556, 33407.49888751622, 33505.49741753924, 32623.213670261237, 32915.0, 33006.50490242696, 33176.33647326992, 33504.0, 33127.33745325128, 33127.503087453224, 33278.667213328525, 33499.16252093717, 33527.83236083901, 29119.272018199714, 29227.0, 29524.0, 31784.0, 32210.0, 24663.753362466145, 24771.13301034455, 24912.003519859, 24914.677473353393, 25267.610281434696], "unit": "score", "name": "ext.html", "value": 16503.957874936325}, {"lowerIsBetter": false, "replicates": [349.32580120367686, 353.4556782554866, 357.88368780146453, 362.09295714235833, 362.912900903783, 15456.69086618267, 15828.525144245677, 16369.345226190953, 16715.414960476384, 17024.82975170248, 16287.674246515062, 16649.25078371473, 16776.245068971893, 16793.496195114167, 16799.0, 4877.731724755137, 4941.802327906879, 5044.142495775709, 5047.141985862394, 5048.444671086178, 5005.54950054495, 5031.949680503185, 5043.041822053798, 5080.1617733074, 5081.898362032757, 4840.733759643218, 5002.399712034561, 5011.649184557083, 5017.49825017499, 5020.874478138057, 4971.602271818246, 4984.476629953839, 4989.0, 5028.874278143057, 5029.270755740416, 4494.483134439516, 4502.707324023961, 4507.706999045052, 4508.256137737302, 4508.661850361236, 19093.809061909342, 20002.599948001105, 20138.798612013838, 20139.6979045313, 20188.39434816958, 1947.6591596470562, 2038.4190505705803, 2126.851120421571, 2127.095984206706, 2145.980659186889, 12823.807642885364, 12899.09706320558, 13033.804492932613, 13264.53574124901, 13340.666483337896, 1773.326136068286, 1780.3501721871553, 1811.550759392494, 1855.137361127069, 1863.9068046597752, 56733.71633141808, 57223.0, 57852.42147578512, 57949.42050579483, 58272.41727582712, 9760.267979901535, 9857.0, 10107.747306317255, 10135.64525241613, 10315.84526232107, 12649.810252846215, 12758.106932514635, 12760.425780839885, 12776.169548979287, 12778.552750653682, 6824.93175068243, 6866.382025617719, 6916.965415172892, 7010.053642758265, 7024.754133605299, 6467.288598254188, 6476.125723027425, 6550.148480697479, 6570.342965703391, 6591.0, 6150.661713605705, 6172.197614310111, 6177.722002509898, 6185.381461853779, 6197.659128747962, 1711.5977745229861, 1743.69485340065, 1747.6668647355668, 1756.306259027677, 1788.4277031350102, 861.7070196133219, 926.5506229478698, 928.6888892221182, 961.4423634292094, 1009.2834087797746, 16420.917895410446, 16728.140378784017, 16929.746053809202, 16949.15254237283, 17271.481855544353, 893.3210759822582, 907.2061945797427, 919.9218066464292, 925.842606756853, 934.4346670264528, 9495.620175192915, 9754.122129008281, 9961.203103751683, 9976.201903847676, 10115.0, 421924.0, 426151.0, 431374.0, 455995.0, 456606.0, 38852.0, 49305.0, 51224.0, 57927.4207257922, 61778.69110654508, 968.1770495079127, 973.6640858903667, 979.0258692600908, 991.965281215154, 992.6228033347426, 15134.545963621109, 15321.845436475194, 15333.6166595836, 15409.922950385624, 15794.447194348142, 31592.052238432883, 32037.87867424629, 32831.0, 33365.0, 34328.82835585806, 44371.33442998422, 44706.77646611746, 44971.77514112408, 45640.0, 45995.77002114968, 7118.181409138016, 7140.9285907140265, 7297.379722723628, 7321.377682897013, 7349.04462419882, 10811.13510919109, 10888.61889833852, 11121.944390277997, 11215.383153926286, 11421.600243991421, 9557.761055973657, 9623.951880240555, 9759.414435133915, 10019.098281154731, 10468.842967355344, 9920.107190352903, 9925.553350099408, 9955.50222488887, 10039.548220329956, 10049.849252261369, 9810.272096603245, 9911.058449447291, 10200.489975501343, 10486.737831554272, 10658.307210031324, 6823.420009299265, 6851.931480685129, 6908.654567271516, 6957.512974091765, 7001.054857594363, 7662.616869156632, 9466.100720431548, 9475.52622368865, 9482.620695172393, 9631.181349585364], "unit": "score", "name": "jquery.html", "value": 8024.366679035638}, {"lowerIsBetter": false, "replicates": [1263.7346157306965, 1432.4771458417677, 1438.9784153237704, 1586.4606033948462, 1745.2408202431934, 6300.590461619991, 7019.333163349486, 7162.96418517908, 7166.60583667898, 7187.640617969107, 6949.200841903183, 7121.572705637665, 7128.251533588963, 7129.0, 7136.821579460516, 1931.2661188748257, 2190.1786829938774, 2210.789974952385, 2236.854604450714, 2242.125571027301, 2209.602271591113, 2213.2032468311395, 2215.5679642469727, 2220.289507357646, 2220.888955552224, 2175.0, 2251.448395143192, 2253.1212826997485, 2253.9098436062536, 2255.661650752384, 2159.8380121490873, 2176.8258539316816, 2186.0381432169875, 2208.3595757230382, 2212.225720997654, 2070.7411573553304, 2100.1809294375207, 2113.5244569971633, 2118.0998075817715, 2121.6075026120216, 7300.123985121766, 7369.078865141857, 7380.594067326295, 7389.630518474109, 7393.112826460859, 4548.863534093983, 4640.303954406832, 4676.69601475903, 4677.906441871178, 4681.5318468153255, 2882.2506148401567, 2958.6597541282813, 3027.076741593813, 3097.349556593118, 3105.1460848266684, 887.9245264152555, 895.8969718482393, 906.854903215489, 931.1945167430192, 959.5633986536109, 9417.576209070608, 9428.10433008863, 9466.810663786755, 9525.0, 9539.0, 3952.7430717003303, 4052.878413647595, 4133.607307305801, 4141.503019637603, 4141.627253547195, 7883.526988380716, 7913.802154946057, 7930.841383172305, 7953.32396746283, 7953.32396746283, 3799.126200973736, 4500.054988452462, 4527.026689261825, 4527.615152712056, 4531.546845315442, 3943.5662077171487, 3998.34027385484, 4010.6991975601363, 4014.0767623446186, 4027.7583344998807, 3348.11275012122, 3440.8623655053516, 3448.517207590939, 3454.7236221102253, 3505.631908649606, 1025.9435731034864, 1054.894510548939, 1056.6777132974362, 1059.523214553454, 1072.9463526823627, 1177.6996865799167, 1187.1808452167977, 1206.0592737664635, 1227.9508819647115, 1247.457356050121, 6943.201531823804, 7027.613481258478, 7051.5063945523325, 7054.6472676365975, 7076.823079422953, 458.86463493269565, 467.96346093403275, 472.34344261476576, 475.3701345716939, 478.7606196901549, 5459.863503412446, 5460.426655201226, 5495.0, 5497.505224529731, 5528.032594295983, 8614.827703445895, 8760.211580957744, 8955.0, 8956.641734330553, 9090.045545217788, 8825.07336729647, 8873.467591944504, 8918.910810891937, 8975.77560560978, 8983.910160898438, 6784.626845523544, 6898.0, 6955.860882782417, 6993.755218567326, 7011.088558487364, 6530.9020364693615, 6551.639659818756, 6573.704183311666, 6578.046183303299, 6616.4045235929, 7444.627768611439, 7711.691532338644, 7711.922880771345, 7719.961400192963, 7893.921060789318, 7753.534787912743, 7871.094824095302, 7966.1237263902085, 8074.878876816735, 8088.150744171778, 5791.652500849962, 6131.540134489842, 6203.4416902479, 6395.904061438989, 6482.448991835747, 6783.728650853911, 6795.72817087311, 6842.418394436529, 6850.246472887879, 6858.211305699709, 6026.909596356146, 6071.210742603434, 6085.4523092921845, 6129.540284478771, 6198.132261483306, 6139.539534534839, 6208.472279856082, 6223.0, 6269.937300626935, 6328.430441260309, 6612.801615951529, 6664.900026499703, 6677.6661166940485, 6681.532292739462, 6681.665916704243, 6062.757489700362, 6157.784477543264, 6168.321484636776, 6169.84575385619, 6177.227846519185, 6112.205413296243, 6233.812985610439, 6236.407541283571, 6238.906416403667, 6239.4696450800375], "unit": "score", "name": "mootools.html", "value": 4117.153134623037}, {"lowerIsBetter": false, "replicates": [311.7505995203836, 312.96087989001376, 316.1952830047528, 316.6247996124591, 322.0, 5219.45195754446, 5222.373315202176, 5286.0, 5297.682139071659, 5303.469653034699, 5185.144451165563, 5203.583713302936, 5215.217717342391, 5219.191025391061, 5226.529612334889, 3921.509811273591, 3947.4868267125235, 4027.7784721840285, 4051.513818341803, 4067.5322337931148, 4000.6999475039343, 4052.29084910141, 4053.3109371406786, 4067.5525692173987, 4070.043539768152, 4006.278869803434, 4006.9599304007024, 4007.2386246613196, 4014.3978403239457, 4017.216642754664, 3865.5361356637245, 3946.7039972001926, 4017.6384125428704, 4086.509618845728, 4127.484064491939, 3636.1455058061333, 3644.0889777555612, 3652.3060618482405, 3657.4513822926506, 3662.926741465182, 5038.722870242135, 5061.316722242487, 5063.468335824722, 5064.34163558735, 5067.873303167414, 4741.786619602126, 4743.881402964919, 4750.073735621555, 4752.904941901177, 4759.928601070987, 5515.365732940683, 5517.917231241535, 5521.696306703129, 5524.972375138139, 5528.668279903219, 3978.2242462719782, 3982.900427489307, 3990.2219067281603, 3990.780507072139, 3995.420664003703, 5597.216389705403, 5807.2160258365, 5820.388859169769, 5847.181394604759, 5889.823305300805, 3898.7465814721954, 3916.373380259202, 3933.704972127102, 3935.2719746846924, 3936.901577460529, 3994.7802870842384, 3995.6603688686205, 3996.100877302642, 3997.340438827619, 3999.7800120993043, 4588.38056862326, 4591.885202869955, 4594.954050459452, 4601.079784043138, 4606.470255920545, 5525.668459892419, 5526.972365138229, 5534.335879694462, 5535.972320138373, 5536.031194540939, 1362.5367375092517, 1398.084254813099, 1398.3288021749618, 1398.6713122416224, 1400.3208443904698, 877.0659247901093, 909.0636644256426, 937.3953799799227, 938.8826396700413, 949.8812648418948, 4819.638527110411, 4896.534829191221, 4904.2643603459765, 4933.235348520985, 4937.35814344133, 5750.568707346965, 5760.6255593386295, 5767.942320576824, 5769.596128271065, 5775.191473193756, 4916.164252077156, 4918.139325618003, 4923.803047878117, 4925.0, 4925.38432695913, 3050.328927635961, 3092.8453577321043, 3096.040227529473, 3097.3340731742783, 3098.2254436390904, 5469.753861076261, 5471.589630777628, 5471.699056551928, 5473.945260547343, 5474.7262636868, 5707.543396528268, 5916.615419997686, 5963.731632076567, 5996.880062398727, 6014.368491308437, 5468.890622187613, 5490.039243132515, 5490.149026900836, 5499.065158922913, 5510.366307874646, 5774.133879918046, 5778.797742079007, 5779.971100144472, 5780.335261444988, 5783.045797443543, 5663.235463212413, 5674.0, 5674.319081710056, 5675.545956323402, 5677.943220567741, 5483.150111732688, 5487.807926722705, 5493.890122197454, 5497.780088796403, 5500.174973753808, 3803.410471376941, 3961.900952476096, 3964.0882597002274, 3973.7019723520275, 3991.082051128315, 5642.520385767091, 5679.914801278067, 5683.602147849776, 5685.090385538294, 5686.800961966312, 5494.642848215013, 5501.037318469172, 5501.229827824188, 5501.504864562208, 5506.0, 5487.506124448819, 5492.47821456961, 5492.642978206404, 5493.340799103973, 5498.762778374834, 5401.6218864679095, 5404.378496472956, 5405.216243644571, 5405.86485337854, 5408.9459105410015, 5378.462153784591, 5483.670979741229, 5540.612157148961, 5545.3622833374675, 5546.639468434701, 5389.380221274603, 5412.75642596092, 5426.186072089218, 5427.348718153847, 5431.755570999236], "unit": "score", "name": "prototype.html", "value": 4160.10164000077}, {"lowerIsBetter": false, "replicates": [668.2882729892667, 692.3906961873552, 719.5862379131997, 744.7467860927284, 784.1217836023654, 12198.0, 12333.136680432362, 12507.874921250796, 12614.81077783834, 12688.80966785499, 12245.510179592828, 12312.507499700001, 12321.5071397144, 12323.691907702312, 12330.938345308283, 624.9250089989208, 766.7278116268728, 782.1240210963729, 782.5734974438916, 782.6869252299098, 676.1413005483033, 682.9214640316353, 683.2313647146959, 684.3737979748524, 684.4866350237322, 660.6036378173081, 825.4387016828554, 826.1284345016036, 826.330672155553, 827.8634025385804, 817.464560712734, 828.7348048624382, 829.2371018662844, 829.2992421403904, 830.0495932157706, 606.1544145916466, 606.2966958328318, 606.6663335165686, 606.9635821850659, 607.696151924038, 12131.93934030333, 12172.513099476011, 12209.145359824815, 12220.572279970158, 12222.511099556006, 11792.174547781658, 12120.0, 12394.504219831197, 12492.500299987989, 12551.686207844785, 10063.949680251626, 10168.59325626974, 10185.694429167137, 10220.386776793417, 10294.330868493524, 3298.571185745862, 3335.1328654549748, 3347.163209197701, 3432.3135372925267, 3460.8788692395647, 42041.0, 42051.36922946158, 42083.579164208575, 42175.36736948918, 42177.78911105425, 9715.514224288898, 9728.951355243178, 9840.261980351503, 10012.599496020077, 10068.446235456973, 16919.830801691827, 16989.745153822703, 16999.40502082421, 17016.48950531486, 17026.0, 6935.930640693629, 6970.616616086062, 6976.232614412411, 7019.789406317818, 7211.062561866924, 3711.9072023199637, 3738.3271011218244, 3754.0990162360836, 3794.829232684536, 3823.8661646842784, 2986.2683642507723, 3016.2007068126527, 3035.9241018974703, 3051.67957364478, 3052.0, 440.37246923134404, 523.4895976422957, 569.473237255537, 572.4361503918636, 572.5362456410321, 501.8494451664486, 572.0635648330349, 581.2734082397004, 601.9488343490852, 608.0939400293531, 7109.466789990772, 7146.464015198881, 7182.60495672743, 7313.524620899624, 7380.630968451556, 429.8237722533746, 572.0703856233621, 584.0946532874028, 605.1497645807648, 605.3643674142133, 3472.930541389158, 3564.982175089108, 3584.390653588896, 3615.258871931248, 3651.94522082169, 51107.744461277456, 52683.209751853756, 53395.0, 53736.73131634395, 53769.1934620981, 44910.0, 45512.77243613761, 45514.77242613766, 46311.768441157576, 46313.5368646316, 42153.57846421497, 42722.35916461256, 42798.0, 43341.56658433438, 43954.12091758147, 7970.572653758939, 8054.597270136587, 8078.798030049295, 8333.624986875726, 8350.248477637042, 30741.23146921345, 32031.0, 32076.358472829947, 32172.0, 33394.16514587155, 39717.0, 40048.79975600103, 40620.79689601533, 40639.39040914448, 40754.592454076264, 10306.0, 10489.580416783549, 10598.574396802991, 10643.787124257316, 10842.728931776453, 8831.867521987047, 11206.578619486669, 11396.202265841312, 11740.58907938218, 11996.64010079699, 10145.797084058426, 10215.591376344863, 10517.684469465928, 10828.079613232963, 11216.270942388719, 11483.942580287045, 11514.078873690252, 11529.0, 11804.041139982652, 11852.051835852939, 10301.433421161608, 10506.684799456028, 10794.676159715222, 11003.119750420108, 11258.887411125785, 9600.471974041495, 9998.0, 10078.697639070839, 10224.548505673396, 10435.37387756737, 9292.349535532448, 9490.193333566724, 9669.274804389559, 9820.55807488679, 9840.311178217456], "unit": "score", "name": "yui.html", "value": 5875.1162391520365}], "name": "dromaeo_css", "value": 6274.945045695651}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 111.0, 112.0, 112.0, 100.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 125.0, 150.0, 161.0, 131.0, 154.0, 149.0, 130.0, 174.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 162.0, 161.0, 160.0, 160.0, 163.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 104.0, 96.0, 73.0, 72.0, 76.0, 110.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 135.0, 94.0, 94.0, 93.0, 140.0, 94.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 103.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 69.0, 70.0, 71.0, 69.0, 70.0, 80.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 90.0, 81.0, 81.0, 80.0, 81.0, 82.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [131.0, 122.0, 132.0, 116.0, 118.0, 117.0, 116.0, 115.0, 121.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [140.0, 139.0, 141.0, 140.0, 139.0, 131.0, 143.0, 143.0, 150.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1511.6000000000001}]} 04:41:18 INFO - Return code: 0 04:41:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:41:18 ERROR - # TBPL SUCCESS # 04:41:18 INFO - Running post-action listener: _resource_record_post_action 04:41:18 INFO - Running post-run listener: _resource_record_post_run 04:41:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302059520; Read time: 168; Write time: 259804 04:41:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20037632; Read time: 0; Write time: 17836 04:41:19 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282021888; Read time: 168; Write time: 241968 04:41:19 INFO - Running post-run listener: _upload_blobber_files 04:41:19 INFO - Blob upload gear active. 04:41:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:19 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 04:41:19 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'] 04:41:19 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 04:41:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:41:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:41:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:21 INFO - (blobuploader) - INFO - Done attempting. 04:41:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:41:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:41:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:22 INFO - (blobuploader) - INFO - Done attempting. 04:41:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:22 INFO - Return code: 0 04:41:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37a187c3f2385a8dc96decac2f8e9bcb645d6376e1683d66e12800c28e782d8c2304520f129c89413904106248ceac5449709e31c1fda120dc9d729dda0958c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee29f959b1fd6a952749e458c1d1c3fce7bc0f8312641158b5e69260ea3085185bad9ada23d4a89a938451a054e46fb120b1c8190d2ae55efb61940e48360f94"} 04:41:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:22 INFO - Contents: 04:41:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37a187c3f2385a8dc96decac2f8e9bcb645d6376e1683d66e12800c28e782d8c2304520f129c89413904106248ceac5449709e31c1fda120dc9d729dda0958c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee29f959b1fd6a952749e458c1d1c3fce7bc0f8312641158b5e69260ea3085185bad9ada23d4a89a938451a054e46fb120b1c8190d2ae55efb61940e48360f94"} 04:41:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:22 INFO - Copying logs to upload dir... 04:41:22 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.226603 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-22 04:41:22.209686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 04:41:22.213708) ========= 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=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37a187c3f2385a8dc96decac2f8e9bcb645d6376e1683d66e12800c28e782d8c2304520f129c89413904106248ceac5449709e31c1fda120dc9d729dda0958c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee29f959b1fd6a952749e458c1d1c3fce7bc0f8312641158b5e69260ea3085185bad9ada23d4a89a938451a054e46fb120b1c8190d2ae55efb61940e48360f94"} build_url:https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009440 build_url: 'https://queue.taskcluster.net/v1/task/KrG8TFZ9R0qqpGSrPd52Mg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37a187c3f2385a8dc96decac2f8e9bcb645d6376e1683d66e12800c28e782d8c2304520f129c89413904106248ceac5449709e31c1fda120dc9d729dda0958c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee29f959b1fd6a952749e458c1d1c3fce7bc0f8312641158b5e69260ea3085185bad9ada23d4a89a938451a054e46fb120b1c8190d2ae55efb61940e48360f94"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 04:41:22.235223) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:41:22.235557) ========= 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=0333a256a5e4f052382dd180000001b1-1458645619.30442-492182210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:41:22.320480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 04:41:22.320784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 04:41:22.321078) ========= ========= Total master_lag: 0.27 =========