builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1457366972.31 results: success (0) buildid: 20160307062423 builduid: 87d9673b05d247c0bf00b7916ab1aa85 revision: be593a64d7c6a826260514fe758ef32a6ee580f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.307752) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.308424) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.308800) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006344 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.332669) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.333061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.350824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.351237) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.400855) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.401145) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.401530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.401809) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-07 08:09:32-- 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% 228M=0s 2016-03-07 08:09:32 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.547046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.547339) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022465 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.597184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:32.597561) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be593a64d7c6a826260514fe758ef32a6ee580f7 --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 be593a64d7c6a826260514fe758ef32a6ee580f7 --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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-07 08:09:33,022 truncating revision to first 12 chars 2016-03-07 08:09:33,022 Setting DEBUG logging. 2016-03-07 08:09:33,022 attempt 1/10 2016-03-07 08:09:33,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be593a64d7c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 08:09:33,285 unpacking tar archive at: mozilla-central-be593a64d7c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550620 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:33.162251) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:33.162566) ========= echo be593a64d7c6a826260514fe758ef32a6ee580f7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'be593a64d7c6a826260514fe758ef32a6ee580f7'] 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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False be593a64d7c6a826260514fe758ef32a6ee580f7 program finished with exit code 0 elapsedTime=0.004669 script_repo_revision: 'be593a64d7c6a826260514fe758ef32a6ee580f7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:33.214242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:33.214575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 08:09:33.224511) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-07 08:09:33.224849) ========= /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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:09:33 INFO - MultiFileLogger online at 20160307 08:09:33 in /builds/slave/test 08:09:33 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 08:09:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:33 INFO - {'append_to_log': False, 08:09:33 INFO - 'base_work_dir': '/builds/slave/test', 08:09:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:09:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:33 INFO - 'branch': 'Firefox-Non-PGO', 08:09:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:33 INFO - 'config_files': ('talos/linux_config.py',), 08:09:33 INFO - 'default_actions': ('clobber', 08:09:33 INFO - 'read-buildbot-config', 08:09:33 INFO - 'download-and-extract', 08:09:33 INFO - 'populate-webroot', 08:09:33 INFO - 'create-virtualenv', 08:09:33 INFO - 'install', 08:09:33 INFO - 'run-tests'), 08:09:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:33 INFO - 'download_minidump_stackwalk': True, 08:09:33 INFO - 'download_symbols': 'ondemand', 08:09:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:33 INFO - 'installer_path': 'installer.exe', 08:09:33 INFO - 'log_level': 'info', 08:09:33 INFO - 'log_name': 'talos', 08:09:33 INFO - 'log_to_console': True, 08:09:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:09:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:09:33 INFO - 'opt_config_files': (), 08:09:33 INFO - 'pip_index': False, 08:09:33 INFO - 'sps_profile': False, 08:09:33 INFO - 'sps_profile_interval': 0, 08:09:33 INFO - 'suite': 'dromaeojs', 08:09:33 INFO - 'system_bits': '32', 08:09:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:33 INFO - 'title': 'talos-linux64-ix-023', 08:09:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:33 INFO - 'use_talos_json': True, 08:09:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:33 INFO - 'work_dir': 'build'} 08:09:33 INFO - ##### 08:09:33 INFO - ##### Running clobber step. 08:09:33 INFO - ##### 08:09:33 INFO - Running pre-action listener: _resource_record_pre_action 08:09:33 INFO - Running main action method: clobber 08:09:33 INFO - rmtree: /builds/slave/test/build 08:09:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:34 INFO - Running post-action listener: _resource_record_post_action 08:09:34 INFO - ##### 08:09:34 INFO - ##### Running read-buildbot-config step. 08:09:34 INFO - ##### 08:09:34 INFO - Running pre-action listener: _resource_record_pre_action 08:09:34 INFO - Running main action method: read_buildbot_config 08:09:34 INFO - Using buildbot properties: 08:09:34 INFO - { 08:09:34 INFO - "project": "", 08:09:34 INFO - "product": "firefox", 08:09:34 INFO - "script_repo_revision": "production", 08:09:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:09:34 INFO - "repository": "", 08:09:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:09:34 INFO - "buildid": "20160307062423", 08:09:34 INFO - "pgo_build": "False", 08:09:34 INFO - "basedir": "/builds/slave/test", 08:09:34 INFO - "buildnumber": 21, 08:09:34 INFO - "slavename": "talos-linux64-ix-023", 08:09:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:09:34 INFO - "platform": "ubuntu64_hw", 08:09:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:09:34 INFO - "branch": "mozilla-central", 08:09:34 INFO - "repo_path": "mozilla-central", 08:09:34 INFO - "revision": "be593a64d7c6a826260514fe758ef32a6ee580f7", 08:09:34 INFO - "stage_platform": "linux64", 08:09:34 INFO - "builduid": "87d9673b05d247c0bf00b7916ab1aa85", 08:09:34 INFO - "slavebuilddir": "test" 08:09:34 INFO - } 08:09:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:09:34 INFO - Running post-action listener: _resource_record_post_action 08:09:34 INFO - ##### 08:09:34 INFO - ##### Running download-and-extract step. 08:09:34 INFO - ##### 08:09:34 INFO - Running pre-action listener: _resource_record_pre_action 08:09:34 INFO - Running main action method: download_and_extract 08:09:34 INFO - mkdir: /builds/slave/test/build/tests 08:09:34 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')]} 08:09:34 INFO - https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:43 INFO - Downloaded 1448 bytes. 08:09:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:09:43 INFO - Using the following test package requirements: 08:09:43 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:09:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:09:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:43 INFO - u'jsshell-linux-x86_64.zip'], 08:09:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:09:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:09:43 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:09:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:09:43 INFO - u'webapprt': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:09:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:43 INFO - https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:48 INFO - Downloaded 22091794 bytes. 08:09:48 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'] 08:09:48 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 08:09:50 INFO - Return code: 0 08:09:50 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 08:09:50 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')]} 08:09:50 INFO - https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:09:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:09:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:09:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:52 INFO - Downloaded 22091794 bytes. 08:09:52 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'] 08:09:52 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 08:09:53 INFO - Return code: 0 08:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:53 INFO - https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:09:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:54 INFO - Downloaded 10845161 bytes. 08:09:54 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'] 08:09:54 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 08:09:54 INFO - Return code: 0 08:09:54 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')]} 08:09:54 INFO - https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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 08:09:55 INFO - Downloaded 54407553 bytes. 08:09:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:09:55 INFO - mkdir: /builds/slave/test/properties 08:09:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:55 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:55 INFO - Contents: 08:09:55 INFO - build_url:https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:09:56 INFO - Running post-action listener: _resource_record_post_action 08:09:56 INFO - Running post-action listener: set_extra_try_arguments 08:09:56 INFO - ##### 08:09:56 INFO - ##### Running populate-webroot step. 08:09:56 INFO - ##### 08:09:56 INFO - Running pre-action listener: _resource_record_pre_action 08:09:56 INFO - Running main action method: populate_webroot 08:09:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:56 INFO - '--tppagecycles', 08:09:56 INFO - '7'], 08:09:56 INFO - 'tests': ['tsvgm']}}, 08:09:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:09:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:09:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:56 INFO - 'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:56 INFO - 'tests': ['damp', 'tps']}, 08:09:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:56 INFO - 'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['damp', 'tps']}, 08:09:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:09:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:56 INFO - 'other': {'tests': ['a11yr', 08:09:56 INFO - 'ts_paint', 08:09:56 INFO - 'tpaint', 08:09:56 INFO - 'sessionrestore', 08:09:56 INFO - 'sessionrestore_no_auto_restore', 08:09:56 INFO - 'tabpaint']}, 08:09:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['a11yr', 08:09:56 INFO - 'ts_paint', 08:09:56 INFO - 'tpaint', 08:09:56 INFO - 'sessionrestore', 08:09:56 INFO - 'sessionrestore_no_auto_restore', 08:09:56 INFO - 'tabpaint']}, 08:09:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['a11yr', 08:09:56 INFO - 'ts_paint', 08:09:56 INFO - 'tpaint', 08:09:56 INFO - 'sessionrestore', 08:09:56 INFO - 'sessionrestore_no_auto_restore', 08:09:56 INFO - 'tabpaint']}, 08:09:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['a11yr', 08:09:56 INFO - 'ts_paint', 08:09:56 INFO - 'tpaint', 08:09:56 INFO - 'sessionrestore', 08:09:56 INFO - 'sessionrestore_no_auto_restore', 08:09:56 INFO - 'tabpaint']}, 08:09:56 INFO - 'other_l64': {'tests': ['a11yr', 08:09:56 INFO - 'ts_paint', 08:09:56 INFO - 'tpaint', 08:09:56 INFO - 'sessionrestore', 08:09:56 INFO - 'sessionrestore_no_auto_restore', 08:09:56 INFO - 'tabpaint']}, 08:09:56 INFO - 'other_nol64': {'tests': ['a11yr', 08:09:56 INFO - 'ts_paint', 08:09:56 INFO - 'tpaint', 08:09:56 INFO - 'sessionrestore', 08:09:56 INFO - 'sessionrestore_no_auto_restore', 08:09:56 INFO - 'tabpaint']}, 08:09:56 INFO - 'svgr': {'tests': ['tsvgx', 08:09:56 INFO - 'tsvgr_opacity', 08:09:56 INFO - 'tart', 08:09:56 INFO - 'tscrollx', 08:09:56 INFO - 'cart']}, 08:09:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['tsvgx', 08:09:56 INFO - 'tsvgr_opacity', 08:09:56 INFO - 'tart', 08:09:56 INFO - 'tscrollx', 08:09:56 INFO - 'cart']}, 08:09:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:56 INFO - 'tests': ['tp5o']}, 08:09:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:56 INFO - 'talos_options': ['--e10s'], 08:09:56 INFO - 'tests': ['tp5o']}, 08:09:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:56 INFO - 'talos_options': ['--xperf_path', 08:09:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:56 INFO - 'tests': ['tp5n']}, 08:09:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:56 INFO - 'talos_options': ['--e10s', 08:09:56 INFO - '--xperf_path', 08:09:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:56 INFO - 'tests': ['tp5n']}}, 08:09:56 INFO - 'talos.zip': {'path': '', 08:09:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:56 INFO - Running post-action listener: _resource_record_post_action 08:09:56 INFO - ##### 08:09:56 INFO - ##### Running create-virtualenv step. 08:09:56 INFO - ##### 08:09:56 INFO - Running pre-action listener: _resource_record_pre_action 08:09:56 INFO - Running main action method: create_virtualenv 08:09:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:56 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 08:09:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:56 INFO - Using real prefix '/usr' 08:09:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:59 INFO - Installing pip.................done. 08:09:59 INFO - Return code: 0 08:09:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:59 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')]} 08:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:59 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')]} 08:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:59 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 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:09:59 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 08:09:59 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 08:09:59 INFO - Using env: {'DISPLAY': ':0', 08:09:59 INFO - 'HOME': '/home/cltbld', 08:09:59 INFO - 'LANG': 'en_US.UTF-8', 08:09:59 INFO - 'LANGUAGE': 'en_US:en', 08:09:59 INFO - 'LOGNAME': 'cltbld', 08:09:59 INFO - 'MAIL': '/var/mail/cltbld', 08:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:59 INFO - 'MOZ_NO_REMOTE': '1', 08:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:59 INFO - 'NO_EM_RESTART': '1', 08:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:59 INFO - 'PWD': '/builds/slave/test', 08:09:59 INFO - 'SHELL': '/bin/bash', 08:09:59 INFO - 'SHLVL': '1', 08:09:59 INFO - 'TERM': 'linux', 08:09:59 INFO - 'TMOUT': '86400', 08:09:59 INFO - 'USER': 'cltbld', 08:09:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:59 INFO - '_': '/tools/buildbot/bin/python'} 08:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:59 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 08:09:59 INFO - Cleaning up... 08:09:59 INFO - Return code: 0 08:09:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:09:59 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')]} 08:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:59 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')]} 08:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:59 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 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:09:59 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 08:09:59 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 08:09:59 INFO - Using env: {'DISPLAY': ':0', 08:09:59 INFO - 'HOME': '/home/cltbld', 08:09:59 INFO - 'LANG': 'en_US.UTF-8', 08:09:59 INFO - 'LANGUAGE': 'en_US:en', 08:09:59 INFO - 'LOGNAME': 'cltbld', 08:09:59 INFO - 'MAIL': '/var/mail/cltbld', 08:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:59 INFO - 'MOZ_NO_REMOTE': '1', 08:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:59 INFO - 'NO_EM_RESTART': '1', 08:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:59 INFO - 'PWD': '/builds/slave/test', 08:09:59 INFO - 'SHELL': '/bin/bash', 08:09:59 INFO - 'SHLVL': '1', 08:09:59 INFO - 'TERM': 'linux', 08:09:59 INFO - 'TMOUT': '86400', 08:09:59 INFO - 'USER': 'cltbld', 08:09:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:59 INFO - '_': '/tools/buildbot/bin/python'} 08:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:59 INFO - Downloading/unpacking psutil>=0.7.1 08:09:59 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 08:09:59 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 08:09:59 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 08:09:59 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 08:09:59 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 08:09:59 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 08:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:01 INFO - Installing collected packages: psutil 08:10:01 INFO - Running setup.py install for psutil 08:10:01 INFO - building 'psutil._psutil_linux' extension 08:10:01 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 08:10:01 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 08:10:01 INFO - building 'psutil._psutil_posix' extension 08:10:01 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 08:10:01 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 08:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:01 INFO - Successfully installed psutil 08:10:01 INFO - Cleaning up... 08:10:02 INFO - Return code: 0 08:10:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:10:02 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')]} 08:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:02 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')]} 08:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:02 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 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:10:02 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 08:10:02 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 08:10:02 INFO - Using env: {'DISPLAY': ':0', 08:10:02 INFO - 'HOME': '/home/cltbld', 08:10:02 INFO - 'LANG': 'en_US.UTF-8', 08:10:02 INFO - 'LANGUAGE': 'en_US:en', 08:10:02 INFO - 'LOGNAME': 'cltbld', 08:10:02 INFO - 'MAIL': '/var/mail/cltbld', 08:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:02 INFO - 'MOZ_NO_REMOTE': '1', 08:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:02 INFO - 'NO_EM_RESTART': '1', 08:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:02 INFO - 'PWD': '/builds/slave/test', 08:10:02 INFO - 'SHELL': '/bin/bash', 08:10:02 INFO - 'SHLVL': '1', 08:10:02 INFO - 'TERM': 'linux', 08:10:02 INFO - 'TMOUT': '86400', 08:10:02 INFO - 'USER': 'cltbld', 08:10:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:02 INFO - '_': '/tools/buildbot/bin/python'} 08:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:10:02 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 08:10:02 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 08:10:02 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 08:10:02 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 08:10:02 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 08:10:02 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 08:10:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:10:04 INFO - Installing collected packages: mozsystemmonitor 08:10:04 INFO - Running setup.py install for mozsystemmonitor 08:10:04 INFO - Successfully installed mozsystemmonitor 08:10:04 INFO - Cleaning up... 08:10:04 INFO - Return code: 0 08:10:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:04 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 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:10:04 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 08:10:04 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 08:10:04 INFO - Using env: {'DISPLAY': ':0', 08:10:04 INFO - 'HOME': '/home/cltbld', 08:10:04 INFO - 'LANG': 'en_US.UTF-8', 08:10:04 INFO - 'LANGUAGE': 'en_US:en', 08:10:04 INFO - 'LOGNAME': 'cltbld', 08:10:04 INFO - 'MAIL': '/var/mail/cltbld', 08:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:04 INFO - 'MOZ_NO_REMOTE': '1', 08:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:04 INFO - 'NO_EM_RESTART': '1', 08:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:04 INFO - 'PWD': '/builds/slave/test', 08:10:04 INFO - 'SHELL': '/bin/bash', 08:10:04 INFO - 'SHLVL': '1', 08:10:04 INFO - 'TERM': 'linux', 08:10:04 INFO - 'TMOUT': '86400', 08:10:04 INFO - 'USER': 'cltbld', 08:10:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:04 INFO - '_': '/tools/buildbot/bin/python'} 08:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:10:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:06 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 08:10:06 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 08:10:06 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 08:10:06 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 08:10:06 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 08:10:06 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 08:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:10:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:06 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 08:10:06 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 08:10:06 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 08:10:06 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 08:10:06 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 08:10:06 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 08:10:07 INFO - Downloading docopt-0.6.1.tar.gz 08:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:10:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:07 INFO - Running setup.py install for blobuploader 08:10:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:10:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:10:07 INFO - Running setup.py install for requests 08:10:07 INFO - Running setup.py install for docopt 08:10:07 INFO - Successfully installed blobuploader requests docopt 08:10:07 INFO - Cleaning up... 08:10:07 INFO - Return code: 0 08:10:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:07 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')]} 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:07 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')]} 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:07 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 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:10:07 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 08:10:07 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 08:10:07 INFO - Using env: {'DISPLAY': ':0', 08:10:07 INFO - 'HOME': '/home/cltbld', 08:10:07 INFO - 'LANG': 'en_US.UTF-8', 08:10:07 INFO - 'LANGUAGE': 'en_US:en', 08:10:07 INFO - 'LOGNAME': 'cltbld', 08:10:07 INFO - 'MAIL': '/var/mail/cltbld', 08:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:07 INFO - 'MOZ_NO_REMOTE': '1', 08:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:07 INFO - 'NO_EM_RESTART': '1', 08:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:07 INFO - 'PWD': '/builds/slave/test', 08:10:07 INFO - 'SHELL': '/bin/bash', 08:10:07 INFO - 'SHLVL': '1', 08:10:07 INFO - 'TERM': 'linux', 08:10:07 INFO - 'TMOUT': '86400', 08:10:07 INFO - 'USER': 'cltbld', 08:10:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:07 INFO - '_': '/tools/buildbot/bin/python'} 08:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:07 INFO - Running setup.py (path:/tmp/pip-XrnvYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:08 INFO - Running setup.py (path:/tmp/pip-jN1_q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:08 INFO - Running setup.py (path:/tmp/pip-w3EXKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:08 INFO - Running setup.py (path:/tmp/pip-yc4H4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:08 INFO - Running setup.py (path:/tmp/pip-ANqpbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:08 INFO - Running setup.py (path:/tmp/pip-9vFwjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:08 INFO - Running setup.py (path:/tmp/pip-Uttofv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:08 INFO - Running setup.py (path:/tmp/pip-shX6qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:08 INFO - Running setup.py (path:/tmp/pip-uSSocR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:08 INFO - Running setup.py (path:/tmp/pip-vcOTFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:08 INFO - Running setup.py (path:/tmp/pip-kcTe3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:08 INFO - Running setup.py (path:/tmp/pip-Ll6LfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:08 INFO - Running setup.py (path:/tmp/pip-nORfmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:08 INFO - Running setup.py (path:/tmp/pip-aNpaZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:08 INFO - Running setup.py (path:/tmp/pip-nahpFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:09 INFO - Running setup.py (path:/tmp/pip-YT1muH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:09 INFO - Running setup.py (path:/tmp/pip-yME6M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:09 INFO - Running setup.py install for manifestparser 08:10:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Running setup.py install for mozcrash 08:10:09 INFO - Running setup.py install for mozdebug 08:10:09 INFO - Running setup.py install for mozdevice 08:10:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Running setup.py install for mozfile 08:10:09 INFO - Running setup.py install for mozhttpd 08:10:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Running setup.py install for mozinfo 08:10:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Running setup.py install for mozInstall 08:10:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:09 INFO - Running setup.py install for mozleak 08:10:10 INFO - Running setup.py install for mozlog 08:10:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:10 INFO - Running setup.py install for moznetwork 08:10:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:10 INFO - Running setup.py install for mozprocess 08:10:10 INFO - Running setup.py install for mozprofile 08:10:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:10 INFO - Running setup.py install for mozrunner 08:10:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:10 INFO - Running setup.py install for mozscreenshot 08:10:10 INFO - Running setup.py install for moztest 08:10:10 INFO - Running setup.py install for mozversion 08:10:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:10 INFO - Cleaning up... 08:10:10 INFO - Return code: 0 08:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:10 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 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:10:10 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 08:10:10 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 08:10:10 INFO - Using env: {'DISPLAY': ':0', 08:10:10 INFO - 'HOME': '/home/cltbld', 08:10:10 INFO - 'LANG': 'en_US.UTF-8', 08:10:10 INFO - 'LANGUAGE': 'en_US:en', 08:10:10 INFO - 'LOGNAME': 'cltbld', 08:10:10 INFO - 'MAIL': '/var/mail/cltbld', 08:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:10 INFO - 'MOZ_NO_REMOTE': '1', 08:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:10 INFO - 'NO_EM_RESTART': '1', 08:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:10 INFO - 'PWD': '/builds/slave/test', 08:10:10 INFO - 'SHELL': '/bin/bash', 08:10:10 INFO - 'SHLVL': '1', 08:10:10 INFO - 'TERM': 'linux', 08:10:10 INFO - 'TMOUT': '86400', 08:10:10 INFO - 'USER': 'cltbld', 08:10:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:10 INFO - '_': '/tools/buildbot/bin/python'} 08:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:11 INFO - Running setup.py (path:/tmp/pip-ro0YRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:11 INFO - Running setup.py (path:/tmp/pip-h36NqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:11 INFO - Running setup.py (path:/tmp/pip-HJ0fD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:11 INFO - Running setup.py (path:/tmp/pip-VUmTUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:11 INFO - Running setup.py (path:/tmp/pip-aQ1S2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:11 INFO - Running setup.py (path:/tmp/pip-hyi7zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:11 INFO - Running setup.py (path:/tmp/pip-nAzTwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:11 INFO - Running setup.py (path:/tmp/pip-fLVWgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:11 INFO - Running setup.py (path:/tmp/pip-X3gpK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:11 INFO - Running setup.py (path:/tmp/pip-4mG7ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:11 INFO - Running setup.py (path:/tmp/pip-VgX7d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:11 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)) 08:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:11 INFO - Running setup.py (path:/tmp/pip-5_A9QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:12 INFO - Running setup.py (path:/tmp/pip-huPkg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:12 INFO - Running setup.py (path:/tmp/pip-kBC5DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:12 INFO - Running setup.py (path:/tmp/pip-CjPVzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:12 INFO - Running setup.py (path:/tmp/pip-LWtIPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:12 INFO - Running setup.py (path:/tmp/pip-kXX1ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:12 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)) 08:10:12 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)) 08:10:12 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)) 08:10:12 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)) 08:10:12 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)) 08:10:12 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)) 08:10:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:10:12 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 08:10:12 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 08:10:12 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 08:10:12 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 08:10:12 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 08:10:12 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 08:10:14 INFO - Downloading blessings-1.6.tar.gz 08:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:14 INFO - Installing collected packages: blessings 08:10:14 INFO - Running setup.py install for blessings 08:10:14 INFO - Successfully installed blessings 08:10:14 INFO - Cleaning up... 08:10:14 INFO - Return code: 0 08:10:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:14 INFO - Reading from file tmpfile_stdout 08:10:14 INFO - Current package versions: 08:10:14 INFO - argparse == 1.2.1 08:10:14 INFO - blessings == 1.6 08:10:14 INFO - blobuploader == 1.2.4 08:10:14 INFO - docopt == 0.6.1 08:10:14 INFO - manifestparser == 1.1 08:10:14 INFO - mozInstall == 1.12 08:10:14 INFO - mozcrash == 0.17 08:10:14 INFO - mozdebug == 0.1 08:10:14 INFO - mozdevice == 0.48 08:10:14 INFO - mozfile == 1.2 08:10:14 INFO - mozhttpd == 0.7 08:10:14 INFO - mozinfo == 0.9 08:10:14 INFO - mozleak == 0.1 08:10:14 INFO - mozlog == 3.1 08:10:14 INFO - moznetwork == 0.27 08:10:14 INFO - mozprocess == 0.22 08:10:14 INFO - mozprofile == 0.28 08:10:14 INFO - mozrunner == 6.11 08:10:14 INFO - mozscreenshot == 0.1 08:10:14 INFO - mozsystemmonitor == 0.0 08:10:14 INFO - moztest == 0.7 08:10:14 INFO - mozversion == 1.4 08:10:14 INFO - psutil == 3.1.1 08:10:14 INFO - requests == 1.2.3 08:10:14 INFO - wsgiref == 0.1.2 08:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 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 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:10:14 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 08:10:14 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 08:10:14 INFO - Using env: {'DISPLAY': ':0', 08:10:14 INFO - 'HOME': '/home/cltbld', 08:10:14 INFO - 'LANG': 'en_US.UTF-8', 08:10:14 INFO - 'LANGUAGE': 'en_US:en', 08:10:14 INFO - 'LOGNAME': 'cltbld', 08:10:14 INFO - 'MAIL': '/var/mail/cltbld', 08:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:14 INFO - 'MOZ_NO_REMOTE': '1', 08:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:14 INFO - 'NO_EM_RESTART': '1', 08:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:14 INFO - 'PWD': '/builds/slave/test', 08:10:14 INFO - 'SHELL': '/bin/bash', 08:10:14 INFO - 'SHLVL': '1', 08:10:14 INFO - 'TERM': 'linux', 08:10:14 INFO - 'TMOUT': '86400', 08:10:14 INFO - 'USER': 'cltbld', 08:10:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:14 INFO - '_': '/tools/buildbot/bin/python'} 08:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 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)) 08:10:14 INFO - Cleaning up... 08:10:14 INFO - Return code: 0 08:10:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 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 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:10:14 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 08:10:14 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 08:10:14 INFO - Using env: {'DISPLAY': ':0', 08:10:14 INFO - 'HOME': '/home/cltbld', 08:10:14 INFO - 'LANG': 'en_US.UTF-8', 08:10:14 INFO - 'LANGUAGE': 'en_US:en', 08:10:14 INFO - 'LOGNAME': 'cltbld', 08:10:14 INFO - 'MAIL': '/var/mail/cltbld', 08:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:14 INFO - 'MOZ_NO_REMOTE': '1', 08:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:14 INFO - 'NO_EM_RESTART': '1', 08:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:14 INFO - 'PWD': '/builds/slave/test', 08:10:14 INFO - 'SHELL': '/bin/bash', 08:10:14 INFO - 'SHLVL': '1', 08:10:14 INFO - 'TERM': 'linux', 08:10:14 INFO - 'TMOUT': '86400', 08:10:14 INFO - 'USER': 'cltbld', 08:10:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:14 INFO - '_': '/tools/buildbot/bin/python'} 08:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:15 INFO - Downloading/unpacking jsonschema 08:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:16 INFO - Downloading/unpacking functools32 (from jsonschema) 08:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:17 INFO - warning: no files found matching '*.txt' 08:10:17 INFO - no previously-included directories found matching 'build' 08:10:17 INFO - no previously-included directories found matching 'dist' 08:10:17 INFO - no previously-included directories found matching '.git*' 08:10:17 INFO - Installing collected packages: jsonschema, functools32 08:10:17 INFO - Running setup.py install for functools32 08:10:17 INFO - warning: no files found matching '*.txt' 08:10:17 INFO - no previously-included directories found matching 'build' 08:10:17 INFO - no previously-included directories found matching 'dist' 08:10:17 INFO - no previously-included directories found matching '.git*' 08:10:17 INFO - Successfully installed jsonschema functools32 08:10:17 INFO - Cleaning up... 08:10:17 INFO - Return code: 0 08:10:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a99254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', '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 08:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:10:17 INFO - Using env: {'DISPLAY': ':0', 08:10:17 INFO - 'HOME': '/home/cltbld', 08:10:17 INFO - 'LANG': 'en_US.UTF-8', 08:10:17 INFO - 'LANGUAGE': 'en_US:en', 08:10:17 INFO - 'LOGNAME': 'cltbld', 08:10:17 INFO - 'MAIL': '/var/mail/cltbld', 08:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:17 INFO - 'MOZ_NO_REMOTE': '1', 08:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:17 INFO - 'NO_EM_RESTART': '1', 08:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:17 INFO - 'PWD': '/builds/slave/test', 08:10:17 INFO - 'SHELL': '/bin/bash', 08:10:17 INFO - 'SHLVL': '1', 08:10:17 INFO - 'TERM': 'linux', 08:10:17 INFO - 'TMOUT': '86400', 08:10:17 INFO - 'USER': 'cltbld', 08:10:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:17 INFO - '_': '/tools/buildbot/bin/python'} 08:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:17 INFO - Downloading/unpacking flake8 08:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:10:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:10:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:10:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:20 INFO - no previously-included directories found matching 'docs/_build' 08:10:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:10:20 INFO - Running setup.py install for pep8 08:10:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:20 INFO - no previously-included directories found matching 'docs/_build' 08:10:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:10:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:10:20 INFO - Cleaning up... 08:10:20 INFO - Return code: 0 08:10:20 INFO - Running post-action listener: _resource_record_post_action 08:10:20 INFO - Running post-action listener: _start_resource_monitoring 08:10:20 INFO - Starting resource monitoring. 08:10:20 INFO - ##### 08:10:20 INFO - ##### Running install step. 08:10:20 INFO - ##### 08:10:20 INFO - Running pre-action listener: _resource_record_pre_action 08:10:20 INFO - Running main action method: install 08:10:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:20 INFO - Reading from file tmpfile_stdout 08:10:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:20 INFO - Reading from file tmpfile_stdout 08:10:20 INFO - Output received: 08:10:20 INFO - Usage: mozinstall [options] installer 08:10:20 INFO - Options: 08:10:20 INFO - -h, --help show this help message and exit 08:10:20 INFO - -d DEST, --destination=DEST 08:10:20 INFO - Directory to install application into. [default: 08:10:20 INFO - "/builds/slave/test"] 08:10:20 INFO - --app=APP Application being installed. [default: firefox] 08:10:20 INFO - mkdir: /builds/slave/test/build/application 08:10:20 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'] 08:10:20 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 08:10:36 INFO - Reading from file tmpfile_stdout 08:10:36 INFO - Output received: 08:10:36 INFO - /builds/slave/test/build/application/firefox/firefox 08:10:36 INFO - Running post-action listener: _resource_record_post_action 08:10:36 INFO - ##### 08:10:36 INFO - ##### Running run-tests step. 08:10:36 INFO - ##### 08:10:36 INFO - Running pre-action listener: _resource_record_pre_action 08:10:36 INFO - Running main action method: run_tests 08:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:36 INFO - Python 2.7.3 08:10:36 INFO - Return code: 0 08:10:36 INFO - grabbing minidump binary from tooltool 08:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:36 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 0x26cf160>, '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 0x26d0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d04f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:36 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 08:10:36 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 08:10:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:36 INFO - Return code: 0 08:10:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:10:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:10:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:10:37 INFO - Return code: 0 08:10:37 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/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:10:37 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/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 08:10:37 INFO - Using env: {'DISPLAY': ':0', 08:10:37 INFO - 'HOME': '/home/cltbld', 08:10:37 INFO - 'LANG': 'en_US.UTF-8', 08:10:37 INFO - 'LANGUAGE': 'en_US:en', 08:10:37 INFO - 'LOGNAME': 'cltbld', 08:10:37 INFO - 'MAIL': '/var/mail/cltbld', 08:10:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:37 INFO - 'MOZ_NO_REMOTE': '1', 08:10:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:37 INFO - 'NO_EM_RESTART': '1', 08:10:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:37 INFO - 'PWD': '/builds/slave/test', 08:10:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:37 INFO - 'SHELL': '/bin/bash', 08:10:37 INFO - 'SHLVL': '1', 08:10:37 INFO - 'TERM': 'linux', 08:10:37 INFO - 'TMOUT': '86400', 08:10:37 INFO - 'USER': 'cltbld', 08:10:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780', 08:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:37 INFO - '_': '/tools/buildbot/bin/python'} 08:10:37 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/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:10:37 INFO - mozversion application_buildid: 20160307062423 08:10:37 INFO - mozversion application_changeset: be593a64d7c6a826260514fe758ef32a6ee580f7 08:10:37 INFO - mozversion application_display_name: Nightly 08:10:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:37 INFO - mozversion application_name: Firefox 08:10:37 INFO - mozversion application_remotingname: firefox 08:10:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:10:37 INFO - mozversion application_vendor: Mozilla 08:10:37 INFO - mozversion application_version: 48.0a1 08:10:37 INFO - mozversion platform_buildid: 20160307062423 08:10:37 INFO - mozversion platform_changeset: be593a64d7c6a826260514fe758ef32a6ee580f7 08:10:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:10:37 INFO - mozversion platform_version: 48.0a1 08:10:37 INFO - using testdate: 1457367037 08:10:37 INFO - actual date: 1457367037 08:10:37 INFO - starting webserver on 'localhost:45978' 08:10:37 INFO - SUITE-START | Running 2 tests 08:10:37 INFO - TEST-START | dromaeo_css 08:10:37 INFO - operating with platform_type : linux_ 08:10:37 INFO - Initialising browser for dromaeo_css test... 08:10:37 INFO - TEST-INFO | started process 12934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvO2RU1/profile http://localhost:45978/getInfo.html) 08:10:41 INFO - PROCESS | 12934 | __metrics Screen width/height:1600/1200 08:10:41 INFO - PROCESS | 12934 | colorDepth:24 08:10:41 INFO - PROCESS | 12934 | Browser inner width/height: 1024/697 08:10:41 INFO - PROCESS | 12934 | __metrics 08:10:42 INFO - PROCESS | 12934 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:43 INFO - TEST-INFO | 12934: exit 0 08:10:43 INFO - Browser initialized. 08:10:43 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:43 INFO - TEST-INFO | started process 13029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvO2RU1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:55 INFO - PROCESS | 13029 | RSS: Main: 156618752 08:10:55 INFO - PROCESS | 13029 | 08:11:46 INFO - PROCESS | 13029 | 1457367106911 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] 08:13:58 INFO - PROCESS | 13029 | Cycle 1(1): loaded http://localhost:45978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45978/tests/dromaeo/cssquery-ext.html) 08:13:59 INFO - PROCESS | 13029 | RSS: Main: 242683904 08:13:59 INFO - PROCESS | 13029 | 08:17:01 INFO - PROCESS | 13029 | Cycle 1(1): loaded http://localhost:45978/tests/dromaeo/cssquery-ext.html (next: http://localhost:45978/tests/dromaeo/cssquery-jquery.html) 08:17:02 INFO - PROCESS | 13029 | RSS: Main: 235175936 08:17:02 INFO - PROCESS | 13029 | 08:20:04 INFO - PROCESS | 13029 | Cycle 1(1): loaded http://localhost:45978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45978/tests/dromaeo/cssquery-mootools.html) 08:20:04 INFO - PROCESS | 13029 | RSS: Main: 232726528 08:20:04 INFO - PROCESS | 13029 | 08:23:06 INFO - PROCESS | 13029 | Cycle 1(1): loaded http://localhost:45978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45978/tests/dromaeo/cssquery-prototype.html) 08:23:07 INFO - PROCESS | 13029 | RSS: Main: 217387008 08:23:07 INFO - PROCESS | 13029 | 08:26:09 INFO - PROCESS | 13029 | Cycle 1(1): loaded http://localhost:45978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45978/tests/dromaeo/cssquery-yui.html) 08:26:10 INFO - PROCESS | 13029 | RSS: Main: 198623232 08:26:10 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | Cycle 1(1): loaded http://localhost:45978/tests/dromaeo/cssquery-yui.html (next: http://localhost:45978/tests/dromaeo/cssquery-dojo.html) 08:29:13 INFO - PROCESS | 13029 | RSS: Main: 296624128 08:29:13 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | __start_tp_report 08:29:13 INFO - PROCESS | 13029 | _x_x_mozilla_page_load 08:29:13 INFO - PROCESS | 13029 | _x_x_mozilla_page_load_details 08:29:13 INFO - PROCESS | 13029 | |i|pagename|runs| 08:29:13 INFO - PROCESS | 13029 | |0;dojo.html;2544.9745502544974;2586.3792689754464;2623.5408803459395;2625.645537852389;2640.28712247693;4312.956870431295;4433.667474939376;4485.372047913291;4493.101379724056;4514.796834142463;4496.865094047175;4514.548545145484;4530.705504142228;4543.65922555808;4588.220002599558;4109.671226301889;4138.0482489027545;4140.668746500288;4153.626173644371;4272.380504826799;4015.1367455996956;4198.559151289117;4239.830406783725;4246.893827654302;4262.2754131797665;4060.614241647039;4094.0583665756744;4121.155163191538;4126.277901367249;4139.793010349501;4087.0395457067566;4095.3037983542868;4115.670746340285;4139.379093136024;4154.833806647761;3974.463447434617;4078.9796051019557;4088.366303223005;4092.7953602320063;4124.608162224584;4383.167198232326;4416.514183439819;4420;4446.933296000562;4469.329600559942;4764.785584648699;4785.066911952171;4785.138675038492;4788.856334309976;4826.565609095198;4703.1064097821645;4778.665493415462;4798.49615790344;4810.494898035691;4869.70781753096;4417.050334178167;4419.580139886705;4458.197524445599;4458.643308535309;4462.174497717868;4837.443693975168;4851.51484851512;4852.053849499313;4852.320675105488;4887.340209071801;4567.269236922077;4658.813647454132;4679;4716.221823399101;4799.088173247072;4821.180399332122;4841.273808928619;4846.660733748674;4870.196417591129;4893.241547560134;4756.6670333077045;4786.210275304536;4786.473487916326;4790;4822.903541929212;4585.9541404585525;4649.7210167389385;4722.433308003062;4742.786574604151;4765.285207218945;3990.10222699896;4005.9799701001307;4013.6989725770686;4028.113814960704;4053.412255222976;3556.3776339140545;3558.768680035789;3577.4276115821344;3600.6579374959338;3611.8555257789394;3994.2610617035944;4069.8575549855614;4086.591340865949;4150.5641907599265;4156.397322388237;4793.400824896888;4819.7108173509705;4824.324594556765;4848.248521479177;4877.073356062337;4159.521655009652;4169.687273454503;4170.833166673299;4174.269502836992;4203.495580530356;4153.501579810381;4234.195502854448;4294.441722576107;4300.591443812833;4340;4602.562756538124;4605.286180642006;4622.791974361229;4625.051864367864;4667.766611669471;4621.399218101626;4830.396200474941;4841.322214889989;4841.806327746851;4869.050535145612;4585.77071146448;4636.489986101594;4643.3963584733765;4666.78999445019;4672.252439609782;4715.151272770934;4728;4730.314104454904;4730.929036064393;4744.383230180055;4602.401687780567;4765.785539650655;4780.282957556395;4792.137415265146;4837.2260438329695;4594.88512787183;4602.884927876696;4606.355110284496;4628.583427491542;4648.279516674921;4575.58819706228;4578.587927086578;4585.335126406586;4619.86140415788;4632;4402.427684401007;4499.662525310549;4515.548445155589;4519.435070616173;4560.087982403466;4601.217792975135;4620.792064357045;4625.953740462553;4647;4672.906541869212;4500.662450316305;4500.9099818004115;4501.977490112528;4545.045540436546;4549.7042692224895 08:29:13 INFO - PROCESS | 13029 | |1;ext.html;474.9596284315833;499.84005118362114;520.8489538033971;561.3880869851861;561.9157126431036;25150.371240718967;32851.178720532;33730.49404258938;33760.99999999997;33767.83116084422;36745;37144;37189.814050929774;37252.44121338182;37269.06827329312;6842.349976752201;7720.498167619101;7900.525968441883;7917.841643167133;9480.146786789188;9775.902240977606;9936.503174841266;9945.10494055535;9946.055124763136;9950.452725100116;9863.654772082979;9966.601335946554;9975.25185611082;9980;9983.351082179672;9850.753731156707;9964.999999999964;9965.252606054575;9967.80064398708;9969.850452243221;9659.758506037335;9864;9864.210863130933;9864.90135098647;10169.644062457852;36896;37450.8127459361;37466.06334841623;37467;37493.625063749285;2916.7083291670665;2949.056301983366;2952.099609619065;3080.3993221321853;3314.734821214297;28184.85907570449;28293.29266768327;28570.714292857014;28770.71229287701;29131.854340728372;3378;3507.809265365375;3532.5760908690863;3551.200979779555;3561.732870034732;154803.22598387048;156072;156255;156379;156655;38610;55876.720616396655;56236;56319;56333;37240.441393378576;37448.502059917846;37458.62541374551;37468.625313747056;37472.62527374691;10636.30863993838;11553.24903881245;11746.765064698659;11751.47118379675;11771.23486973344;9520.238755830054;9792.853107203398;9806.411615303105;9817.214622830157;9826;12706.174098683556;12709.53840308358;12719.427625756864;12737.598864124939;12867.970562354989;5140.537351638371;5256.842294731164;5258.395284542326;5279.076161671692;5342.519173274424;804.1516200408508;824.7402068348451;867.4058270085012;872.3283072034498;903.9141281578239;25768.355791105372;26128.608070878952;26287.34281642936;26545.601815972776;26556.734432655427;897.9236764874928;927.9350445468752;928.6749637626912;948.4546385828038;995.711243739322;13466.394012269471;13742.793858092136;13956;13997.720045599031;14041.297935103408;240874;244476;245728;246296;246387;44944.55055449404;45469.317960230626;45603.315950260774;45657.31514027292;45714.31428528575;1087.075985412409;1099.1536516881956;1118.927269727465;1170.3270619394052;1198.406788639629;24179.032838686257;25651.486970260117;26526.86736566305;26573;26625.866870666297;36704.08239794026;36967.630323696416;37060.44409333808;37117.62882371142;37120.257594848496;169666;169710;170691;171055;171349.14325428294;23956.640650390607;28262.293442664097;28488.14827036236;28542.85728571344;28891.277718057216;35452.29095418026;36592;36644.26711465702;36843.75295047263;37114.25771484609;29661.703382965894;31001;31022;31276.218094547818;31318.843405782824;31284.687153128176;31296;31358.686413135576;31674.841625791723;31741.36517269688;31473.370532589677;31807.36385272328;32042.51936220912;32097;32141.517877232327;27444.17667469979;28272.15183544497;28560.285992849513;28696.569551457163;28893.27766805847;22660.206892758673;22712.205072822373;22976.540469190855;23086.076556938206;23198 08:29:13 INFO - PROCESS | 13029 | |2;jquery.html;340.23107776425286;341.8393355123092;342.790897552493;350.98596056157754;351.27812345629735;14459.855401445982;14938.402463901431;15541.756659467244;15706.921465392657;16130.919345403256;14966.251687415614;15132.773008404884;15340.156291403968;15925.920370398131;15965.441209557668;4996.075725990703;5151.536361727443;5153.922691159635;5156.097682905495;5178.559822415099;4908.337374454457;5197.766100525486;5197.974010129944;5199.298094757216;5205.661631993928;5130.127878260705;5135.51212634801;5146.176611742122;5172.146595811705;5172.715500647463;4989.975050124763;5080.2125670520945;5138.306328645641;5150.768215430296;5162;4576.336431217454;4592.609628181609;4592.724436533786;4597.448306203277;4603.28649059393;18864.5283867903;19029.61940761177;19623.411297661092;19674.50813729654;19683.409497715093;1784.125778368603;1858.3031363238786;1933.8839669619726;2022.1911235505916;2253.5718213539376;8613.397062205648;8646.481211127353;8729.7817554561;9160.404573702755;12681.619551413472;1746.2840235503384;1766.2493440287826;1802.8918264904148;1829.8170182981728;1868.943931682038;56218.71890640521;57895;59459.40540594625;59528;60901.6954915227;9358.859617105749;9370.85943710845;9532.380395274424;9559.713208603753;9956.103950644478;11692.298462092302;11778.587749428729;11800.52797888092;11809.940950295366;11823.763524729457;6596.472282217411;6614.173228346457;6836.726530938707;6972.1284839395075;6981.232064472904;6438.774642887476;6456.741730330734;6643.335666433318;6645.036469711865;6645.202575690948;4012.3580227163516;4238.597333253336;4251.744895306291;4286.742795432284;4289.699721019499;1679.3702361614394;1714.8971061736336;1730.3857130718666;1738.8174241704692;1761.3923196497187;814.8696208606713;841.9621117049747;862.1723145779996;901.9684311049082;901.977450563728;15177.317020734094;15420.383184672712;15587.220638968007;15592.454264100703;15603.609909752347;802.5987006496752;805.3557154276673;825.3727167352855;833.9867061520282;834.591050385319;8585.914140858637;8882.333824963025;8942.061083586259;9033.548322583845;9159.404638698463;391333;395399;400440;400467;401801;41935.16129677389;42493.57506424896;64009.359906401274;65877.34122658712;66106.33893661002;422.4866786853987;431.45851955795905;441.8166460918683;873.8820259265045;898.7169041751959;9555.426674399558;9818.312718109664;9838.852417213604;9866.703998880044;10040.849387259052;31733.20666983344;32677.509837351983;33060.834695826365;34631;34823.950527173925;42142.789286053376;46157.538424616665;46361.304580430646;46742.06515869732;47414.288785668934;6965.268646792014;7437.70249190048;7472.813179670552;7604.8479030420185;7632.923670763222;8693.391462597558;11329.150313726339;11441.313521188755;11455.140864435367;11610.6516804496;5780.537556995514;9800.990796886763;9904.851427228741;10124.59501619927;10286.177105831664;9855.35940163887;10145.79708405813;10245.334053286513;10346.741331466774;10367.792644146924;9636.71089867305;10229.363301871665;10276.131761138213;10375.377477351383;10432.165426765992;7328.413726901728;7406.14829294638;7468.290512401313;7566.470347075652;7618.123915749759;9712.514374281116;10242.283040187116;10282.794344113225;10403.063724264852;10476.633317834145 08:29:13 INFO - PROCESS | 13029 | |3;mootools.html;1208.166365208007;1373.560460652591;1378.648444646615;1515.3938424630146;1752.4041825779232;6343.207099112611;7224.566526008437;7362;7386.298301661347;7400.962995185023;7213.386862116727;7327.670254838532;7367.594782286972;7404.925950740491;7408.111026676793;1772.1227992143906;1815.0289595066643;2089.9582008359826;2091.613051585458;2125.7661657217695;2156.579467003935;2195.9451013724624;2197.121151539381;2197.307848027874;2200.3179014505477;2116.2804646420213;2155.2887547109417;2155.353393981807;2169.7287839020123;2171.3703026122485;2106.431263558846;2141.9250326238584;2153.0849389009763;2159.1903036361286;2161.0923412166926;2125.8193053590307;2159.8272138228904;2161.902714377841;2169.143188440557;2170.9565808683897;7259.34665880068;7327.340539351484;7330.853382932365;7334.083239595051;7340.26597340267;4407.757573333465;4496.460424749019;4498.145352383037;4501.527339629324;4522.366868638361;2733.5489644208683;2884.7115288471196;2893.9276518087004;2912.6504819421807;2916.518774402221;851.833892390984;893.5175005497024;914.5061666699974;914.5701520285521;923.3813345058827;9835.21318294542;9935.552900119439;9990;10011.199104071657;10061;3987.76073435589;4078.6125318094732;4090.5295890972325;4098.303288440972;4113.794310284474;7869.449138560361;7885.2114788520685;7929.088154862265;7943;7948.960255198803;4370.825166993348;4373.1472362888935;4375.081232941055;4385.276429389115;4402.163588918095;3433.7081348085694;3892.591277915835;3966.643002129822;4003.2193722223888;4006.1386801837743;3260.413125637408;3323.997383937159;3331.6501767314085;3359.764816462824;3360.983195084009;958.8609651600478;1008.4251976373544;1017.9236557258236;1028.747956750601;1043.1811028342715;1148.1847887999447;1151.5451396698256;1166.597523854269;1180.5218886351042;1184.6386852010219;6929.792106236821;6978.720851165998;7018.473614478935;7032.226455090038;7055.89416158758;436.70522397381643;443.962263207631;450.39421977440946;452.1341630777091;460.35320374873356;5512.228288039678;5586.748596313176;5600.943990560124;5633.8309850704545;5647.37878833328;8827.735167944971;9053.275737940949;9200.585973631203;9305.767355816159;9321.766955826022;9221.216196623229;9239.491827949392;9262.768430789149;9299.488528131018;9299.581518831668;7091.432685385157;7105.71577136919;7155.677994490156;7235.5658660479485;7241.818954526179;6837.042814006142;6853.588784672936;6861.4510839133745;6876.449884009167;6904.965475172592;8097.595120244082;8249.216324449168;8360.038595561346;8402.579871006548;8409.87385189235;8402.495850249004;8491.660333586588;8513.914860851311;8680.175383338572;8685.739427817176;5443.074677304789;6001.579889407874;6196.969015154896;6254.6247225166635;6449.193850768654;6954.47841411886;6992;7016.158061032709;7034.894476582957;7036.718531258693;6136.723847426787;6307.117003619589;6359.96820015897;6367.840803979938;6403.64779937108;6184.103305020837;6280.654563999024;6302.495800336053;6340;6378.362163783585;6740.966295168493;6765.594064356154;6784.898226526508;6789.762358317435;6797.89803152963;6116.541259405473;6190.102435146789;6213.347598502273;6239;6239.06414037898;6095.451409373178;6174.289956654862;6186.257649081959;6193.876122477615;6201.875962480815 08:29:13 INFO - PROCESS | 13029 | |4;prototype.html;300.13411308375333;308.4124742365793;310.94247564200623;314.72461596103403;315.08939165810824;5277.525022747952;5282.260483532304;5332.120200166973;5333.280007199027;5406.351237851453;5273.2617433559235;5307.575393968483;5308.097623404021;5311.707856067915;5322.787088516465;3905.9804700976597;4016.6987475939277;4100.610442008005;4108.506979162505;4148.668106551476;4117.053077792095;4148.191102734968;4151.3150330195485;4154.937675934848;4165.916681666365;4108.712390132692;4110.486189226347;4120.072983578701;4123.917521649565;4125.587441255881;3890.9027274318228;4003.319435695939;4107;4118.176364727066;4124.05146816231;3619.113317237294;3622.619624939396;3623.184783423735;3624.818759062063;3630.2557975614936;5079;5091.719955402451;5094.184930411154;5095.745212739385;5100.209467532539;4763.833265835679;4766.094442055998;4766.523347665206;4778.689385189951;4784.378030856001;5556.388797232301;5575.107982722786;5577.442255774431;5579.13523403873;5582.553395728332;3973.304671682473;3973.960260397388;3974.225026119908;3979.94030089546;3989.68082553395;5591.30108736408;5783.537317014629;5813.854653633651;5842.094475356326;5847.7953271635715;3902;3943.526776786804;3949.822257998397;3956.3076461619103;3957.3668213085766;4018.6584140347813;4019.9196016079513;4020.537638171648;4020.6582440492884;4022.054817117975;4620.145273124483;4624.815007399734;4629.791659375269;4636.513166117509;4640.23436133041;5556.333240011225;5556.805511807067;5558.194061861008;5560.499555040065;5566.693831839288;1399.979000314996;1419.673475100712;1419.8438171801095;1422.4807945099965;1423.7366087273888;881.2245224202661;892.8125093730259;930.9581068851918;944.7874228298715;951.9095685909828;4762.880927976828;4777.904441911142;4803.1114243864995;4906.386701662293;4906.650671065486;5800.854978625568;5821.155932389865;5835.212246346774;5836.620619659709;5839.883202335929;4956.35567376246;4959.876003099951;4960.90078198434;4966.255061740768;4968.403791544965;3079.2609773654162;3109.657937626859;3115.9376812463624;3116.875324986975;3124.562561241428;5544.22380866679;5555.861103472445;5558.166275058693;5566.165075238666;5568.053430916754;5777.277840269966;5960.731767070405;5966.671833049224;5969;5970.641761494324;5523.033469142884;5553.416891226444;5555.944440555623;5610.0743377343915;5614.045612245846;5780.710964451845;5792.986227410271;5797.072468405035;5801.912971305349;5803.3616302207565;5671.773129074956;5672.5745569081655;5675.914861277167;5678.261825962599;5682.062459694104;5541.224228608079;5544.0575102231915;5547.11246200606;5547.445255474582;5549.417311182267;3801.5818259991934;3930.7838068906485;3946.9210615788097;3947.0724379771304;3949;5675.489205971482;5685.20407142992;5689.800856969986;5691.174779657009;5696.458836410535;5432.429594892637;5436.320459942507;5437.646552974044;5441.319835020622;5441.809536666197;5429.049916264559;5433.320834895638;5433.750237445489;5434.10337294342;5438.592105592175;5330.440303768049;5355.196720491802;5366.168243922199;5368.57051435892;5378.865528361822;5404.648697834628;5548.167774833646;5558.110702287615;5605.5235304997905;5632.436756324335;5441.673499590037;5460.071787796005;5474.39781624029;5479.232907392889;5480.780768769205 08:29:13 INFO - PROCESS | 13029 | |5;yui.html;680.9182898052231;710.9893351599725;723.7141329174976;724.1455083002055;735.2353552305602;11547.13396495263;11615.825762613567;11721.238119522224;11728.17902746807;11782.528698852046;11427.200095993283;11458.083353331735;11468.139889508278;11542.538298468073;11552.133589980744;755.7883792538098;771.1863983497408;776.4642396746227;779.7582749347692;780.0132831967566;595.2172892646156;765.6057130577757;784.7802615267706;785.418790095331;786.1391776005265;822.0833770346051;825.1954344514111;825.5789547330844;827.1439060572309;829.0134739659785;618.2303032724287;816.391788117856;817.2767101115526;817.7301490508119;817.9959100204491;591.1339887065427;600.7867207141489;600.9909851352234;601.0593421295658;601.975920963161;12144.939275303566;12162.331071791048;12210.938945305306;12231.510739570407;12235.388230588524;11304.547818087267;12011.759764804743;12197.939010304981;12217.389130543437;12344.38278086092;9519.952400237955;9617.27870409715;9711.854322185101;9722.416655000652;9877.357971731815;3324.8337583120747;3329.1510664780567;3380.087376408356;3396.4226081565944;3415.299863527971;39254.803725981474;39577;39606;39622.80188599038;39815;9491.810163796823;9553.61785528585;9691.12779849817;9809.460479673544;9883.505824708736;16964.74552881708;17010.234539445755;17197;17220.225089870986;17228.224729887184;6663.500237482208;6710.731570737214;6741.2921643226755;6774.390304872487;6870.793876183722;3700.288586623307;3732.234891847165;3738.2897249522503;3793.279276937428;3807.8857634271017;2595.6755405574304;2607.38726399296;2616.6336712860216;2618.3585021669433;2628.132716203648;469.72051629280526;474.5776259129378;481.8867566121959;487.01865740532855;489.0902920567741;539.1454544546937;553.4631407534685;556.7967691792547;564.6865989375935;590.4833270887973;6965.686544105527;7198.208197098315;7310.780676579711;7354.963225183947;7384.5570214189265;436.52418863439004;445.13865669928146;492.990140197194;496.3324328777788;539.3958766181823;3182.50271774363;3260.543523906655;3303.620083690358;3327.38443387974;3408.693217610427;43242.13515729731;43556.3466548002;43734;43864.780676096416;43878.7806060974;42007.78996105;42046;42437;42464.57535424606;42990.570094299284;39659.999999999425;39707.60292397097;39758;39960.20079598392;40011.79994100011;6276.6547839869245;6356.745730170926;6371.23545174582;6452.483801295979;6567.080608714688;30364.544531831598;30750;31294.37411251808;31361.372772543964;32008;37815.62184378121;37852.81073594614;38145;38988.2202355957;39418;9503.382280151767;9528.094830991045;9535.666251681158;9659.806803864023;9684.903150968401;10041;10201.775786905322;10249.59001639956;10260.384376937407;10401.94799026;9487.156626744716;9649.807003859743;9681.322307438411;9705.6117755289;10041.297109202285;9293.814123717353;9778.462184579916;9800.80398392014;10069.244806639677;10090.69727908164;8943.418677785923;9104.998450170608;9393.107654772786;9399;9406.106419890373;7288;7332.560046397233;7644.0827100748265;7890.408219383455;7918.089419716806;7165.462590305644;7312.341889229995;7661.961690191736;7871.606419679108;7921.128675845537 08:29:13 INFO - PROCESS | 13029 | __end_tp_report 08:29:13 INFO - PROCESS | 13029 | __start_cc_report 08:29:13 INFO - PROCESS | 13029 | _x_x_mozilla_cycle_collect,840 08:29:13 INFO - PROCESS | 13029 | __end_cc_report 08:29:13 INFO - PROCESS | 13029 | __startTimestamp1457368153305__endTimestamp 08:29:13 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | ------- Summary: start ------- 08:29:13 INFO - PROCESS | 13029 | Number of tests: 6 08:29:13 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | [#0] dojo.html Cycles:165 Average:4422.80 Median:4549.70 stddev:446.76 (9.8%) stddev-sans-first:423.15 08:29:13 INFO - PROCESS | 13029 | Values: 2545.0 2586.4 2623.5 2625.6 2640.3 4313.0 4433.7 4485.4 4493.1 4514.8 4496.9 4514.5 4530.7 4543.7 4588.2 4109.7 4138.0 4140.7 4153.6 4272.4 4015.1 4198.6 4239.8 4246.9 4262.3 4060.6 4094.1 4121.2 4126.3 4139.8 4087.0 4095.3 4115.7 4139.4 4154.8 3974.5 4079.0 4088.4 4092.8 4124.6 4383.2 4416.5 4420.0 4446.9 4469.3 4764.8 4785.1 4785.1 4788.9 4826.6 4703.1 4778.7 4798.5 4810.5 4869.7 4417.1 4419.6 4458.2 4458.6 4462.2 4837.4 4851.5 4852.1 4852.3 4887.3 4567.3 4658.8 4679.0 4716.2 4799.1 4821.2 4841.3 4846.7 4870.2 4893.2 4756.7 4786.2 4786.5 4790.0 4822.9 4586.0 4649.7 4722.4 4742.8 4765.3 3990.1 4006.0 4013.7 4028.1 4053.4 3556.4 3558.8 3577.4 3600.7 3611.9 3994.3 4069.9 4086.6 4150.6 4156.4 4793.4 4819.7 4824.3 4848.2 4877.1 4159.5 4169.7 4170.8 4174.3 4203.5 4153.5 4234.2 4294.4 4300.6 4340.0 4602.6 4605.3 4622.8 4625.1 4667.8 4621.4 4830.4 4841.3 4841.8 4869.1 4585.8 4636.5 4643.4 4666.8 4672.3 4715.2 4728.0 4730.3 4730.9 4744.4 4602.4 4765.8 4780.3 4792.1 4837.2 4594.9 4602.9 4606.4 4628.6 4648.3 4575.6 4578.6 4585.3 4619.9 4632.0 4402.4 4499.7 4515.5 4519.4 4560.1 4601.2 4620.8 4626.0 4647.0 4672.9 4500.7 4500.9 4502.0 4545.0 4549.7 08:29:13 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | [#1] ext.html Cycles:180 Average:34760.61 Median:18572.92 stddev:50403.43 (271.4%) stddev-sans-first:50479.08 08:29:13 INFO - PROCESS | 13029 | Values: 475.0 499.8 520.8 561.4 561.9 25150.4 32851.2 33730.5 33761.0 33767.8 36745.0 37144.0 37189.8 37252.4 37269.1 6842.3 7720.5 7900.5 7917.8 9480.1 9775.9 9936.5 9945.1 9946.1 9950.5 9863.7 9966.6 9975.3 9980.0 9983.4 9850.8 9965.0 9965.3 9967.8 9969.9 9659.8 9864.0 9864.2 9864.9 10169.6 36896.0 37450.8 37466.1 37467.0 37493.6 2916.7 2949.1 2952.1 3080.4 3314.7 28184.9 28293.3 28570.7 28770.7 29131.9 3378.0 3507.8 3532.6 3551.2 3561.7 154803.2 156072.0 156255.0 156379.0 156655.0 38610.0 55876.7 56236.0 56319.0 56333.0 37240.4 37448.5 37458.6 37468.6 37472.6 10636.3 11553.2 11746.8 11751.5 11771.2 9520.2 9792.9 9806.4 9817.2 9826.0 12706.2 12709.5 12719.4 12737.6 12868.0 5140.5 5256.8 5258.4 5279.1 5342.5 804.2 824.7 867.4 872.3 903.9 25768.4 26128.6 26287.3 26545.6 26556.7 897.9 927.9 928.7 948.5 995.7 13466.4 13742.8 13956.0 13997.7 14041.3 240874.0 244476.0 245728.0 246296.0 246387.0 44944.6 45469.3 45603.3 45657.3 45714.3 1087.1 1099.2 1118.9 1170.3 1198.4 24179.0 25651.5 26526.9 26573.0 26625.9 36704.1 36967.6 37060.4 37117.6 37120.3 169666.0 169710.0 170691.0 171055.0 171349.1 23956.6 28262.3 28488.1 28542.9 28891.3 35452.3 36592.0 36644.3 36843.8 37114.3 29661.7 31001.0 31022.0 31276.2 31318.8 31284.7 31296.0 31358.7 31674.8 31741.4 31473.4 31807.4 32042.5 32097.0 32141.5 27444.2 28272.2 28560.3 28696.6 28893.3 22660.2 22712.2 22976.5 23086.1 23198.0 08:29:13 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | [#2] jquery.html Cycles:180 Average:22879.86 Median:25380.41 stddev:65138.51 (256.6%) stddev-sans-first:65299.26 08:29:13 INFO - PROCESS | 13029 | Values: 340.2 341.8 342.8 351.0 351.3 14459.9 14938.4 15541.8 15706.9 16130.9 14966.3 15132.8 15340.2 15925.9 15965.4 4996.1 5151.5 5153.9 5156.1 5178.6 4908.3 5197.8 5198.0 5199.3 5205.7 5130.1 5135.5 5146.2 5172.1 5172.7 4990.0 5080.2 5138.3 5150.8 5162.0 4576.3 4592.6 4592.7 4597.4 4603.3 18864.5 19029.6 19623.4 19674.5 19683.4 1784.1 1858.3 1933.9 2022.2 2253.6 8613.4 8646.5 8729.8 9160.4 12681.6 1746.3 1766.2 1802.9 1829.8 1868.9 56218.7 57895.0 59459.4 59528.0 60901.7 9358.9 9370.9 9532.4 9559.7 9956.1 11692.3 11778.6 11800.5 11809.9 11823.8 6596.5 6614.2 6836.7 6972.1 6981.2 6438.8 6456.7 6643.3 6645.0 6645.2 4012.4 4238.6 4251.7 4286.7 4289.7 1679.4 1714.9 1730.4 1738.8 1761.4 814.9 842.0 862.2 902.0 902.0 15177.3 15420.4 15587.2 15592.5 15603.6 802.6 805.4 825.4 834.0 834.6 8585.9 8882.3 8942.1 9033.5 9159.4 391333.0 395399.0 400440.0 400467.0 401801.0 41935.2 42493.6 64009.4 65877.3 66106.3 422.5 431.5 441.8 873.9 898.7 9555.4 9818.3 9838.9 9866.7 10040.8 31733.2 32677.5 33060.8 34631.0 34824.0 42142.8 46157.5 46361.3 46742.1 47414.3 6965.3 7437.7 7472.8 7604.8 7632.9 8693.4 11329.2 11441.3 11455.1 11610.7 5780.5 9801.0 9904.9 10124.6 10286.2 9855.4 10145.8 10245.3 10346.7 10367.8 9636.7 10229.4 10276.1 10375.4 10432.2 7328.4 7406.1 7468.3 7566.5 7618.1 9712.5 10242.3 10282.8 10403.1 10476.6 08:29:13 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | [#3] mootools.html Cycles:180 Average:5139.18 Median:6195.42 stddev:2729.36 (44.1%) stddev-sans-first:2721.03 08:29:13 INFO - PROCESS | 13029 | Values: 1208.2 1373.6 1378.6 1515.4 1752.4 6343.2 7224.6 7362.0 7386.3 7401.0 7213.4 7327.7 7367.6 7404.9 7408.1 1772.1 1815.0 2090.0 2091.6 2125.8 2156.6 2195.9 2197.1 2197.3 2200.3 2116.3 2155.3 2155.4 2169.7 2171.4 2106.4 2141.9 2153.1 2159.2 2161.1 2125.8 2159.8 2161.9 2169.1 2171.0 7259.3 7327.3 7330.9 7334.1 7340.3 4407.8 4496.5 4498.1 4501.5 4522.4 2733.5 2884.7 2893.9 2912.7 2916.5 851.8 893.5 914.5 914.6 923.4 9835.2 9935.6 9990.0 10011.2 10061.0 3987.8 4078.6 4090.5 4098.3 4113.8 7869.4 7885.2 7929.1 7943.0 7949.0 4370.8 4373.1 4375.1 4385.3 4402.2 3433.7 3892.6 3966.6 4003.2 4006.1 3260.4 3324.0 3331.7 3359.8 3361.0 958.9 1008.4 1017.9 1028.7 1043.2 1148.2 1151.5 1166.6 1180.5 1184.6 6929.8 6978.7 7018.5 7032.2 7055.9 436.7 444.0 450.4 452.1 460.4 5512.2 5586.7 5600.9 5633.8 5647.4 8827.7 9053.3 9200.6 9305.8 9321.8 9221.2 9239.5 9262.8 9299.5 9299.6 7091.4 7105.7 7155.7 7235.6 7241.8 6837.0 6853.6 6861.5 6876.4 6905.0 8097.6 8249.2 8360.0 8402.6 8409.9 8402.5 8491.7 8513.9 8680.2 8685.7 5443.1 6001.6 6197.0 6254.6 6449.2 6954.5 6992.0 7016.2 7034.9 7036.7 6136.7 6307.1 6360.0 6367.8 6403.6 6184.1 6280.7 6302.5 6340.0 6378.4 6741.0 6765.6 6784.9 6789.8 6797.9 6116.5 6190.1 6213.3 6239.0 6239.1 6095.5 6174.3 6186.3 6193.9 6201.9 08:29:13 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | [#4] prototype.html Cycles:180 Average:4618.71 Median:5317.25 stddev:1358.92 (25.6%) stddev-sans-first:1323.51 08:29:13 INFO - PROCESS | 13029 | Values: 300.1 308.4 310.9 314.7 315.1 5277.5 5282.3 5332.1 5333.3 5406.4 5273.3 5307.6 5308.1 5311.7 5322.8 3906.0 4016.7 4100.6 4108.5 4148.7 4117.1 4148.2 4151.3 4154.9 4165.9 4108.7 4110.5 4120.1 4123.9 4125.6 3890.9 4003.3 4107.0 4118.2 4124.1 3619.1 3622.6 3623.2 3624.8 3630.3 5079.0 5091.7 5094.2 5095.7 5100.2 4763.8 4766.1 4766.5 4778.7 4784.4 5556.4 5575.1 5577.4 5579.1 5582.6 3973.3 3974.0 3974.2 3979.9 3989.7 5591.3 5783.5 5813.9 5842.1 5847.8 3902.0 3943.5 3949.8 3956.3 3957.4 4018.7 4019.9 4020.5 4020.7 4022.1 4620.1 4624.8 4629.8 4636.5 4640.2 5556.3 5556.8 5558.2 5560.5 5566.7 1400.0 1419.7 1419.8 1422.5 1423.7 881.2 892.8 931.0 944.8 951.9 4762.9 4777.9 4803.1 4906.4 4906.7 5800.9 5821.2 5835.2 5836.6 5839.9 4956.4 4959.9 4960.9 4966.3 4968.4 3079.3 3109.7 3115.9 3116.9 3124.6 5544.2 5555.9 5558.2 5566.2 5568.1 5777.3 5960.7 5966.7 5969.0 5970.6 5523.0 5553.4 5555.9 5610.1 5614.0 5780.7 5793.0 5797.1 5801.9 5803.4 5671.8 5672.6 5675.9 5678.3 5682.1 5541.2 5544.1 5547.1 5547.4 5549.4 3801.6 3930.8 3946.9 3947.1 3949.0 5675.5 5685.2 5689.8 5691.2 5696.5 5432.4 5436.3 5437.6 5441.3 5441.8 5429.0 5433.3 5433.8 5434.1 5438.6 5330.4 5355.2 5366.2 5368.6 5378.9 5404.6 5548.2 5558.1 5605.5 5632.4 5441.7 5460.1 5474.4 5479.2 5480.8 08:29:13 INFO - PROCESS | 13029 | 08:29:13 INFO - PROCESS | 13029 | [#5] yui.html Cycles:180 Average:11724.80 Median:494.66 stddev:13130.73 (2654.5%) stddev-sans-first:13141.37 08:29:13 INFO - PROCESS | 13029 | Values: 680.9 711.0 723.7 724.1 735.2 11547.1 11615.8 11721.2 11728.2 11782.5 11427.2 11458.1 11468.1 11542.5 11552.1 755.8 771.2 776.5 779.8 780.0 595.2 765.6 784.8 785.4 786.1 822.1 825.2 825.6 827.1 829.0 618.2 816.4 817.3 817.7 818.0 591.1 600.8 601.0 601.1 602.0 12144.9 12162.3 12210.9 12231.5 12235.4 11304.5 12011.8 12197.9 12217.4 12344.4 9520.0 9617.3 9711.9 9722.4 9877.4 3324.8 3329.2 3380.1 3396.4 3415.3 39254.8 39577.0 39606.0 39622.8 39815.0 9491.8 9553.6 9691.1 9809.5 9883.5 16964.7 17010.2 17197.0 17220.2 17228.2 6663.5 6710.7 6741.3 6774.4 6870.8 3700.3 3732.2 3738.3 3793.3 3807.9 2595.7 2607.4 2616.6 2618.4 2628.1 469.7 474.6 481.9 487.0 489.1 539.1 553.5 556.8 564.7 590.5 6965.7 7198.2 7310.8 7355.0 7384.6 436.5 445.1 493.0 496.3 539.4 3182.5 3260.5 3303.6 3327.4 3408.7 43242.1 43556.3 43734.0 43864.8 43878.8 42007.8 42046.0 42437.0 42464.6 42990.6 39660.0 39707.6 39758.0 39960.2 40011.8 6276.7 6356.7 6371.2 6452.5 6567.1 30364.5 30750.0 31294.4 31361.4 32008.0 37815.6 37852.8 38145.0 38988.2 39418.0 9503.4 9528.1 9535.7 9659.8 9684.9 10041.0 10201.8 10249.6 10260.4 10401.9 9487.2 9649.8 9681.3 9705.6 10041.3 9293.8 9778.5 9800.8 10069.2 10090.7 8943.4 9105.0 9393.1 9399.0 9406.1 7288.0 7332.6 7644.1 7890.4 7918.1 7165.5 7312.3 7662.0 7871.6 7921.1 08:29:13 INFO - PROCESS | 13029 | -------- Summary: end -------- 08:29:13 INFO - PROCESS | 13029 | 08:29:14 INFO - TEST-INFO | 13029: exit 0 08:29:14 INFO - TEST-OK | dromaeo_css | took 1116294ms 08:29:14 INFO - TEST-START | kraken 08:29:14 INFO - operating with platform_type : linux_ 08:29:14 INFO - Initialising browser for kraken test... 08:29:14 INFO - TEST-INFO | started process 13211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ2lU2S/profile http://localhost:45978/getInfo.html) 08:29:18 INFO - PROCESS | 13211 | __metrics Screen width/height:1600/1200 08:29:18 INFO - PROCESS | 13211 | colorDepth:24 08:29:18 INFO - PROCESS | 13211 | Browser inner width/height: 1024/697 08:29:18 INFO - PROCESS | 13211 | __metrics 08:29:18 INFO - PROCESS | 13211 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:19 INFO - TEST-INFO | 13211: exit 0 08:29:19 INFO - Browser initialized. 08:29:19 INFO - Running cycle 1/1 for kraken test... 08:29:19 INFO - TEST-INFO | started process 13296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ2lU2S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:31 INFO - PROCESS | 13296 | RSS: Main: 156487680 08:29:31 INFO - PROCESS | 13296 | 08:29:34 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45978/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:34 INFO - PROCESS | 13296 | RSS: Main: 200785920 08:29:34 INFO - PROCESS | 13296 | 08:29:37 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45978/tests/kraken/driver.html?testName=audio-dft) 08:29:38 INFO - PROCESS | 13296 | RSS: Main: 188911616 08:29:38 INFO - PROCESS | 13296 | 08:29:41 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45978/tests/kraken/driver.html?testName=audio-fft) 08:29:41 INFO - PROCESS | 13296 | RSS: Main: 173318144 08:29:41 INFO - PROCESS | 13296 | 08:29:43 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45978/tests/kraken/driver.html?testName=audio-oscillator) 08:29:44 INFO - PROCESS | 13296 | RSS: Main: 175722496 08:29:44 INFO - PROCESS | 13296 | 08:29:46 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:47 INFO - PROCESS | 13296 | RSS: Main: 176680960 08:29:47 INFO - PROCESS | 13296 | 08:29:50 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45978/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:51 INFO - PROCESS | 13296 | RSS: Main: 177684480 08:29:51 INFO - PROCESS | 13296 | 08:29:54 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45978/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:55 INFO - PROCESS | 13296 | RSS: Main: 178339840 08:29:55 INFO - PROCESS | 13296 | 08:29:58 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45978/tests/kraken/driver.html?testName=json-parse-financial) 08:29:58 INFO - PROCESS | 13296 | RSS: Main: 178941952 08:29:58 INFO - PROCESS | 13296 | 08:30:00 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:00 INFO - PROCESS | 13296 | RSS: Main: 187785216 08:30:00 INFO - PROCESS | 13296 | 08:30:02 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45978/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:03 INFO - PROCESS | 13296 | RSS: Main: 185663488 08:30:03 INFO - PROCESS | 13296 | 08:30:05 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:06 INFO - PROCESS | 13296 | RSS: Main: 195600384 08:30:06 INFO - PROCESS | 13296 | 08:30:08 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:09 INFO - PROCESS | 13296 | RSS: Main: 202067968 08:30:09 INFO - PROCESS | 13296 | 08:30:12 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:12 INFO - PROCESS | 13296 | RSS: Main: 202473472 08:30:12 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:45978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45978/tests/kraken/driver.html?testName=ai-astar) 08:30:14 INFO - PROCESS | 13296 | RSS: Main: 264392704 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | __start_tp_report 08:30:14 INFO - PROCESS | 13296 | _x_x_mozilla_page_load 08:30:14 INFO - PROCESS | 13296 | _x_x_mozilla_page_load_details 08:30:14 INFO - PROCESS | 13296 | |i|pagename|runs| 08:30:14 INFO - PROCESS | 13296 | |0;ai-astar;112;115;109;115;113;114;103;112;113;113 08:30:14 INFO - PROCESS | 13296 | |1;audio-beat-detection;158;136;167;178;130;158;152;137;173;132 08:30:14 INFO - PROCESS | 13296 | |2;audio-dft;161;161;160;161;162;163;162;161;160;160 08:30:14 INFO - PROCESS | 13296 | |3;audio-fft;78;75;93;98;73;73;73;103;94;73 08:30:14 INFO - PROCESS | 13296 | |4;audio-oscillator;96;96;138;95;96;95;141;94;95;143 08:30:14 INFO - PROCESS | 13296 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 08:30:14 INFO - PROCESS | 13296 | |6;imaging-darkroom;146;147;147;146;147;146;147;146;146;146 08:30:14 INFO - PROCESS | 13296 | |7;imaging-desaturate;96;96;96;95;95;95;96;96;95;95 08:30:14 INFO - PROCESS | 13296 | |8;json-parse-financial;67;67;67;68;72;68;67;77;68;65 08:30:14 INFO - PROCESS | 13296 | |9;json-stringify-tinderbox;69;70;70;71;72;71;71;71;71;71 08:30:14 INFO - PROCESS | 13296 | |10;stanford-crypto-aes;87;96;83;83;82;93;82;84;85;82 08:30:14 INFO - PROCESS | 13296 | |11;stanford-crypto-ccm;127;129;129;134;119;125;136;125;120;121 08:30:14 INFO - PROCESS | 13296 | |12;stanford-crypto-pbkdf2;150;144;149;150;153;136;153;151;150;150 08:30:14 INFO - PROCESS | 13296 | |13;stanford-crypto-sha256-iterative;72;73;70;71;72;71;71;73;70;70 08:30:14 INFO - PROCESS | 13296 | __end_tp_report 08:30:14 INFO - PROCESS | 13296 | __start_cc_report 08:30:14 INFO - PROCESS | 13296 | _x_x_mozilla_cycle_collect,1185 08:30:14 INFO - PROCESS | 13296 | __end_cc_report 08:30:14 INFO - PROCESS | 13296 | __startTimestamp1457368214744__endTimestamp 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | ------- Summary: start ------- 08:30:14 INFO - PROCESS | 13296 | Number of tests: 14 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.57 (3.2%) stddev-sans-first:3.79 08:30:14 INFO - PROCESS | 13296 | Values: 112.0 115.0 109.0 115.0 113.0 114.0 103.0 112.0 113.0 113.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:158.00 stddev:17.57 (11.1%) stddev-sans-first:18.51 08:30:14 INFO - PROCESS | 13296 | Values: 158.0 136.0 167.0 178.0 130.0 158.0 152.0 137.0 173.0 132.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 08:30:14 INFO - PROCESS | 13296 | Values: 161.0 161.0 160.0 161.0 162.0 163.0 162.0 161.0 160.0 160.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.50 stddev:12.18 (15.9%) stddev-sans-first:12.76 08:30:14 INFO - PROCESS | 13296 | Values: 78.0 75.0 93.0 98.0 73.0 73.0 73.0 103.0 94.0 73.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:21.96 (23.1%) stddev-sans-first:22.79 08:30:14 INFO - PROCESS | 13296 | Values: 96.0 96.0 138.0 95.0 96.0 95.0 141.0 94.0 95.0 143.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:30:14 INFO - PROCESS | 13296 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:30:14 INFO - PROCESS | 13296 | Values: 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:30:14 INFO - PROCESS | 13296 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:68.00 stddev:3.44 (5.1%) stddev-sans-first:3.60 08:30:14 INFO - PROCESS | 13296 | Values: 67.0 67.0 67.0 68.0 72.0 68.0 67.0 77.0 68.0 65.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.60 08:30:14 INFO - PROCESS | 13296 | Values: 69.0 70.0 70.0 71.0 72.0 71.0 71.0 71.0 71.0 71.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:4.95 (5.9%) stddev-sans-first:5.22 08:30:14 INFO - PROCESS | 13296 | Values: 87.0 96.0 83.0 83.0 82.0 93.0 82.0 84.0 85.0 82.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:128.00 stddev:5.70 (4.5%) stddev-sans-first:6.04 08:30:14 INFO - PROCESS | 13296 | Values: 127.0 129.0 129.0 134.0 119.0 125.0 136.0 125.0 120.0 121.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:150.00 stddev:5.08 (3.4%) stddev-sans-first:5.36 08:30:14 INFO - PROCESS | 13296 | Values: 150.0 144.0 149.0 150.0 153.0 136.0 153.0 151.0 150.0 150.0 08:30:14 INFO - PROCESS | 13296 | 08:30:14 INFO - PROCESS | 13296 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:1.16 (1.6%) stddev-sans-first:1.20 08:30:14 INFO - PROCESS | 13296 | Values: 72.0 73.0 70.0 71.0 72.0 71.0 71.0 73.0 70.0 70.0 08:30:14 INFO - PROCESS | 13296 | -------- Summary: end -------- 08:30:14 INFO - PROCESS | 13296 | 08:30:15 INFO - TEST-INFO | 13296: exit 0 08:30:15 INFO - TEST-OK | kraken | took 61663ms 08:30:15 INFO - SUITE-END | took 1177s 08:30:15 INFO - Completed test suite (00:19:38) 08:30:15 INFO - javascript benchmark 08:30:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2544.9745502544974, 2586.3792689754464, 2623.5408803459395, 2625.645537852389, 2640.28712247693, 4312.956870431295, 4433.667474939376, 4485.372047913291, 4493.101379724056, 4514.796834142463, 4496.865094047175, 4514.548545145484, 4530.705504142228, 4543.65922555808, 4588.220002599558, 4109.671226301889, 4138.0482489027545, 4140.668746500288, 4153.626173644371, 4272.380504826799, 4015.1367455996956, 4198.559151289117, 4239.830406783725, 4246.893827654302, 4262.2754131797665, 4060.614241647039, 4094.0583665756744, 4121.155163191538, 4126.277901367249, 4139.793010349501, 4087.0395457067566, 4095.3037983542868, 4115.670746340285, 4139.379093136024, 4154.833806647761, 3974.463447434617, 4078.9796051019557, 4088.366303223005, 4092.7953602320063, 4124.608162224584, 4383.167198232326, 4416.514183439819, 4420.0, 4446.933296000562, 4469.329600559942, 4764.785584648699, 4785.066911952171, 4785.138675038492, 4788.856334309976, 4826.565609095198, 4703.1064097821645, 4778.665493415462, 4798.49615790344, 4810.494898035691, 4869.70781753096, 4417.050334178167, 4419.580139886705, 4458.197524445599, 4458.643308535309, 4462.174497717868, 4837.443693975168, 4851.51484851512, 4852.053849499313, 4852.320675105488, 4887.340209071801, 4567.269236922077, 4658.813647454132, 4679.0, 4716.221823399101, 4799.088173247072, 4821.180399332122, 4841.273808928619, 4846.660733748674, 4870.196417591129, 4893.241547560134, 4756.6670333077045, 4786.210275304536, 4786.473487916326, 4790.0, 4822.903541929212, 4585.9541404585525, 4649.7210167389385, 4722.433308003062, 4742.786574604151, 4765.285207218945, 3990.10222699896, 4005.9799701001307, 4013.6989725770686, 4028.113814960704, 4053.412255222976, 3556.3776339140545, 3558.768680035789, 3577.4276115821344, 3600.6579374959338, 3611.8555257789394, 3994.2610617035944, 4069.8575549855614, 4086.591340865949, 4150.5641907599265, 4156.397322388237, 4793.400824896888, 4819.7108173509705, 4824.324594556765, 4848.248521479177, 4877.073356062337, 4159.521655009652, 4169.687273454503, 4170.833166673299, 4174.269502836992, 4203.495580530356, 4153.501579810381, 4234.195502854448, 4294.441722576107, 4300.591443812833, 4340.0, 4602.562756538124, 4605.286180642006, 4622.791974361229, 4625.051864367864, 4667.766611669471, 4621.399218101626, 4830.396200474941, 4841.322214889989, 4841.806327746851, 4869.050535145612, 4585.77071146448, 4636.489986101594, 4643.3963584733765, 4666.78999445019, 4672.252439609782, 4715.151272770934, 4728.0, 4730.314104454904, 4730.929036064393, 4744.383230180055, 4602.401687780567, 4765.785539650655, 4780.282957556395, 4792.137415265146, 4837.2260438329695, 4594.88512787183, 4602.884927876696, 4606.355110284496, 4628.583427491542, 4648.279516674921, 4575.58819706228, 4578.587927086578, 4585.335126406586, 4619.86140415788, 4632.0, 4402.427684401007, 4499.662525310549, 4515.548445155589, 4519.435070616173, 4560.087982403466, 4601.217792975135, 4620.792064357045, 4625.953740462553, 4647.0, 4672.906541869212, 4500.662450316305, 4500.9099818004115, 4501.977490112528, 4545.045540436546, 4549.7042692224895], "unit": "score", "name": "dojo.html", "value": 4395.934461878618}, {"lowerIsBetter": false, "replicates": [474.9596284315833, 499.84005118362114, 520.8489538033971, 561.3880869851861, 561.9157126431036, 25150.371240718967, 32851.178720532, 33730.49404258938, 33760.99999999997, 33767.83116084422, 36745.0, 37144.0, 37189.814050929774, 37252.44121338182, 37269.06827329312, 6842.349976752201, 7720.498167619101, 7900.525968441883, 7917.841643167133, 9480.146786789188, 9775.902240977606, 9936.503174841266, 9945.10494055535, 9946.055124763136, 9950.452725100116, 9863.654772082979, 9966.601335946554, 9975.25185611082, 9980.0, 9983.351082179672, 9850.753731156707, 9964.999999999964, 9965.252606054575, 9967.80064398708, 9969.850452243221, 9659.758506037335, 9864.0, 9864.210863130933, 9864.90135098647, 10169.644062457852, 36896.0, 37450.8127459361, 37466.06334841623, 37467.0, 37493.625063749285, 2916.7083291670665, 2949.056301983366, 2952.099609619065, 3080.3993221321853, 3314.734821214297, 28184.85907570449, 28293.29266768327, 28570.714292857014, 28770.71229287701, 29131.854340728372, 3378.0, 3507.809265365375, 3532.5760908690863, 3551.200979779555, 3561.732870034732, 154803.22598387048, 156072.0, 156255.0, 156379.0, 156655.0, 38610.0, 55876.720616396655, 56236.0, 56319.0, 56333.0, 37240.441393378576, 37448.502059917846, 37458.62541374551, 37468.625313747056, 37472.62527374691, 10636.30863993838, 11553.24903881245, 11746.765064698659, 11751.47118379675, 11771.23486973344, 9520.238755830054, 9792.853107203398, 9806.411615303105, 9817.214622830157, 9826.0, 12706.174098683556, 12709.53840308358, 12719.427625756864, 12737.598864124939, 12867.970562354989, 5140.537351638371, 5256.842294731164, 5258.395284542326, 5279.076161671692, 5342.519173274424, 804.1516200408508, 824.7402068348451, 867.4058270085012, 872.3283072034498, 903.9141281578239, 25768.355791105372, 26128.608070878952, 26287.34281642936, 26545.601815972776, 26556.734432655427, 897.9236764874928, 927.9350445468752, 928.6749637626912, 948.4546385828038, 995.711243739322, 13466.394012269471, 13742.793858092136, 13956.0, 13997.720045599031, 14041.297935103408, 240874.0, 244476.0, 245728.0, 246296.0, 246387.0, 44944.55055449404, 45469.317960230626, 45603.315950260774, 45657.31514027292, 45714.31428528575, 1087.075985412409, 1099.1536516881956, 1118.927269727465, 1170.3270619394052, 1198.406788639629, 24179.032838686257, 25651.486970260117, 26526.86736566305, 26573.0, 26625.866870666297, 36704.08239794026, 36967.630323696416, 37060.44409333808, 37117.62882371142, 37120.257594848496, 169666.0, 169710.0, 170691.0, 171055.0, 171349.14325428294, 23956.640650390607, 28262.293442664097, 28488.14827036236, 28542.85728571344, 28891.277718057216, 35452.29095418026, 36592.0, 36644.26711465702, 36843.75295047263, 37114.25771484609, 29661.703382965894, 31001.0, 31022.0, 31276.218094547818, 31318.843405782824, 31284.687153128176, 31296.0, 31358.686413135576, 31674.841625791723, 31741.36517269688, 31473.370532589677, 31807.36385272328, 32042.51936220912, 32097.0, 32141.517877232327, 27444.17667469979, 28272.15183544497, 28560.285992849513, 28696.569551457163, 28893.27766805847, 22660.206892758673, 22712.205072822373, 22976.540469190855, 23086.076556938206, 23198.0], "unit": "score", "name": "ext.html", "value": 15839.5263011705}, {"lowerIsBetter": false, "replicates": [340.23107776425286, 341.8393355123092, 342.790897552493, 350.98596056157754, 351.27812345629735, 14459.855401445982, 14938.402463901431, 15541.756659467244, 15706.921465392657, 16130.919345403256, 14966.251687415614, 15132.773008404884, 15340.156291403968, 15925.920370398131, 15965.441209557668, 4996.075725990703, 5151.536361727443, 5153.922691159635, 5156.097682905495, 5178.559822415099, 4908.337374454457, 5197.766100525486, 5197.974010129944, 5199.298094757216, 5205.661631993928, 5130.127878260705, 5135.51212634801, 5146.176611742122, 5172.146595811705, 5172.715500647463, 4989.975050124763, 5080.2125670520945, 5138.306328645641, 5150.768215430296, 5162.0, 4576.336431217454, 4592.609628181609, 4592.724436533786, 4597.448306203277, 4603.28649059393, 18864.5283867903, 19029.61940761177, 19623.411297661092, 19674.50813729654, 19683.409497715093, 1784.125778368603, 1858.3031363238786, 1933.8839669619726, 2022.1911235505916, 2253.5718213539376, 8613.397062205648, 8646.481211127353, 8729.7817554561, 9160.404573702755, 12681.619551413472, 1746.2840235503384, 1766.2493440287826, 1802.8918264904148, 1829.8170182981728, 1868.943931682038, 56218.71890640521, 57895.0, 59459.40540594625, 59528.0, 60901.6954915227, 9358.859617105749, 9370.85943710845, 9532.380395274424, 9559.713208603753, 9956.103950644478, 11692.298462092302, 11778.587749428729, 11800.52797888092, 11809.940950295366, 11823.763524729457, 6596.472282217411, 6614.173228346457, 6836.726530938707, 6972.1284839395075, 6981.232064472904, 6438.774642887476, 6456.741730330734, 6643.335666433318, 6645.036469711865, 6645.202575690948, 4012.3580227163516, 4238.597333253336, 4251.744895306291, 4286.742795432284, 4289.699721019499, 1679.3702361614394, 1714.8971061736336, 1730.3857130718666, 1738.8174241704692, 1761.3923196497187, 814.8696208606713, 841.9621117049747, 862.1723145779996, 901.9684311049082, 901.977450563728, 15177.317020734094, 15420.383184672712, 15587.220638968007, 15592.454264100703, 15603.609909752347, 802.5987006496752, 805.3557154276673, 825.3727167352855, 833.9867061520282, 834.591050385319, 8585.914140858637, 8882.333824963025, 8942.061083586259, 9033.548322583845, 9159.404638698463, 391333.0, 395399.0, 400440.0, 400467.0, 401801.0, 41935.16129677389, 42493.57506424896, 64009.359906401274, 65877.34122658712, 66106.33893661002, 422.4866786853987, 431.45851955795905, 441.8166460918683, 873.8820259265045, 898.7169041751959, 9555.426674399558, 9818.312718109664, 9838.852417213604, 9866.703998880044, 10040.849387259052, 31733.20666983344, 32677.509837351983, 33060.834695826365, 34631.0, 34823.950527173925, 42142.789286053376, 46157.538424616665, 46361.304580430646, 46742.06515869732, 47414.288785668934, 6965.268646792014, 7437.70249190048, 7472.813179670552, 7604.8479030420185, 7632.923670763222, 8693.391462597558, 11329.150313726339, 11441.313521188755, 11455.140864435367, 11610.6516804496, 5780.537556995514, 9800.990796886763, 9904.851427228741, 10124.59501619927, 10286.177105831664, 9855.35940163887, 10145.79708405813, 10245.334053286513, 10346.741331466774, 10367.792644146924, 9636.71089867305, 10229.363301871665, 10276.131761138213, 10375.377477351383, 10432.165426765992, 7328.413726901728, 7406.14829294638, 7468.290512401313, 7566.470347075652, 7618.123915749759, 9712.514374281116, 10242.283040187116, 10282.794344113225, 10403.063724264852, 10476.633317834145], "unit": "score", "name": "jquery.html", "value": 7568.971615404372}, {"lowerIsBetter": false, "replicates": [1208.166365208007, 1373.560460652591, 1378.648444646615, 1515.3938424630146, 1752.4041825779232, 6343.207099112611, 7224.566526008437, 7362.0, 7386.298301661347, 7400.962995185023, 7213.386862116727, 7327.670254838532, 7367.594782286972, 7404.925950740491, 7408.111026676793, 1772.1227992143906, 1815.0289595066643, 2089.9582008359826, 2091.613051585458, 2125.7661657217695, 2156.579467003935, 2195.9451013724624, 2197.121151539381, 2197.307848027874, 2200.3179014505477, 2116.2804646420213, 2155.2887547109417, 2155.353393981807, 2169.7287839020123, 2171.3703026122485, 2106.431263558846, 2141.9250326238584, 2153.0849389009763, 2159.1903036361286, 2161.0923412166926, 2125.8193053590307, 2159.8272138228904, 2161.902714377841, 2169.143188440557, 2170.9565808683897, 7259.34665880068, 7327.340539351484, 7330.853382932365, 7334.083239595051, 7340.26597340267, 4407.757573333465, 4496.460424749019, 4498.145352383037, 4501.527339629324, 4522.366868638361, 2733.5489644208683, 2884.7115288471196, 2893.9276518087004, 2912.6504819421807, 2916.518774402221, 851.833892390984, 893.5175005497024, 914.5061666699974, 914.5701520285521, 923.3813345058827, 9835.21318294542, 9935.552900119439, 9990.0, 10011.199104071657, 10061.0, 3987.76073435589, 4078.6125318094732, 4090.5295890972325, 4098.303288440972, 4113.794310284474, 7869.449138560361, 7885.2114788520685, 7929.088154862265, 7943.0, 7948.960255198803, 4370.825166993348, 4373.1472362888935, 4375.081232941055, 4385.276429389115, 4402.163588918095, 3433.7081348085694, 3892.591277915835, 3966.643002129822, 4003.2193722223888, 4006.1386801837743, 3260.413125637408, 3323.997383937159, 3331.6501767314085, 3359.764816462824, 3360.983195084009, 958.8609651600478, 1008.4251976373544, 1017.9236557258236, 1028.747956750601, 1043.1811028342715, 1148.1847887999447, 1151.5451396698256, 1166.597523854269, 1180.5218886351042, 1184.6386852010219, 6929.792106236821, 6978.720851165998, 7018.473614478935, 7032.226455090038, 7055.89416158758, 436.70522397381643, 443.962263207631, 450.39421977440946, 452.1341630777091, 460.35320374873356, 5512.228288039678, 5586.748596313176, 5600.943990560124, 5633.8309850704545, 5647.37878833328, 8827.735167944971, 9053.275737940949, 9200.585973631203, 9305.767355816159, 9321.766955826022, 9221.216196623229, 9239.491827949392, 9262.768430789149, 9299.488528131018, 9299.581518831668, 7091.432685385157, 7105.71577136919, 7155.677994490156, 7235.5658660479485, 7241.818954526179, 6837.042814006142, 6853.588784672936, 6861.4510839133745, 6876.449884009167, 6904.965475172592, 8097.595120244082, 8249.216324449168, 8360.038595561346, 8402.579871006548, 8409.87385189235, 8402.495850249004, 8491.660333586588, 8513.914860851311, 8680.175383338572, 8685.739427817176, 5443.074677304789, 6001.579889407874, 6196.969015154896, 6254.6247225166635, 6449.193850768654, 6954.47841411886, 6992.0, 7016.158061032709, 7034.894476582957, 7036.718531258693, 6136.723847426787, 6307.117003619589, 6359.96820015897, 6367.840803979938, 6403.64779937108, 6184.103305020837, 6280.654563999024, 6302.495800336053, 6340.0, 6378.362163783585, 6740.966295168493, 6765.594064356154, 6784.898226526508, 6789.762358317435, 6797.89803152963, 6116.541259405473, 6190.102435146789, 6213.347598502273, 6239.0, 6239.06414037898, 6095.451409373178, 6174.289956654862, 6186.257649081959, 6193.876122477615, 6201.875962480815], "unit": "score", "name": "mootools.html", "value": 4118.879868409509}, {"lowerIsBetter": false, "replicates": [300.13411308375333, 308.4124742365793, 310.94247564200623, 314.72461596103403, 315.08939165810824, 5277.525022747952, 5282.260483532304, 5332.120200166973, 5333.280007199027, 5406.351237851453, 5273.2617433559235, 5307.575393968483, 5308.097623404021, 5311.707856067915, 5322.787088516465, 3905.9804700976597, 4016.6987475939277, 4100.610442008005, 4108.506979162505, 4148.668106551476, 4117.053077792095, 4148.191102734968, 4151.3150330195485, 4154.937675934848, 4165.916681666365, 4108.712390132692, 4110.486189226347, 4120.072983578701, 4123.917521649565, 4125.587441255881, 3890.9027274318228, 4003.319435695939, 4107.0, 4118.176364727066, 4124.05146816231, 3619.113317237294, 3622.619624939396, 3623.184783423735, 3624.818759062063, 3630.2557975614936, 5079.0, 5091.719955402451, 5094.184930411154, 5095.745212739385, 5100.209467532539, 4763.833265835679, 4766.094442055998, 4766.523347665206, 4778.689385189951, 4784.378030856001, 5556.388797232301, 5575.107982722786, 5577.442255774431, 5579.13523403873, 5582.553395728332, 3973.304671682473, 3973.960260397388, 3974.225026119908, 3979.94030089546, 3989.68082553395, 5591.30108736408, 5783.537317014629, 5813.854653633651, 5842.094475356326, 5847.7953271635715, 3902.0, 3943.526776786804, 3949.822257998397, 3956.3076461619103, 3957.3668213085766, 4018.6584140347813, 4019.9196016079513, 4020.537638171648, 4020.6582440492884, 4022.054817117975, 4620.145273124483, 4624.815007399734, 4629.791659375269, 4636.513166117509, 4640.23436133041, 5556.333240011225, 5556.805511807067, 5558.194061861008, 5560.499555040065, 5566.693831839288, 1399.979000314996, 1419.673475100712, 1419.8438171801095, 1422.4807945099965, 1423.7366087273888, 881.2245224202661, 892.8125093730259, 930.9581068851918, 944.7874228298715, 951.9095685909828, 4762.880927976828, 4777.904441911142, 4803.1114243864995, 4906.386701662293, 4906.650671065486, 5800.854978625568, 5821.155932389865, 5835.212246346774, 5836.620619659709, 5839.883202335929, 4956.35567376246, 4959.876003099951, 4960.90078198434, 4966.255061740768, 4968.403791544965, 3079.2609773654162, 3109.657937626859, 3115.9376812463624, 3116.875324986975, 3124.562561241428, 5544.22380866679, 5555.861103472445, 5558.166275058693, 5566.165075238666, 5568.053430916754, 5777.277840269966, 5960.731767070405, 5966.671833049224, 5969.0, 5970.641761494324, 5523.033469142884, 5553.416891226444, 5555.944440555623, 5610.0743377343915, 5614.045612245846, 5780.710964451845, 5792.986227410271, 5797.072468405035, 5801.912971305349, 5803.3616302207565, 5671.773129074956, 5672.5745569081655, 5675.914861277167, 5678.261825962599, 5682.062459694104, 5541.224228608079, 5544.0575102231915, 5547.11246200606, 5547.445255474582, 5549.417311182267, 3801.5818259991934, 3930.7838068906485, 3946.9210615788097, 3947.0724379771304, 3949.0, 5675.489205971482, 5685.20407142992, 5689.800856969986, 5691.174779657009, 5696.458836410535, 5432.429594892637, 5436.320459942507, 5437.646552974044, 5441.319835020622, 5441.809536666197, 5429.049916264559, 5433.320834895638, 5433.750237445489, 5434.10337294342, 5438.592105592175, 5330.440303768049, 5355.196720491802, 5366.168243922199, 5368.57051435892, 5378.865528361822, 5404.648697834628, 5548.167774833646, 5558.110702287615, 5605.5235304997905, 5632.436756324335, 5441.673499590037, 5460.071787796005, 5474.39781624029, 5479.232907392889, 5480.780768769205], "unit": "score", "name": "prototype.html", "value": 4179.90277015553}, {"lowerIsBetter": false, "replicates": [680.9182898052231, 710.9893351599725, 723.7141329174976, 724.1455083002055, 735.2353552305602, 11547.13396495263, 11615.825762613567, 11721.238119522224, 11728.17902746807, 11782.528698852046, 11427.200095993283, 11458.083353331735, 11468.139889508278, 11542.538298468073, 11552.133589980744, 755.7883792538098, 771.1863983497408, 776.4642396746227, 779.7582749347692, 780.0132831967566, 595.2172892646156, 765.6057130577757, 784.7802615267706, 785.418790095331, 786.1391776005265, 822.0833770346051, 825.1954344514111, 825.5789547330844, 827.1439060572309, 829.0134739659785, 618.2303032724287, 816.391788117856, 817.2767101115526, 817.7301490508119, 817.9959100204491, 591.1339887065427, 600.7867207141489, 600.9909851352234, 601.0593421295658, 601.975920963161, 12144.939275303566, 12162.331071791048, 12210.938945305306, 12231.510739570407, 12235.388230588524, 11304.547818087267, 12011.759764804743, 12197.939010304981, 12217.389130543437, 12344.38278086092, 9519.952400237955, 9617.27870409715, 9711.854322185101, 9722.416655000652, 9877.357971731815, 3324.8337583120747, 3329.1510664780567, 3380.087376408356, 3396.4226081565944, 3415.299863527971, 39254.803725981474, 39577.0, 39606.0, 39622.80188599038, 39815.0, 9491.810163796823, 9553.61785528585, 9691.12779849817, 9809.460479673544, 9883.505824708736, 16964.74552881708, 17010.234539445755, 17197.0, 17220.225089870986, 17228.224729887184, 6663.500237482208, 6710.731570737214, 6741.2921643226755, 6774.390304872487, 6870.793876183722, 3700.288586623307, 3732.234891847165, 3738.2897249522503, 3793.279276937428, 3807.8857634271017, 2595.6755405574304, 2607.38726399296, 2616.6336712860216, 2618.3585021669433, 2628.132716203648, 469.72051629280526, 474.5776259129378, 481.8867566121959, 487.01865740532855, 489.0902920567741, 539.1454544546937, 553.4631407534685, 556.7967691792547, 564.6865989375935, 590.4833270887973, 6965.686544105527, 7198.208197098315, 7310.780676579711, 7354.963225183947, 7384.5570214189265, 436.52418863439004, 445.13865669928146, 492.990140197194, 496.3324328777788, 539.3958766181823, 3182.50271774363, 3260.543523906655, 3303.620083690358, 3327.38443387974, 3408.693217610427, 43242.13515729731, 43556.3466548002, 43734.0, 43864.780676096416, 43878.7806060974, 42007.78996105, 42046.0, 42437.0, 42464.57535424606, 42990.570094299284, 39659.999999999425, 39707.60292397097, 39758.0, 39960.20079598392, 40011.79994100011, 6276.6547839869245, 6356.745730170926, 6371.23545174582, 6452.483801295979, 6567.080608714688, 30364.544531831598, 30750.0, 31294.37411251808, 31361.372772543964, 32008.0, 37815.62184378121, 37852.81073594614, 38145.0, 38988.2202355957, 39418.0, 9503.382280151767, 9528.094830991045, 9535.666251681158, 9659.806803864023, 9684.903150968401, 10041.0, 10201.775786905322, 10249.59001639956, 10260.384376937407, 10401.94799026, 9487.156626744716, 9649.807003859743, 9681.322307438411, 9705.6117755289, 10041.297109202285, 9293.814123717353, 9778.462184579916, 9800.80398392014, 10069.244806639677, 10090.69727908164, 8943.418677785923, 9104.998450170608, 9393.107654772786, 9399.0, 9406.106419890373, 7288.0, 7332.560046397233, 7644.0827100748265, 7890.408219383455, 7918.089419716806, 7165.462590305644, 7312.341889229995, 7661.961690191736, 7871.606419679108, 7921.128675845537], "unit": "score", "name": "yui.html", "value": 5478.278150780083}], "name": "dromaeo_css", "value": 6063.7835136496615}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 109.0, 115.0, 113.0, 114.0, 103.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [158.0, 136.0, 167.0, 178.0, 130.0, 158.0, 152.0, 137.0, 173.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0, 161.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [78.0, 75.0, 93.0, 98.0, 73.0, 73.0, 73.0, 103.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 95.0, 96.0, 95.0, 141.0, 94.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 72.0, 68.0, 67.0, 77.0, 68.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 71.0, 72.0, 71.0, 71.0, 71.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.7}, {"lowerIsBetter": true, "replicates": [87.0, 96.0, 83.0, 83.0, 82.0, 93.0, 82.0, 84.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [127.0, 129.0, 129.0, 134.0, 119.0, 125.0, 136.0, 125.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.5}, {"lowerIsBetter": true, "replicates": [150.0, 144.0, 149.0, 150.0, 153.0, 136.0, 153.0, 151.0, 150.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 70.0, 71.0, 72.0, 71.0, 71.0, 73.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1547.6}]} 08:30:15 INFO - Return code: 0 08:30:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:30:16 INFO - # TBPL SUCCESS # 08:30:16 INFO - Running post-action listener: _resource_record_post_action 08:30:16 INFO - Running post-run listener: _resource_record_post_run 08:30:17 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 524496896; Read time: 244; Write time: 438704 08:30:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233455616; Read time: 0; Write time: 228648 08:30:17 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291041280; Read time: 244; Write time: 210056 08:30:17 INFO - Running post-run listener: _upload_blobber_files 08:30:17 INFO - Blob upload gear active. 08:30:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:30:17 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 08:30:17 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'] 08:30:17 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 08:30:17 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:18 INFO - (blobuploader) - INFO - Done attempting. 08:30:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:30:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:19 INFO - (blobuploader) - INFO - Done attempting. 08:30:19 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:19 INFO - Return code: 0 08:30:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a388653f5d108168ee6d54ebf28b03469fda8fb24efd1fc294d907911053017c17972b5efd79350cb96ef0b209eeba383e135d24ec2b0d615fbd99afd428f567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/deff2398c071211177af4dbf5b3cf97f4624706a0f2a69cab13b699c7a737ddb4fe3f67f1e2f148e85d84c3a6477cda0d09c0216e14bdbbd41e65f124900d246"} 08:30:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:19 INFO - Contents: 08:30:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a388653f5d108168ee6d54ebf28b03469fda8fb24efd1fc294d907911053017c17972b5efd79350cb96ef0b209eeba383e135d24ec2b0d615fbd99afd428f567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/deff2398c071211177af4dbf5b3cf97f4624706a0f2a69cab13b699c7a737ddb4fe3f67f1e2f148e85d84c3a6477cda0d09c0216e14bdbbd41e65f124900d246"} 08:30:19 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:19 INFO - Copying logs to upload dir... 08:30:19 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.641769 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-07 08:30:18.890236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 08:30:18.894632) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 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/a388653f5d108168ee6d54ebf28b03469fda8fb24efd1fc294d907911053017c17972b5efd79350cb96ef0b209eeba383e135d24ec2b0d615fbd99afd428f567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/deff2398c071211177af4dbf5b3cf97f4624706a0f2a69cab13b699c7a737ddb4fe3f67f1e2f148e85d84c3a6477cda0d09c0216e14bdbbd41e65f124900d246"} build_url:https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/K3ks8KMdSUmKpR-WUHFGQw/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/a388653f5d108168ee6d54ebf28b03469fda8fb24efd1fc294d907911053017c17972b5efd79350cb96ef0b209eeba383e135d24ec2b0d615fbd99afd428f567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/deff2398c071211177af4dbf5b3cf97f4624706a0f2a69cab13b699c7a737ddb4fe3f67f1e2f148e85d84c3a6477cda0d09c0216e14bdbbd41e65f124900d246"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 08:30:18.922345) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:30:18.922719) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457366145.672843-1703610780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:30:19.001978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 08:30:19.005331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 08:30:19.005640) ========= ========= Total master_lag: 0.28 =========