builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1458694945.52 results: success (0) buildid: 20160322163032 builduid: 2523bafb3ef245a78741312eb8fe062e revision: 5453ae837f6a9394f01f2219c3998098f23a41fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.521988) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.522458) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.522741) ========= 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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006346 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.576587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.576883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.595735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.596112) ========= 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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.652543) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.652887) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.653282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.653582) ========= 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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-22 18:02:25-- 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% 544K=0.02s 2016-03-22 18:02:25 (544 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.225736 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.894409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.894715) ========= 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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014402 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:25.946130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 18:02:25.946584) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5453ae837f6a9394f01f2219c3998098f23a41fb --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 5453ae837f6a9394f01f2219c3998098f23a41fb --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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-22 18:02:26,064 truncating revision to first 12 chars 2016-03-22 18:02:26,064 Setting DEBUG logging. 2016-03-22 18:02:26,064 attempt 1/10 2016-03-22 18:02:26,064 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5453ae837f6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 18:02:27,527 unpacking tar archive at: mozilla-central-5453ae837f6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.959872 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 18:02:27.922036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:27.922433) ========= echo 5453ae837f6a9394f01f2219c3998098f23a41fb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5453ae837f6a9394f01f2219c3998098f23a41fb'] 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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5453ae837f6a9394f01f2219c3998098f23a41fb program finished with exit code 0 elapsedTime=0.004769 script_repo_revision: '5453ae837f6a9394f01f2219c3998098f23a41fb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:27.981062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:27.981389) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 18:02:27.993638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-03-22 18:02:27.994034) ========= /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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:02:28 INFO - MultiFileLogger online at 20160322 18:02:28 in /builds/slave/test 18:02:28 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 18:02:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:02:28 INFO - {'append_to_log': False, 18:02:28 INFO - 'base_work_dir': '/builds/slave/test', 18:02:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:02:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:02:28 INFO - 'branch': 'Firefox-Non-PGO', 18:02:28 INFO - 'buildbot_json_path': 'buildprops.json', 18:02:28 INFO - 'config_files': ('talos/linux_config.py',), 18:02:28 INFO - 'default_actions': ('clobber', 18:02:28 INFO - 'read-buildbot-config', 18:02:28 INFO - 'download-and-extract', 18:02:28 INFO - 'populate-webroot', 18:02:28 INFO - 'create-virtualenv', 18:02:28 INFO - 'install', 18:02:28 INFO - 'run-tests'), 18:02:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:02:28 INFO - 'download_minidump_stackwalk': True, 18:02:28 INFO - 'download_symbols': 'ondemand', 18:02:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:02:28 INFO - 'tooltool.py': '/tools/tooltool.py', 18:02:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:02:28 INFO - '/tools/misc-python/virtualenv.py')}, 18:02:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:02:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:02:28 INFO - 'installer_path': 'installer.exe', 18:02:28 INFO - 'log_level': 'info', 18:02:28 INFO - 'log_name': 'talos', 18:02:28 INFO - 'log_to_console': True, 18:02:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:02:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:02:28 INFO - 'opt_config_files': (), 18:02:28 INFO - 'pip_index': False, 18:02:28 INFO - 'sps_profile': False, 18:02:28 INFO - 'sps_profile_interval': 0, 18:02:28 INFO - 'suite': 'dromaeojs', 18:02:28 INFO - 'system_bits': '32', 18:02:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:02:28 INFO - 'title': 'talos-linux64-ix-045', 18:02:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:02:28 INFO - 'use_talos_json': True, 18:02:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:02:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:02:28 INFO - 'work_dir': 'build'} 18:02:28 INFO - ##### 18:02:28 INFO - ##### Running clobber step. 18:02:28 INFO - ##### 18:02:28 INFO - Running pre-action listener: _resource_record_pre_action 18:02:28 INFO - Running main action method: clobber 18:02:28 INFO - rmtree: /builds/slave/test/build 18:02:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:02:28 INFO - Running post-action listener: _resource_record_post_action 18:02:28 INFO - ##### 18:02:28 INFO - ##### Running read-buildbot-config step. 18:02:28 INFO - ##### 18:02:28 INFO - Running pre-action listener: _resource_record_pre_action 18:02:28 INFO - Running main action method: read_buildbot_config 18:02:28 INFO - Using buildbot properties: 18:02:28 INFO - { 18:02:28 INFO - "project": "", 18:02:28 INFO - "product": "firefox", 18:02:28 INFO - "script_repo_revision": "production", 18:02:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:02:28 INFO - "repository": "", 18:02:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:02:28 INFO - "buildid": "20160322163032", 18:02:28 INFO - "pgo_build": "False", 18:02:28 INFO - "basedir": "/builds/slave/test", 18:02:28 INFO - "buildnumber": 454, 18:02:28 INFO - "slavename": "talos-linux64-ix-045", 18:02:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:02:28 INFO - "platform": "ubuntu64_hw", 18:02:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:02:28 INFO - "branch": "mozilla-central", 18:02:28 INFO - "repo_path": "mozilla-central", 18:02:28 INFO - "revision": "5453ae837f6a9394f01f2219c3998098f23a41fb", 18:02:28 INFO - "stage_platform": "linux64", 18:02:28 INFO - "builduid": "2523bafb3ef245a78741312eb8fe062e", 18:02:28 INFO - "slavebuilddir": "test" 18:02:28 INFO - } 18:02:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:02:28 INFO - Running post-action listener: _resource_record_post_action 18:02:28 INFO - ##### 18:02:28 INFO - ##### Running download-and-extract step. 18:02:28 INFO - ##### 18:02:28 INFO - Running pre-action listener: _resource_record_pre_action 18:02:28 INFO - Running main action method: download_and_extract 18:02:28 INFO - mkdir: /builds/slave/test/build/tests 18:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:28 INFO - https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:29 INFO - Downloaded 1361 bytes. 18:02:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:02:29 INFO - Using the following test package requirements: 18:02:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:02:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:02:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:02:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:29 INFO - u'jsshell-linux-x86_64.zip'], 18:02:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:02:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:02:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:02:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:02:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:02:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:02:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:29 INFO - https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:02:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:02:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:02:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:34 INFO - Downloaded 22001980 bytes. 18:02:34 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'] 18:02:34 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 18:02:35 INFO - Return code: 0 18:02:35 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 18:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:35 INFO - https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:40 INFO - Downloaded 22001980 bytes. 18:02:40 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'] 18:02:40 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 18:02:41 INFO - Return code: 0 18:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:41 INFO - https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:43 INFO - Downloaded 10848120 bytes. 18:02:43 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'] 18:02:43 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 18:02:43 INFO - Return code: 0 18:02: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')]} 18:02:43 INFO - https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N71FFfdHSvmcaibHUay6bg/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 18:02:49 INFO - Downloaded 54175546 bytes. 18:02:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:02:49 INFO - mkdir: /builds/slave/test/properties 18:02:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:02:49 INFO - Writing to file /builds/slave/test/properties/build_url 18:02:49 INFO - Contents: 18:02:49 INFO - build_url:https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:02:51 INFO - Running post-action listener: _resource_record_post_action 18:02:51 INFO - Running post-action listener: set_extra_try_arguments 18:02:51 INFO - ##### 18:02:51 INFO - ##### Running populate-webroot step. 18:02:51 INFO - ##### 18:02:51 INFO - Running pre-action listener: _resource_record_pre_action 18:02:51 INFO - Running main action method: populate_webroot 18:02:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:02:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:02:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:02:51 INFO - '--tppagecycles', 18:02:51 INFO - '7'], 18:02:51 INFO - 'tests': ['tsvgm']}}, 18:02:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:02:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:02:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:02:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:02:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:02:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:51 INFO - 'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:02:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:51 INFO - 'tests': ['damp', 'tps']}, 18:02:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:51 INFO - 'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['damp', 'tps']}, 18:02:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:02:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:02:51 INFO - 'other': {'tests': ['a11yr', 18:02:51 INFO - 'ts_paint', 18:02:51 INFO - 'tpaint', 18:02:51 INFO - 'sessionrestore', 18:02:51 INFO - 'sessionrestore_no_auto_restore', 18:02:51 INFO - 'tabpaint']}, 18:02:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['a11yr', 18:02:51 INFO - 'ts_paint', 18:02:51 INFO - 'tpaint', 18:02:51 INFO - 'sessionrestore', 18:02:51 INFO - 'sessionrestore_no_auto_restore', 18:02:51 INFO - 'tabpaint']}, 18:02:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['a11yr', 18:02:51 INFO - 'ts_paint', 18:02:51 INFO - 'tpaint', 18:02:51 INFO - 'sessionrestore', 18:02:51 INFO - 'sessionrestore_no_auto_restore', 18:02:51 INFO - 'tabpaint']}, 18:02:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['a11yr', 18:02:51 INFO - 'ts_paint', 18:02:51 INFO - 'tpaint', 18:02:51 INFO - 'sessionrestore', 18:02:51 INFO - 'sessionrestore_no_auto_restore', 18:02:51 INFO - 'tabpaint']}, 18:02:51 INFO - 'other_l64': {'tests': ['a11yr', 18:02:51 INFO - 'ts_paint', 18:02:51 INFO - 'tpaint', 18:02:51 INFO - 'sessionrestore', 18:02:51 INFO - 'sessionrestore_no_auto_restore', 18:02:51 INFO - 'tabpaint']}, 18:02:51 INFO - 'other_nol64': {'tests': ['a11yr', 18:02:51 INFO - 'ts_paint', 18:02:51 INFO - 'tpaint', 18:02:51 INFO - 'sessionrestore', 18:02:51 INFO - 'sessionrestore_no_auto_restore', 18:02:51 INFO - 'tabpaint']}, 18:02:51 INFO - 'svgr': {'tests': ['tsvgx', 18:02:51 INFO - 'tsvgr_opacity', 18:02:51 INFO - 'tart', 18:02:51 INFO - 'tscrollx', 18:02:51 INFO - 'cart']}, 18:02:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['tsvgx', 18:02:51 INFO - 'tsvgr_opacity', 18:02:51 INFO - 'tart', 18:02:51 INFO - 'tscrollx', 18:02:51 INFO - 'cart']}, 18:02:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:51 INFO - 'tests': ['tp5o']}, 18:02:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:51 INFO - 'talos_options': ['--e10s'], 18:02:51 INFO - 'tests': ['tp5o']}, 18:02:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:51 INFO - 'talos_options': ['--xperf_path', 18:02:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:02:51 INFO - 'tests': ['tp5n']}, 18:02:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:51 INFO - 'talos_options': ['--e10s', 18:02:51 INFO - '--xperf_path', 18:02:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:02:51 INFO - 'tests': ['tp5n']}}, 18:02:51 INFO - 'talos.zip': {'path': '', 18:02:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:02:51 INFO - Running post-action listener: _resource_record_post_action 18:02:51 INFO - ##### 18:02:51 INFO - ##### Running create-virtualenv step. 18:02:51 INFO - ##### 18:02:51 INFO - Running pre-action listener: _resource_record_pre_action 18:02:51 INFO - Running main action method: create_virtualenv 18:02:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:02:51 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 18:02:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:02:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:02:51 INFO - Using real prefix '/usr' 18:02:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:02:51 INFO - Installing distribute.............................................................................................................................................................................................done. 18:02:53 INFO - Installing pip.................done. 18:02:53 INFO - Return code: 0 18:02:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:02: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')]} 18:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02: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')]} 18:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02: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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:02: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 18:02: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 18:02:53 INFO - Using env: {'DISPLAY': ':0', 18:02:53 INFO - 'HOME': '/home/cltbld', 18:02:53 INFO - 'LANG': 'en_US.UTF-8', 18:02:53 INFO - 'LANGUAGE': 'en_US:en', 18:02:53 INFO - 'LOGNAME': 'cltbld', 18:02:53 INFO - 'MAIL': '/var/mail/cltbld', 18:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:53 INFO - 'MOZ_NO_REMOTE': '1', 18:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:02:53 INFO - 'NO_EM_RESTART': '1', 18:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:53 INFO - 'PWD': '/builds/slave/test', 18:02:53 INFO - 'SHELL': '/bin/bash', 18:02:53 INFO - 'SHLVL': '1', 18:02:53 INFO - 'TERM': 'linux', 18:02:53 INFO - 'TMOUT': '86400', 18:02:53 INFO - 'USER': 'cltbld', 18:02:53 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:53 INFO - '_': '/tools/buildbot/bin/python'} 18:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02: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 18:02:53 INFO - Cleaning up... 18:02:53 INFO - Return code: 0 18:02:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:02: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')]} 18:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02: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')]} 18:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02: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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:02: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 18:02: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 18:02:53 INFO - Using env: {'DISPLAY': ':0', 18:02:53 INFO - 'HOME': '/home/cltbld', 18:02:53 INFO - 'LANG': 'en_US.UTF-8', 18:02:53 INFO - 'LANGUAGE': 'en_US:en', 18:02:53 INFO - 'LOGNAME': 'cltbld', 18:02:53 INFO - 'MAIL': '/var/mail/cltbld', 18:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:53 INFO - 'MOZ_NO_REMOTE': '1', 18:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:02:53 INFO - 'NO_EM_RESTART': '1', 18:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:53 INFO - 'PWD': '/builds/slave/test', 18:02:53 INFO - 'SHELL': '/bin/bash', 18:02:53 INFO - 'SHLVL': '1', 18:02:53 INFO - 'TERM': 'linux', 18:02:53 INFO - 'TMOUT': '86400', 18:02:53 INFO - 'USER': 'cltbld', 18:02:53 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:53 INFO - '_': '/tools/buildbot/bin/python'} 18:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:54 INFO - Downloading/unpacking psutil>=0.7.1 18:02:54 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 18:02:54 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 18:02:54 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 18:02:54 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 18:02:54 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 18:02:54 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 18:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:02:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:02:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:02:57 INFO - Installing collected packages: psutil 18:02:57 INFO - Running setup.py install for psutil 18:02:57 INFO - building 'psutil._psutil_linux' extension 18:02: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 18:02:58 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 18:02:58 INFO - building 'psutil._psutil_posix' extension 18:02:58 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 18:02:58 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 18:02:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:02:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:02:58 INFO - Successfully installed psutil 18:02:58 INFO - Cleaning up... 18:02:58 INFO - Return code: 0 18:02:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:02:58 INFO - Using env: {'DISPLAY': ':0', 18:02:58 INFO - 'HOME': '/home/cltbld', 18:02:58 INFO - 'LANG': 'en_US.UTF-8', 18:02:58 INFO - 'LANGUAGE': 'en_US:en', 18:02:58 INFO - 'LOGNAME': 'cltbld', 18:02:58 INFO - 'MAIL': '/var/mail/cltbld', 18:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:58 INFO - 'MOZ_NO_REMOTE': '1', 18:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:02:58 INFO - 'NO_EM_RESTART': '1', 18:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:58 INFO - 'PWD': '/builds/slave/test', 18:02:58 INFO - 'SHELL': '/bin/bash', 18:02:58 INFO - 'SHLVL': '1', 18:02:58 INFO - 'TERM': 'linux', 18:02:58 INFO - 'TMOUT': '86400', 18:02:58 INFO - 'USER': 'cltbld', 18:02:58 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:58 INFO - '_': '/tools/buildbot/bin/python'} 18:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:03: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) 18:03:01 INFO - Installing collected packages: mozsystemmonitor 18:03:01 INFO - Running setup.py install for mozsystemmonitor 18:03:01 INFO - Successfully installed mozsystemmonitor 18:03:01 INFO - Cleaning up... 18:03:01 INFO - Return code: 0 18:03:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:03: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')]} 18:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03: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')]} 18:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03: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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:03: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 18:03: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 18:03:01 INFO - Using env: {'DISPLAY': ':0', 18:03:01 INFO - 'HOME': '/home/cltbld', 18:03:01 INFO - 'LANG': 'en_US.UTF-8', 18:03:01 INFO - 'LANGUAGE': 'en_US:en', 18:03:01 INFO - 'LOGNAME': 'cltbld', 18:03:01 INFO - 'MAIL': '/var/mail/cltbld', 18:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:01 INFO - 'MOZ_NO_REMOTE': '1', 18:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:01 INFO - 'NO_EM_RESTART': '1', 18:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:01 INFO - 'PWD': '/builds/slave/test', 18:03:01 INFO - 'SHELL': '/bin/bash', 18:03:01 INFO - 'SHLVL': '1', 18:03:01 INFO - 'TERM': 'linux', 18:03:01 INFO - 'TMOUT': '86400', 18:03:01 INFO - 'USER': 'cltbld', 18:03:01 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:01 INFO - '_': '/tools/buildbot/bin/python'} 18:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:01 INFO - Downloading/unpacking blobuploader==1.2.4 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:03 INFO - Downloading blobuploader-1.2.4.tar.gz 18:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:03:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:03:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:04 INFO - Downloading docopt-0.6.1.tar.gz 18:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:03:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:03:04 INFO - Running setup.py install for blobuploader 18:03:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:03:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:03:04 INFO - Running setup.py install for requests 18:03:04 INFO - Running setup.py install for docopt 18:03:04 INFO - Successfully installed blobuploader requests docopt 18:03:04 INFO - Cleaning up... 18:03:04 INFO - Return code: 0 18:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:04 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')]} 18:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:04 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')]} 18:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:04 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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:03:04 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 18:03:04 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 18:03:04 INFO - Using env: {'DISPLAY': ':0', 18:03:04 INFO - 'HOME': '/home/cltbld', 18:03:04 INFO - 'LANG': 'en_US.UTF-8', 18:03:04 INFO - 'LANGUAGE': 'en_US:en', 18:03:04 INFO - 'LOGNAME': 'cltbld', 18:03:04 INFO - 'MAIL': '/var/mail/cltbld', 18:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:04 INFO - 'MOZ_NO_REMOTE': '1', 18:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:04 INFO - 'NO_EM_RESTART': '1', 18:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:04 INFO - 'PWD': '/builds/slave/test', 18:03:04 INFO - 'SHELL': '/bin/bash', 18:03:04 INFO - 'SHLVL': '1', 18:03:04 INFO - 'TERM': 'linux', 18:03:04 INFO - 'TMOUT': '86400', 18:03:04 INFO - 'USER': 'cltbld', 18:03:04 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:04 INFO - '_': '/tools/buildbot/bin/python'} 18:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:03:05 INFO - Running setup.py (path:/tmp/pip-EJuX0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:03:05 INFO - Running setup.py (path:/tmp/pip-b1dve5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:03:05 INFO - Running setup.py (path:/tmp/pip-alNwW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:03:05 INFO - Running setup.py (path:/tmp/pip-0BlAU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:03:05 INFO - Running setup.py (path:/tmp/pip-c7Cdk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:03:05 INFO - Running setup.py (path:/tmp/pip-ah7gBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:03:05 INFO - Running setup.py (path:/tmp/pip-xLXoGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:03:05 INFO - Running setup.py (path:/tmp/pip-T5fuuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:03:05 INFO - Running setup.py (path:/tmp/pip-uqCkcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:03:05 INFO - Running setup.py (path:/tmp/pip-plQt0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:03:05 INFO - Running setup.py (path:/tmp/pip-RR5lSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:03:05 INFO - Running setup.py (path:/tmp/pip-Yt9JLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:03:06 INFO - Running setup.py (path:/tmp/pip-njJdE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:03:06 INFO - Running setup.py (path:/tmp/pip-NVPrhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:06 INFO - Running setup.py (path:/tmp/pip-eooJZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:03:06 INFO - Running setup.py (path:/tmp/pip-tKq00c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:03:06 INFO - Running setup.py (path:/tmp/pip-UibQET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:03:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:03:06 INFO - Running setup.py install for manifestparser 18:03:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:03:06 INFO - Running setup.py install for mozcrash 18:03:06 INFO - Running setup.py install for mozdebug 18:03:06 INFO - Running setup.py install for mozdevice 18:03:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:03:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:03:06 INFO - Running setup.py install for mozfile 18:03:06 INFO - Running setup.py install for mozhttpd 18:03:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for mozinfo 18:03:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for mozInstall 18:03:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for mozleak 18:03:07 INFO - Running setup.py install for mozlog 18:03:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for moznetwork 18:03:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for mozprocess 18:03:07 INFO - Running setup.py install for mozprofile 18:03:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for mozrunner 18:03:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:03:07 INFO - Running setup.py install for mozscreenshot 18:03:07 INFO - Running setup.py install for moztest 18:03:08 INFO - Running setup.py install for mozversion 18:03:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:03:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:03:08 INFO - Cleaning up... 18:03:08 INFO - Return code: 0 18:03:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:08 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')]} 18:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:08 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')]} 18:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:08 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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:03:08 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 18:03:08 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 18:03:08 INFO - Using env: {'DISPLAY': ':0', 18:03:08 INFO - 'HOME': '/home/cltbld', 18:03:08 INFO - 'LANG': 'en_US.UTF-8', 18:03:08 INFO - 'LANGUAGE': 'en_US:en', 18:03:08 INFO - 'LOGNAME': 'cltbld', 18:03:08 INFO - 'MAIL': '/var/mail/cltbld', 18:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:08 INFO - 'MOZ_NO_REMOTE': '1', 18:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:08 INFO - 'NO_EM_RESTART': '1', 18:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:08 INFO - 'PWD': '/builds/slave/test', 18:03:08 INFO - 'SHELL': '/bin/bash', 18:03:08 INFO - 'SHLVL': '1', 18:03:08 INFO - 'TERM': 'linux', 18:03:08 INFO - 'TMOUT': '86400', 18:03:08 INFO - 'USER': 'cltbld', 18:03:08 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:08 INFO - '_': '/tools/buildbot/bin/python'} 18:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:03:08 INFO - Running setup.py (path:/tmp/pip-0Bx2Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:03:08 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)) 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:03:08 INFO - Running setup.py (path:/tmp/pip-eyfDoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:03:08 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)) 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:03:08 INFO - Running setup.py (path:/tmp/pip-8_LGCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:03:08 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)) 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:03:08 INFO - Running setup.py (path:/tmp/pip-02JHOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:03:08 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)) 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:03:08 INFO - Running setup.py (path:/tmp/pip-wuC9Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:03:08 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)) 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:03:08 INFO - Running setup.py (path:/tmp/pip-bBwBmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:03:08 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)) 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:03:08 INFO - Running setup.py (path:/tmp/pip-da48d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:03:08 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)) 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:03:08 INFO - Running setup.py (path:/tmp/pip-voasDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:03:08 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)) 18:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:03:08 INFO - Running setup.py (path:/tmp/pip-2XN9IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:03: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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:03:09 INFO - Running setup.py (path:/tmp/pip-eIDvr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:03: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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:03:09 INFO - Running setup.py (path:/tmp/pip-IVa4DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:03:09 INFO - Running setup.py (path:/tmp/pip-oOkcj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:03:09 INFO - Running setup.py (path:/tmp/pip-4g4Xhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:03:09 INFO - Running setup.py (path:/tmp/pip-3Fnl4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:09 INFO - Running setup.py (path:/tmp/pip-fPik6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:03:09 INFO - Running setup.py (path:/tmp/pip-WVQ8GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:03:09 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)) 18:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:03:09 INFO - Running setup.py (path:/tmp/pip-ooWEZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:03:09 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)) 18:03:09 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)) 18:03:09 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)) 18:03:09 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)) 18:03:09 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)) 18:03:09 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)) 18:03:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:03:09 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 18:03:09 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 18:03:09 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 18:03:09 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 18:03:09 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 18:03:09 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 18:03:12 INFO - Downloading blessings-1.6.tar.gz 18:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:03:12 INFO - Installing collected packages: blessings 18:03:12 INFO - Running setup.py install for blessings 18:03:12 INFO - Successfully installed blessings 18:03:12 INFO - Cleaning up... 18:03:12 INFO - Return code: 0 18:03:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:03:12 INFO - Reading from file tmpfile_stdout 18:03:12 INFO - Current package versions: 18:03:12 INFO - argparse == 1.2.1 18:03:12 INFO - blessings == 1.6 18:03:12 INFO - blobuploader == 1.2.4 18:03:12 INFO - docopt == 0.6.1 18:03:12 INFO - manifestparser == 1.1 18:03:12 INFO - mozInstall == 1.12 18:03:12 INFO - mozcrash == 0.17 18:03:12 INFO - mozdebug == 0.1 18:03:12 INFO - mozdevice == 0.48 18:03:12 INFO - mozfile == 1.2 18:03:12 INFO - mozhttpd == 0.7 18:03:12 INFO - mozinfo == 0.9 18:03:12 INFO - mozleak == 0.1 18:03:12 INFO - mozlog == 3.1 18:03:12 INFO - moznetwork == 0.27 18:03:12 INFO - mozprocess == 0.22 18:03:12 INFO - mozprofile == 0.28 18:03:12 INFO - mozrunner == 6.11 18:03:12 INFO - mozscreenshot == 0.1 18:03:12 INFO - mozsystemmonitor == 0.0 18:03:12 INFO - moztest == 0.7 18:03:12 INFO - mozversion == 1.4 18:03:12 INFO - psutil == 3.1.1 18:03:12 INFO - requests == 1.2.3 18:03:12 INFO - wsgiref == 0.1.2 18:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:12 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')]} 18:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:12 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')]} 18:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:12 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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:03:12 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 18:03:12 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 18:03:12 INFO - Using env: {'DISPLAY': ':0', 18:03:12 INFO - 'HOME': '/home/cltbld', 18:03:12 INFO - 'LANG': 'en_US.UTF-8', 18:03:12 INFO - 'LANGUAGE': 'en_US:en', 18:03:12 INFO - 'LOGNAME': 'cltbld', 18:03:12 INFO - 'MAIL': '/var/mail/cltbld', 18:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:12 INFO - 'MOZ_NO_REMOTE': '1', 18:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:12 INFO - 'NO_EM_RESTART': '1', 18:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:12 INFO - 'PWD': '/builds/slave/test', 18:03:12 INFO - 'SHELL': '/bin/bash', 18:03:12 INFO - 'SHLVL': '1', 18:03:12 INFO - 'TERM': 'linux', 18:03:12 INFO - 'TMOUT': '86400', 18:03:12 INFO - 'USER': 'cltbld', 18:03:12 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:12 INFO - '_': '/tools/buildbot/bin/python'} 18:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 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)) 18:03:12 INFO - Cleaning up... 18:03:12 INFO - Return code: 0 18:03:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:03:12 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')]} 18:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:12 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')]} 18:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:12 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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:03:12 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 18:03:12 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 18:03:12 INFO - Using env: {'DISPLAY': ':0', 18:03:12 INFO - 'HOME': '/home/cltbld', 18:03:12 INFO - 'LANG': 'en_US.UTF-8', 18:03:12 INFO - 'LANGUAGE': 'en_US:en', 18:03:12 INFO - 'LOGNAME': 'cltbld', 18:03:12 INFO - 'MAIL': '/var/mail/cltbld', 18:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:12 INFO - 'MOZ_NO_REMOTE': '1', 18:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:12 INFO - 'NO_EM_RESTART': '1', 18:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:12 INFO - 'PWD': '/builds/slave/test', 18:03:12 INFO - 'SHELL': '/bin/bash', 18:03:12 INFO - 'SHLVL': '1', 18:03:12 INFO - 'TERM': 'linux', 18:03:12 INFO - 'TMOUT': '86400', 18:03:12 INFO - 'USER': 'cltbld', 18:03:12 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:12 INFO - '_': '/tools/buildbot/bin/python'} 18:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:13 INFO - Downloading/unpacking jsonschema 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:03:15 INFO - Downloading/unpacking functools32 (from jsonschema) 18:03:15 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 18:03:15 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 18:03:15 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 18:03:15 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 18:03:15 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 18:03:15 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 18:03:15 INFO - Downloading functools32-3.2.3-2.tar.gz 18:03:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:03:15 INFO - warning: no files found matching '*.txt' 18:03:15 INFO - no previously-included directories found matching 'build' 18:03:15 INFO - no previously-included directories found matching 'dist' 18:03:15 INFO - no previously-included directories found matching '.git*' 18:03:15 INFO - Installing collected packages: jsonschema, functools32 18:03:15 INFO - Running setup.py install for functools32 18:03:15 INFO - warning: no files found matching '*.txt' 18:03:15 INFO - no previously-included directories found matching 'build' 18:03:15 INFO - no previously-included directories found matching 'dist' 18:03:15 INFO - no previously-included directories found matching '.git*' 18:03:15 INFO - Successfully installed jsonschema functools32 18:03:15 INFO - Cleaning up... 18:03:15 INFO - Return code: 0 18:03:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:15 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 0x7f6b23985f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, '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': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', '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 18:03:15 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 18:03:15 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 18:03:15 INFO - Using env: {'DISPLAY': ':0', 18:03:15 INFO - 'HOME': '/home/cltbld', 18:03:15 INFO - 'LANG': 'en_US.UTF-8', 18:03:15 INFO - 'LANGUAGE': 'en_US:en', 18:03:15 INFO - 'LOGNAME': 'cltbld', 18:03:15 INFO - 'MAIL': '/var/mail/cltbld', 18:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:15 INFO - 'MOZ_NO_REMOTE': '1', 18:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:15 INFO - 'NO_EM_RESTART': '1', 18:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:15 INFO - 'PWD': '/builds/slave/test', 18:03:15 INFO - 'SHELL': '/bin/bash', 18:03:15 INFO - 'SHLVL': '1', 18:03:15 INFO - 'TERM': 'linux', 18:03:15 INFO - 'TMOUT': '86400', 18:03:15 INFO - 'USER': 'cltbld', 18:03:15 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:15 INFO - '_': '/tools/buildbot/bin/python'} 18:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:16 INFO - Downloading/unpacking flake8 18:03:16 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 18:03:16 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 18:03:16 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 18:03:16 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 18:03:16 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 18:03:16 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 18:03:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:03:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:03:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:03:18 INFO - no previously-included directories found matching 'docs/_build' 18:03:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:03:18 INFO - Running setup.py install for pep8 18:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:03:18 INFO - no previously-included directories found matching 'docs/_build' 18:03:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:03:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:03:19 INFO - Cleaning up... 18:03:19 INFO - Return code: 0 18:03:19 INFO - Running post-action listener: _resource_record_post_action 18:03:19 INFO - Running post-action listener: _start_resource_monitoring 18:03:19 INFO - Starting resource monitoring. 18:03:19 INFO - ##### 18:03:19 INFO - ##### Running install step. 18:03:19 INFO - ##### 18:03:19 INFO - Running pre-action listener: _resource_record_pre_action 18:03:19 INFO - Running main action method: install 18:03:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:03:19 INFO - Reading from file tmpfile_stdout 18:03:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:03:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:03:19 INFO - Reading from file tmpfile_stdout 18:03:19 INFO - Output received: 18:03:19 INFO - Usage: mozinstall [options] installer 18:03:19 INFO - Options: 18:03:19 INFO - -h, --help show this help message and exit 18:03:19 INFO - -d DEST, --destination=DEST 18:03:19 INFO - Directory to install application into. [default: 18:03:19 INFO - "/builds/slave/test"] 18:03:19 INFO - --app=APP Application being installed. [default: firefox] 18:03:19 INFO - mkdir: /builds/slave/test/build/application 18:03:19 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'] 18:03:19 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 18:03:35 INFO - Reading from file tmpfile_stdout 18:03:35 INFO - Output received: 18:03:35 INFO - /builds/slave/test/build/application/firefox/firefox 18:03:35 INFO - Running post-action listener: _resource_record_post_action 18:03:35 INFO - ##### 18:03:35 INFO - ##### Running run-tests step. 18:03:35 INFO - ##### 18:03:35 INFO - Running pre-action listener: _resource_record_pre_action 18:03:35 INFO - Running main action method: run_tests 18:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:03:35 INFO - Python 2.7.3 18:03:35 INFO - Return code: 0 18:03:35 INFO - grabbing minidump binary from tooltool 18:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:35 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 0x2344410>, '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 0x2345310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23457a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:03:35 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 18:03:35 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 18:03:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:03:35 INFO - Return code: 0 18:03:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:03:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:03:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:03:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:03:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:03:36 INFO - Return code: 0 18:03:36 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/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 18:03:36 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/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 18:03:36 INFO - Using env: {'DISPLAY': ':0', 18:03:36 INFO - 'HOME': '/home/cltbld', 18:03:36 INFO - 'LANG': 'en_US.UTF-8', 18:03:36 INFO - 'LANGUAGE': 'en_US:en', 18:03:36 INFO - 'LOGNAME': 'cltbld', 18:03:36 INFO - 'MAIL': '/var/mail/cltbld', 18:03:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:03:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:36 INFO - 'MOZ_NO_REMOTE': '1', 18:03:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:36 INFO - 'NO_EM_RESTART': '1', 18:03:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:36 INFO - 'PWD': '/builds/slave/test', 18:03:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:03:36 INFO - 'SHELL': '/bin/bash', 18:03:36 INFO - 'SHLVL': '1', 18:03:36 INFO - 'TERM': 'linux', 18:03:36 INFO - 'TMOUT': '86400', 18:03:36 INFO - 'USER': 'cltbld', 18:03:36 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065', 18:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:36 INFO - '_': '/tools/buildbot/bin/python'} 18:03:36 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/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 18:03:36 INFO - mozversion application_buildid: 20160322163032 18:03:36 INFO - mozversion application_changeset: 5453ae837f6a9394f01f2219c3998098f23a41fb 18:03:36 INFO - mozversion application_display_name: Nightly 18:03:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:03:36 INFO - mozversion application_name: Firefox 18:03:36 INFO - mozversion application_remotingname: firefox 18:03:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:03:36 INFO - mozversion application_vendor: Mozilla 18:03:36 INFO - mozversion application_version: 48.0a1 18:03:36 INFO - mozversion platform_buildid: 20160322163032 18:03:36 INFO - mozversion platform_changeset: 5453ae837f6a9394f01f2219c3998098f23a41fb 18:03:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:03:36 INFO - mozversion platform_version: 48.0a1 18:03:36 INFO - using testdate: 1458695016 18:03:36 INFO - actual date: 1458695016 18:03:36 INFO - starting webserver on 'localhost:50450' 18:03:36 INFO - SUITE-START | Running 2 tests 18:03:36 INFO - TEST-START | dromaeo_css 18:03:36 INFO - operating with platform_type : linux_ 18:03:36 INFO - Initialising browser for dromaeo_css test... 18:03:36 INFO - TEST-INFO | started process 5478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGB63_V/profile http://localhost:50450/getInfo.html) 18:03:40 INFO - PROCESS | 5478 | __metrics Screen width/height:1600/1200 18:03:40 INFO - PROCESS | 5478 | colorDepth:24 18:03:40 INFO - PROCESS | 5478 | Browser inner width/height: 1024/697 18:03:40 INFO - PROCESS | 5478 | __metrics 18:03:41 ERROR - PROCESS | 5478 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:03:41 INFO - PROCESS | 5478 | 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. 18:03:42 INFO - TEST-INFO | 5478: exit 0 18:03:42 INFO - Browser initialized. 18:03:42 INFO - Running cycle 1/1 for dromaeo_css test... 18:03:42 INFO - TEST-INFO | started process 5572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGB63_V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:54 INFO - PROCESS | 5572 | RSS: Main: 157634560 18:03:54 INFO - PROCESS | 5572 | 18:04:45 INFO - PROCESS | 5572 | 1458695085060 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] 18:06:57 INFO - PROCESS | 5572 | Cycle 1(1): loaded http://localhost:50450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50450/tests/dromaeo/cssquery-ext.html) 18:06:58 INFO - PROCESS | 5572 | RSS: Main: 246636544 18:06:58 INFO - PROCESS | 5572 | 18:10:01 INFO - PROCESS | 5572 | Cycle 1(1): loaded http://localhost:50450/tests/dromaeo/cssquery-ext.html (next: http://localhost:50450/tests/dromaeo/cssquery-jquery.html) 18:10:01 INFO - PROCESS | 5572 | RSS: Main: 238104576 18:10:01 INFO - PROCESS | 5572 | 18:13:03 INFO - PROCESS | 5572 | Cycle 1(1): loaded http://localhost:50450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50450/tests/dromaeo/cssquery-mootools.html) 18:13:04 INFO - PROCESS | 5572 | RSS: Main: 238030848 18:13:04 INFO - PROCESS | 5572 | 18:16:06 INFO - PROCESS | 5572 | Cycle 1(1): loaded http://localhost:50450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50450/tests/dromaeo/cssquery-prototype.html) 18:16:06 INFO - PROCESS | 5572 | RSS: Main: 207093760 18:16:06 INFO - PROCESS | 5572 | 18:19:09 INFO - PROCESS | 5572 | Cycle 1(1): loaded http://localhost:50450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50450/tests/dromaeo/cssquery-yui.html) 18:19:10 INFO - PROCESS | 5572 | RSS: Main: 202731520 18:19:10 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | Cycle 1(1): loaded http://localhost:50450/tests/dromaeo/cssquery-yui.html (next: http://localhost:50450/tests/dromaeo/cssquery-dojo.html) 18:22:12 INFO - PROCESS | 5572 | RSS: Main: 289533952 18:22:12 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | __start_tp_report 18:22:12 INFO - PROCESS | 5572 | _x_x_mozilla_page_load 18:22:12 INFO - PROCESS | 5572 | _x_x_mozilla_page_load_details 18:22:12 INFO - PROCESS | 5572 | |i|pagename|runs| 18:22:12 INFO - PROCESS | 5572 | |0;dojo.html;2578.355411147213;2645.6163856240833;2649.5495765719825;2652.3501742073195;2659.1756555467796;4484.4618645762475;4551.6586256030805;4558.133954548638;4566.429196350457;4570.451545814507;4507.323901414789;4608.861734147972;4674.08855273221;4694.4366675998845;4710.811567537303;4258.850940217093;4291.463567054118;4307.655387568987;4354.129174165164;4386.451693538308;4250.766207858566;4344.978929951459;4346.478422589278;4387.868363949086;4395.296752519597;4202.432671589327;4275.209086319041;4303.91392172158;4343.826246950118;4365.039691267916;4251.723637963553;4254.276772948606;4268.509121451042;4269.295566231568;4272.038791271939;4240.385144154111;4241.024564350186;4241.448611680462;4243.448351714257;4245.575442455761;4448.421705178306;4484;4490.87728067983;4531.184386810372;4578.35902973584;4950.133726597831;4951.876203094916;4954.2568614707725;4954.653174277802;4993.350864387607;4831.251156070814;4969.254611808222;4974.87562810929;4976.552110310089;5015.648904576681;4670.322803193518;4670.6497012724185;4699.154152252593;4705.576498115186;4717.339572459859;5093.719845408538;5101.974490127525;5104.69371837691;5105.2086926526445;5105.489451054865;4733.83431579893;4882.6826256293225;4886.560209581155;4890.804367825247;4951;4904.4605093440405;4925;4928.236123400879;4931.50684931504;4975.502449754996;4874.8050077997195;4882.292067650171;4885.827401423704;4890.535399137077;4949.133901567211;4769.57073863354;4845.466998630148;4847;4849.151398505247;4939.431965324034;4112.670986321147;4113.938290925578;4118.382242663624;4130.793460327031;4135.958640413557;3645.5625324961175;3670.064133645903;3689.3912504436466;3689.815509224528;3691.1694868654877;4299.376590394375;4301.956980430218;4316.438862947797;4320.308750599889;4376.978115109468;4979.402471703419;5027.170516864677;5033.79864805411;5037.345145131109;5074.695518268842;4192.916141677149;4309.612134907873;4331.371951067078;4336.219480493542;4361.127774445124;4455.1535208310315;4459.264221403497;4462.286034234507;4506.842260520866;4510.819567217341;4669.509701481432;4684.929726054112;4688.179568575418;4696.953030469652;4720.858374248778;4861.611071114373;4889.853304400874;4953.925691114564;4976.154053810933;4987.47631498702;4664.113818374498;4670;4681.882952926204;4701.341812146234;4724.881877953078;4912.8771780705765;4913.8034478621885;4915.582175515121;4915.852524424273;4960.578350840219;4842.322074909586;4915.729634869974;4919.729414882216;4992.900141997213;5032.924506132338;4759.690620109682;4769.4753577107185;4776.761161941959;4777.665563410528;4819.108464933998;4769.2130798417875;4779.06808172403;4779.5220477951925;4780.1873681473535;4818.10864989978;4611.515790842048;4698.459677137173;4719.693219940693;4761.571458568746;4780.139574876555;4839.516048395132;4860.659753817199;4860.708357498562;4865.391826021747;4893.290472881484;4764.380630518011;4766.7854946526795;4774.427068751772;4774.856754297377;4818.7831547581145 18:22:12 INFO - PROCESS | 5572 | |1;ext.html;500.1896926978298;507.3936645708378;523.3484312031521;523.9895202095959;546.3553007451208;27627.861860690693;28113.43773124536;28117.437651247015;28137.57793633097;34423.48364774524;32947.341053178985;33342.49986250208;33407.498887516645;33435.66564334362;33473;7704.383649308042;7898.763037108896;7902;7909.446338756289;7910.406719496032;7592.696292148307;7611.1627720950655;7798.844023119563;7804.60976951153;10022;9948.90051099487;10046.34698744583;10053.849192262122;10056.949715251414;10070.647527336545;9845.60617575296;9954.651587194414;9957.153641940444;9957.55191016406;9964.153046991014;9473.715788526355;9597.520123993841;9597.616095356178;9600.471974041426;9605.951970240174;35129;38452.230955380735;38709;38732.22535549273;38749.41875871836;2994.7304742573274;3064.6475655299705;3154.952675709866;3176.9682303176905;3540.7521473496868;29805.701942980508;29913;30422.391552168832;30423.391532169455;32282;3464.7574669773126;3471.861125554975;3501.369753444379;3510.596281427643;3516.49010893419;250218;253357.99999999817;253992;254988;255687;41658.79170604127;59123.40876591265;59786.40213597808;59817.40182598205;59843.10235346473;35753.1061723459;35880.64119358773;36019.099522512144;36055.4591681125;36072.27855442876;12226.75546489083;12454.875451245553;12464.5014199431;12475.6296303702;12493;9072.455652660861;9160.770980725536;9165.81668366629;9168.083191680778;9168.44989300644;12172.208806427554;12322.876771232352;12372.876271237172;13139.60581182566;14994.250287485582;5738.799142030009;5744.597878148489;5772.365039845614;5790.060329789568;5861.765529378862;897.8518544440225;970.669972209438;978.6036655154674;994.8060128275062;1038.5378506564507;25920.740792591834;26354.341141471617;26406.207813765617;26463.470730585665;26481.47037059248;944.5985456181096;979.5934687104772;994.5425104451889;1004.0662184168647;1037.9740506487246;14343.56969290923;14446.638834029234;14491;14714.852851471349;14743.189124598035;299414;303910;304433;304916;305705;46834.531654683014;48277;48494.27258591124;48510.27234591484;48580.271295930586;1094.5567045346647;1143.1197977557235;1193.8149586814059;1219.3232755820427;1239.2007155384906;24543.631845521973;25051.24846254615;25541.23376298714;25716.228513144637;25758;37261.81369093137;38021.61978380291;38356;38358.424623631225;38408.615913840506;271377;275492;277308;277765;278380;34858.65141348554;40115.398269025405;40644.187116256915;40867.182656346115;42266;37898.43152352772;37914;37939.62060379471;38711;38958.61041389663;32524.18689532686;35547.64452355443;35555.644443556266;35593.64406355903;35691.64308356883;35287.29425411426;35418.11454713653;35510.82244588761;35773.284534308645;37882.24235515219;30447.391052179275;31278.06165815029;31632.209194769395;31779;31838.36323273475;29117.563236551894;31262.687373126886;31788;31805.681943180272;31889.840550797097;24834;24890.75109248957;24918.501629966937;24925.750742492342;25287.22989390725 18:22:12 INFO - PROCESS | 5572 | |2;jquery.html;349.87579409309694;353.9769914955528;353.9840707168178;356.5222601713705;360.72945291031726;14933.402663893432;15185.544433666993;15802.13088280144;16339.754903676454;16715.91642041791;14907.552773416788;14928.402863885432;15522.456714015012;15855.36578536857;15910.76133857993;5041.369828771403;5098;5243.6853788772605;5247.1866860636665;5270.499302566269;5179.689218646874;5183.663061900965;5215.426303106655;5219.71291578963;5222.660527065728;5158.303629010092;5163.81926632568;5173.6119791015635;5175.171972484403;5231.503007214308;4932.704037757746;5164.715940623264;5167.819126330561;5170.638055336128;5177.094008548508;4566.657500687462;4605.125026245037;4611.515790841947;4619.584237418649;4621.1219868224925;18898.149583268787;19875.50311242216;19970.600587988305;20026.39920802364;20064.89967550153;2005.458526197933;2021.5148364392587;2036.3890832750265;2054.4555692741437;2296.5062511559927;12522.373881305899;12861.807072893915;12948.254636432257;12955.09314347996;12999.220046797222;1751.0106789663798;1791.426743442086;1829.3688677406406;1852.2128095559467;1859.2655900919062;44546.55453445457;45818.770906145255;58481.70759146177;60144.39855601432;61183.694081529306;9829.55766990487;9934.900650993543;10006.449645269435;10121.595136194617;10203.489825508696;11402.885971140347;11837.46731397072;12343.876561234272;12982.935085324512;13037.217766934014;6764.0868482754195;6812;6817.761378351833;6925;6950.165980082322;6363.395477429729;6367.904481432783;6416.647084410309;6473.967630161913;6477;6075.969620151959;6237.781677641261;6239.719212635351;6244.188255526843;6293.3391993840905;1713.4945191168636;1715.828417158299;1737.800152982398;1739.850869925439;1740.8259174082743;853.108501615813;859.3509115684119;871.6992637540038;919.3197034194782;928.211020632457;16266.674666506604;16581.58546036359;16639.334426622798;16735.079570623733;17076.658466830842;882.7881308486045;949.7388218240039;960.151707962184;971.218169373661;999.7350702063959;9546.713598591914;9931.453770042717;9936.304458687822;9944.35361701487;10034.949825250973;392580;406058;406134;407940;409605;59032;60607.09089363663;60770.392296076476;61389.69305153446;62044.37955620476;950.3110245072405;963.8313295173317;964.6816550538306;975.7853272280087;977.7751117243074;14729.410823566937;14951.401943922121;14979.925100374865;14995;15354;21280.787192127882;25792;28985.565216521347;31857.8407107963;32350.514742278414;32880.34239315153;33274.500882487264;33967.49048764221;34436;37887.24225515419;7527.360174385239;7584.014078169803;7607.429442791702;7655.349295309738;7690.538567685957;10818.621348252773;11424.714382140513;11427;11545.307281563133;11752.471138798604;10094.293399461967;10235.539400726837;10248.59005639796;10300.433476158883;10439.37363758177;9880.950595246977;9887.456189909624;10378.325408848401;10627.946860265958;10742;9969.800603987735;10202.234832387452;10238.436885971343;10418;10440.42577658236;7389.519681220919;7410.592417416879;7444.813879652836;7614.010178676736;7617.809554761176;10119.949400252952;10175.643852465424;10243.539040743333;10310.742231444274;10335 18:22:12 INFO - PROCESS | 5572 | |3;mootools.html;1266.809978503225;1339.9196048237104;1424.8788852947503;1538.5538193923762;1743.058748275931;6025.758969641214;7057.752978645748;7239.20368759436;7244.420446364292;7259.056322678044;7048.400885924702;7216.314450127243;7218.63906804659;7223.241559636242;7223.313785190412;1912.9330473433433;2133.242698841912;2192.55052714194;2204.930608654805;2229.520653059592;2217.079911836586;2223.866568005925;2227.0312414099835;2228;2228.1533017453344;2138.6685063815135;2199;2200.6148923938326;2203.9421077882625;2209.9668504972437;2173.467500462389;2181.770914054025;2191.4192738924116;2271.9091236350528;2272.034385386204;2226.6437370020717;2234.2626933112033;2243.4054975431523;2245.4049676835652;2248.685184074231;7417.332440080419;7478.925210747877;7484.700611975514;7486.9251307486775;7499.325060744504;4484.596386325246;4573.039661671053;4592.0815836832435;4594.173048851206;4597.885052873671;2806.722941061812;2871.454423659498;2896.2614533294086;2901.6663083745216;2914.184028472031;853.3301358433662;861.7457849934221;864.1962974433774;882.4308321132834;886.4415418286503;9920.45437500937;9948.651797187136;9956;9997.15024222942;10005.549750261256;4029.37544680575;4065.065035041957;4146.709730318848;4152.563980782034;4154.91690166195;8567.057623661392;8583.05586385497;8589.055203927563;8608.870866937;8623.051464338918;3983.1635356575443;4462.531434199427;4464.799084041226;4464.843730469418;4466.173757854807;4042.8989275268355;4079.1637714268504;4123.0516981093915;4139.461869956886;4142.46148000764;3651.8174091295327;3698.14942563212;3711.4432835074413;3746.325661380923;3761.6426439488205;1095.2935356695045;1180.167981572989;1184.976300474003;1188.5780547905542;1191.398343836357;993.7018894331671;1004.3070281505737;1164.5341863254766;1181.9586314479125;1189.607429548247;6778.661066946633;6832.0093586430685;6848.041274221613;6941.34057264559;6965;987.511181964932;989.4310771306527;992.6029588164647;999.195647503752;1078.428432930548;5401.7029063401105;5403.972980135074;5435.076037073707;5470.835874923759;5476.123820188751;8222.342212622976;9109.544522773835;9171.174594286545;9210.125038121501;9241.399309044891;9035.593398297093;9065.456072635663;9066.727998160066;9073.500957447272;9077.09229077087;6643.136392269071;6759.5606285591275;6795.2185498667295;6818.28408017161;6822.9317706823285;6774.187097548326;6797.5581587196675;6815.761448349284;6829.829254268683;6838.487113466411;7695.461317707931;7951.960240198762;8051.637676304697;8060.073091594541;8075.030996280249;8005.919940800517;8114.959425202836;8121.309688676292;8226.383021273548;8246.422750407413;6594.703238354382;6644.867102658017;6698.430633396216;6745.291744366967;6750.05499230118;6844.520883538304;6849.10961575012;6881.071055407456;6882.03651488802;6903.585784852925;6254.718537665725;6393.904091438725;6473.449756770538;6486.610803351814;6543.0185472179555;6228.781992630236;6290.339514351111;6298.527610429328;6326.114343991937;6355.205424810604;6652.434543063894;6655.23464801554;6674.898641724061;6714.630695311805;6733.898991515229;6130.295016073031;6176.258848938156;6178.165947597017;6187.783427580013;6232.875342493216;6127.693615319127;6156.907646385397;6168.35232300602;6221.440070393686;6228.906566401598 18:22:12 INFO - PROCESS | 5572 | |4;prototype.html;312.79355625287315;315.0658298145997;318.4395463983389;320.44243017150166;320.83637344954053;5279.736013199339;5443;5451.454854514546;5467.808626698066;5484.177373393993;5270.8418747437545;5370.597205209606;5384.030874442598;5384.1923711443305;5387.272718183044;4025.919481610381;4149.917001659965;4258.361245813122;4263.275243208662;4269.252880745873;4242.342436922282;4257.425247591566;4258.127083947783;4264.189803937242;4266.018815672382;4209.9789501052455;4214.831406743727;4224.387463817745;4225.239456897757;4228.619424251817;4018.899527511821;4093.8771836844944;4193.790310484464;4197.832086716528;4224.302990006645;3718.349288874463;3719.3491139050557;3720.8883733488037;3726.7204959627866;3736.047307936486;5175.585953123741;5178.135871086406;5191.532762051434;5202.193659982709;5203.557697595709;4807.11068452334;4821.276808478756;4830.2030165022725;4831.685940413862;4846.61227101831;5639.210510528529;5640.238567793336;5642.4357564243655;5652.689102099383;5660.5471562274915;4040.6363427291685;4050.8379664813374;4078.082431452929;4087.3255912774357;4089.6932730045364;5678.488935995739;5924.289085309747;5937.435943585352;5950.494207992283;5953.851153721148;4152.480939882515;4176;4178.6865985051245;4184.267753143188;4184.476940382452;4227.3447615619625;4228.957710422918;4230.767307798039;4235.343521754133;4238.3006803877015;4811;4819.927701084486;4820.373351464287;4820.807167713322;4823.903521929612;5662.37713851476;5664.037113690682;5669.574781891375;5671.1493276008105;5673.290838645169;1475.1001888847795;1498.1086253679043;1498.6777842763859;1501.496998505491;1505.0894209003395;946;1000.6091532769457;1041.8958104189521;1044.6002356841716;1055.024102704995;4901.36282283308;5025.824096156617;5027.84916452507;5029;5029.1450453423;5914.497267732291;5944.405559444108;5955.40445955401;5958.582899197101;5997.820065398045;5001.524855138756;5024.698518088926;5027.1956486962645;5029.2958985742025;5038.067957427815;3158.952615710766;3193.8562764675644;3198.6641402652854;3199.1202419334404;3199.792013519114;5536.086545719912;5541.6120871539415;5543.113101903676;5549.5837812164245;5553.08374118266;5801.9419805802245;6022.939770602238;6045.6070355426755;6047.244094488189;6058.21243238385;5498.670079795225;5517.724113794375;5520.067976208295;5523.392426832965;5524;5913.231279933581;5918.704064796829;5920.141579471038;5923.170756094064;5923.348431672599;5783.768649254151;5786.42135786418;5810.5351571875;5821.301443826768;5839.182514447895;5353.491418315254;5505.807296744595;5518.806841760519;5522.779088836402;5523.392426832965;4180.289350810309;4197.160567886373;4205.074883525619;4205.158968206432;4211.305134652748;5853.531717462508;5879.382664820132;5883.235179426818;5888.852778680396;5896.351401345934;5689.2319536862;5691.032524470767;5693.544516438592;5696.515796157208;5698.629589076862;5658.236138121466;5671.801486947937;5676.375598684059;5679.630823996427;5679.772809087755;5406.675599464044;5570.6657600544095;5601.971990140023;5604.103343465026;5614.606977511535;5667.40492248308;5694.857628559319;5702.600817942704;5703.486686198262;5708.57185711065;5515.806946756844;5546.251256080377;5564.415736347625;5568.6658800472105;5571.832845014656 18:22:12 INFO - PROCESS | 5572 | |5;yui.html;671.738022171353;686.7321744519635;717.6340066566049;728.6720975560999;739.1721272175165;11929.463174157163;12097.153199276054;12107.455164517596;12108.515659373625;12110.576129835468;11126.721831954204;11137.554497820098;11180.496877640506;11181.888181118187;11194.944025279861;763.7746864674921;777.5606782168057;779.0651218537749;779.5361759752966;779.7270955165703;641.3970867384644;764.182324912344;786.319833344156;786.8622990976585;788.4047544104193;835.7994081420476;839.1776059461731;839.5927974932183;841.3731769831484;842.7682387343499;675.1223409567542;833.2833762963846;834.4784509681449;835.5362773660615;835.6907944060706;600.9639421634672;602.2141105856855;607.808540309801;607.8146165419545;609.9115628233881;12274.815877761841;12323.75352492945;12351.629451116482;12375.381230938507;12431.316277604728;10539.84190237147;10960.12319014477;11027.61403350887;11215.439228038647;11365.943170284096;9095.59069841852;9194.17252447283;9406.200472959807;9587.808243835154;9875.160611348045;3284.8193349365774;3310.652381499956;3341.7827841190488;3408.1479630092476;3415.5389022481895;42726.57273427288;42933.78533107346;42943.57056429427;43020.56979430197;43059.784701076605;9171.63313467454;9507.714768556954;9520.452390290875;9580.0898914603;9596.280278978966;15654.9217253913;15655.138967356905;15657.138857362954;15694.293756780973;15703.293351799197;6643.069970204176;6677.09859169006;6694;6719.798406047827;6983.615901125487;3625.1118475973026;3680.4847321375028;3713.33160031197;3734.533183352081;3784.962150378516;2926.6634337051087;2962.6889176636573;2974.2713035306488;2975.866086026134;2977.077106097117;510.6399988008445;519.5090639345857;522.0759256116728;523.683171681135;566.3911295357507;522.8509874685697;540.4514417865869;540.7107197649239;544.3522208571787;549.2118809508288;7019.543729657658;7270.309320614533;7295.781126566211;7378.631068446556;7503.437242206856;563.5745012515524;565.7341049706631;578.1732123064058;590.6987436407463;597.2892258212713;3451.516787649731;3485.89542313731;3610.115521697201;3649.069487280726;3710.925781484409;53643;54119.18821217685;54428;54445.45554544483;54507.454925450234;44314.113717725464;45105.32342014872;45225.773871130434;45376.77311613421;45607.66727160914;43348.783256083516;43519.56480435219;43584;43735.12529749387;43862.56137438585;7172.928270717435;7211.6033618151505;7225.747098851515;7255.818604534928;7562.962185189039;33275.667243327254;33563;33580;33771.83114084414;34522.30955380828;40171.39742903801;41194.58805411908;41746.37380439357;43162.352564712186;43841.56158438375;10351.68944931623;10505.474726263808;10602.946985265024;10657.520411581343;10967.287126336763;11246.437678115897;11256.549738010388;11513.884861151617;11629.651110466699;11675;10352.585896564053;10777.13782897382;10786.137109031415;10815.297005694605;11398.20212585111;10845.511951962339;11064.336139831636;11410.486528106088;11426.828597570877;11883.702907427038;10956.123510119012;11056.11551075928;11179.217454778087;11477.081833453136;11516.53933842637;9223.907760922304;9226.802845881104;9392.95303523478;9412.811743764949;9569.569369378534;9032.45805251687;9193.770155745893;9240.075992400707;9394.906050939404;9398.859017114612 18:22:12 INFO - PROCESS | 5572 | __end_tp_report 18:22:12 INFO - PROCESS | 5572 | __start_cc_report 18:22:12 INFO - PROCESS | 5572 | _x_x_mozilla_cycle_collect,887 18:22:12 INFO - PROCESS | 5572 | __end_cc_report 18:22:12 INFO - PROCESS | 5572 | __startTimestamp1458696132895__endTimestamp 18:22:12 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | ------- Summary: start ------- 18:22:12 INFO - PROCESS | 5572 | Number of tests: 6 18:22:12 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | [#0] dojo.html Cycles:165 Average:4578.66 Median:4705.58 stddev:468.55 (10.0%) stddev-sans-first:442.93 18:22:12 INFO - PROCESS | 5572 | Values: 2578.4 2645.6 2649.5 2652.4 2659.2 4484.5 4551.7 4558.1 4566.4 4570.5 4507.3 4608.9 4674.1 4694.4 4710.8 4258.9 4291.5 4307.7 4354.1 4386.5 4250.8 4345.0 4346.5 4387.9 4395.3 4202.4 4275.2 4303.9 4343.8 4365.0 4251.7 4254.3 4268.5 4269.3 4272.0 4240.4 4241.0 4241.4 4243.4 4245.6 4448.4 4484.0 4490.9 4531.2 4578.4 4950.1 4951.9 4954.3 4954.7 4993.4 4831.3 4969.3 4974.9 4976.6 5015.6 4670.3 4670.6 4699.2 4705.6 4717.3 5093.7 5102.0 5104.7 5105.2 5105.5 4733.8 4882.7 4886.6 4890.8 4951.0 4904.5 4925.0 4928.2 4931.5 4975.5 4874.8 4882.3 4885.8 4890.5 4949.1 4769.6 4845.5 4847.0 4849.2 4939.4 4112.7 4113.9 4118.4 4130.8 4136.0 3645.6 3670.1 3689.4 3689.8 3691.2 4299.4 4302.0 4316.4 4320.3 4377.0 4979.4 5027.2 5033.8 5037.3 5074.7 4192.9 4309.6 4331.4 4336.2 4361.1 4455.2 4459.3 4462.3 4506.8 4510.8 4669.5 4684.9 4688.2 4697.0 4720.9 4861.6 4889.9 4953.9 4976.2 4987.5 4664.1 4670.0 4681.9 4701.3 4724.9 4912.9 4913.8 4915.6 4915.9 4960.6 4842.3 4915.7 4919.7 4992.9 5032.9 4759.7 4769.5 4776.8 4777.7 4819.1 4769.2 4779.1 4779.5 4780.2 4818.1 4611.5 4698.5 4719.7 4761.6 4780.1 4839.5 4860.7 4860.7 4865.4 4893.3 4764.4 4766.8 4774.4 4774.9 4818.8 18:22:12 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | [#1] ext.html Cycles:180 Average:42826.13 Median:19180.01 stddev:72841.75 (379.8%) stddev-sans-first:72976.76 18:22:12 INFO - PROCESS | 5572 | Values: 500.2 507.4 523.3 524.0 546.4 27627.9 28113.4 28117.4 28137.6 34423.5 32947.3 33342.5 33407.5 33435.7 33473.0 7704.4 7898.8 7902.0 7909.4 7910.4 7592.7 7611.2 7798.8 7804.6 10022.0 9948.9 10046.3 10053.8 10056.9 10070.6 9845.6 9954.7 9957.2 9957.6 9964.2 9473.7 9597.5 9597.6 9600.5 9606.0 35129.0 38452.2 38709.0 38732.2 38749.4 2994.7 3064.6 3155.0 3177.0 3540.8 29805.7 29913.0 30422.4 30423.4 32282.0 3464.8 3471.9 3501.4 3510.6 3516.5 250218.0 253358.0 253992.0 254988.0 255687.0 41658.8 59123.4 59786.4 59817.4 59843.1 35753.1 35880.6 36019.1 36055.5 36072.3 12226.8 12454.9 12464.5 12475.6 12493.0 9072.5 9160.8 9165.8 9168.1 9168.4 12172.2 12322.9 12372.9 13139.6 14994.3 5738.8 5744.6 5772.4 5790.1 5861.8 897.9 970.7 978.6 994.8 1038.5 25920.7 26354.3 26406.2 26463.5 26481.5 944.6 979.6 994.5 1004.1 1038.0 14343.6 14446.6 14491.0 14714.9 14743.2 299414.0 303910.0 304433.0 304916.0 305705.0 46834.5 48277.0 48494.3 48510.3 48580.3 1094.6 1143.1 1193.8 1219.3 1239.2 24543.6 25051.2 25541.2 25716.2 25758.0 37261.8 38021.6 38356.0 38358.4 38408.6 271377.0 275492.0 277308.0 277765.0 278380.0 34858.7 40115.4 40644.2 40867.2 42266.0 37898.4 37914.0 37939.6 38711.0 38958.6 32524.2 35547.6 35555.6 35593.6 35691.6 35287.3 35418.1 35510.8 35773.3 37882.2 30447.4 31278.1 31632.2 31779.0 31838.4 29117.6 31262.7 31788.0 31805.7 31889.8 24834.0 24890.8 24918.5 24925.8 25287.2 18:22:12 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | [#2] jquery.html Cycles:180 Average:23074.12 Median:215233.62 stddev:66002.28 (30.7%) stddev-sans-first:66165.38 18:22:12 INFO - PROCESS | 5572 | Values: 349.9 354.0 354.0 356.5 360.7 14933.4 15185.5 15802.1 16339.8 16715.9 14907.6 14928.4 15522.5 15855.4 15910.8 5041.4 5098.0 5243.7 5247.2 5270.5 5179.7 5183.7 5215.4 5219.7 5222.7 5158.3 5163.8 5173.6 5175.2 5231.5 4932.7 5164.7 5167.8 5170.6 5177.1 4566.7 4605.1 4611.5 4619.6 4621.1 18898.1 19875.5 19970.6 20026.4 20064.9 2005.5 2021.5 2036.4 2054.5 2296.5 12522.4 12861.8 12948.3 12955.1 12999.2 1751.0 1791.4 1829.4 1852.2 1859.3 44546.6 45818.8 58481.7 60144.4 61183.7 9829.6 9934.9 10006.4 10121.6 10203.5 11402.9 11837.5 12343.9 12982.9 13037.2 6764.1 6812.0 6817.8 6925.0 6950.2 6363.4 6367.9 6416.6 6474.0 6477.0 6076.0 6237.8 6239.7 6244.2 6293.3 1713.5 1715.8 1737.8 1739.9 1740.8 853.1 859.4 871.7 919.3 928.2 16266.7 16581.6 16639.3 16735.1 17076.7 882.8 949.7 960.2 971.2 999.7 9546.7 9931.5 9936.3 9944.4 10034.9 392580.0 406058.0 406134.0 407940.0 409605.0 59032.0 60607.1 60770.4 61389.7 62044.4 950.3 963.8 964.7 975.8 977.8 14729.4 14951.4 14979.9 14995.0 15354.0 21280.8 25792.0 28985.6 31857.8 32350.5 32880.3 33274.5 33967.5 34436.0 37887.2 7527.4 7584.0 7607.4 7655.3 7690.5 10818.6 11424.7 11427.0 11545.3 11752.5 10094.3 10235.5 10248.6 10300.4 10439.4 9881.0 9887.5 10378.3 10627.9 10742.0 9969.8 10202.2 10238.4 10418.0 10440.4 7389.5 7410.6 7444.8 7614.0 7617.8 10119.9 10175.6 10243.5 10310.7 10335.0 18:22:12 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | [#3] mootools.html Cycles:180 Average:5165.09 Median:6312.32 stddev:2651.42 (42.0%) stddev-sans-first:2642.66 18:22:12 INFO - PROCESS | 5572 | Values: 1266.8 1339.9 1424.9 1538.6 1743.1 6025.8 7057.8 7239.2 7244.4 7259.1 7048.4 7216.3 7218.6 7223.2 7223.3 1912.9 2133.2 2192.6 2204.9 2229.5 2217.1 2223.9 2227.0 2228.0 2228.2 2138.7 2199.0 2200.6 2203.9 2210.0 2173.5 2181.8 2191.4 2271.9 2272.0 2226.6 2234.3 2243.4 2245.4 2248.7 7417.3 7478.9 7484.7 7486.9 7499.3 4484.6 4573.0 4592.1 4594.2 4597.9 2806.7 2871.5 2896.3 2901.7 2914.2 853.3 861.7 864.2 882.4 886.4 9920.5 9948.7 9956.0 9997.2 10005.5 4029.4 4065.1 4146.7 4152.6 4154.9 8567.1 8583.1 8589.1 8608.9 8623.1 3983.2 4462.5 4464.8 4464.8 4466.2 4042.9 4079.2 4123.1 4139.5 4142.5 3651.8 3698.1 3711.4 3746.3 3761.6 1095.3 1180.2 1185.0 1188.6 1191.4 993.7 1004.3 1164.5 1182.0 1189.6 6778.7 6832.0 6848.0 6941.3 6965.0 987.5 989.4 992.6 999.2 1078.4 5401.7 5404.0 5435.1 5470.8 5476.1 8222.3 9109.5 9171.2 9210.1 9241.4 9035.6 9065.5 9066.7 9073.5 9077.1 6643.1 6759.6 6795.2 6818.3 6822.9 6774.2 6797.6 6815.8 6829.8 6838.5 7695.5 7952.0 8051.6 8060.1 8075.0 8005.9 8115.0 8121.3 8226.4 8246.4 6594.7 6644.9 6698.4 6745.3 6750.1 6844.5 6849.1 6881.1 6882.0 6903.6 6254.7 6393.9 6473.4 6486.6 6543.0 6228.8 6290.3 6298.5 6326.1 6355.2 6652.4 6655.2 6674.9 6714.6 6733.9 6130.3 6176.3 6178.2 6187.8 6232.9 6127.7 6156.9 6168.4 6221.4 6228.9 18:22:12 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | [#4] prototype.html Cycles:180 Average:4732.51 Median:5316.61 stddev:1366.45 (25.7%) stddev-sans-first:1329.41 18:22:12 INFO - PROCESS | 5572 | Values: 312.8 315.1 318.4 320.4 320.8 5279.7 5443.0 5451.5 5467.8 5484.2 5270.8 5370.6 5384.0 5384.2 5387.3 4025.9 4149.9 4258.4 4263.3 4269.3 4242.3 4257.4 4258.1 4264.2 4266.0 4210.0 4214.8 4224.4 4225.2 4228.6 4018.9 4093.9 4193.8 4197.8 4224.3 3718.3 3719.3 3720.9 3726.7 3736.0 5175.6 5178.1 5191.5 5202.2 5203.6 4807.1 4821.3 4830.2 4831.7 4846.6 5639.2 5640.2 5642.4 5652.7 5660.5 4040.6 4050.8 4078.1 4087.3 4089.7 5678.5 5924.3 5937.4 5950.5 5953.9 4152.5 4176.0 4178.7 4184.3 4184.5 4227.3 4229.0 4230.8 4235.3 4238.3 4811.0 4819.9 4820.4 4820.8 4823.9 5662.4 5664.0 5669.6 5671.1 5673.3 1475.1 1498.1 1498.7 1501.5 1505.1 946.0 1000.6 1041.9 1044.6 1055.0 4901.4 5025.8 5027.8 5029.0 5029.1 5914.5 5944.4 5955.4 5958.6 5997.8 5001.5 5024.7 5027.2 5029.3 5038.1 3159.0 3193.9 3198.7 3199.1 3199.8 5536.1 5541.6 5543.1 5549.6 5553.1 5801.9 6022.9 6045.6 6047.2 6058.2 5498.7 5517.7 5520.1 5523.4 5524.0 5913.2 5918.7 5920.1 5923.2 5923.3 5783.8 5786.4 5810.5 5821.3 5839.2 5353.5 5505.8 5518.8 5522.8 5523.4 4180.3 4197.2 4205.1 4205.2 4211.3 5853.5 5879.4 5883.2 5888.9 5896.4 5689.2 5691.0 5693.5 5696.5 5698.6 5658.2 5671.8 5676.4 5679.6 5679.8 5406.7 5570.7 5602.0 5604.1 5614.6 5667.4 5694.9 5702.6 5703.5 5708.6 5515.8 5546.3 5564.4 5568.7 5571.8 18:22:12 INFO - PROCESS | 5572 | 18:22:12 INFO - PROCESS | 5572 | [#5] yui.html Cycles:180 Average:12722.33 Median:44709.72 stddev:14726.27 (32.9%) stddev-sans-first:14739.77 18:22:12 INFO - PROCESS | 5572 | Values: 671.7 686.7 717.6 728.7 739.2 11929.5 12097.2 12107.5 12108.5 12110.6 11126.7 11137.6 11180.5 11181.9 11194.9 763.8 777.6 779.1 779.5 779.7 641.4 764.2 786.3 786.9 788.4 835.8 839.2 839.6 841.4 842.8 675.1 833.3 834.5 835.5 835.7 601.0 602.2 607.8 607.8 609.9 12274.8 12323.8 12351.6 12375.4 12431.3 10539.8 10960.1 11027.6 11215.4 11365.9 9095.6 9194.2 9406.2 9587.8 9875.2 3284.8 3310.7 3341.8 3408.1 3415.5 42726.6 42933.8 42943.6 43020.6 43059.8 9171.6 9507.7 9520.5 9580.1 9596.3 15654.9 15655.1 15657.1 15694.3 15703.3 6643.1 6677.1 6694.0 6719.8 6983.6 3625.1 3680.5 3713.3 3734.5 3785.0 2926.7 2962.7 2974.3 2975.9 2977.1 510.6 519.5 522.1 523.7 566.4 522.9 540.5 540.7 544.4 549.2 7019.5 7270.3 7295.8 7378.6 7503.4 563.6 565.7 578.2 590.7 597.3 3451.5 3485.9 3610.1 3649.1 3710.9 53643.0 54119.2 54428.0 54445.5 54507.5 44314.1 45105.3 45225.8 45376.8 45607.7 43348.8 43519.6 43584.0 43735.1 43862.6 7172.9 7211.6 7225.7 7255.8 7563.0 33275.7 33563.0 33580.0 33771.8 34522.3 40171.4 41194.6 41746.4 43162.4 43841.6 10351.7 10505.5 10602.9 10657.5 10967.3 11246.4 11256.5 11513.9 11629.7 11675.0 10352.6 10777.1 10786.1 10815.3 11398.2 10845.5 11064.3 11410.5 11426.8 11883.7 10956.1 11056.1 11179.2 11477.1 11516.5 9223.9 9226.8 9393.0 9412.8 9569.6 9032.5 9193.8 9240.1 9394.9 9398.9 18:22:12 INFO - PROCESS | 5572 | -------- Summary: end -------- 18:22:12 INFO - PROCESS | 5572 | 18:22:13 INFO - TEST-INFO | 5572: exit 0 18:22:13 INFO - TEST-OK | dromaeo_css | took 1117013ms 18:22:13 INFO - TEST-START | kraken 18:22:13 INFO - operating with platform_type : linux_ 18:22:13 INFO - Initialising browser for kraken test... 18:22:13 INFO - TEST-INFO | started process 5753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf7Tm5Z/profile http://localhost:50450/getInfo.html) 18:22:17 INFO - PROCESS | 5753 | __metrics Screen width/height:1600/1200 18:22:17 INFO - PROCESS | 5753 | colorDepth:24 18:22:17 INFO - PROCESS | 5753 | Browser inner width/height: 1024/697 18:22:17 INFO - PROCESS | 5753 | __metrics 18:22:18 ERROR - PROCESS | 5753 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:22:18 INFO - PROCESS | 5753 | 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. 18:22:19 INFO - TEST-INFO | 5753: exit 0 18:22:19 INFO - Browser initialized. 18:22:19 INFO - Running cycle 1/1 for kraken test... 18:22:19 INFO - TEST-INFO | started process 5835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf7Tm5Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:31 INFO - PROCESS | 5835 | RSS: Main: 157691904 18:22:31 INFO - PROCESS | 5835 | 18:22:33 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50450/tests/kraken/driver.html?testName=audio-beat-detection) 18:22:34 INFO - PROCESS | 5835 | RSS: Main: 197869568 18:22:34 INFO - PROCESS | 5835 | 18:22:37 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50450/tests/kraken/driver.html?testName=audio-dft) 18:22:37 INFO - PROCESS | 5835 | RSS: Main: 188510208 18:22:37 INFO - PROCESS | 5835 | 18:22:40 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50450/tests/kraken/driver.html?testName=audio-fft) 18:22:41 INFO - PROCESS | 5835 | RSS: Main: 174440448 18:22:41 INFO - PROCESS | 5835 | 18:22:43 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50450/tests/kraken/driver.html?testName=audio-oscillator) 18:22:43 INFO - PROCESS | 5835 | RSS: Main: 174206976 18:22:43 INFO - PROCESS | 5835 | 18:22:46 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:22:46 INFO - PROCESS | 5835 | RSS: Main: 177336320 18:22:46 INFO - PROCESS | 5835 | 18:22:49 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50450/tests/kraken/driver.html?testName=imaging-darkroom) 18:22:50 INFO - PROCESS | 5835 | RSS: Main: 177393664 18:22:50 INFO - PROCESS | 5835 | 18:22:53 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50450/tests/kraken/driver.html?testName=imaging-desaturate) 18:22:54 INFO - PROCESS | 5835 | RSS: Main: 177500160 18:22:54 INFO - PROCESS | 5835 | 18:22:57 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50450/tests/kraken/driver.html?testName=json-parse-financial) 18:22:57 INFO - PROCESS | 5835 | RSS: Main: 178700288 18:22:57 INFO - PROCESS | 5835 | 18:22:59 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:23:00 INFO - PROCESS | 5835 | RSS: Main: 187658240 18:23:00 INFO - PROCESS | 5835 | 18:23:02 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50450/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:23:02 INFO - PROCESS | 5835 | RSS: Main: 184664064 18:23:02 INFO - PROCESS | 5835 | 18:23:04 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:23:05 INFO - PROCESS | 5835 | RSS: Main: 198471680 18:23:05 INFO - PROCESS | 5835 | 18:23:07 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:23:08 INFO - PROCESS | 5835 | RSS: Main: 203100160 18:23:08 INFO - PROCESS | 5835 | 18:23:11 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:23:11 INFO - PROCESS | 5835 | RSS: Main: 202579968 18:23:11 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:50450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50450/tests/kraken/driver.html?testName=ai-astar) 18:23:13 INFO - PROCESS | 5835 | RSS: Main: 262713344 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | __start_tp_report 18:23:13 INFO - PROCESS | 5835 | _x_x_mozilla_page_load 18:23:13 INFO - PROCESS | 5835 | _x_x_mozilla_page_load_details 18:23:13 INFO - PROCESS | 5835 | |i|pagename|runs| 18:23:13 INFO - PROCESS | 5835 | |0;ai-astar;110;113;108;114;113;113;101;111;112;111 18:23:13 INFO - PROCESS | 5835 | |1;audio-beat-detection;150;128;152;167;130;160;163;129;176;131 18:23:13 INFO - PROCESS | 5835 | |2;audio-dft;161;159;162;161;160;162;161;161;159;163 18:23:13 INFO - PROCESS | 5835 | |3;audio-fft;72;73;98;96;72;80;73;118;94;72 18:23:13 INFO - PROCESS | 5835 | |4;audio-oscillator;94;93;133;94;93;94;133;94;93;143 18:23:13 INFO - PROCESS | 5835 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;117;118 18:23:13 INFO - PROCESS | 5835 | |6;imaging-darkroom;146;147;146;146;146;146;145;146;147;146 18:23:13 INFO - PROCESS | 5835 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 18:23:13 INFO - PROCESS | 5835 | |8;json-parse-financial;68;74;68;69;68;68;68;78;76;69 18:23:13 INFO - PROCESS | 5835 | |9;json-stringify-tinderbox;64;64;65;65;65;65;64;65;64;64 18:23:13 INFO - PROCESS | 5835 | |10;stanford-crypto-aes;82;81;85;81;82;98;81;82;82;82 18:23:13 INFO - PROCESS | 5835 | |11;stanford-crypto-ccm;115;115;123;120;113;122;116;114;114;114 18:23:13 INFO - PROCESS | 5835 | |12;stanford-crypto-pbkdf2;140;131;156;142;139;126;152;136;137;149 18:23:13 INFO - PROCESS | 5835 | |13;stanford-crypto-sha256-iterative;65;66;66;68;64;65;65;67;65;65 18:23:13 INFO - PROCESS | 5835 | __end_tp_report 18:23:13 INFO - PROCESS | 5835 | __start_cc_report 18:23:13 INFO - PROCESS | 5835 | _x_x_mozilla_cycle_collect,1142 18:23:13 INFO - PROCESS | 5835 | __end_cc_report 18:23:13 INFO - PROCESS | 5835 | __startTimestamp1458696193634__endTimestamp 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | ------- Summary: start ------- 18:23:13 INFO - PROCESS | 5835 | Number of tests: 14 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:3.81 (3.4%) stddev-sans-first:4.03 18:23:13 INFO - PROCESS | 5835 | Values: 110.0 113.0 108.0 114.0 113.0 113.0 101.0 111.0 112.0 111.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:156.00 stddev:17.96 (11.5%) stddev-sans-first:19.05 18:23:13 INFO - PROCESS | 5835 | Values: 150.0 128.0 152.0 167.0 130.0 160.0 163.0 129.0 176.0 131.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 18:23:13 INFO - PROCESS | 5835 | Values: 161.0 159.0 162.0 161.0 160.0 162.0 161.0 161.0 159.0 163.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.50 stddev:15.92 (20.8%) stddev-sans-first:16.19 18:23:13 INFO - PROCESS | 5835 | Values: 72.0 73.0 98.0 96.0 72.0 80.0 73.0 118.0 94.0 72.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:93.50 stddev:20.84 (22.3%) stddev-sans-first:21.61 18:23:13 INFO - PROCESS | 5835 | Values: 94.0 93.0 133.0 94.0 93.0 94.0 133.0 94.0 93.0 143.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 18:23:13 INFO - PROCESS | 5835 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:23:13 INFO - PROCESS | 5835 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 147.0 146.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:23:13 INFO - PROCESS | 5835 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#8] json-parse-financial Cycles:10 Average:70.60 Median:69.00 stddev:3.86 (5.6%) stddev-sans-first:3.98 18:23:13 INFO - PROCESS | 5835 | Values: 68.0 74.0 68.0 69.0 68.0 68.0 68.0 78.0 76.0 69.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 18:23:13 INFO - PROCESS | 5835 | Values: 64.0 64.0 65.0 65.0 65.0 65.0 64.0 65.0 64.0 64.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.00 stddev:5.19 (6.3%) stddev-sans-first:5.47 18:23:13 INFO - PROCESS | 5835 | Values: 82.0 81.0 85.0 81.0 82.0 98.0 81.0 82.0 82.0 82.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:115.50 stddev:3.66 (3.2%) stddev-sans-first:3.83 18:23:13 INFO - PROCESS | 5835 | Values: 115.0 115.0 123.0 120.0 113.0 122.0 116.0 114.0 114.0 114.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.80 Median:141.00 stddev:9.32 (6.6%) stddev-sans-first:9.88 18:23:13 INFO - PROCESS | 5835 | Values: 140.0 131.0 156.0 142.0 139.0 126.0 152.0 136.0 137.0 149.0 18:23:13 INFO - PROCESS | 5835 | 18:23:13 INFO - PROCESS | 5835 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 18:23:13 INFO - PROCESS | 5835 | Values: 65.0 66.0 66.0 68.0 64.0 65.0 65.0 67.0 65.0 65.0 18:23:13 INFO - PROCESS | 5835 | -------- Summary: end -------- 18:23:13 INFO - PROCESS | 5835 | 18:23:14 INFO - TEST-INFO | 5835: exit 0 18:23:14 INFO - TEST-OK | kraken | took 60876ms 18:23:14 INFO - SUITE-END | took 1177s 18:23:14 INFO - Completed test suite (00:19:38) 18:23:14 INFO - javascript benchmark 18:23:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2578.355411147213, 2645.6163856240833, 2649.5495765719825, 2652.3501742073195, 2659.1756555467796, 4484.4618645762475, 4551.6586256030805, 4558.133954548638, 4566.429196350457, 4570.451545814507, 4507.323901414789, 4608.861734147972, 4674.08855273221, 4694.4366675998845, 4710.811567537303, 4258.850940217093, 4291.463567054118, 4307.655387568987, 4354.129174165164, 4386.451693538308, 4250.766207858566, 4344.978929951459, 4346.478422589278, 4387.868363949086, 4395.296752519597, 4202.432671589327, 4275.209086319041, 4303.91392172158, 4343.826246950118, 4365.039691267916, 4251.723637963553, 4254.276772948606, 4268.509121451042, 4269.295566231568, 4272.038791271939, 4240.385144154111, 4241.024564350186, 4241.448611680462, 4243.448351714257, 4245.575442455761, 4448.421705178306, 4484.0, 4490.87728067983, 4531.184386810372, 4578.35902973584, 4950.133726597831, 4951.876203094916, 4954.2568614707725, 4954.653174277802, 4993.350864387607, 4831.251156070814, 4969.254611808222, 4974.87562810929, 4976.552110310089, 5015.648904576681, 4670.322803193518, 4670.6497012724185, 4699.154152252593, 4705.576498115186, 4717.339572459859, 5093.719845408538, 5101.974490127525, 5104.69371837691, 5105.2086926526445, 5105.489451054865, 4733.83431579893, 4882.6826256293225, 4886.560209581155, 4890.804367825247, 4951.0, 4904.4605093440405, 4925.0, 4928.236123400879, 4931.50684931504, 4975.502449754996, 4874.8050077997195, 4882.292067650171, 4885.827401423704, 4890.535399137077, 4949.133901567211, 4769.57073863354, 4845.466998630148, 4847.0, 4849.151398505247, 4939.431965324034, 4112.670986321147, 4113.938290925578, 4118.382242663624, 4130.793460327031, 4135.958640413557, 3645.5625324961175, 3670.064133645903, 3689.3912504436466, 3689.815509224528, 3691.1694868654877, 4299.376590394375, 4301.956980430218, 4316.438862947797, 4320.308750599889, 4376.978115109468, 4979.402471703419, 5027.170516864677, 5033.79864805411, 5037.345145131109, 5074.695518268842, 4192.916141677149, 4309.612134907873, 4331.371951067078, 4336.219480493542, 4361.127774445124, 4455.1535208310315, 4459.264221403497, 4462.286034234507, 4506.842260520866, 4510.819567217341, 4669.509701481432, 4684.929726054112, 4688.179568575418, 4696.953030469652, 4720.858374248778, 4861.611071114373, 4889.853304400874, 4953.925691114564, 4976.154053810933, 4987.47631498702, 4664.113818374498, 4670.0, 4681.882952926204, 4701.341812146234, 4724.881877953078, 4912.8771780705765, 4913.8034478621885, 4915.582175515121, 4915.852524424273, 4960.578350840219, 4842.322074909586, 4915.729634869974, 4919.729414882216, 4992.900141997213, 5032.924506132338, 4759.690620109682, 4769.4753577107185, 4776.761161941959, 4777.665563410528, 4819.108464933998, 4769.2130798417875, 4779.06808172403, 4779.5220477951925, 4780.1873681473535, 4818.10864989978, 4611.515790842048, 4698.459677137173, 4719.693219940693, 4761.571458568746, 4780.139574876555, 4839.516048395132, 4860.659753817199, 4860.708357498562, 4865.391826021747, 4893.290472881484, 4764.380630518011, 4766.7854946526795, 4774.427068751772, 4774.856754297377, 4818.7831547581145], "unit": "score", "name": "dojo.html", "value": 4549.609536864304}, {"lowerIsBetter": false, "replicates": [500.1896926978298, 507.3936645708378, 523.3484312031521, 523.9895202095959, 546.3553007451208, 27627.861860690693, 28113.43773124536, 28117.437651247015, 28137.57793633097, 34423.48364774524, 32947.341053178985, 33342.49986250208, 33407.498887516645, 33435.66564334362, 33473.0, 7704.383649308042, 7898.763037108896, 7902.0, 7909.446338756289, 7910.406719496032, 7592.696292148307, 7611.1627720950655, 7798.844023119563, 7804.60976951153, 10022.0, 9948.90051099487, 10046.34698744583, 10053.849192262122, 10056.949715251414, 10070.647527336545, 9845.60617575296, 9954.651587194414, 9957.153641940444, 9957.55191016406, 9964.153046991014, 9473.715788526355, 9597.520123993841, 9597.616095356178, 9600.471974041426, 9605.951970240174, 35129.0, 38452.230955380735, 38709.0, 38732.22535549273, 38749.41875871836, 2994.7304742573274, 3064.6475655299705, 3154.952675709866, 3176.9682303176905, 3540.7521473496868, 29805.701942980508, 29913.0, 30422.391552168832, 30423.391532169455, 32282.0, 3464.7574669773126, 3471.861125554975, 3501.369753444379, 3510.596281427643, 3516.49010893419, 250218.0, 253357.99999999817, 253992.0, 254988.0, 255687.0, 41658.79170604127, 59123.40876591265, 59786.40213597808, 59817.40182598205, 59843.10235346473, 35753.1061723459, 35880.64119358773, 36019.099522512144, 36055.4591681125, 36072.27855442876, 12226.75546489083, 12454.875451245553, 12464.5014199431, 12475.6296303702, 12493.0, 9072.455652660861, 9160.770980725536, 9165.81668366629, 9168.083191680778, 9168.44989300644, 12172.208806427554, 12322.876771232352, 12372.876271237172, 13139.60581182566, 14994.250287485582, 5738.799142030009, 5744.597878148489, 5772.365039845614, 5790.060329789568, 5861.765529378862, 897.8518544440225, 970.669972209438, 978.6036655154674, 994.8060128275062, 1038.5378506564507, 25920.740792591834, 26354.341141471617, 26406.207813765617, 26463.470730585665, 26481.47037059248, 944.5985456181096, 979.5934687104772, 994.5425104451889, 1004.0662184168647, 1037.9740506487246, 14343.56969290923, 14446.638834029234, 14491.0, 14714.852851471349, 14743.189124598035, 299414.0, 303910.0, 304433.0, 304916.0, 305705.0, 46834.531654683014, 48277.0, 48494.27258591124, 48510.27234591484, 48580.271295930586, 1094.5567045346647, 1143.1197977557235, 1193.8149586814059, 1219.3232755820427, 1239.2007155384906, 24543.631845521973, 25051.24846254615, 25541.23376298714, 25716.228513144637, 25758.0, 37261.81369093137, 38021.61978380291, 38356.0, 38358.424623631225, 38408.615913840506, 271377.0, 275492.0, 277308.0, 277765.0, 278380.0, 34858.65141348554, 40115.398269025405, 40644.187116256915, 40867.182656346115, 42266.0, 37898.43152352772, 37914.0, 37939.62060379471, 38711.0, 38958.61041389663, 32524.18689532686, 35547.64452355443, 35555.644443556266, 35593.64406355903, 35691.64308356883, 35287.29425411426, 35418.11454713653, 35510.82244588761, 35773.284534308645, 37882.24235515219, 30447.391052179275, 31278.06165815029, 31632.209194769395, 31779.0, 31838.36323273475, 29117.563236551894, 31262.687373126886, 31788.0, 31805.681943180272, 31889.840550797097, 24834.0, 24890.75109248957, 24918.501629966937, 24925.750742492342, 25287.22989390725], "unit": "score", "name": "ext.html", "value": 16838.748103038135}, {"lowerIsBetter": false, "replicates": [349.87579409309694, 353.9769914955528, 353.9840707168178, 356.5222601713705, 360.72945291031726, 14933.402663893432, 15185.544433666993, 15802.13088280144, 16339.754903676454, 16715.91642041791, 14907.552773416788, 14928.402863885432, 15522.456714015012, 15855.36578536857, 15910.76133857993, 5041.369828771403, 5098.0, 5243.6853788772605, 5247.1866860636665, 5270.499302566269, 5179.689218646874, 5183.663061900965, 5215.426303106655, 5219.71291578963, 5222.660527065728, 5158.303629010092, 5163.81926632568, 5173.6119791015635, 5175.171972484403, 5231.503007214308, 4932.704037757746, 5164.715940623264, 5167.819126330561, 5170.638055336128, 5177.094008548508, 4566.657500687462, 4605.125026245037, 4611.515790841947, 4619.584237418649, 4621.1219868224925, 18898.149583268787, 19875.50311242216, 19970.600587988305, 20026.39920802364, 20064.89967550153, 2005.458526197933, 2021.5148364392587, 2036.3890832750265, 2054.4555692741437, 2296.5062511559927, 12522.373881305899, 12861.807072893915, 12948.254636432257, 12955.09314347996, 12999.220046797222, 1751.0106789663798, 1791.426743442086, 1829.3688677406406, 1852.2128095559467, 1859.2655900919062, 44546.55453445457, 45818.770906145255, 58481.70759146177, 60144.39855601432, 61183.694081529306, 9829.55766990487, 9934.900650993543, 10006.449645269435, 10121.595136194617, 10203.489825508696, 11402.885971140347, 11837.46731397072, 12343.876561234272, 12982.935085324512, 13037.217766934014, 6764.0868482754195, 6812.0, 6817.761378351833, 6925.0, 6950.165980082322, 6363.395477429729, 6367.904481432783, 6416.647084410309, 6473.967630161913, 6477.0, 6075.969620151959, 6237.781677641261, 6239.719212635351, 6244.188255526843, 6293.3391993840905, 1713.4945191168636, 1715.828417158299, 1737.800152982398, 1739.850869925439, 1740.8259174082743, 853.108501615813, 859.3509115684119, 871.6992637540038, 919.3197034194782, 928.211020632457, 16266.674666506604, 16581.58546036359, 16639.334426622798, 16735.079570623733, 17076.658466830842, 882.7881308486045, 949.7388218240039, 960.151707962184, 971.218169373661, 999.7350702063959, 9546.713598591914, 9931.453770042717, 9936.304458687822, 9944.35361701487, 10034.949825250973, 392580.0, 406058.0, 406134.0, 407940.0, 409605.0, 59032.0, 60607.09089363663, 60770.392296076476, 61389.69305153446, 62044.37955620476, 950.3110245072405, 963.8313295173317, 964.6816550538306, 975.7853272280087, 977.7751117243074, 14729.410823566937, 14951.401943922121, 14979.925100374865, 14995.0, 15354.0, 21280.787192127882, 25792.0, 28985.565216521347, 31857.8407107963, 32350.514742278414, 32880.34239315153, 33274.500882487264, 33967.49048764221, 34436.0, 37887.24225515419, 7527.360174385239, 7584.014078169803, 7607.429442791702, 7655.349295309738, 7690.538567685957, 10818.621348252773, 11424.714382140513, 11427.0, 11545.307281563133, 11752.471138798604, 10094.293399461967, 10235.539400726837, 10248.59005639796, 10300.433476158883, 10439.37363758177, 9880.950595246977, 9887.456189909624, 10378.325408848401, 10627.946860265958, 10742.0, 9969.800603987735, 10202.234832387452, 10238.436885971343, 10418.0, 10440.42577658236, 7389.519681220919, 7410.592417416879, 7444.813879652836, 7614.010178676736, 7617.809554761176, 10119.949400252952, 10175.643852465424, 10243.539040743333, 10310.742231444274, 10335.0], "unit": "score", "name": "jquery.html", "value": 7983.261424743691}, {"lowerIsBetter": false, "replicates": [1266.809978503225, 1339.9196048237104, 1424.8788852947503, 1538.5538193923762, 1743.058748275931, 6025.758969641214, 7057.752978645748, 7239.20368759436, 7244.420446364292, 7259.056322678044, 7048.400885924702, 7216.314450127243, 7218.63906804659, 7223.241559636242, 7223.313785190412, 1912.9330473433433, 2133.242698841912, 2192.55052714194, 2204.930608654805, 2229.520653059592, 2217.079911836586, 2223.866568005925, 2227.0312414099835, 2228.0, 2228.1533017453344, 2138.6685063815135, 2199.0, 2200.6148923938326, 2203.9421077882625, 2209.9668504972437, 2173.467500462389, 2181.770914054025, 2191.4192738924116, 2271.9091236350528, 2272.034385386204, 2226.6437370020717, 2234.2626933112033, 2243.4054975431523, 2245.4049676835652, 2248.685184074231, 7417.332440080419, 7478.925210747877, 7484.700611975514, 7486.9251307486775, 7499.325060744504, 4484.596386325246, 4573.039661671053, 4592.0815836832435, 4594.173048851206, 4597.885052873671, 2806.722941061812, 2871.454423659498, 2896.2614533294086, 2901.6663083745216, 2914.184028472031, 853.3301358433662, 861.7457849934221, 864.1962974433774, 882.4308321132834, 886.4415418286503, 9920.45437500937, 9948.651797187136, 9956.0, 9997.15024222942, 10005.549750261256, 4029.37544680575, 4065.065035041957, 4146.709730318848, 4152.563980782034, 4154.91690166195, 8567.057623661392, 8583.05586385497, 8589.055203927563, 8608.870866937, 8623.051464338918, 3983.1635356575443, 4462.531434199427, 4464.799084041226, 4464.843730469418, 4466.173757854807, 4042.8989275268355, 4079.1637714268504, 4123.0516981093915, 4139.461869956886, 4142.46148000764, 3651.8174091295327, 3698.14942563212, 3711.4432835074413, 3746.325661380923, 3761.6426439488205, 1095.2935356695045, 1180.167981572989, 1184.976300474003, 1188.5780547905542, 1191.398343836357, 993.7018894331671, 1004.3070281505737, 1164.5341863254766, 1181.9586314479125, 1189.607429548247, 6778.661066946633, 6832.0093586430685, 6848.041274221613, 6941.34057264559, 6965.0, 987.511181964932, 989.4310771306527, 992.6029588164647, 999.195647503752, 1078.428432930548, 5401.7029063401105, 5403.972980135074, 5435.076037073707, 5470.835874923759, 5476.123820188751, 8222.342212622976, 9109.544522773835, 9171.174594286545, 9210.125038121501, 9241.399309044891, 9035.593398297093, 9065.456072635663, 9066.727998160066, 9073.500957447272, 9077.09229077087, 6643.136392269071, 6759.5606285591275, 6795.2185498667295, 6818.28408017161, 6822.9317706823285, 6774.187097548326, 6797.5581587196675, 6815.761448349284, 6829.829254268683, 6838.487113466411, 7695.461317707931, 7951.960240198762, 8051.637676304697, 8060.073091594541, 8075.030996280249, 8005.919940800517, 8114.959425202836, 8121.309688676292, 8226.383021273548, 8246.422750407413, 6594.703238354382, 6644.867102658017, 6698.430633396216, 6745.291744366967, 6750.05499230118, 6844.520883538304, 6849.10961575012, 6881.071055407456, 6882.03651488802, 6903.585784852925, 6254.718537665725, 6393.904091438725, 6473.449756770538, 6486.610803351814, 6543.0185472179555, 6228.781992630236, 6290.339514351111, 6298.527610429328, 6326.114343991937, 6355.205424810604, 6652.434543063894, 6655.23464801554, 6674.898641724061, 6714.630695311805, 6733.898991515229, 6130.295016073031, 6176.258848938156, 6178.165947597017, 6187.783427580013, 6232.875342493216, 6127.693615319127, 6156.907646385397, 6168.35232300602, 6221.440070393686, 6228.906566401598], "unit": "score", "name": "mootools.html", "value": 4252.983525370474}, {"lowerIsBetter": false, "replicates": [312.79355625287315, 315.0658298145997, 318.4395463983389, 320.44243017150166, 320.83637344954053, 5279.736013199339, 5443.0, 5451.454854514546, 5467.808626698066, 5484.177373393993, 5270.8418747437545, 5370.597205209606, 5384.030874442598, 5384.1923711443305, 5387.272718183044, 4025.919481610381, 4149.917001659965, 4258.361245813122, 4263.275243208662, 4269.252880745873, 4242.342436922282, 4257.425247591566, 4258.127083947783, 4264.189803937242, 4266.018815672382, 4209.9789501052455, 4214.831406743727, 4224.387463817745, 4225.239456897757, 4228.619424251817, 4018.899527511821, 4093.8771836844944, 4193.790310484464, 4197.832086716528, 4224.302990006645, 3718.349288874463, 3719.3491139050557, 3720.8883733488037, 3726.7204959627866, 3736.047307936486, 5175.585953123741, 5178.135871086406, 5191.532762051434, 5202.193659982709, 5203.557697595709, 4807.11068452334, 4821.276808478756, 4830.2030165022725, 4831.685940413862, 4846.61227101831, 5639.210510528529, 5640.238567793336, 5642.4357564243655, 5652.689102099383, 5660.5471562274915, 4040.6363427291685, 4050.8379664813374, 4078.082431452929, 4087.3255912774357, 4089.6932730045364, 5678.488935995739, 5924.289085309747, 5937.435943585352, 5950.494207992283, 5953.851153721148, 4152.480939882515, 4176.0, 4178.6865985051245, 4184.267753143188, 4184.476940382452, 4227.3447615619625, 4228.957710422918, 4230.767307798039, 4235.343521754133, 4238.3006803877015, 4811.0, 4819.927701084486, 4820.373351464287, 4820.807167713322, 4823.903521929612, 5662.37713851476, 5664.037113690682, 5669.574781891375, 5671.1493276008105, 5673.290838645169, 1475.1001888847795, 1498.1086253679043, 1498.6777842763859, 1501.496998505491, 1505.0894209003395, 946.0, 1000.6091532769457, 1041.8958104189521, 1044.6002356841716, 1055.024102704995, 4901.36282283308, 5025.824096156617, 5027.84916452507, 5029.0, 5029.1450453423, 5914.497267732291, 5944.405559444108, 5955.40445955401, 5958.582899197101, 5997.820065398045, 5001.524855138756, 5024.698518088926, 5027.1956486962645, 5029.2958985742025, 5038.067957427815, 3158.952615710766, 3193.8562764675644, 3198.6641402652854, 3199.1202419334404, 3199.792013519114, 5536.086545719912, 5541.6120871539415, 5543.113101903676, 5549.5837812164245, 5553.08374118266, 5801.9419805802245, 6022.939770602238, 6045.6070355426755, 6047.244094488189, 6058.21243238385, 5498.670079795225, 5517.724113794375, 5520.067976208295, 5523.392426832965, 5524.0, 5913.231279933581, 5918.704064796829, 5920.141579471038, 5923.170756094064, 5923.348431672599, 5783.768649254151, 5786.42135786418, 5810.5351571875, 5821.301443826768, 5839.182514447895, 5353.491418315254, 5505.807296744595, 5518.806841760519, 5522.779088836402, 5523.392426832965, 4180.289350810309, 4197.160567886373, 4205.074883525619, 4205.158968206432, 4211.305134652748, 5853.531717462508, 5879.382664820132, 5883.235179426818, 5888.852778680396, 5896.351401345934, 5689.2319536862, 5691.032524470767, 5693.544516438592, 5696.515796157208, 5698.629589076862, 5658.236138121466, 5671.801486947937, 5676.375598684059, 5679.630823996427, 5679.772809087755, 5406.675599464044, 5570.6657600544095, 5601.971990140023, 5604.103343465026, 5614.606977511535, 5667.40492248308, 5694.857628559319, 5702.600817942704, 5703.486686198262, 5708.57185711065, 5515.806946756844, 5546.251256080377, 5564.415736347625, 5568.6658800472105, 5571.832845014656], "unit": "score", "name": "prototype.html", "value": 4296.868159863944}, {"lowerIsBetter": false, "replicates": [671.738022171353, 686.7321744519635, 717.6340066566049, 728.6720975560999, 739.1721272175165, 11929.463174157163, 12097.153199276054, 12107.455164517596, 12108.515659373625, 12110.576129835468, 11126.721831954204, 11137.554497820098, 11180.496877640506, 11181.888181118187, 11194.944025279861, 763.7746864674921, 777.5606782168057, 779.0651218537749, 779.5361759752966, 779.7270955165703, 641.3970867384644, 764.182324912344, 786.319833344156, 786.8622990976585, 788.4047544104193, 835.7994081420476, 839.1776059461731, 839.5927974932183, 841.3731769831484, 842.7682387343499, 675.1223409567542, 833.2833762963846, 834.4784509681449, 835.5362773660615, 835.6907944060706, 600.9639421634672, 602.2141105856855, 607.808540309801, 607.8146165419545, 609.9115628233881, 12274.815877761841, 12323.75352492945, 12351.629451116482, 12375.381230938507, 12431.316277604728, 10539.84190237147, 10960.12319014477, 11027.61403350887, 11215.439228038647, 11365.943170284096, 9095.59069841852, 9194.17252447283, 9406.200472959807, 9587.808243835154, 9875.160611348045, 3284.8193349365774, 3310.652381499956, 3341.7827841190488, 3408.1479630092476, 3415.5389022481895, 42726.57273427288, 42933.78533107346, 42943.57056429427, 43020.56979430197, 43059.784701076605, 9171.63313467454, 9507.714768556954, 9520.452390290875, 9580.0898914603, 9596.280278978966, 15654.9217253913, 15655.138967356905, 15657.138857362954, 15694.293756780973, 15703.293351799197, 6643.069970204176, 6677.09859169006, 6694.0, 6719.798406047827, 6983.615901125487, 3625.1118475973026, 3680.4847321375028, 3713.33160031197, 3734.533183352081, 3784.962150378516, 2926.6634337051087, 2962.6889176636573, 2974.2713035306488, 2975.866086026134, 2977.077106097117, 510.6399988008445, 519.5090639345857, 522.0759256116728, 523.683171681135, 566.3911295357507, 522.8509874685697, 540.4514417865869, 540.7107197649239, 544.3522208571787, 549.2118809508288, 7019.543729657658, 7270.309320614533, 7295.781126566211, 7378.631068446556, 7503.437242206856, 563.5745012515524, 565.7341049706631, 578.1732123064058, 590.6987436407463, 597.2892258212713, 3451.516787649731, 3485.89542313731, 3610.115521697201, 3649.069487280726, 3710.925781484409, 53643.0, 54119.18821217685, 54428.0, 54445.45554544483, 54507.454925450234, 44314.113717725464, 45105.32342014872, 45225.773871130434, 45376.77311613421, 45607.66727160914, 43348.783256083516, 43519.56480435219, 43584.0, 43735.12529749387, 43862.56137438585, 7172.928270717435, 7211.6033618151505, 7225.747098851515, 7255.818604534928, 7562.962185189039, 33275.667243327254, 33563.0, 33580.0, 33771.83114084414, 34522.30955380828, 40171.39742903801, 41194.58805411908, 41746.37380439357, 43162.352564712186, 43841.56158438375, 10351.68944931623, 10505.474726263808, 10602.946985265024, 10657.520411581343, 10967.287126336763, 11246.437678115897, 11256.549738010388, 11513.884861151617, 11629.651110466699, 11675.0, 10352.585896564053, 10777.13782897382, 10786.137109031415, 10815.297005694605, 11398.20212585111, 10845.511951962339, 11064.336139831636, 11410.486528106088, 11426.828597570877, 11883.702907427038, 10956.123510119012, 11056.11551075928, 11179.217454778087, 11477.081833453136, 11516.53933842637, 9223.907760922304, 9226.802845881104, 9392.95303523478, 9412.811743764949, 9569.569369378534, 9032.45805251687, 9193.770155745893, 9240.075992400707, 9394.906050939404, 9398.859017114612], "unit": "score", "name": "yui.html", "value": 5809.950521915052}], "name": "dromaeo_css", "value": 6339.974359004309}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 108.0, 114.0, 113.0, 113.0, 101.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [150.0, 128.0, 152.0, 167.0, 130.0, 160.0, 163.0, 129.0, 176.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 159.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 98.0, 96.0, 72.0, 80.0, 73.0, 118.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 133.0, 94.0, 93.0, 94.0, 133.0, 94.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [68.0, 74.0, 68.0, 69.0, 68.0, 68.0, 68.0, 78.0, 76.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 85.0, 81.0, 82.0, 98.0, 81.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 123.0, 120.0, 113.0, 122.0, 116.0, 114.0, 114.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [140.0, 131.0, 156.0, 142.0, 139.0, 126.0, 152.0, 136.0, 137.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 68.0, 64.0, 65.0, 65.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1510.9999999999998}]} 18:23:14 INFO - Return code: 0 18:23:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:23:14 ERROR - # TBPL SUCCESS # 18:23:14 INFO - Running post-action listener: _resource_record_post_action 18:23:14 INFO - Running post-run listener: _resource_record_post_run 18:23:16 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 303235072; Read time: 0; Write time: 241668 18:23:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20471808; Read time: 0; Write time: 13224 18:23:16 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 282763264; Read time: 0; Write time: 228444 18:23:16 INFO - Running post-run listener: _upload_blobber_files 18:23:16 INFO - Blob upload gear active. 18:23:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:23:16 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 18:23:16 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'] 18:23:16 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 18:23:17 INFO - (blobuploader) - INFO - Open directory for files ... 18:23:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:23:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:23:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:23:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:23:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:23:20 INFO - (blobuploader) - INFO - Done attempting. 18:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:23:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:23:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:23:22 INFO - (blobuploader) - INFO - Done attempting. 18:23:22 INFO - (blobuploader) - INFO - Iteration through files over. 18:23:22 INFO - Return code: 0 18:23:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:23:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:23:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21bfa941d5d7630a24215d159ce32f56e664d7539fb2ba0aea0ffc90a12c5eb1d71d2d8c5be615ce2623920805e4eee513308d033573caa7dcc7029c854b5250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/452aa831a2a2755fed477f0cbbdb18d2d5df8929cce7560aae5b6763af7f24bcce25af971f8a4a4976914c076d61457c28f1aa752a576e805eeba1de4753a3fc"} 18:23:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:23:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:23:22 INFO - Contents: 18:23:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21bfa941d5d7630a24215d159ce32f56e664d7539fb2ba0aea0ffc90a12c5eb1d71d2d8c5be615ce2623920805e4eee513308d033573caa7dcc7029c854b5250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/452aa831a2a2755fed477f0cbbdb18d2d5df8929cce7560aae5b6763af7f24bcce25af971f8a4a4976914c076d61457c28f1aa752a576e805eeba1de4753a3fc"} 18:23:22 INFO - Running post-run listener: copy_logs_to_upload_dir 18:23:22 INFO - Copying logs to upload dir... 18:23:22 INFO - mkdir: /builds/slave/test/build/upload/logs 18:23:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.551290 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-03-22 18:23:22.569818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 18:23:22.574690) ========= 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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 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/21bfa941d5d7630a24215d159ce32f56e664d7539fb2ba0aea0ffc90a12c5eb1d71d2d8c5be615ce2623920805e4eee513308d033573caa7dcc7029c854b5250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/452aa831a2a2755fed477f0cbbdb18d2d5df8929cce7560aae5b6763af7f24bcce25af971f8a4a4976914c076d61457c28f1aa752a576e805eeba1de4753a3fc"} build_url:https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/N71FFfdHSvmcaibHUay6bg/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/21bfa941d5d7630a24215d159ce32f56e664d7539fb2ba0aea0ffc90a12c5eb1d71d2d8c5be615ce2623920805e4eee513308d033573caa7dcc7029c854b5250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/452aa831a2a2755fed477f0cbbdb18d2d5df8929cce7560aae5b6763af7f24bcce25af971f8a4a4976914c076d61457c28f1aa752a576e805eeba1de4753a3fc"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 18:23:22.636984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 18:23:22.637339) ========= 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=1b9da9da7504fe468691862d000001b9-1458694940.296504-1503354065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 18:23:22.749897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 18:23:22.750313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 18:23:22.750701) ========= ========= Total master_lag: 0.40 =========