builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1458127086.53 results: success (0) buildid: 20160316025750 builduid: a6bfc521402f4a5fa4eb8f83ce9a3aee revision: 341344bdec8f10bf50646cd6ef2355361435cbf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.527997) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.528452) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.528742) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004971 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.552789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.553410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.567841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.568114) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.618668) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.619035) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.619394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.619666) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 04:18:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.9M=0s 2016-03-16 04:18:07 (38.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.779534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.779845) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021662 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.829562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:06.829906) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 341344bdec8f10bf50646cd6ef2355361435cbf6 --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 341344bdec8f10bf50646cd6ef2355361435cbf6 --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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 04:18:07,468 truncating revision to first 12 chars 2016-03-16 04:18:07,468 Setting DEBUG logging. 2016-03-16 04:18:07,468 attempt 1/10 2016-03-16 04:18:07,468 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/341344bdec8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 04:18:08,033 unpacking tar archive at: mozilla-central-341344bdec8f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.823094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:07.666866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:07.667285) ========= echo 341344bdec8f10bf50646cd6ef2355361435cbf6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'341344bdec8f10bf50646cd6ef2355361435cbf6'] 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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 341344bdec8f10bf50646cd6ef2355361435cbf6 program finished with exit code 0 elapsedTime=0.004313 script_repo_revision: '341344bdec8f10bf50646cd6ef2355361435cbf6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:07.718224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:07.718579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 04:18:07.728530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-16 04:18:07.728888) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:18:08 INFO - MultiFileLogger online at 20160316 04:18:08 in /builds/slave/test 04:18:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:18:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:18:08 INFO - {'append_to_log': False, 04:18:08 INFO - 'base_work_dir': '/builds/slave/test', 04:18:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:18:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:18:08 INFO - 'branch': 'Firefox-Non-PGO', 04:18:08 INFO - 'buildbot_json_path': 'buildprops.json', 04:18:08 INFO - 'config_files': ('talos/linux_config.py',), 04:18:08 INFO - 'default_actions': ('clobber', 04:18:08 INFO - 'read-buildbot-config', 04:18:08 INFO - 'download-and-extract', 04:18:08 INFO - 'populate-webroot', 04:18:08 INFO - 'create-virtualenv', 04:18:08 INFO - 'install', 04:18:08 INFO - 'run-tests'), 04:18:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:18:08 INFO - 'download_minidump_stackwalk': True, 04:18:08 INFO - 'download_symbols': 'ondemand', 04:18:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:18:08 INFO - 'tooltool.py': '/tools/tooltool.py', 04:18:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:18:08 INFO - '/tools/misc-python/virtualenv.py')}, 04:18:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:18:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:18:08 INFO - 'installer_path': 'installer.exe', 04:18:08 INFO - 'log_level': 'info', 04:18:08 INFO - 'log_name': 'talos', 04:18:08 INFO - 'log_to_console': True, 04:18:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:18:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:18:08 INFO - 'opt_config_files': (), 04:18:08 INFO - 'pip_index': False, 04:18:08 INFO - 'sps_profile': False, 04:18:08 INFO - 'sps_profile_interval': 0, 04:18:08 INFO - 'suite': 'dromaeojs', 04:18:08 INFO - 'system_bits': '32', 04:18:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:18:08 INFO - 'title': 'talos-linux64-ix-005', 04:18:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:18:08 INFO - 'use_talos_json': True, 04:18:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:18:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:18:08 INFO - 'work_dir': 'build'} 04:18:08 INFO - ##### 04:18:08 INFO - ##### Running clobber step. 04:18:08 INFO - ##### 04:18:08 INFO - Running pre-action listener: _resource_record_pre_action 04:18:08 INFO - Running main action method: clobber 04:18:08 INFO - rmtree: /builds/slave/test/build 04:18:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:18:08 INFO - Running post-action listener: _resource_record_post_action 04:18:08 INFO - ##### 04:18:08 INFO - ##### Running read-buildbot-config step. 04:18:08 INFO - ##### 04:18:08 INFO - Running pre-action listener: _resource_record_pre_action 04:18:08 INFO - Running main action method: read_buildbot_config 04:18:08 INFO - Using buildbot properties: 04:18:08 INFO - { 04:18:08 INFO - "project": "", 04:18:08 INFO - "product": "firefox", 04:18:08 INFO - "script_repo_revision": "production", 04:18:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:18:08 INFO - "repository": "", 04:18:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:18:08 INFO - "buildid": "20160316025750", 04:18:08 INFO - "pgo_build": "False", 04:18:08 INFO - "basedir": "/builds/slave/test", 04:18:08 INFO - "buildnumber": 451, 04:18:08 INFO - "slavename": "talos-linux64-ix-005", 04:18:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:18:08 INFO - "platform": "ubuntu64_hw", 04:18:08 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:18:08 INFO - "branch": "mozilla-central", 04:18:08 INFO - "repo_path": "mozilla-central", 04:18:08 INFO - "revision": "341344bdec8f10bf50646cd6ef2355361435cbf6", 04:18:08 INFO - "stage_platform": "linux64", 04:18:08 INFO - "builduid": "a6bfc521402f4a5fa4eb8f83ce9a3aee", 04:18:08 INFO - "slavebuilddir": "test" 04:18:08 INFO - } 04:18:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:18:08 INFO - Running post-action listener: _resource_record_post_action 04:18:08 INFO - ##### 04:18:08 INFO - ##### Running download-and-extract step. 04:18:08 INFO - ##### 04:18:08 INFO - Running pre-action listener: _resource_record_pre_action 04:18:08 INFO - Running main action method: download_and_extract 04:18:08 INFO - mkdir: /builds/slave/test/build/tests 04:18: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')]} 04:18:08 INFO - https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:18:09 INFO - Downloaded 1361 bytes. 04:18:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:18:09 INFO - Using the following test package requirements: 04:18:09 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:18:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:18:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:09 INFO - u'jsshell-linux-x86_64.zip'], 04:18:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:18:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:18:09 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:18:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:18:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:18:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:09 INFO - https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:18:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:18:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:18:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:18:10 INFO - Downloaded 21992660 bytes. 04:18:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:18:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:18:11 INFO - Return code: 0 04:18:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:11 INFO - https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:18:12 INFO - Downloaded 21992660 bytes. 04:18:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:18:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:18:14 INFO - Return code: 0 04:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:14 INFO - https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:18:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:18:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:18:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:18:15 INFO - Downloaded 10846462 bytes. 04:18:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:18:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:18:15 INFO - Return code: 0 04:18: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')]} 04:18:15 INFO - https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:18:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:18:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:18:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:18:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:18:18 INFO - Downloaded 54123829 bytes. 04:18:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:18:18 INFO - mkdir: /builds/slave/test/properties 04:18:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:18:18 INFO - Writing to file /builds/slave/test/properties/build_url 04:18:18 INFO - Contents: 04:18:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:18:18 INFO - Running post-action listener: _resource_record_post_action 04:18:18 INFO - Running post-action listener: set_extra_try_arguments 04:18:18 INFO - ##### 04:18:18 INFO - ##### Running populate-webroot step. 04:18:18 INFO - ##### 04:18:18 INFO - Running pre-action listener: _resource_record_pre_action 04:18:18 INFO - Running main action method: populate_webroot 04:18:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:18:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:18:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:18:18 INFO - '--tppagecycles', 04:18:18 INFO - '7'], 04:18:18 INFO - 'tests': ['tsvgm']}}, 04:18:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:18:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:18:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:18:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:18:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:18 INFO - 'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:18 INFO - 'tests': ['damp', 'tps']}, 04:18:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:18 INFO - 'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['damp', 'tps']}, 04:18:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:18:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:18:18 INFO - 'other': {'tests': ['a11yr', 04:18:18 INFO - 'ts_paint', 04:18:18 INFO - 'tpaint', 04:18:18 INFO - 'sessionrestore', 04:18:18 INFO - 'sessionrestore_no_auto_restore', 04:18:18 INFO - 'tabpaint']}, 04:18:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['a11yr', 04:18:18 INFO - 'ts_paint', 04:18:18 INFO - 'tpaint', 04:18:18 INFO - 'sessionrestore', 04:18:18 INFO - 'sessionrestore_no_auto_restore', 04:18:18 INFO - 'tabpaint']}, 04:18:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['a11yr', 04:18:18 INFO - 'ts_paint', 04:18:18 INFO - 'tpaint', 04:18:18 INFO - 'sessionrestore', 04:18:18 INFO - 'sessionrestore_no_auto_restore', 04:18:18 INFO - 'tabpaint']}, 04:18:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['a11yr', 04:18:18 INFO - 'ts_paint', 04:18:18 INFO - 'tpaint', 04:18:18 INFO - 'sessionrestore', 04:18:18 INFO - 'sessionrestore_no_auto_restore', 04:18:18 INFO - 'tabpaint']}, 04:18:18 INFO - 'other_l64': {'tests': ['a11yr', 04:18:18 INFO - 'ts_paint', 04:18:18 INFO - 'tpaint', 04:18:18 INFO - 'sessionrestore', 04:18:18 INFO - 'sessionrestore_no_auto_restore', 04:18:18 INFO - 'tabpaint']}, 04:18:18 INFO - 'other_nol64': {'tests': ['a11yr', 04:18:18 INFO - 'ts_paint', 04:18:18 INFO - 'tpaint', 04:18:18 INFO - 'sessionrestore', 04:18:18 INFO - 'sessionrestore_no_auto_restore', 04:18:18 INFO - 'tabpaint']}, 04:18:18 INFO - 'svgr': {'tests': ['tsvgx', 04:18:18 INFO - 'tsvgr_opacity', 04:18:18 INFO - 'tart', 04:18:18 INFO - 'tscrollx', 04:18:18 INFO - 'cart']}, 04:18:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['tsvgx', 04:18:18 INFO - 'tsvgr_opacity', 04:18:18 INFO - 'tart', 04:18:18 INFO - 'tscrollx', 04:18:18 INFO - 'cart']}, 04:18:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:18 INFO - 'tests': ['tp5o']}, 04:18:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:18 INFO - 'talos_options': ['--e10s'], 04:18:18 INFO - 'tests': ['tp5o']}, 04:18:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:18 INFO - 'talos_options': ['--xperf_path', 04:18:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:18 INFO - 'tests': ['tp5n']}, 04:18:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:18 INFO - 'talos_options': ['--e10s', 04:18:18 INFO - '--xperf_path', 04:18:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:18 INFO - 'tests': ['tp5n']}}, 04:18:18 INFO - 'talos.zip': {'path': '', 04:18:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:18:18 INFO - Running post-action listener: _resource_record_post_action 04:18:18 INFO - ##### 04:18:18 INFO - ##### Running create-virtualenv step. 04:18:18 INFO - ##### 04:18:18 INFO - Running pre-action listener: _resource_record_pre_action 04:18:18 INFO - Running main action method: create_virtualenv 04:18:18 INFO - Creating virtualenv /builds/slave/test/build/venv 04:18:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:18:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:18:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:18:18 INFO - Using real prefix '/usr' 04:18:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:18:19 INFO - Installing distribute.............................................................................................................................................................................................done. 04:18:21 INFO - Installing pip.................done. 04:18:21 INFO - Return code: 0 04:18:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:21 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 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:18:21 INFO - Using env: {'DISPLAY': ':0', 04:18:21 INFO - 'HOME': '/home/cltbld', 04:18:21 INFO - 'LANG': 'en_US.UTF-8', 04:18:21 INFO - 'LANGUAGE': 'en_US:en', 04:18:21 INFO - 'LOGNAME': 'cltbld', 04:18:21 INFO - 'MAIL': '/var/mail/cltbld', 04:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:21 INFO - 'MOZ_NO_REMOTE': '1', 04:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:21 INFO - 'NO_EM_RESTART': '1', 04:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:21 INFO - 'PWD': '/builds/slave/test', 04:18:21 INFO - 'SHELL': '/bin/bash', 04:18:21 INFO - 'SHLVL': '1', 04:18:21 INFO - 'TERM': 'linux', 04:18:21 INFO - 'TMOUT': '86400', 04:18:21 INFO - 'USER': 'cltbld', 04:18:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:21 INFO - '_': '/tools/buildbot/bin/python'} 04:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:18:21 INFO - Cleaning up... 04:18:21 INFO - Return code: 0 04:18:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:21 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 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:18:21 INFO - Using env: {'DISPLAY': ':0', 04:18:21 INFO - 'HOME': '/home/cltbld', 04:18:21 INFO - 'LANG': 'en_US.UTF-8', 04:18:21 INFO - 'LANGUAGE': 'en_US:en', 04:18:21 INFO - 'LOGNAME': 'cltbld', 04:18:21 INFO - 'MAIL': '/var/mail/cltbld', 04:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:21 INFO - 'MOZ_NO_REMOTE': '1', 04:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:21 INFO - 'NO_EM_RESTART': '1', 04:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:21 INFO - 'PWD': '/builds/slave/test', 04:18:21 INFO - 'SHELL': '/bin/bash', 04:18:21 INFO - 'SHLVL': '1', 04:18:21 INFO - 'TERM': 'linux', 04:18:21 INFO - 'TMOUT': '86400', 04:18:21 INFO - 'USER': 'cltbld', 04:18:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:21 INFO - '_': '/tools/buildbot/bin/python'} 04:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:21 INFO - Downloading/unpacking psutil>=0.7.1 04:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:18:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:23 INFO - Installing collected packages: psutil 04:18:23 INFO - Running setup.py install for psutil 04:18:23 INFO - building 'psutil._psutil_linux' extension 04:18:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:18:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:18:23 INFO - building 'psutil._psutil_posix' extension 04:18:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:18:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:18:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:24 INFO - Successfully installed psutil 04:18:24 INFO - Cleaning up... 04:18:24 INFO - Return code: 0 04:18:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:24 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 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:18:24 INFO - Using env: {'DISPLAY': ':0', 04:18:24 INFO - 'HOME': '/home/cltbld', 04:18:24 INFO - 'LANG': 'en_US.UTF-8', 04:18:24 INFO - 'LANGUAGE': 'en_US:en', 04:18:24 INFO - 'LOGNAME': 'cltbld', 04:18:24 INFO - 'MAIL': '/var/mail/cltbld', 04:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:24 INFO - 'MOZ_NO_REMOTE': '1', 04:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:24 INFO - 'NO_EM_RESTART': '1', 04:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:24 INFO - 'PWD': '/builds/slave/test', 04:18:24 INFO - 'SHELL': '/bin/bash', 04:18:24 INFO - 'SHLVL': '1', 04:18:24 INFO - 'TERM': 'linux', 04:18:24 INFO - 'TMOUT': '86400', 04:18:24 INFO - 'USER': 'cltbld', 04:18:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:24 INFO - '_': '/tools/buildbot/bin/python'} 04:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:18:26 INFO - Installing collected packages: mozsystemmonitor 04:18:26 INFO - Running setup.py install for mozsystemmonitor 04:18:26 INFO - Successfully installed mozsystemmonitor 04:18:26 INFO - Cleaning up... 04:18:26 INFO - Return code: 0 04:18:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:26 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 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:18:26 INFO - Using env: {'DISPLAY': ':0', 04:18:26 INFO - 'HOME': '/home/cltbld', 04:18:26 INFO - 'LANG': 'en_US.UTF-8', 04:18:26 INFO - 'LANGUAGE': 'en_US:en', 04:18:26 INFO - 'LOGNAME': 'cltbld', 04:18:26 INFO - 'MAIL': '/var/mail/cltbld', 04:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:26 INFO - 'MOZ_NO_REMOTE': '1', 04:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:26 INFO - 'NO_EM_RESTART': '1', 04:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:26 INFO - 'PWD': '/builds/slave/test', 04:18:26 INFO - 'SHELL': '/bin/bash', 04:18:26 INFO - 'SHLVL': '1', 04:18:26 INFO - 'TERM': 'linux', 04:18:26 INFO - 'TMOUT': '86400', 04:18:26 INFO - 'USER': 'cltbld', 04:18:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:26 INFO - '_': '/tools/buildbot/bin/python'} 04:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:18:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:29 INFO - Downloading docopt-0.6.1.tar.gz 04:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:29 INFO - Running setup.py install for blobuploader 04:18:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:29 INFO - Running setup.py install for requests 04:18:29 INFO - Running setup.py install for docopt 04:18:30 INFO - Successfully installed blobuploader requests docopt 04:18:30 INFO - Cleaning up... 04:18:30 INFO - Return code: 0 04:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:30 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 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:18:30 INFO - Using env: {'DISPLAY': ':0', 04:18:30 INFO - 'HOME': '/home/cltbld', 04:18:30 INFO - 'LANG': 'en_US.UTF-8', 04:18:30 INFO - 'LANGUAGE': 'en_US:en', 04:18:30 INFO - 'LOGNAME': 'cltbld', 04:18:30 INFO - 'MAIL': '/var/mail/cltbld', 04:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:30 INFO - 'MOZ_NO_REMOTE': '1', 04:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:30 INFO - 'NO_EM_RESTART': '1', 04:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:30 INFO - 'PWD': '/builds/slave/test', 04:18:30 INFO - 'SHELL': '/bin/bash', 04:18:30 INFO - 'SHLVL': '1', 04:18:30 INFO - 'TERM': 'linux', 04:18:30 INFO - 'TMOUT': '86400', 04:18:30 INFO - 'USER': 'cltbld', 04:18:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:30 INFO - '_': '/tools/buildbot/bin/python'} 04:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:30 INFO - Running setup.py (path:/tmp/pip-vjo75u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:30 INFO - Running setup.py (path:/tmp/pip-bh0yQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:30 INFO - Running setup.py (path:/tmp/pip-8X5UMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:30 INFO - Running setup.py (path:/tmp/pip-smfE_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:30 INFO - Running setup.py (path:/tmp/pip-0Hw16w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:30 INFO - Running setup.py (path:/tmp/pip-G1sHok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:30 INFO - Running setup.py (path:/tmp/pip-RwQFx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:30 INFO - Running setup.py (path:/tmp/pip-x_6OZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:30 INFO - Running setup.py (path:/tmp/pip-gp75RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:30 INFO - Running setup.py (path:/tmp/pip-W2MDaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:31 INFO - Running setup.py (path:/tmp/pip-1rsPjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:31 INFO - Running setup.py (path:/tmp/pip-FR0EbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:31 INFO - Running setup.py (path:/tmp/pip-sT08_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:31 INFO - Running setup.py (path:/tmp/pip-PDHhc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:31 INFO - Running setup.py (path:/tmp/pip-mHrkl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:31 INFO - Running setup.py (path:/tmp/pip-1WGOIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:31 INFO - Running setup.py (path:/tmp/pip-lGou1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:18:31 INFO - Running setup.py install for manifestparser 04:18:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:18:31 INFO - Running setup.py install for mozcrash 04:18:31 INFO - Running setup.py install for mozdebug 04:18:31 INFO - Running setup.py install for mozdevice 04:18:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:18:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:18:31 INFO - Running setup.py install for mozfile 04:18:32 INFO - Running setup.py install for mozhttpd 04:18:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Running setup.py install for mozinfo 04:18:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Running setup.py install for mozInstall 04:18:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Running setup.py install for mozleak 04:18:32 INFO - Running setup.py install for mozlog 04:18:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Running setup.py install for moznetwork 04:18:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Running setup.py install for mozprocess 04:18:32 INFO - Running setup.py install for mozprofile 04:18:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Running setup.py install for mozrunner 04:18:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:18:32 INFO - Running setup.py install for mozscreenshot 04:18:33 INFO - Running setup.py install for moztest 04:18:33 INFO - Running setup.py install for mozversion 04:18:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:18:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:18:33 INFO - Cleaning up... 04:18:33 INFO - Return code: 0 04:18:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:33 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 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:18:33 INFO - Using env: {'DISPLAY': ':0', 04:18:33 INFO - 'HOME': '/home/cltbld', 04:18:33 INFO - 'LANG': 'en_US.UTF-8', 04:18:33 INFO - 'LANGUAGE': 'en_US:en', 04:18:33 INFO - 'LOGNAME': 'cltbld', 04:18:33 INFO - 'MAIL': '/var/mail/cltbld', 04:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:33 INFO - 'MOZ_NO_REMOTE': '1', 04:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:33 INFO - 'NO_EM_RESTART': '1', 04:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:33 INFO - 'PWD': '/builds/slave/test', 04:18:33 INFO - 'SHELL': '/bin/bash', 04:18:33 INFO - 'SHLVL': '1', 04:18:33 INFO - 'TERM': 'linux', 04:18:33 INFO - 'TMOUT': '86400', 04:18:33 INFO - 'USER': 'cltbld', 04:18:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:33 INFO - '_': '/tools/buildbot/bin/python'} 04:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:33 INFO - Running setup.py (path:/tmp/pip-KcyYQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:33 INFO - Running setup.py (path:/tmp/pip-vTscva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:33 INFO - Running setup.py (path:/tmp/pip-MCq3ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:33 INFO - Running setup.py (path:/tmp/pip-1jBwBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:33 INFO - Running setup.py (path:/tmp/pip-RyuL7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:33 INFO - Running setup.py (path:/tmp/pip-IfU9kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:33 INFO - Running setup.py (path:/tmp/pip-zIBrw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:34 INFO - Running setup.py (path:/tmp/pip-cEGYg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:34 INFO - Running setup.py (path:/tmp/pip-zuKJoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:34 INFO - Running setup.py (path:/tmp/pip-xAc0Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:34 INFO - Running setup.py (path:/tmp/pip-vphfLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:34 INFO - Running setup.py (path:/tmp/pip-VC3olG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:34 INFO - Running setup.py (path:/tmp/pip-6snpxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:34 INFO - Running setup.py (path:/tmp/pip-tdtZOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:34 INFO - Running setup.py (path:/tmp/pip-G3VAMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:34 INFO - Running setup.py (path:/tmp/pip-pwJrKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:34 INFO - Running setup.py (path:/tmp/pip-zrT6FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:18:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:36 INFO - Downloading blessings-1.6.tar.gz 04:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:18:36 INFO - Installing collected packages: blessings 04:18:36 INFO - Running setup.py install for blessings 04:18:36 INFO - Successfully installed blessings 04:18:36 INFO - Cleaning up... 04:18:36 INFO - Return code: 0 04:18:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:37 INFO - Reading from file tmpfile_stdout 04:18:37 INFO - Current package versions: 04:18:37 INFO - argparse == 1.2.1 04:18:37 INFO - blessings == 1.6 04:18:37 INFO - blobuploader == 1.2.4 04:18:37 INFO - docopt == 0.6.1 04:18:37 INFO - manifestparser == 1.1 04:18:37 INFO - mozInstall == 1.12 04:18:37 INFO - mozcrash == 0.17 04:18:37 INFO - mozdebug == 0.1 04:18:37 INFO - mozdevice == 0.48 04:18:37 INFO - mozfile == 1.2 04:18:37 INFO - mozhttpd == 0.7 04:18:37 INFO - mozinfo == 0.9 04:18:37 INFO - mozleak == 0.1 04:18:37 INFO - mozlog == 3.1 04:18:37 INFO - moznetwork == 0.27 04:18:37 INFO - mozprocess == 0.22 04:18:37 INFO - mozprofile == 0.28 04:18:37 INFO - mozrunner == 6.11 04:18:37 INFO - mozscreenshot == 0.1 04:18:37 INFO - mozsystemmonitor == 0.0 04:18:37 INFO - moztest == 0.7 04:18:37 INFO - mozversion == 1.4 04:18:37 INFO - psutil == 3.1.1 04:18:37 INFO - requests == 1.2.3 04:18:37 INFO - wsgiref == 0.1.2 04:18:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:37 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 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:18:37 INFO - Using env: {'DISPLAY': ':0', 04:18:37 INFO - 'HOME': '/home/cltbld', 04:18:37 INFO - 'LANG': 'en_US.UTF-8', 04:18:37 INFO - 'LANGUAGE': 'en_US:en', 04:18:37 INFO - 'LOGNAME': 'cltbld', 04:18:37 INFO - 'MAIL': '/var/mail/cltbld', 04:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:37 INFO - 'MOZ_NO_REMOTE': '1', 04:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:37 INFO - 'NO_EM_RESTART': '1', 04:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:37 INFO - 'PWD': '/builds/slave/test', 04:18:37 INFO - 'SHELL': '/bin/bash', 04:18:37 INFO - 'SHLVL': '1', 04:18:37 INFO - 'TERM': 'linux', 04:18:37 INFO - 'TMOUT': '86400', 04:18:37 INFO - 'USER': 'cltbld', 04:18:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:37 INFO - '_': '/tools/buildbot/bin/python'} 04:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:18:37 INFO - Cleaning up... 04:18:37 INFO - Return code: 0 04:18:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:37 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 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:18:37 INFO - Using env: {'DISPLAY': ':0', 04:18:37 INFO - 'HOME': '/home/cltbld', 04:18:37 INFO - 'LANG': 'en_US.UTF-8', 04:18:37 INFO - 'LANGUAGE': 'en_US:en', 04:18:37 INFO - 'LOGNAME': 'cltbld', 04:18:37 INFO - 'MAIL': '/var/mail/cltbld', 04:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:37 INFO - 'MOZ_NO_REMOTE': '1', 04:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:37 INFO - 'NO_EM_RESTART': '1', 04:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:37 INFO - 'PWD': '/builds/slave/test', 04:18:37 INFO - 'SHELL': '/bin/bash', 04:18:37 INFO - 'SHLVL': '1', 04:18:37 INFO - 'TERM': 'linux', 04:18:37 INFO - 'TMOUT': '86400', 04:18:37 INFO - 'USER': 'cltbld', 04:18:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:37 INFO - '_': '/tools/buildbot/bin/python'} 04:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:37 INFO - Downloading/unpacking jsonschema 04:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:18:39 INFO - Downloading/unpacking functools32 (from jsonschema) 04:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:18:39 INFO - warning: no files found matching '*.txt' 04:18:39 INFO - no previously-included directories found matching 'build' 04:18:39 INFO - no previously-included directories found matching 'dist' 04:18:39 INFO - no previously-included directories found matching '.git*' 04:18:39 INFO - Installing collected packages: jsonschema, functools32 04:18:39 INFO - Running setup.py install for functools32 04:18:39 INFO - warning: no files found matching '*.txt' 04:18:39 INFO - no previously-included directories found matching 'build' 04:18:39 INFO - no previously-included directories found matching 'dist' 04:18:39 INFO - no previously-included directories found matching '.git*' 04:18:39 INFO - Successfully installed jsonschema functools32 04:18:39 INFO - Cleaning up... 04:18:39 INFO - Return code: 0 04:18:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0c33996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2598410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:18:39 INFO - Using env: {'DISPLAY': ':0', 04:18:39 INFO - 'HOME': '/home/cltbld', 04:18:39 INFO - 'LANG': 'en_US.UTF-8', 04:18:39 INFO - 'LANGUAGE': 'en_US:en', 04:18:39 INFO - 'LOGNAME': 'cltbld', 04:18:39 INFO - 'MAIL': '/var/mail/cltbld', 04:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:39 INFO - 'MOZ_NO_REMOTE': '1', 04:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:39 INFO - 'NO_EM_RESTART': '1', 04:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:39 INFO - 'PWD': '/builds/slave/test', 04:18:39 INFO - 'SHELL': '/bin/bash', 04:18:39 INFO - 'SHLVL': '1', 04:18:39 INFO - 'TERM': 'linux', 04:18:39 INFO - 'TMOUT': '86400', 04:18:39 INFO - 'USER': 'cltbld', 04:18:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:39 INFO - '_': '/tools/buildbot/bin/python'} 04:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:40 INFO - Downloading/unpacking flake8 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:18:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:18:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:18:42 INFO - no previously-included directories found matching 'docs/_build' 04:18:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:18:42 INFO - Running setup.py install for pep8 04:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:18:42 INFO - no previously-included directories found matching 'docs/_build' 04:18:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:18:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:18:42 INFO - Cleaning up... 04:18:42 INFO - Return code: 0 04:18:42 INFO - Running post-action listener: _resource_record_post_action 04:18:42 INFO - Running post-action listener: _start_resource_monitoring 04:18:42 INFO - Starting resource monitoring. 04:18:42 INFO - ##### 04:18:42 INFO - ##### Running install step. 04:18:42 INFO - ##### 04:18:42 INFO - Running pre-action listener: _resource_record_pre_action 04:18:42 INFO - Running main action method: install 04:18:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:43 INFO - Reading from file tmpfile_stdout 04:18:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:18:43 INFO - Reading from file tmpfile_stdout 04:18:43 INFO - Output received: 04:18:43 INFO - Usage: mozinstall [options] installer 04:18:43 INFO - Options: 04:18:43 INFO - -h, --help show this help message and exit 04:18:43 INFO - -d DEST, --destination=DEST 04:18:43 INFO - Directory to install application into. [default: 04:18:43 INFO - "/builds/slave/test"] 04:18:43 INFO - --app=APP Application being installed. [default: firefox] 04:18:43 INFO - mkdir: /builds/slave/test/build/application 04:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:18:58 INFO - Reading from file tmpfile_stdout 04:18:58 INFO - Output received: 04:18:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:18:58 INFO - Running post-action listener: _resource_record_post_action 04:18:58 INFO - ##### 04:18:58 INFO - ##### Running run-tests step. 04:18:58 INFO - ##### 04:18:58 INFO - Running pre-action listener: _resource_record_pre_action 04:18:58 INFO - Running main action method: run_tests 04:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:18:58 INFO - Python 2.7.3 04:18:58 INFO - Return code: 0 04:18:58 INFO - grabbing minidump binary from tooltool 04:18: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')]} 04:18:58 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 0x2627160>, '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 0x2628060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26284f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:18:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:18:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:18:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:18:58 INFO - Return code: 0 04:18:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:18:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:18:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:18:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:18:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:18:59 INFO - Return code: 0 04:18:59 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/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:18:59 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/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:18:59 INFO - Using env: {'DISPLAY': ':0', 04:18:59 INFO - 'HOME': '/home/cltbld', 04:18:59 INFO - 'LANG': 'en_US.UTF-8', 04:18:59 INFO - 'LANGUAGE': 'en_US:en', 04:18:59 INFO - 'LOGNAME': 'cltbld', 04:18:59 INFO - 'MAIL': '/var/mail/cltbld', 04:18:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:18:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:59 INFO - 'MOZ_NO_REMOTE': '1', 04:18:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:59 INFO - 'NO_EM_RESTART': '1', 04:18:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:59 INFO - 'PWD': '/builds/slave/test', 04:18:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:18:59 INFO - 'SHELL': '/bin/bash', 04:18:59 INFO - 'SHLVL': '1', 04:18:59 INFO - 'TERM': 'linux', 04:18:59 INFO - 'TMOUT': '86400', 04:18:59 INFO - 'USER': 'cltbld', 04:18:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228', 04:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:59 INFO - '_': '/tools/buildbot/bin/python'} 04:18:59 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/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:18:59 INFO - mozversion application_buildid: 20160316025750 04:18:59 INFO - mozversion application_changeset: 341344bdec8f10bf50646cd6ef2355361435cbf6 04:18:59 INFO - mozversion application_display_name: Nightly 04:18:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:18:59 INFO - mozversion application_name: Firefox 04:18:59 INFO - mozversion application_remotingname: firefox 04:18:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:18:59 INFO - mozversion application_vendor: Mozilla 04:18:59 INFO - mozversion application_version: 48.0a1 04:18:59 INFO - mozversion platform_buildid: 20160316025750 04:18:59 INFO - mozversion platform_changeset: 341344bdec8f10bf50646cd6ef2355361435cbf6 04:18:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:18:59 INFO - mozversion platform_version: 48.0a1 04:18:59 INFO - using testdate: 1458127139 04:18:59 INFO - actual date: 1458127139 04:18:59 INFO - starting webserver on 'localhost:36736' 04:18:59 INFO - SUITE-START | Running 2 tests 04:18:59 INFO - TEST-START | dromaeo_css 04:18:59 INFO - operating with platform_type : linux_ 04:18:59 INFO - Initialising browser for dromaeo_css test... 04:19:00 INFO - TEST-INFO | started process 14543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5r3V5B/profile http://localhost:36736/getInfo.html) 04:19:04 INFO - PROCESS | 14543 | __metrics Screen width/height:1600/1200 04:19:04 INFO - PROCESS | 14543 | colorDepth:24 04:19:04 INFO - PROCESS | 14543 | Browser inner width/height: 1024/697 04:19:04 INFO - PROCESS | 14543 | __metrics 04:19:05 ERROR - PROCESS | 14543 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:19:05 INFO - PROCESS | 14543 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:19:06 INFO - TEST-INFO | 14543: exit 0 04:19:06 INFO - Browser initialized. 04:19:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:19:06 INFO - TEST-INFO | started process 14634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5r3V5B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:18 INFO - PROCESS | 14634 | RSS: Main: 153948160 04:19:18 INFO - PROCESS | 14634 | 04:20:08 INFO - PROCESS | 14634 | 1458127208936 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:22:20 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:36736/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36736/tests/dromaeo/cssquery-ext.html) 04:22:21 INFO - PROCESS | 14634 | RSS: Main: 278380544 04:22:21 INFO - PROCESS | 14634 | 04:25:23 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:36736/tests/dromaeo/cssquery-ext.html (next: http://localhost:36736/tests/dromaeo/cssquery-jquery.html) 04:25:24 INFO - PROCESS | 14634 | RSS: Main: 238911488 04:25:24 INFO - PROCESS | 14634 | 04:28:26 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:36736/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36736/tests/dromaeo/cssquery-mootools.html) 04:28:26 INFO - PROCESS | 14634 | RSS: Main: 237760512 04:28:26 INFO - PROCESS | 14634 | 04:31:28 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:36736/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36736/tests/dromaeo/cssquery-prototype.html) 04:31:29 INFO - PROCESS | 14634 | RSS: Main: 210149376 04:31:29 INFO - PROCESS | 14634 | 04:34:32 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:36736/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36736/tests/dromaeo/cssquery-yui.html) 04:34:32 INFO - PROCESS | 14634 | RSS: Main: 206880768 04:34:32 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:36736/tests/dromaeo/cssquery-yui.html (next: http://localhost:36736/tests/dromaeo/cssquery-dojo.html) 04:37:35 INFO - PROCESS | 14634 | RSS: Main: 272031744 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | __start_tp_report 04:37:35 INFO - PROCESS | 14634 | _x_x_mozilla_page_load 04:37:35 INFO - PROCESS | 14634 | _x_x_mozilla_page_load_details 04:37:35 INFO - PROCESS | 14634 | |i|pagename|runs| 04:37:35 INFO - PROCESS | 14634 | |0;dojo.html;2629.0929629277894;2707.783377329814;2707.9323016924573;2717.782577393809;2746.5193591121556;4545.3863728396655;4658.464276608191;4687.36720542727;4695.483496815347;4712.128256272592;4662.766861656921;4705.223638099709;4750.121227572901;4755.3104799804005;4756.7621618919;4300.2044621745;4334.501532323776;4338.652907767387;4374.58441448062;4467.553244675522;4263.637590804786;4386.144701783153;4399.692021558492;4440.356148358486;4472.932906006413;4298.892527686801;4329.112531930947;4333.090051089275;4408.647308215367;4410.0077482566485;4233.047564298039;4233.872983810491;4274.123804620045;4278.165757677223;4292.871213863589;4240.427542281815;4256.978715106436;4267.743935363888;4276.18752437036;4289.506706728735;4592.770361481913;4651.023285110131;4658.720476771405;4668.953310466886;4685.88285292867;5064.797408103672;5073.898522029539;5076.720780357079;5093.236014597803;5097.6941383517105;5100.954304367596;5105.132127538327;5110.335656364686;5113.974430127862;5164.845054648366;4596.195665758479;4669.859904202879;4743.620510359163;4746.169420351424;4766.547178018082;5102.846914592494;5116.948830511722;5118.820841270538;5119.539241468286;5123.308353372322;4902.534259245366;4904.5340692634145;4910.48439913811;4911.87720306988;4961.925571116436;4923.212286034217;4998.525140111684;5061.9746901266;5111.667741596784;5130.461301563357;4966.404031516169;5013.222950442687;5015.448300686921;5016.849494515171;5062.215356619729;4846.418429788448;4993;5001.824936127218;5004.154373535414;5004.949950500449;4184.602462766033;4207.284761590537;4228.703990720682;4264.786760661955;4267.295896177158;3705.5368078990127;3711.981440092782;3714.1643130295465;3720.516332876709;3739.794311312904;4246.129543443587;4351.782410879443;4352.630026447724;4352.651787856964;4398.47218333802;5068.138416469209;5106.770195341219;5125.359330083739;5157.896842063213;5163.4062082860955;4320.611144996902;4348.847790327323;4352.586504282088;4359.106383191438;4375.803088861009;4408.911821763547;4538.1377538267625;4540.931886021713;4543.432070991126;4576.771161441981;4759.42886853566;4784.760761961818;4787.042591481648;4806.543378379049;4837.612990960714;5029.798808047637;5051.292819005269;5053.11570475158;5053.898922021613;5097.108006098992;4690.882727931829;4790.281457781361;4792.400949881126;4854.514548545118;4864.148773964613;4930.186519224288;4949.82675606352;4951.752412379295;4953.182724850503;4973.254011898244;5018.799248030038;5022.447530771686;5023.196288593807;5036.244563315532;5070.873228169326;4751.83368582098;4870.78081486341;4916.729579873141;4944.184209605375;4978.103941290602;4846.273059041172;4855.5387238212315;4860.854174374775;4862.173430516891;4919.237518184687;4799.712017278975;4807.639427043056;4808.230683090689;4811.206150985188;4858.004109157685;4799.616030717604;4839.564439200489;4855.95144048555;4873.244647079709;4916.631252656137;4757.595604373529;4757.976210118927;4821.156297647827;4857.222844344888;4877.048975449895 04:37:35 INFO - PROCESS | 14634 | |1;ext.html;531.9999999999998;557.1086261980834;564.463759428543;574.4628772098089;582.8863371642531;27620.309492262702;35841.462378064316;36106.277874442494;36404.45393319102;36507.26985460296;39028.21943561134;39562.60437395625;39567.208655826864;39624.20751584974;39878;7755.146933837287;7932.643031063616;7938.24586664266;7942;7943.602819858984;7732.342750866155;7842.490238134503;7843.725469608565;7846.489978151402;8049.034115906099;8038.035435747718;8113.7565873023905;8122.796930076736;8125.959370203141;8137.430379873411;7962.044554653449;8000.119986801447;8040.115587285394;8044.356451483867;8046.155153708864;7903.56530390834;8028;8042.437029407944;8042.879356809653;8048.879266811003;38170.42744358837;38837.41743873844;38839.223215535814;38841.223175536616;38863.41704874429;3191.920201994969;3200.2799370141765;3202.5356323333217;3234.66036066212;3354.312365964996;29552.408951821057;29582.40835183306;29598.556021659693;29815.403691926258;30260.54609180864;3477.0959550517045;3489.965100349015;3543.85824567017;3561.1631266652316;3569.232614987764;249380;250545;250943;251306;251902;56726;56844;57012.71493642505;57064.71467642718;57094.42905570974;60421.69789151114;65583;66855.66572167205;66873.99689004669;66875.66562167255;14008.299585020708;14092.084014539023;14117.294135293194;14136.71726565463;14137.293135343192;11151.944240278908;11202.327860328407;11236.606718764804;11243.156763242627;11245.775084498428;20694.48263793387;20906;20916.686249706265;20937.685934710993;21005.36983890486;7736.7447903652765;7842.176571460029;7848.7252946147755;7986.321162701235;7992.640331185111;915.2357781252596;947.4031360243002;971.3540495570367;989.6981420666766;1005.9144972677404;26717.732822671915;27930.162095137177;28304.43391132166;28435.857820710764;28490.430191396055;1049.5172220778527;1069.8823129455754;1082.3992684060422;1103.089950790601;1119.3955264157428;14317.713645727026;14539.854601454063;14616.707665846623;14735.852641473448;14799.112053276838;290471;291010;294934;295292;295861;47346.34287799979;47859.76070119627;47861.28208076882;47877.28184077242;47950.28074578884;1096.1614365010773;1254.4480428611382;1263.128441375448;1276.5595869425033;1280.2766436963086;24031.658234070226;26933;27598.7058894017;27873.581896271167;28026.43947121087;39049.21901561896;39182.6081739179;39200.80399597984;39228.803855980535;39553.406698898965;201152;206582;206664;207441;208090;28834.42331153323;29496.557551636313;30484.695153048186;31413.52879706852;31715.20711982219;34478.31043379169;35091.64908350986;35136.82431587826;35724.821375892956;35773.821130894175;31192.532112017885;34053.65946340505;34080.48879266763;34175;34352.79765208206;32767.18082047968;33454.83272583621;33694.157646059044;33733.83133084319;33769.49345759865;33157.33685326328;33650.83174584111;33762.15594610154;33993.83003084969;34008.829955850066;29769.702302976693;30687.539686905162;30807.53788693216;30854.53718194274;30904.690953090183;23747.168849090198;24027;24274;24398.26805195847;24467 04:37:35 INFO - PROCESS | 14634 | |2;jquery.html;354.9645035496452;362.95825980012296;363.45663233465956;368.35353953811057;371.09823129794603;15405.306761195745;15766.527004189878;16772.999999999985;17066.23201955912;17069.57326066849;16356;16678;16683.83316166838;16714.49856504304;16897.662046759087;4700.318453824193;5011.799528018884;5160.509751573613;5990.760369585211;5993.130996005599;5898.292204935414;5900.557458190631;5913.024350982083;5920.289565252176;5932.228810254661;5798.594098413113;5815.47660710536;5843.912341314884;5873.442023007808;5979.46184843364;5947.345791962881;5954.434328738763;5954.761809527614;5962.940370596282;5978.52171826255;5078.568321692661;5151.304573882516;5212.895742085175;5241.371035475768;5242.475752424765;18928.90535547327;19837.40487785369;19912.20351185951;19960.800391996185;20050;2024.595080983809;2033.0546295972297;2058.7323647925673;2485.8632775197357;2563.5513785087724;12390.62828115158;12541.435635396429;12721.491140354376;12890.935545322307;12914.160579562298;1770.590080513057;1788.3115000724686;1806.9186886590135;1810.2758896441396;1865.2538984406347;58950.41049589492;60460.659296783546;60954.390456095316;61431.38568614301;61441.385586143566;9522.190613797904;9669.811320754812;9697.854532182022;9744.269179811543;9985.500724963722;12287.877121228674;12337.889589936949;12396.504139834306;12416.565420210249;12428;7265.818354541178;7438.479306448605;7453.478256522099;7537.849243015109;7544.396448284124;7295.70817167318;7323.63381830917;7344.118705755343;7414.740484083031;7421.109466864011;5916.112583112482;6006.759729610854;6033.487153591994;6039.214902062704;6135.171751813537;1727.8444939955464;1751.6321572469924;1764.9823501764818;1767.7878654561277;1774.4587900690155;868.9956550217208;879.2921698033017;917.2845180759018;969.966051188205;977.6627063663025;15958.202089895458;16200;16525.91737041307;16786.916065419595;16838.747418788727;890.5992303463468;907.2061945797427;925.2967744514083;929.9814003720023;970.4129001953858;9234.676786312446;9365.625374984924;9857.260705447121;9944.950275248577;9949.751256218507;431466;436306;444735;445413;456136;71682.64158679277;72887;73087.26912730804;76240;77484.61257693789;948.7296120605595;953.804470083645;969.8545218217324;972.246508955551;978.8825340958988;9951.900480995388;9963.153131983863;10159.288849780445;10792.730181745519;15484.767728484307;32425.675743242267;34547.309053819285;34561.827190863885;34646.307073857875;34664.13339666528;46744;47547;47762.28356574585;47821.28268076051;48069.519304806505;10213.84679229827;10580.629677961235;10583.5237414315;10694.679159625224;10699.572017119228;12117.27296362221;12172.939135304267;12278.81581776292;12317.076219283768;12404.937975310066;9877.901220987986;10402.531886064993;10442.68671939843;10777.868323826198;10902.672919812418;10231.641892534024;10269.127124194527;10464.476776161313;10725.41010244444;10791.136709063414;9656.95171524138;10303.124234440156;10722.571097156026;10802.783944320912;10968.341899486057;10291.279610427198;10358.430286334324;10498.580056797642;10503.894961050291;10745.355278683304;10366.585336586451;10581.52383142745;10627.574897004342;10817.134629229486;10937.289076210021 04:37:35 INFO - PROCESS | 14634 | |3;mootools.html;1287.3177216075483;1443.3504922784746;1458.6426325550237;1633.9428120015803;1813.8548916086716;7040.823979400511;7250.528715633487;7254.093238345207;7263.3826124779325;7265.963670181655;7454.888176677354;7600.657970391332;7622.96188519058;7629.008228930245;7629.923700762991;1957.2660252405349;2202.493426511903;2211.060299372768;2237.272886311955;2265.286434773041;2260.333201705501;2270.977290227093;2271.205078222625;2272.091163534583;2274.533720587284;2144.5818065477238;2208.138825857917;2209.9668504972437;2210.8120809731113;2213.0815711479718;2188.660757582569;2208.3485371815273;2209.9447513812124;2258.5144193998203;2260.333201705501;2210.5136869888597;2222.29997550771;2239.731232252124;2239.731232252124;2279.7606251343536;7740.767776966643;7809.219078092202;7813.531188128673;7814.804629884242;7819.726309579194;4523.796429160696;4649.953500464986;4666.066786642651;4686.9765651171865;4694.624430045588;3054.618172728409;3109.6890310968947;3171.841407929617;3172.74618030557;3202.9199270018203;945;967.1682353176262;967.7919247361851;983.0906411569341;1011.8886922438526;10554.261201715883;10656.893431065668;10689.572417103307;10692.786144277148;10704.946475267574;3958.287508248485;4132.173565286955;4147.937780933288;4194.769287689145;4211.0946146578635;8469.957650211709;8481.872771908425;8487.872681909776;8496.192861678255;8531.65873365071;4017.397390391465;4623.791929363187;4624.468186158635;4629.166749984967;4631.374764406762;4049.4330793688905;4058.5129784425467;4078.632923036941;4098.508179018537;4101.241270364992;3339.1652086978256;3401.5067815166663;3430.6740859618294;3441.9483707744403;3469;961.9374740641836;963.4315753705348;965.1217392173229;988.5403287471361;1023.0638965346773;1020.3469779341227;1024.0169437340087;1031.7214352124884;1104.8508451359126;1200.4537935239446;6882.5870447773295;6888.070110535114;6929.514933954575;6934.687939042755;6944.791656250321;464.9767511624405;482.0527663141943;485.68430520161473;489.8603897889156;491.0302153247379;5613.298337707786;5718.571107166979;5722.856928576819;5758.481736643722;5767.250257466502;9097.13577210164;9673.806523869483;9779.070988256246;9783.168430683472;9788.461634610023;9602.855957160647;9628.566714497865;9661.903380966241;9663.516824158905;9663.90336096644;7234.529755565872;7439.739609113655;7508.911207874828;7511.924880751232;7514.346843694379;6977.546459480118;7011;7065.752698655522;7076.964615176891;7077.5399599025895;8396.748097557083;8586.098459661895;8607.225349718556;8728.301735861243;8734.69428569997;8581.184787445183;8737.912620873964;8743.169398907094;8784.648614055366;8872.378933474594;5457.754401052041;6089.756409743561;6275.090111933835;6413.134226879498;6469.450096741642;7357.5953322567775;7361.558306501627;7361.631918403951;7406.962965185139;7409.66656500448;6448;6555.6066636002;6564.179477565304;6651.102101216274;6676.9666151668935;6294.716737746904;6488.643124628191;6509.804705858643;6587;6614.801555953329;6434;6451.677416129269;6469.417752402306;6474.223093228843;6484.837879053061;6093.116498107661;6111.786087487095;6136.048912418582;6205.47253483459;6341.302456729663;6238.251409830667;6285.654289013965;6301.936980630318;6305.464035557029;6363.96818015907 04:37:35 INFO - PROCESS | 14634 | |4;prototype.html;325.29573473430025;327.32897560002004;329.4383076853964;332.380111092812;333.13219064337414;5411.404745477994;5432.103702889023;5463.836084917449;5496.312960879885;5497.230387745719;5368.677879327243;5376.91934620981;5378.112611419121;5384.165454354572;5392.056390131721;3979.303621866162;4088.1619268049976;4132.731372460796;4169.937450938239;4227.999999999993;4172.728772629769;4202.579742025803;4203.264428724976;4211.38934854446;4220.177065472234;4165.416841642173;4168.603982621661;4177.707560470768;4178.832846686144;4189.266878296301;3996.2806694794926;4092.774897380658;4150.896227594304;4151.3150330195485;4153.563875793028;3664.871729489482;3672.706183505313;3678.08047988003;3684.299983003221;3685.8157092145284;5127.4359820420095;5132.486751324875;5136.743162841843;5138.2549530318265;5140.357455318085;4794.664373493822;4799.880002999918;4862.610991120702;4868.440129385131;4870.829520966749;5703.77184912603;5707.429257074301;5715.3998830122655;5715.514181294595;5716.857078573027;4083;4083.8570650027405;4084.14233011068;4086.080631857838;4088.2028004539125;5776.884462310731;6018.789342373039;6067.908981365283;6075.027995520695;6077.726502307407;4033.778142202207;4084.203580301872;4086.40747091676;4089.5501494835544;4091.774952377648;4129.194807012604;4144.70987030905;4145.191687620945;4145.730527515701;4150.522689890701;4755.239161734106;4756.762161891961;4762.8333008345235;4772.665913386029;4774.116788394158;5694.658320500783;5698.572607054488;5713.457221563945;5715.628484148517;5716.57125715573;1430.5136253673802;1447.269129089824;1450.6518435575385;1453.0990785712925;1454.3891565542497;906.5739102621757;952.5045678285026;958.0467434902178;977.4037836919473;994.4778991029767;4953.678010929278;4979.153543897473;4981.003799240167;4987.551120399109;5001.849944501598;5868.2664666916635;5871.853203669943;5879.353271140171;5891.145783861316;5891.234139561915;4944.134776414113;4965.255211718271;4973.825916092992;4989.201727723546;4993.375828021497;3102.488089465258;3149.2126968257935;3150.779445438843;3153.30627262002;3153.858076386568;5526.866992266576;5536.4186760390385;5536.52939500147;5536.972315138479;5537.944620553743;5912.320083190402;6080.695965201722;6107.206063211843;6132.877342453126;6135.877282454326;5552.08390615552;5596.804111856066;5602.1036634138345;5613.466720661612;5617;5958.880822383441;5959.374265702038;5963.165156878127;5964.582479226413;5971.731272092679;5832.154337621106;5840.240768700211;5842.532597392284;5842.912356314744;5849.5612829037145;5432.239486471976;5594.13290939905;5596.384397716167;5600.327960644749;5608.7195640217005;4025.2150830587752;4027.4562934004707;4052.189562087653;4053.493313335833;4054.493188351456;5935.703214839327;5939.643621382731;5962;5962.970185149046;5965.612235204698;5699.059655156852;5723.427657234243;5725.08398656213;5733.165387076096;5739;5715.39988301239;5717.085266357529;5718.485336319751;5720.19917211599;5726;5415.539679127318;5608.523275521627;5608.775648973995;5618.410066942912;5631.802886898939;5748.655080695172;5768.423157684198;5771.394003629726;5782.10377391505;5789.623674461147;5603.299587551556;5629.437056294338;5646.661200327993;5649.971750141223;5656.660600363992 04:37:35 INFO - PROCESS | 14634 | |5;yui.html;705.3264132753221;737.9557226566407;749.605733335995;754.8301632132774;759.9734009309674;11221.102311815055;11316.773664526714;11339.43302834859;11442.599509017185;11450.141239407058;10209;10702.46487675617;11192.216544841864;11204.775904481905;11292.266002709817;803.8713805791075;814.1980149552686;815.5066184958104;819.9467034642759;820.216693058131;810.05628442864;815.4169768615438;815.4780940198278;816.1960468938091;816.3958670583785;864.9913500864974;865.4374656473279;869.0527325215514;870.1820288928419;870.4385671242045;862.4006315610653;865.4244927123456;865.7748985263845;866.3242670716851;866.8613021916494;635.5995722694719;636.3127821952327;636.4144986612328;636.6339354870921;637.0953246390137;10316.535755891004;10366.326188797779;10372.325798823127;10376.740581485448;10404.583816647326;10401.94799026;10606.840897386546;10655.84016239757;10853.565857365697;11096.389698566576;8928.955355223183;8961.372703910729;9003.369764116514;9080.68217612387;9122.087791220825;3188.792728472642;3201.407739568164;3261.037993791837;3280.852361643732;3302.735781137503;38257;39736.20527589461;40241.19517609631;40308.798456007826;44075;9103.81792364149;9290.070992900655;9306.767330816649;9516.286278529138;9737.172340351008;17845.553861153574;17851.910740446216;17888.642227155386;17895.821041789677;17923.10384480771;5936.643801371932;6558.967205164039;6578.3092775258865;6900.896486552706;6953.061336719579;3675.3568125577917;3676.0809797550614;3690.612485689018;3694.722895782827;3813.675837553839;2733.72662733725;2750.546159883637;2761.3924936513936;2780.3188218886503;2781.972180278212;509.997450012755;512.4823927832915;517.729755024214;519.3819354967577;520.3703518742288;465.17895913712323;576.6453631016894;596.8269201931391;598.2970010237952;659.5383231737803;7423.369013633902;7576.3181313682035;7583.696652133964;7754.651040703182;7769;483.91289567877413;495.86363749969047;506.89608630230714;638.5625846295303;641.8222561599517;3435.7594968352473;3596.298721749286;3598.838052287653;3662.212624285738;3698.778073315556;54324.45675543273;55930.720346398004;56267;56508.15237771437;56564;47963;48125.518744812805;48157.5184248153;49234.26148607774;49445.752771236635;36675.449868252;38701;44334.33498497525;44495.33257001147;45411.545884541396;7915.762527124196;8100.149484304299;8127.309178719638;8212.909561290076;8271.83456330858;32898.67101329052;33086.50370244496;33554.496682549296;33794.193461536815;34337.484937726455;39356.606433935296;43235.567644324416;43761.34357984569;43770.781146094065;43783.78108109439;9937.552810123707;10042.949785251027;10290.794184116126;10495.317804342692;10590.576376944837;11075.5569777208;11193.608223712132;11347.716307092389;11416;11729.765404692029;10622.09712174443;10650.254482186172;10846.511906964364;10949.890501094887;11139.164562657996;10661.626843060456;10717.785644287227;10726.73183170427;10881.945590271998;10899;9474.478903660365;9507.714768556954;9592.184664303333;9655.275854310814;10112.342697724624;8358.707445239388;8389.286910612665;8485.618147183268;8557.015943166616;8662.263707584925;8402.327813775006;8553.44402613853;8634.699215344377;8671.13288671153;8786.736397908073 04:37:35 INFO - PROCESS | 14634 | __end_tp_report 04:37:35 INFO - PROCESS | 14634 | __start_cc_report 04:37:35 INFO - PROCESS | 14634 | _x_x_mozilla_cycle_collect,1146 04:37:35 INFO - PROCESS | 14634 | __end_cc_report 04:37:35 INFO - PROCESS | 14634 | __startTimestamp1458128255274__endTimestamp 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | ------- Summary: start ------- 04:37:35 INFO - PROCESS | 14634 | Number of tests: 6 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | [#0] dojo.html Cycles:165 Average:4652.16 Median:4790.28 stddev:481.54 (10.1%) stddev-sans-first:456.12 04:37:35 INFO - PROCESS | 14634 | Values: 2629.1 2707.8 2707.9 2717.8 2746.5 4545.4 4658.5 4687.4 4695.5 4712.1 4662.8 4705.2 4750.1 4755.3 4756.8 4300.2 4334.5 4338.7 4374.6 4467.6 4263.6 4386.1 4399.7 4440.4 4472.9 4298.9 4329.1 4333.1 4408.6 4410.0 4233.0 4233.9 4274.1 4278.2 4292.9 4240.4 4257.0 4267.7 4276.2 4289.5 4592.8 4651.0 4658.7 4669.0 4685.9 5064.8 5073.9 5076.7 5093.2 5097.7 5101.0 5105.1 5110.3 5114.0 5164.8 4596.2 4669.9 4743.6 4746.2 4766.5 5102.8 5116.9 5118.8 5119.5 5123.3 4902.5 4904.5 4910.5 4911.9 4961.9 4923.2 4998.5 5062.0 5111.7 5130.5 4966.4 5013.2 5015.4 5016.8 5062.2 4846.4 4993.0 5001.8 5004.2 5004.9 4184.6 4207.3 4228.7 4264.8 4267.3 3705.5 3712.0 3714.2 3720.5 3739.8 4246.1 4351.8 4352.6 4352.7 4398.5 5068.1 5106.8 5125.4 5157.9 5163.4 4320.6 4348.8 4352.6 4359.1 4375.8 4408.9 4538.1 4540.9 4543.4 4576.8 4759.4 4784.8 4787.0 4806.5 4837.6 5029.8 5051.3 5053.1 5053.9 5097.1 4690.9 4790.3 4792.4 4854.5 4864.1 4930.2 4949.8 4951.8 4953.2 4973.3 5018.8 5022.4 5023.2 5036.2 5070.9 4751.8 4870.8 4916.7 4944.2 4978.1 4846.3 4855.5 4860.9 4862.2 4919.2 4799.7 4807.6 4808.2 4811.2 4858.0 4799.6 4839.6 4856.0 4873.2 4916.6 4757.6 4758.0 4821.2 4857.2 4877.0 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | [#1] ext.html Cycles:180 Average:41593.57 Median:33881.66 stddev:65942.59 (194.6%) stddev-sans-first:66055.50 04:37:35 INFO - PROCESS | 14634 | Values: 532.0 557.1 564.5 574.5 582.9 27620.3 35841.5 36106.3 36404.5 36507.3 39028.2 39562.6 39567.2 39624.2 39878.0 7755.1 7932.6 7938.2 7942.0 7943.6 7732.3 7842.5 7843.7 7846.5 8049.0 8038.0 8113.8 8122.8 8126.0 8137.4 7962.0 8000.1 8040.1 8044.4 8046.2 7903.6 8028.0 8042.4 8042.9 8048.9 38170.4 38837.4 38839.2 38841.2 38863.4 3191.9 3200.3 3202.5 3234.7 3354.3 29552.4 29582.4 29598.6 29815.4 30260.5 3477.1 3490.0 3543.9 3561.2 3569.2 249380.0 250545.0 250943.0 251306.0 251902.0 56726.0 56844.0 57012.7 57064.7 57094.4 60421.7 65583.0 66855.7 66874.0 66875.7 14008.3 14092.1 14117.3 14136.7 14137.3 11151.9 11202.3 11236.6 11243.2 11245.8 20694.5 20906.0 20916.7 20937.7 21005.4 7736.7 7842.2 7848.7 7986.3 7992.6 915.2 947.4 971.4 989.7 1005.9 26717.7 27930.2 28304.4 28435.9 28490.4 1049.5 1069.9 1082.4 1103.1 1119.4 14317.7 14539.9 14616.7 14735.9 14799.1 290471.0 291010.0 294934.0 295292.0 295861.0 47346.3 47859.8 47861.3 47877.3 47950.3 1096.2 1254.4 1263.1 1276.6 1280.3 24031.7 26933.0 27598.7 27873.6 28026.4 39049.2 39182.6 39200.8 39228.8 39553.4 201152.0 206582.0 206664.0 207441.0 208090.0 28834.4 29496.6 30484.7 31413.5 31715.2 34478.3 35091.6 35136.8 35724.8 35773.8 31192.5 34053.7 34080.5 34175.0 34352.8 32767.2 33454.8 33694.2 33733.8 33769.5 33157.3 33650.8 33762.2 33993.8 34008.8 29769.7 30687.5 30807.5 30854.5 30904.7 23747.2 24027.0 24274.0 24398.3 24467.0 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | [#2] jquery.html Cycles:180 Average:25500.86 Median:215918.55 stddev:72535.18 (33.6%) stddev-sans-first:72714.08 04:37:35 INFO - PROCESS | 14634 | Values: 355.0 363.0 363.5 368.4 371.1 15405.3 15766.5 16773.0 17066.2 17069.6 16356.0 16678.0 16683.8 16714.5 16897.7 4700.3 5011.8 5160.5 5990.8 5993.1 5898.3 5900.6 5913.0 5920.3 5932.2 5798.6 5815.5 5843.9 5873.4 5979.5 5947.3 5954.4 5954.8 5962.9 5978.5 5078.6 5151.3 5212.9 5241.4 5242.5 18928.9 19837.4 19912.2 19960.8 20050.0 2024.6 2033.1 2058.7 2485.9 2563.6 12390.6 12541.4 12721.5 12890.9 12914.2 1770.6 1788.3 1806.9 1810.3 1865.3 58950.4 60460.7 60954.4 61431.4 61441.4 9522.2 9669.8 9697.9 9744.3 9985.5 12287.9 12337.9 12396.5 12416.6 12428.0 7265.8 7438.5 7453.5 7537.8 7544.4 7295.7 7323.6 7344.1 7414.7 7421.1 5916.1 6006.8 6033.5 6039.2 6135.2 1727.8 1751.6 1765.0 1767.8 1774.5 869.0 879.3 917.3 970.0 977.7 15958.2 16200.0 16525.9 16786.9 16838.7 890.6 907.2 925.3 930.0 970.4 9234.7 9365.6 9857.3 9945.0 9949.8 431466.0 436306.0 444735.0 445413.0 456136.0 71682.6 72887.0 73087.3 76240.0 77484.6 948.7 953.8 969.9 972.2 978.9 9951.9 9963.2 10159.3 10792.7 15484.8 32425.7 34547.3 34561.8 34646.3 34664.1 46744.0 47547.0 47762.3 47821.3 48069.5 10213.8 10580.6 10583.5 10694.7 10699.6 12117.3 12172.9 12278.8 12317.1 12404.9 9877.9 10402.5 10442.7 10777.9 10902.7 10231.6 10269.1 10464.5 10725.4 10791.1 9657.0 10303.1 10722.6 10802.8 10968.3 10291.3 10358.4 10498.6 10503.9 10745.4 10366.6 10581.5 10627.6 10817.1 10937.3 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | [#3] mootools.html Cycles:180 Average:5308.16 Median:6290.19 stddev:2839.74 (45.1%) stddev-sans-first:2831.62 04:37:35 INFO - PROCESS | 14634 | Values: 1287.3 1443.4 1458.6 1633.9 1813.9 7040.8 7250.5 7254.1 7263.4 7266.0 7454.9 7600.7 7623.0 7629.0 7629.9 1957.3 2202.5 2211.1 2237.3 2265.3 2260.3 2271.0 2271.2 2272.1 2274.5 2144.6 2208.1 2210.0 2210.8 2213.1 2188.7 2208.3 2209.9 2258.5 2260.3 2210.5 2222.3 2239.7 2239.7 2279.8 7740.8 7809.2 7813.5 7814.8 7819.7 4523.8 4650.0 4666.1 4687.0 4694.6 3054.6 3109.7 3171.8 3172.7 3202.9 945.0 967.2 967.8 983.1 1011.9 10554.3 10656.9 10689.6 10692.8 10704.9 3958.3 4132.2 4147.9 4194.8 4211.1 8470.0 8481.9 8487.9 8496.2 8531.7 4017.4 4623.8 4624.5 4629.2 4631.4 4049.4 4058.5 4078.6 4098.5 4101.2 3339.2 3401.5 3430.7 3441.9 3469.0 961.9 963.4 965.1 988.5 1023.1 1020.3 1024.0 1031.7 1104.9 1200.5 6882.6 6888.1 6929.5 6934.7 6944.8 465.0 482.1 485.7 489.9 491.0 5613.3 5718.6 5722.9 5758.5 5767.3 9097.1 9673.8 9779.1 9783.2 9788.5 9602.9 9628.6 9661.9 9663.5 9663.9 7234.5 7439.7 7508.9 7511.9 7514.3 6977.5 7011.0 7065.8 7077.0 7077.5 8396.7 8586.1 8607.2 8728.3 8734.7 8581.2 8737.9 8743.2 8784.6 8872.4 5457.8 6089.8 6275.1 6413.1 6469.5 7357.6 7361.6 7361.6 7407.0 7409.7 6448.0 6555.6 6564.2 6651.1 6677.0 6294.7 6488.6 6509.8 6587.0 6614.8 6434.0 6451.7 6469.4 6474.2 6484.8 6093.1 6111.8 6136.0 6205.5 6341.3 6238.3 6285.7 6301.9 6305.5 6364.0 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | [#4] prototype.html Cycles:180 Average:4730.63 Median:5413.47 stddev:1397.55 (25.8%) stddev-sans-first:1361.79 04:37:35 INFO - PROCESS | 14634 | Values: 325.3 327.3 329.4 332.4 333.1 5411.4 5432.1 5463.8 5496.3 5497.2 5368.7 5376.9 5378.1 5384.2 5392.1 3979.3 4088.2 4132.7 4169.9 4228.0 4172.7 4202.6 4203.3 4211.4 4220.2 4165.4 4168.6 4177.7 4178.8 4189.3 3996.3 4092.8 4150.9 4151.3 4153.6 3664.9 3672.7 3678.1 3684.3 3685.8 5127.4 5132.5 5136.7 5138.3 5140.4 4794.7 4799.9 4862.6 4868.4 4870.8 5703.8 5707.4 5715.4 5715.5 5716.9 4083.0 4083.9 4084.1 4086.1 4088.2 5776.9 6018.8 6067.9 6075.0 6077.7 4033.8 4084.2 4086.4 4089.6 4091.8 4129.2 4144.7 4145.2 4145.7 4150.5 4755.2 4756.8 4762.8 4772.7 4774.1 5694.7 5698.6 5713.5 5715.6 5716.6 1430.5 1447.3 1450.7 1453.1 1454.4 906.6 952.5 958.0 977.4 994.5 4953.7 4979.2 4981.0 4987.6 5001.8 5868.3 5871.9 5879.4 5891.1 5891.2 4944.1 4965.3 4973.8 4989.2 4993.4 3102.5 3149.2 3150.8 3153.3 3153.9 5526.9 5536.4 5536.5 5537.0 5537.9 5912.3 6080.7 6107.2 6132.9 6135.9 5552.1 5596.8 5602.1 5613.5 5617.0 5958.9 5959.4 5963.2 5964.6 5971.7 5832.2 5840.2 5842.5 5842.9 5849.6 5432.2 5594.1 5596.4 5600.3 5608.7 4025.2 4027.5 4052.2 4053.5 4054.5 5935.7 5939.6 5962.0 5963.0 5965.6 5699.1 5723.4 5725.1 5733.2 5739.0 5715.4 5717.1 5718.5 5720.2 5726.0 5415.5 5608.5 5608.8 5618.4 5631.8 5748.7 5768.4 5771.4 5782.1 5789.6 5603.3 5629.4 5646.7 5650.0 5656.7 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - PROCESS | 14634 | [#5] yui.html Cycles:180 Average:12638.15 Median:49340.01 stddev:14946.77 (30.3%) stddev-sans-first:14961.83 04:37:35 INFO - PROCESS | 14634 | Values: 705.3 738.0 749.6 754.8 760.0 11221.1 11316.8 11339.4 11442.6 11450.1 10209.0 10702.5 11192.2 11204.8 11292.3 803.9 814.2 815.5 819.9 820.2 810.1 815.4 815.5 816.2 816.4 865.0 865.4 869.1 870.2 870.4 862.4 865.4 865.8 866.3 866.9 635.6 636.3 636.4 636.6 637.1 10316.5 10366.3 10372.3 10376.7 10404.6 10401.9 10606.8 10655.8 10853.6 11096.4 8929.0 8961.4 9003.4 9080.7 9122.1 3188.8 3201.4 3261.0 3280.9 3302.7 38257.0 39736.2 40241.2 40308.8 44075.0 9103.8 9290.1 9306.8 9516.3 9737.2 17845.6 17851.9 17888.6 17895.8 17923.1 5936.6 6559.0 6578.3 6900.9 6953.1 3675.4 3676.1 3690.6 3694.7 3813.7 2733.7 2750.5 2761.4 2780.3 2782.0 510.0 512.5 517.7 519.4 520.4 465.2 576.6 596.8 598.3 659.5 7423.4 7576.3 7583.7 7754.7 7769.0 483.9 495.9 506.9 638.6 641.8 3435.8 3596.3 3598.8 3662.2 3698.8 54324.5 55930.7 56267.0 56508.2 56564.0 47963.0 48125.5 48157.5 49234.3 49445.8 36675.4 38701.0 44334.3 44495.3 45411.5 7915.8 8100.1 8127.3 8212.9 8271.8 32898.7 33086.5 33554.5 33794.2 34337.5 39356.6 43235.6 43761.3 43770.8 43783.8 9937.6 10042.9 10290.8 10495.3 10590.6 11075.6 11193.6 11347.7 11416.0 11729.8 10622.1 10650.3 10846.5 10949.9 11139.2 10661.6 10717.8 10726.7 10881.9 10899.0 9474.5 9507.7 9592.2 9655.3 10112.3 8358.7 8389.3 8485.6 8557.0 8662.3 8402.3 8553.4 8634.7 8671.1 8786.7 04:37:35 INFO - PROCESS | 14634 | -------- Summary: end -------- 04:37:35 INFO - PROCESS | 14634 | 04:37:35 INFO - TEST-INFO | 14634: exit 0 04:37:36 INFO - TEST-OK | dromaeo_css | took 1116018ms 04:37:36 INFO - TEST-START | kraken 04:37:36 INFO - operating with platform_type : linux_ 04:37:36 INFO - Initialising browser for kraken test... 04:37:36 INFO - TEST-INFO | started process 14811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIzA0LG/profile http://localhost:36736/getInfo.html) 04:37:40 INFO - PROCESS | 14811 | __metrics Screen width/height:1600/1200 04:37:40 INFO - PROCESS | 14811 | colorDepth:24 04:37:40 INFO - PROCESS | 14811 | Browser inner width/height: 1024/697 04:37:40 INFO - PROCESS | 14811 | __metrics 04:37:40 ERROR - PROCESS | 14811 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:37:41 INFO - TEST-INFO | 14811: exit 0 04:37:41 INFO - Browser initialized. 04:37:41 INFO - Running cycle 1/1 for kraken test... 04:37:41 INFO - TEST-INFO | started process 14892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIzA0LG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:53 INFO - PROCESS | 14892 | RSS: Main: 154460160 04:37:53 INFO - PROCESS | 14892 | 04:37:56 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36736/tests/kraken/driver.html?testName=audio-beat-detection) 04:37:57 INFO - PROCESS | 14892 | RSS: Main: 195596288 04:37:57 INFO - PROCESS | 14892 | 04:37:59 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36736/tests/kraken/driver.html?testName=audio-dft) 04:38:00 INFO - PROCESS | 14892 | RSS: Main: 187285504 04:38:00 INFO - PROCESS | 14892 | 04:38:03 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36736/tests/kraken/driver.html?testName=audio-fft) 04:38:04 INFO - PROCESS | 14892 | RSS: Main: 173510656 04:38:04 INFO - PROCESS | 14892 | 04:38:06 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36736/tests/kraken/driver.html?testName=audio-oscillator) 04:38:06 INFO - PROCESS | 14892 | RSS: Main: 174415872 04:38:06 INFO - PROCESS | 14892 | 04:38:08 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36736/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:38:09 INFO - PROCESS | 14892 | RSS: Main: 173539328 04:38:09 INFO - PROCESS | 14892 | 04:38:12 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36736/tests/kraken/driver.html?testName=imaging-darkroom) 04:38:13 INFO - PROCESS | 14892 | RSS: Main: 176132096 04:38:13 INFO - PROCESS | 14892 | 04:38:16 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36736/tests/kraken/driver.html?testName=imaging-desaturate) 04:38:17 INFO - PROCESS | 14892 | RSS: Main: 174841856 04:38:17 INFO - PROCESS | 14892 | 04:38:20 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36736/tests/kraken/driver.html?testName=json-parse-financial) 04:38:20 INFO - PROCESS | 14892 | RSS: Main: 177123328 04:38:20 INFO - PROCESS | 14892 | 04:38:22 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36736/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:38:22 INFO - PROCESS | 14892 | RSS: Main: 188755968 04:38:22 INFO - PROCESS | 14892 | 04:38:24 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36736/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:38:25 INFO - PROCESS | 14892 | RSS: Main: 185978880 04:38:25 INFO - PROCESS | 14892 | 04:38:27 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36736/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:38:28 INFO - PROCESS | 14892 | RSS: Main: 198930432 04:38:28 INFO - PROCESS | 14892 | 04:38:30 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:38:31 INFO - PROCESS | 14892 | RSS: Main: 202502144 04:38:31 INFO - PROCESS | 14892 | 04:38:33 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:38:34 INFO - PROCESS | 14892 | RSS: Main: 201670656 04:38:34 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | Cycle 1(1): loaded http://localhost:36736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36736/tests/kraken/driver.html?testName=ai-astar) 04:38:36 INFO - PROCESS | 14892 | RSS: Main: 262914048 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | __start_tp_report 04:38:36 INFO - PROCESS | 14892 | _x_x_mozilla_page_load 04:38:36 INFO - PROCESS | 14892 | _x_x_mozilla_page_load_details 04:38:36 INFO - PROCESS | 14892 | |i|pagename|runs| 04:38:36 INFO - PROCESS | 14892 | |0;ai-astar;111;112;106;112;113;112;101;112;112;112 04:38:36 INFO - PROCESS | 14892 | |1;audio-beat-detection;156;131;154;173;129;167;155;132;172;131 04:38:36 INFO - PROCESS | 14892 | |2;audio-dft;165;166;166;166;164;164;164;168;165;164 04:38:36 INFO - PROCESS | 14892 | |3;audio-fft;75;77;74;154;74;75;73;75;148;77 04:38:36 INFO - PROCESS | 14892 | |4;audio-oscillator;94;94;134;94;94;94;151;93;94;137 04:38:36 INFO - PROCESS | 14892 | |5;imaging-gaussian-blur;117;116;116;116;118;116;117;116;117;117 04:38:36 INFO - PROCESS | 14892 | |6;imaging-darkroom;146;146;146;145;146;145;146;145;145;145 04:38:36 INFO - PROCESS | 14892 | |7;imaging-desaturate;95;96;96;95;96;95;96;96;96;95 04:38:36 INFO - PROCESS | 14892 | |8;json-parse-financial;66;67;66;72;66;65;66;75;63;63 04:38:36 INFO - PROCESS | 14892 | |9;json-stringify-tinderbox;65;65;64;65;64;65;65;64;65;65 04:38:36 INFO - PROCESS | 14892 | |10;stanford-crypto-aes;81;81;82;81;81;81;81;80;82;80 04:38:36 INFO - PROCESS | 14892 | |11;stanford-crypto-ccm;124;114;115;116;124;116;125;120;117;117 04:38:36 INFO - PROCESS | 14892 | |12;stanford-crypto-pbkdf2;144;133;155;142;142;131;144;143;144;151 04:38:36 INFO - PROCESS | 14892 | |13;stanford-crypto-sha256-iterative;66;68;68;68;67;66;68;67;66;65 04:38:36 INFO - PROCESS | 14892 | __end_tp_report 04:38:36 INFO - PROCESS | 14892 | __start_cc_report 04:38:36 INFO - PROCESS | 14892 | _x_x_mozilla_cycle_collect,1149 04:38:36 INFO - PROCESS | 14892 | __end_cc_report 04:38:36 INFO - PROCESS | 14892 | __startTimestamp1458128316345__endTimestamp 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | ------- Summary: start ------- 04:38:36 INFO - PROCESS | 14892 | Number of tests: 14 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.80 (3.4%) stddev-sans-first:4.02 04:38:36 INFO - PROCESS | 14892 | Values: 111.0 112.0 106.0 112.0 113.0 112.0 101.0 112.0 112.0 112.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:155.50 stddev:17.85 (11.5%) stddev-sans-first:18.79 04:38:36 INFO - PROCESS | 14892 | Values: 156.0 131.0 154.0 173.0 129.0 167.0 155.0 132.0 172.0 131.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:1.32 (0.8%) stddev-sans-first:1.39 04:38:36 INFO - PROCESS | 14892 | Values: 165.0 166.0 166.0 166.0 164.0 164.0 164.0 168.0 165.0 164.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#3] audio-fft Cycles:10 Average:90.20 Median:75.00 stddev:32.10 (42.8%) stddev-sans-first:33.57 04:38:36 INFO - PROCESS | 14892 | Values: 75.0 77.0 74.0 154.0 74.0 75.0 73.0 75.0 148.0 77.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.00 stddev:23.01 (24.5%) stddev-sans-first:23.85 04:38:36 INFO - PROCESS | 14892 | Values: 94.0 94.0 134.0 94.0 94.0 94.0 151.0 93.0 94.0 137.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:38:36 INFO - PROCESS | 14892 | Values: 117.0 116.0 116.0 116.0 118.0 116.0 117.0 116.0 117.0 117.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:38:36 INFO - PROCESS | 14892 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:38:36 INFO - PROCESS | 14892 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:66.00 stddev:3.78 (5.7%) stddev-sans-first:4.00 04:38:36 INFO - PROCESS | 14892 | Values: 66.0 67.0 66.0 72.0 66.0 65.0 66.0 75.0 63.0 63.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:38:36 INFO - PROCESS | 14892 | Values: 65.0 65.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 04:38:36 INFO - PROCESS | 14892 | Values: 81.0 81.0 82.0 81.0 81.0 81.0 81.0 80.0 82.0 80.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:118.50 stddev:4.13 (3.5%) stddev-sans-first:3.93 04:38:36 INFO - PROCESS | 14892 | Values: 124.0 114.0 115.0 116.0 124.0 116.0 125.0 120.0 117.0 117.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:144.00 stddev:7.13 (4.9%) stddev-sans-first:7.55 04:38:36 INFO - PROCESS | 14892 | Values: 144.0 133.0 155.0 142.0 142.0 131.0 144.0 143.0 144.0 151.0 04:38:36 INFO - PROCESS | 14892 | 04:38:36 INFO - PROCESS | 14892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.10 (1.6%) stddev-sans-first:1.12 04:38:36 INFO - PROCESS | 14892 | Values: 66.0 68.0 68.0 68.0 67.0 66.0 68.0 67.0 66.0 65.0 04:38:36 INFO - PROCESS | 14892 | -------- Summary: end -------- 04:38:36 INFO - PROCESS | 14892 | 04:38:37 INFO - TEST-INFO | 14892: exit 0 04:38:37 INFO - TEST-OK | kraken | took 61254ms 04:38:37 INFO - SUITE-END | took 1177s 04:38:37 INFO - Completed test suite (00:19:37) 04:38:37 INFO - javascript benchmark 04:38:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.0929629277894, 2707.783377329814, 2707.9323016924573, 2717.782577393809, 2746.5193591121556, 4545.3863728396655, 4658.464276608191, 4687.36720542727, 4695.483496815347, 4712.128256272592, 4662.766861656921, 4705.223638099709, 4750.121227572901, 4755.3104799804005, 4756.7621618919, 4300.2044621745, 4334.501532323776, 4338.652907767387, 4374.58441448062, 4467.553244675522, 4263.637590804786, 4386.144701783153, 4399.692021558492, 4440.356148358486, 4472.932906006413, 4298.892527686801, 4329.112531930947, 4333.090051089275, 4408.647308215367, 4410.0077482566485, 4233.047564298039, 4233.872983810491, 4274.123804620045, 4278.165757677223, 4292.871213863589, 4240.427542281815, 4256.978715106436, 4267.743935363888, 4276.18752437036, 4289.506706728735, 4592.770361481913, 4651.023285110131, 4658.720476771405, 4668.953310466886, 4685.88285292867, 5064.797408103672, 5073.898522029539, 5076.720780357079, 5093.236014597803, 5097.6941383517105, 5100.954304367596, 5105.132127538327, 5110.335656364686, 5113.974430127862, 5164.845054648366, 4596.195665758479, 4669.859904202879, 4743.620510359163, 4746.169420351424, 4766.547178018082, 5102.846914592494, 5116.948830511722, 5118.820841270538, 5119.539241468286, 5123.308353372322, 4902.534259245366, 4904.5340692634145, 4910.48439913811, 4911.87720306988, 4961.925571116436, 4923.212286034217, 4998.525140111684, 5061.9746901266, 5111.667741596784, 5130.461301563357, 4966.404031516169, 5013.222950442687, 5015.448300686921, 5016.849494515171, 5062.215356619729, 4846.418429788448, 4993.0, 5001.824936127218, 5004.154373535414, 5004.949950500449, 4184.602462766033, 4207.284761590537, 4228.703990720682, 4264.786760661955, 4267.295896177158, 3705.5368078990127, 3711.981440092782, 3714.1643130295465, 3720.516332876709, 3739.794311312904, 4246.129543443587, 4351.782410879443, 4352.630026447724, 4352.651787856964, 4398.47218333802, 5068.138416469209, 5106.770195341219, 5125.359330083739, 5157.896842063213, 5163.4062082860955, 4320.611144996902, 4348.847790327323, 4352.586504282088, 4359.106383191438, 4375.803088861009, 4408.911821763547, 4538.1377538267625, 4540.931886021713, 4543.432070991126, 4576.771161441981, 4759.42886853566, 4784.760761961818, 4787.042591481648, 4806.543378379049, 4837.612990960714, 5029.798808047637, 5051.292819005269, 5053.11570475158, 5053.898922021613, 5097.108006098992, 4690.882727931829, 4790.281457781361, 4792.400949881126, 4854.514548545118, 4864.148773964613, 4930.186519224288, 4949.82675606352, 4951.752412379295, 4953.182724850503, 4973.254011898244, 5018.799248030038, 5022.447530771686, 5023.196288593807, 5036.244563315532, 5070.873228169326, 4751.83368582098, 4870.78081486341, 4916.729579873141, 4944.184209605375, 4978.103941290602, 4846.273059041172, 4855.5387238212315, 4860.854174374775, 4862.173430516891, 4919.237518184687, 4799.712017278975, 4807.639427043056, 4808.230683090689, 4811.206150985188, 4858.004109157685, 4799.616030717604, 4839.564439200489, 4855.95144048555, 4873.244647079709, 4916.631252656137, 4757.595604373529, 4757.976210118927, 4821.156297647827, 4857.222844344888, 4877.048975449895], "unit": "score", "name": "dojo.html", "value": 4622.286719179301}, {"lowerIsBetter": false, "replicates": [531.9999999999998, 557.1086261980834, 564.463759428543, 574.4628772098089, 582.8863371642531, 27620.309492262702, 35841.462378064316, 36106.277874442494, 36404.45393319102, 36507.26985460296, 39028.21943561134, 39562.60437395625, 39567.208655826864, 39624.20751584974, 39878.0, 7755.146933837287, 7932.643031063616, 7938.24586664266, 7942.0, 7943.602819858984, 7732.342750866155, 7842.490238134503, 7843.725469608565, 7846.489978151402, 8049.034115906099, 8038.035435747718, 8113.7565873023905, 8122.796930076736, 8125.959370203141, 8137.430379873411, 7962.044554653449, 8000.119986801447, 8040.115587285394, 8044.356451483867, 8046.155153708864, 7903.56530390834, 8028.0, 8042.437029407944, 8042.879356809653, 8048.879266811003, 38170.42744358837, 38837.41743873844, 38839.223215535814, 38841.223175536616, 38863.41704874429, 3191.920201994969, 3200.2799370141765, 3202.5356323333217, 3234.66036066212, 3354.312365964996, 29552.408951821057, 29582.40835183306, 29598.556021659693, 29815.403691926258, 30260.54609180864, 3477.0959550517045, 3489.965100349015, 3543.85824567017, 3561.1631266652316, 3569.232614987764, 249380.0, 250545.0, 250943.0, 251306.0, 251902.0, 56726.0, 56844.0, 57012.71493642505, 57064.71467642718, 57094.42905570974, 60421.69789151114, 65583.0, 66855.66572167205, 66873.99689004669, 66875.66562167255, 14008.299585020708, 14092.084014539023, 14117.294135293194, 14136.71726565463, 14137.293135343192, 11151.944240278908, 11202.327860328407, 11236.606718764804, 11243.156763242627, 11245.775084498428, 20694.48263793387, 20906.0, 20916.686249706265, 20937.685934710993, 21005.36983890486, 7736.7447903652765, 7842.176571460029, 7848.7252946147755, 7986.321162701235, 7992.640331185111, 915.2357781252596, 947.4031360243002, 971.3540495570367, 989.6981420666766, 1005.9144972677404, 26717.732822671915, 27930.162095137177, 28304.43391132166, 28435.857820710764, 28490.430191396055, 1049.5172220778527, 1069.8823129455754, 1082.3992684060422, 1103.089950790601, 1119.3955264157428, 14317.713645727026, 14539.854601454063, 14616.707665846623, 14735.852641473448, 14799.112053276838, 290471.0, 291010.0, 294934.0, 295292.0, 295861.0, 47346.34287799979, 47859.76070119627, 47861.28208076882, 47877.28184077242, 47950.28074578884, 1096.1614365010773, 1254.4480428611382, 1263.128441375448, 1276.5595869425033, 1280.2766436963086, 24031.658234070226, 26933.0, 27598.7058894017, 27873.581896271167, 28026.43947121087, 39049.21901561896, 39182.6081739179, 39200.80399597984, 39228.803855980535, 39553.406698898965, 201152.0, 206582.0, 206664.0, 207441.0, 208090.0, 28834.42331153323, 29496.557551636313, 30484.695153048186, 31413.52879706852, 31715.20711982219, 34478.31043379169, 35091.64908350986, 35136.82431587826, 35724.821375892956, 35773.821130894175, 31192.532112017885, 34053.65946340505, 34080.48879266763, 34175.0, 34352.79765208206, 32767.18082047968, 33454.83272583621, 33694.157646059044, 33733.83133084319, 33769.49345759865, 33157.33685326328, 33650.83174584111, 33762.15594610154, 33993.83003084969, 34008.829955850066, 29769.702302976693, 30687.539686905162, 30807.53788693216, 30854.53718194274, 30904.690953090183, 23747.168849090198, 24027.0, 24274.0, 24398.26805195847, 24467.0], "unit": "score", "name": "ext.html", "value": 17318.070196407625}, {"lowerIsBetter": false, "replicates": [354.9645035496452, 362.95825980012296, 363.45663233465956, 368.35353953811057, 371.09823129794603, 15405.306761195745, 15766.527004189878, 16772.999999999985, 17066.23201955912, 17069.57326066849, 16356.0, 16678.0, 16683.83316166838, 16714.49856504304, 16897.662046759087, 4700.318453824193, 5011.799528018884, 5160.509751573613, 5990.760369585211, 5993.130996005599, 5898.292204935414, 5900.557458190631, 5913.024350982083, 5920.289565252176, 5932.228810254661, 5798.594098413113, 5815.47660710536, 5843.912341314884, 5873.442023007808, 5979.46184843364, 5947.345791962881, 5954.434328738763, 5954.761809527614, 5962.940370596282, 5978.52171826255, 5078.568321692661, 5151.304573882516, 5212.895742085175, 5241.371035475768, 5242.475752424765, 18928.90535547327, 19837.40487785369, 19912.20351185951, 19960.800391996185, 20050.0, 2024.595080983809, 2033.0546295972297, 2058.7323647925673, 2485.8632775197357, 2563.5513785087724, 12390.62828115158, 12541.435635396429, 12721.491140354376, 12890.935545322307, 12914.160579562298, 1770.590080513057, 1788.3115000724686, 1806.9186886590135, 1810.2758896441396, 1865.2538984406347, 58950.41049589492, 60460.659296783546, 60954.390456095316, 61431.38568614301, 61441.385586143566, 9522.190613797904, 9669.811320754812, 9697.854532182022, 9744.269179811543, 9985.500724963722, 12287.877121228674, 12337.889589936949, 12396.504139834306, 12416.565420210249, 12428.0, 7265.818354541178, 7438.479306448605, 7453.478256522099, 7537.849243015109, 7544.396448284124, 7295.70817167318, 7323.63381830917, 7344.118705755343, 7414.740484083031, 7421.109466864011, 5916.112583112482, 6006.759729610854, 6033.487153591994, 6039.214902062704, 6135.171751813537, 1727.8444939955464, 1751.6321572469924, 1764.9823501764818, 1767.7878654561277, 1774.4587900690155, 868.9956550217208, 879.2921698033017, 917.2845180759018, 969.966051188205, 977.6627063663025, 15958.202089895458, 16200.0, 16525.91737041307, 16786.916065419595, 16838.747418788727, 890.5992303463468, 907.2061945797427, 925.2967744514083, 929.9814003720023, 970.4129001953858, 9234.676786312446, 9365.625374984924, 9857.260705447121, 9944.950275248577, 9949.751256218507, 431466.0, 436306.0, 444735.0, 445413.0, 456136.0, 71682.64158679277, 72887.0, 73087.26912730804, 76240.0, 77484.61257693789, 948.7296120605595, 953.804470083645, 969.8545218217324, 972.246508955551, 978.8825340958988, 9951.900480995388, 9963.153131983863, 10159.288849780445, 10792.730181745519, 15484.767728484307, 32425.675743242267, 34547.309053819285, 34561.827190863885, 34646.307073857875, 34664.13339666528, 46744.0, 47547.0, 47762.28356574585, 47821.28268076051, 48069.519304806505, 10213.84679229827, 10580.629677961235, 10583.5237414315, 10694.679159625224, 10699.572017119228, 12117.27296362221, 12172.939135304267, 12278.81581776292, 12317.076219283768, 12404.937975310066, 9877.901220987986, 10402.531886064993, 10442.68671939843, 10777.868323826198, 10902.672919812418, 10231.641892534024, 10269.127124194527, 10464.476776161313, 10725.41010244444, 10791.136709063414, 9656.95171524138, 10303.124234440156, 10722.571097156026, 10802.783944320912, 10968.341899486057, 10291.279610427198, 10358.430286334324, 10498.580056797642, 10503.894961050291, 10745.355278683304, 10366.585336586451, 10581.52383142745, 10627.574897004342, 10817.134629229486, 10937.289076210021], "unit": "score", "name": "jquery.html", "value": 8529.281971126413}, {"lowerIsBetter": false, "replicates": [1287.3177216075483, 1443.3504922784746, 1458.6426325550237, 1633.9428120015803, 1813.8548916086716, 7040.823979400511, 7250.528715633487, 7254.093238345207, 7263.3826124779325, 7265.963670181655, 7454.888176677354, 7600.657970391332, 7622.96188519058, 7629.008228930245, 7629.923700762991, 1957.2660252405349, 2202.493426511903, 2211.060299372768, 2237.272886311955, 2265.286434773041, 2260.333201705501, 2270.977290227093, 2271.205078222625, 2272.091163534583, 2274.533720587284, 2144.5818065477238, 2208.138825857917, 2209.9668504972437, 2210.8120809731113, 2213.0815711479718, 2188.660757582569, 2208.3485371815273, 2209.9447513812124, 2258.5144193998203, 2260.333201705501, 2210.5136869888597, 2222.29997550771, 2239.731232252124, 2239.731232252124, 2279.7606251343536, 7740.767776966643, 7809.219078092202, 7813.531188128673, 7814.804629884242, 7819.726309579194, 4523.796429160696, 4649.953500464986, 4666.066786642651, 4686.9765651171865, 4694.624430045588, 3054.618172728409, 3109.6890310968947, 3171.841407929617, 3172.74618030557, 3202.9199270018203, 945.0, 967.1682353176262, 967.7919247361851, 983.0906411569341, 1011.8886922438526, 10554.261201715883, 10656.893431065668, 10689.572417103307, 10692.786144277148, 10704.946475267574, 3958.287508248485, 4132.173565286955, 4147.937780933288, 4194.769287689145, 4211.0946146578635, 8469.957650211709, 8481.872771908425, 8487.872681909776, 8496.192861678255, 8531.65873365071, 4017.397390391465, 4623.791929363187, 4624.468186158635, 4629.166749984967, 4631.374764406762, 4049.4330793688905, 4058.5129784425467, 4078.632923036941, 4098.508179018537, 4101.241270364992, 3339.1652086978256, 3401.5067815166663, 3430.6740859618294, 3441.9483707744403, 3469.0, 961.9374740641836, 963.4315753705348, 965.1217392173229, 988.5403287471361, 1023.0638965346773, 1020.3469779341227, 1024.0169437340087, 1031.7214352124884, 1104.8508451359126, 1200.4537935239446, 6882.5870447773295, 6888.070110535114, 6929.514933954575, 6934.687939042755, 6944.791656250321, 464.9767511624405, 482.0527663141943, 485.68430520161473, 489.8603897889156, 491.0302153247379, 5613.298337707786, 5718.571107166979, 5722.856928576819, 5758.481736643722, 5767.250257466502, 9097.13577210164, 9673.806523869483, 9779.070988256246, 9783.168430683472, 9788.461634610023, 9602.855957160647, 9628.566714497865, 9661.903380966241, 9663.516824158905, 9663.90336096644, 7234.529755565872, 7439.739609113655, 7508.911207874828, 7511.924880751232, 7514.346843694379, 6977.546459480118, 7011.0, 7065.752698655522, 7076.964615176891, 7077.5399599025895, 8396.748097557083, 8586.098459661895, 8607.225349718556, 8728.301735861243, 8734.69428569997, 8581.184787445183, 8737.912620873964, 8743.169398907094, 8784.648614055366, 8872.378933474594, 5457.754401052041, 6089.756409743561, 6275.090111933835, 6413.134226879498, 6469.450096741642, 7357.5953322567775, 7361.558306501627, 7361.631918403951, 7406.962965185139, 7409.66656500448, 6448.0, 6555.6066636002, 6564.179477565304, 6651.102101216274, 6676.9666151668935, 6294.716737746904, 6488.643124628191, 6509.804705858643, 6587.0, 6614.801555953329, 6434.0, 6451.677416129269, 6469.417752402306, 6474.223093228843, 6484.837879053061, 6093.116498107661, 6111.786087487095, 6136.048912418582, 6205.47253483459, 6341.302456729663, 6238.251409830667, 6285.654289013965, 6301.936980630318, 6305.464035557029, 6363.96818015907], "unit": "score", "name": "mootools.html", "value": 4251.517992071146}, {"lowerIsBetter": false, "replicates": [325.29573473430025, 327.32897560002004, 329.4383076853964, 332.380111092812, 333.13219064337414, 5411.404745477994, 5432.103702889023, 5463.836084917449, 5496.312960879885, 5497.230387745719, 5368.677879327243, 5376.91934620981, 5378.112611419121, 5384.165454354572, 5392.056390131721, 3979.303621866162, 4088.1619268049976, 4132.731372460796, 4169.937450938239, 4227.999999999993, 4172.728772629769, 4202.579742025803, 4203.264428724976, 4211.38934854446, 4220.177065472234, 4165.416841642173, 4168.603982621661, 4177.707560470768, 4178.832846686144, 4189.266878296301, 3996.2806694794926, 4092.774897380658, 4150.896227594304, 4151.3150330195485, 4153.563875793028, 3664.871729489482, 3672.706183505313, 3678.08047988003, 3684.299983003221, 3685.8157092145284, 5127.4359820420095, 5132.486751324875, 5136.743162841843, 5138.2549530318265, 5140.357455318085, 4794.664373493822, 4799.880002999918, 4862.610991120702, 4868.440129385131, 4870.829520966749, 5703.77184912603, 5707.429257074301, 5715.3998830122655, 5715.514181294595, 5716.857078573027, 4083.0, 4083.8570650027405, 4084.14233011068, 4086.080631857838, 4088.2028004539125, 5776.884462310731, 6018.789342373039, 6067.908981365283, 6075.027995520695, 6077.726502307407, 4033.778142202207, 4084.203580301872, 4086.40747091676, 4089.5501494835544, 4091.774952377648, 4129.194807012604, 4144.70987030905, 4145.191687620945, 4145.730527515701, 4150.522689890701, 4755.239161734106, 4756.762161891961, 4762.8333008345235, 4772.665913386029, 4774.116788394158, 5694.658320500783, 5698.572607054488, 5713.457221563945, 5715.628484148517, 5716.57125715573, 1430.5136253673802, 1447.269129089824, 1450.6518435575385, 1453.0990785712925, 1454.3891565542497, 906.5739102621757, 952.5045678285026, 958.0467434902178, 977.4037836919473, 994.4778991029767, 4953.678010929278, 4979.153543897473, 4981.003799240167, 4987.551120399109, 5001.849944501598, 5868.2664666916635, 5871.853203669943, 5879.353271140171, 5891.145783861316, 5891.234139561915, 4944.134776414113, 4965.255211718271, 4973.825916092992, 4989.201727723546, 4993.375828021497, 3102.488089465258, 3149.2126968257935, 3150.779445438843, 3153.30627262002, 3153.858076386568, 5526.866992266576, 5536.4186760390385, 5536.52939500147, 5536.972315138479, 5537.944620553743, 5912.320083190402, 6080.695965201722, 6107.206063211843, 6132.877342453126, 6135.877282454326, 5552.08390615552, 5596.804111856066, 5602.1036634138345, 5613.466720661612, 5617.0, 5958.880822383441, 5959.374265702038, 5963.165156878127, 5964.582479226413, 5971.731272092679, 5832.154337621106, 5840.240768700211, 5842.532597392284, 5842.912356314744, 5849.5612829037145, 5432.239486471976, 5594.13290939905, 5596.384397716167, 5600.327960644749, 5608.7195640217005, 4025.2150830587752, 4027.4562934004707, 4052.189562087653, 4053.493313335833, 4054.493188351456, 5935.703214839327, 5939.643621382731, 5962.0, 5962.970185149046, 5965.612235204698, 5699.059655156852, 5723.427657234243, 5725.08398656213, 5733.165387076096, 5739.0, 5715.39988301239, 5717.085266357529, 5718.485336319751, 5720.19917211599, 5726.0, 5415.539679127318, 5608.523275521627, 5608.775648973995, 5618.410066942912, 5631.802886898939, 5748.655080695172, 5768.423157684198, 5771.394003629726, 5782.10377391505, 5789.623674461147, 5603.299587551556, 5629.437056294338, 5646.661200327993, 5649.971750141223, 5656.660600363992], "unit": "score", "name": "prototype.html", "value": 4284.649146809134}, {"lowerIsBetter": false, "replicates": [705.3264132753221, 737.9557226566407, 749.605733335995, 754.8301632132774, 759.9734009309674, 11221.102311815055, 11316.773664526714, 11339.43302834859, 11442.599509017185, 11450.141239407058, 10209.0, 10702.46487675617, 11192.216544841864, 11204.775904481905, 11292.266002709817, 803.8713805791075, 814.1980149552686, 815.5066184958104, 819.9467034642759, 820.216693058131, 810.05628442864, 815.4169768615438, 815.4780940198278, 816.1960468938091, 816.3958670583785, 864.9913500864974, 865.4374656473279, 869.0527325215514, 870.1820288928419, 870.4385671242045, 862.4006315610653, 865.4244927123456, 865.7748985263845, 866.3242670716851, 866.8613021916494, 635.5995722694719, 636.3127821952327, 636.4144986612328, 636.6339354870921, 637.0953246390137, 10316.535755891004, 10366.326188797779, 10372.325798823127, 10376.740581485448, 10404.583816647326, 10401.94799026, 10606.840897386546, 10655.84016239757, 10853.565857365697, 11096.389698566576, 8928.955355223183, 8961.372703910729, 9003.369764116514, 9080.68217612387, 9122.087791220825, 3188.792728472642, 3201.407739568164, 3261.037993791837, 3280.852361643732, 3302.735781137503, 38257.0, 39736.20527589461, 40241.19517609631, 40308.798456007826, 44075.0, 9103.81792364149, 9290.070992900655, 9306.767330816649, 9516.286278529138, 9737.172340351008, 17845.553861153574, 17851.910740446216, 17888.642227155386, 17895.821041789677, 17923.10384480771, 5936.643801371932, 6558.967205164039, 6578.3092775258865, 6900.896486552706, 6953.061336719579, 3675.3568125577917, 3676.0809797550614, 3690.612485689018, 3694.722895782827, 3813.675837553839, 2733.72662733725, 2750.546159883637, 2761.3924936513936, 2780.3188218886503, 2781.972180278212, 509.997450012755, 512.4823927832915, 517.729755024214, 519.3819354967577, 520.3703518742288, 465.17895913712323, 576.6453631016894, 596.8269201931391, 598.2970010237952, 659.5383231737803, 7423.369013633902, 7576.3181313682035, 7583.696652133964, 7754.651040703182, 7769.0, 483.91289567877413, 495.86363749969047, 506.89608630230714, 638.5625846295303, 641.8222561599517, 3435.7594968352473, 3596.298721749286, 3598.838052287653, 3662.212624285738, 3698.778073315556, 54324.45675543273, 55930.720346398004, 56267.0, 56508.15237771437, 56564.0, 47963.0, 48125.518744812805, 48157.5184248153, 49234.26148607774, 49445.752771236635, 36675.449868252, 38701.0, 44334.33498497525, 44495.33257001147, 45411.545884541396, 7915.762527124196, 8100.149484304299, 8127.309178719638, 8212.909561290076, 8271.83456330858, 32898.67101329052, 33086.50370244496, 33554.496682549296, 33794.193461536815, 34337.484937726455, 39356.606433935296, 43235.567644324416, 43761.34357984569, 43770.781146094065, 43783.78108109439, 9937.552810123707, 10042.949785251027, 10290.794184116126, 10495.317804342692, 10590.576376944837, 11075.5569777208, 11193.608223712132, 11347.716307092389, 11416.0, 11729.765404692029, 10622.09712174443, 10650.254482186172, 10846.511906964364, 10949.890501094887, 11139.164562657996, 10661.626843060456, 10717.785644287227, 10726.73183170427, 10881.945590271998, 10899.0, 9474.478903660365, 9507.714768556954, 9592.184664303333, 9655.275854310814, 10112.342697724624, 8358.707445239388, 8389.286910612665, 8485.618147183268, 8557.015943166616, 8662.263707584925, 8402.327813775006, 8553.44402613853, 8634.699215344377, 8671.13288671153, 8786.736397908073], "unit": "score", "name": "yui.html", "value": 5771.86738265286}], "name": "dromaeo_css", "value": 6446.858877075846}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 112.0, 113.0, 112.0, 101.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 154.0, 173.0, 129.0, 167.0, 155.0, 132.0, 172.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.0}, {"lowerIsBetter": true, "replicates": [165.0, 166.0, 166.0, 166.0, 164.0, 164.0, 164.0, 168.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.2}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 74.0, 154.0, 74.0, 75.0, 73.0, 75.0, 148.0, 77.0], "unit": "score", "name": "audio-fft", "value": 90.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 134.0, 94.0, 94.0, 94.0, 151.0, 93.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 116.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 72.0, 66.0, 65.0, 66.0, 75.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 81.0, 81.0, 81.0, 81.0, 80.0, 82.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.0}, {"lowerIsBetter": true, "replicates": [124.0, 114.0, 115.0, 116.0, 124.0, 116.0, 125.0, 120.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [144.0, 133.0, 155.0, 142.0, 142.0, 131.0, 144.0, 143.0, 144.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 68.0, 67.0, 66.0, 68.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1522.5000000000002}]} 04:38:37 INFO - Return code: 0 04:38:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:38:37 ERROR - # TBPL SUCCESS # 04:38:37 INFO - Running post-action listener: _resource_record_post_action 04:38:37 INFO - Running post-run listener: _resource_record_post_run 04:38:38 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519647232; Read time: 12; Write time: 382668 04:38:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232062976; Read time: 0; Write time: 206008 04:38:38 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286986240; Read time: 12; Write time: 176660 04:38:38 INFO - Running post-run listener: _upload_blobber_files 04:38:38 INFO - Blob upload gear active. 04:38:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:38:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:38:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:38:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:38:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:38:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:40 INFO - (blobuploader) - INFO - Done attempting. 04:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:38:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:40 INFO - (blobuploader) - INFO - Done attempting. 04:38:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:38:40 INFO - Return code: 0 04:38:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:38:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:38:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df9f1dd322db40e863e4a8df330080aed4ff0313de8de2ba015a4b1c43ba254fc82b3bd432754f33a0267c1bd8f596aa6f4c971f7c9afc4e33b45bb668513dc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0532d22eba22b4fbd1c177352e431b3d8890da7e232bb71eb3cc01b00c75e436b58b6ad68cb42bed4a92a294bc3d5ee97818be98f0bd777f475d801701729a2b"} 04:38:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:38:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:38:40 INFO - Contents: 04:38:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df9f1dd322db40e863e4a8df330080aed4ff0313de8de2ba015a4b1c43ba254fc82b3bd432754f33a0267c1bd8f596aa6f4c971f7c9afc4e33b45bb668513dc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0532d22eba22b4fbd1c177352e431b3d8890da7e232bb71eb3cc01b00c75e436b58b6ad68cb42bed4a92a294bc3d5ee97818be98f0bd777f475d801701729a2b"} 04:38:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:38:40 INFO - Copying logs to upload dir... 04:38:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:38:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.465692 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-16 04:38:40.207614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 04:38:40.211354) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 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/df9f1dd322db40e863e4a8df330080aed4ff0313de8de2ba015a4b1c43ba254fc82b3bd432754f33a0267c1bd8f596aa6f4c971f7c9afc4e33b45bb668513dc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0532d22eba22b4fbd1c177352e431b3d8890da7e232bb71eb3cc01b00c75e436b58b6ad68cb42bed4a92a294bc3d5ee97818be98f0bd777f475d801701729a2b"} build_url:https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/ff7fV7VxSnOLui9_H9SD7Q/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/df9f1dd322db40e863e4a8df330080aed4ff0313de8de2ba015a4b1c43ba254fc82b3bd432754f33a0267c1bd8f596aa6f4c971f7c9afc4e33b45bb668513dc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0532d22eba22b4fbd1c177352e431b3d8890da7e232bb71eb3cc01b00c75e436b58b6ad68cb42bed4a92a294bc3d5ee97818be98f0bd777f475d801701729a2b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 04:38:40.235869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:38:40.236172) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458127086.180096-403678228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:38:40.320699) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 04:38:40.321017) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 04:38:40.321321) ========= ========= Total master_lag: 0.27 =========