builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1464775056.47 results: success (0) buildid: 20160601002322 builduid: 2626cdfc65fb4fc7bfa72d5f99172c38 revision: b6fe7fa88db0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.471847) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.472435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.472780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.489315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.489753) ========= 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=ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 02:57:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-06-01 02:57:36 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.664818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.665450) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012681 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.716692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:36.717059) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b6fe7fa88db0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b6fe7fa88db0 --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=ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 02:57:36,816 Setting DEBUG logging. 2016-06-01 02:57:36,816 attempt 1/10 2016-06-01 02:57:36,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b6fe7fa88db0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 02:57:37,173 unpacking tar archive at: mozilla-inbound-b6fe7fa88db0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679345 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:37.410397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:37.410799) ========= script_repo_revision: b6fe7fa88db0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:37.411246) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:37.411567) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 02:57:37.420148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-01 02:57:37.420567) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:57:37 INFO - MultiFileLogger online at 20160601 02:57:37 in /builds/slave/test 02:57:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:57:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:57:37 INFO - {'append_to_log': False, 02:57:37 INFO - 'base_work_dir': '/builds/slave/test', 02:57:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:57:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:57:37 INFO - 'branch': 'Mozilla-Inbound', 02:57:37 INFO - 'buildbot_json_path': 'buildprops.json', 02:57:37 INFO - 'config_files': ('talos/linux_config.py',), 02:57:37 INFO - 'default_actions': ('clobber', 02:57:37 INFO - 'read-buildbot-config', 02:57:37 INFO - 'download-and-extract', 02:57:37 INFO - 'populate-webroot', 02:57:37 INFO - 'create-virtualenv', 02:57:37 INFO - 'install', 02:57:37 INFO - 'run-tests'), 02:57:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:57:37 INFO - 'download_minidump_stackwalk': True, 02:57:37 INFO - 'download_symbols': 'ondemand', 02:57:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:57:37 INFO - 'tooltool.py': '/tools/tooltool.py', 02:57:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:57:37 INFO - '/tools/misc-python/virtualenv.py')}, 02:57:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:57:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:57:37 INFO - 'installer_path': 'installer.exe', 02:57:37 INFO - 'log_level': 'info', 02:57:37 INFO - 'log_name': 'talos', 02:57:37 INFO - 'log_to_console': True, 02:57:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:57:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:57:37 INFO - 'opt_config_files': (), 02:57:37 INFO - 'pip_index': False, 02:57:37 INFO - 'sps_profile': False, 02:57:37 INFO - 'sps_profile_interval': 0, 02:57:37 INFO - 'suite': 'dromaeojs', 02:57:37 INFO - 'system_bits': '32', 02:57:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:57:37 INFO - 'title': 'talos-linux64-ix-035', 02:57:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:57:37 INFO - 'use_talos_json': True, 02:57:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:57:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:57:37 INFO - 'work_dir': 'build'} 02:57:37 INFO - ##### 02:57:37 INFO - ##### Running clobber step. 02:57:37 INFO - ##### 02:57:37 INFO - Running pre-action listener: _resource_record_pre_action 02:57:37 INFO - Running main action method: clobber 02:57:37 INFO - rmtree: /builds/slave/test/build 02:57:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:38 INFO - Running post-action listener: _resource_record_post_action 02:57:38 INFO - ##### 02:57:38 INFO - ##### Finished clobber step (success) 02:57:38 INFO - ##### 02:57:38 INFO - ##### 02:57:38 INFO - ##### Running read-buildbot-config step. 02:57:38 INFO - ##### 02:57:38 INFO - Running pre-action listener: _resource_record_pre_action 02:57:38 INFO - Running main action method: read_buildbot_config 02:57:38 INFO - Using buildbot properties: 02:57:38 INFO - { 02:57:38 INFO - "project": "", 02:57:38 INFO - "product": "firefox", 02:57:38 INFO - "script_repo_revision": "production", 02:57:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:57:38 INFO - "repository": "", 02:57:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 02:57:38 INFO - "buildid": "20160601002322", 02:57:38 INFO - "pgo_build": "True", 02:57:38 INFO - "basedir": "/builds/slave/test", 02:57:38 INFO - "buildnumber": 1025, 02:57:38 INFO - "slavename": "talos-linux64-ix-035", 02:57:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:57:38 INFO - "platform": "ubuntu64_hw", 02:57:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:57:38 INFO - "branch": "mozilla-inbound", 02:57:38 INFO - "repo_path": "integration/mozilla-inbound", 02:57:38 INFO - "revision": "b6fe7fa88db0", 02:57:38 INFO - "stage_platform": "linux64-pgo", 02:57:38 INFO - "builduid": "2626cdfc65fb4fc7bfa72d5f99172c38", 02:57:38 INFO - "slavebuilddir": "test" 02:57:38 INFO - } 02:57:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:57:38 INFO - Running post-action listener: _resource_record_post_action 02:57:38 INFO - ##### 02:57:38 INFO - ##### Finished read-buildbot-config step (success) 02:57:38 INFO - ##### 02:57:38 INFO - ##### 02:57:38 INFO - ##### Running download-and-extract step. 02:57:38 INFO - ##### 02:57:38 INFO - Running pre-action listener: _resource_record_pre_action 02:57:38 INFO - Running main action method: download_and_extract 02:57:38 INFO - mkdir: /builds/slave/test/build/tests 02:57:38 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')]} 02:57:38 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:57:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:57:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:57:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:57:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:57:39 INFO - Downloaded 1361 bytes. 02:57:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:57:39 INFO - Using the following test package requirements: 02:57:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:57:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:57:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:57:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:39 INFO - u'jsshell-linux-x86_64.zip'], 02:57:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:57:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:57:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:57:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:57:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:57:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:57:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:39 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:57:40 INFO - Downloaded 24422470 bytes. 02:57:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:57:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:57:41 INFO - Return code: 0 02:57:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:41 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:57:44 INFO - Downloaded 24422470 bytes. 02:57:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:57:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:57:45 INFO - Return code: 0 02:57:45 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')]} 02:57:45 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:57:46 INFO - Downloaded 10834055 bytes. 02:57:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:57:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:57:46 INFO - Return code: 0 02:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:46 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:57:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:57:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:57:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:57:48 INFO - Downloaded 59015252 bytes. 02:57:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:57:48 INFO - mkdir: /builds/slave/test/properties 02:57:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:48 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:48 INFO - Contents: 02:57:48 INFO - build_url:https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:57:49 INFO - Running post-action listener: _resource_record_post_action 02:57:49 INFO - Running post-action listener: set_extra_try_arguments 02:57:49 INFO - ##### 02:57:49 INFO - ##### Finished download-and-extract step (success) 02:57:49 INFO - ##### 02:57:49 INFO - ##### 02:57:49 INFO - ##### Running populate-webroot step. 02:57:49 INFO - ##### 02:57:49 INFO - Running pre-action listener: _resource_record_pre_action 02:57:49 INFO - Running main action method: populate_webroot 02:57:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:57:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:57:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:57:49 INFO - '--tppagecycles', 02:57:49 INFO - '7'], 02:57:49 INFO - 'tests': ['tsvgm']}}, 02:57:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['damp', 'tps']}, 02:57:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'tests': ['damp', 'tps']}, 02:57:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['dromaeo_dom']}, 02:57:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['tsvgx', 02:57:49 INFO - 'tsvgr_opacity', 02:57:49 INFO - 'tart', 02:57:49 INFO - 'tscrollx', 02:57:49 INFO - 'cart']}, 02:57:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:49 INFO - 'tsvgr_opacity', 02:57:49 INFO - 'tart', 02:57:49 INFO - 'tscrollx', 02:57:49 INFO - 'cart']}, 02:57:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['tp5o']}, 02:57:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'tests': ['tp5o']}, 02:57:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--disable-e10s', 02:57:49 INFO - '--xperf_path', 02:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:49 INFO - 'tests': ['tp5n']}, 02:57:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--xperf_path', 02:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:49 INFO - 'tests': ['tp5n']}}, 02:57:49 INFO - 'talos.zip': {'path': '', 02:57:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:57:49 INFO - Running post-action listener: _resource_record_post_action 02:57:49 INFO - ##### 02:57:49 INFO - ##### Finished populate-webroot step (success) 02:57:49 INFO - ##### 02:57:49 INFO - ##### 02:57:49 INFO - ##### Running create-virtualenv step. 02:57:49 INFO - ##### 02:57:49 INFO - Running pre-action listener: _resource_record_pre_action 02:57:49 INFO - Running main action method: create_virtualenv 02:57:49 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:49 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 02:57:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:49 INFO - Using real prefix '/usr' 02:57:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:53 INFO - Installing pip.................done. 02:57:53 INFO - Return code: 0 02:57:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:57:53 INFO - Using env: {'DISPLAY': ':0', 02:57:53 INFO - 'HOME': '/home/cltbld', 02:57:53 INFO - 'LANG': 'en_US.UTF-8', 02:57:53 INFO - 'LANGUAGE': 'en_US:en', 02:57:53 INFO - 'LOGNAME': 'cltbld', 02:57:53 INFO - 'MAIL': '/var/mail/cltbld', 02:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:53 INFO - 'MOZ_NO_REMOTE': '1', 02:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:53 INFO - 'NO_EM_RESTART': '1', 02:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:53 INFO - 'PWD': '/builds/slave/test', 02:57:53 INFO - 'SHELL': '/bin/bash', 02:57:53 INFO - 'SHLVL': '1', 02:57:53 INFO - 'TERM': 'linux', 02:57:53 INFO - 'TMOUT': '86400', 02:57:53 INFO - 'USER': 'cltbld', 02:57:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:53 INFO - '_': '/tools/buildbot/bin/python'} 02:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:57:53 INFO - Cleaning up... 02:57:53 INFO - Return code: 0 02:57:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:57:53 INFO - Using env: {'DISPLAY': ':0', 02:57:53 INFO - 'HOME': '/home/cltbld', 02:57:53 INFO - 'LANG': 'en_US.UTF-8', 02:57:53 INFO - 'LANGUAGE': 'en_US:en', 02:57:53 INFO - 'LOGNAME': 'cltbld', 02:57:53 INFO - 'MAIL': '/var/mail/cltbld', 02:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:53 INFO - 'MOZ_NO_REMOTE': '1', 02:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:53 INFO - 'NO_EM_RESTART': '1', 02:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:53 INFO - 'PWD': '/builds/slave/test', 02:57:53 INFO - 'SHELL': '/bin/bash', 02:57:53 INFO - 'SHLVL': '1', 02:57:53 INFO - 'TERM': 'linux', 02:57:53 INFO - 'TMOUT': '86400', 02:57:53 INFO - 'USER': 'cltbld', 02:57:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:53 INFO - '_': '/tools/buildbot/bin/python'} 02:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:54 INFO - Downloading/unpacking psutil>=3.1.1 02:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:56 INFO - Installing collected packages: psutil 02:57:56 INFO - Running setup.py install for psutil 02:57:56 INFO - building 'psutil._psutil_linux' extension 02:57:56 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 02:57:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:57:57 INFO - building 'psutil._psutil_posix' extension 02:57:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:57:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:57:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:57 INFO - Successfully installed psutil 02:57:57 INFO - Cleaning up... 02:57:57 INFO - Return code: 0 02:57:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:57:57 INFO - Using env: {'DISPLAY': ':0', 02:57:57 INFO - 'HOME': '/home/cltbld', 02:57:57 INFO - 'LANG': 'en_US.UTF-8', 02:57:57 INFO - 'LANGUAGE': 'en_US:en', 02:57:57 INFO - 'LOGNAME': 'cltbld', 02:57:57 INFO - 'MAIL': '/var/mail/cltbld', 02:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:57 INFO - 'MOZ_NO_REMOTE': '1', 02:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:57 INFO - 'NO_EM_RESTART': '1', 02:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:57 INFO - 'PWD': '/builds/slave/test', 02:57:57 INFO - 'SHELL': '/bin/bash', 02:57:57 INFO - 'SHLVL': '1', 02:57:57 INFO - 'TERM': 'linux', 02:57:57 INFO - 'TMOUT': '86400', 02:57:57 INFO - 'USER': 'cltbld', 02:57:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:57 INFO - '_': '/tools/buildbot/bin/python'} 02:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:58:00 INFO - Installing collected packages: mozsystemmonitor 02:58:00 INFO - Running setup.py install for mozsystemmonitor 02:58:00 INFO - Successfully installed mozsystemmonitor 02:58:00 INFO - Cleaning up... 02:58:00 INFO - Return code: 0 02:58:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58:00 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')]} 02:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:00 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')]} 02:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:00 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 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:58:00 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 02:58:00 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 02:58:00 INFO - Using env: {'DISPLAY': ':0', 02:58:00 INFO - 'HOME': '/home/cltbld', 02:58:00 INFO - 'LANG': 'en_US.UTF-8', 02:58:00 INFO - 'LANGUAGE': 'en_US:en', 02:58:00 INFO - 'LOGNAME': 'cltbld', 02:58:00 INFO - 'MAIL': '/var/mail/cltbld', 02:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:00 INFO - 'MOZ_NO_REMOTE': '1', 02:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:00 INFO - 'NO_EM_RESTART': '1', 02:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:00 INFO - 'PWD': '/builds/slave/test', 02:58:00 INFO - 'SHELL': '/bin/bash', 02:58:00 INFO - 'SHLVL': '1', 02:58:00 INFO - 'TERM': 'linux', 02:58:00 INFO - 'TMOUT': '86400', 02:58:00 INFO - 'USER': 'cltbld', 02:58:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:00 INFO - '_': '/tools/buildbot/bin/python'} 02:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:00 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:00 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 02:58:00 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 02:58:00 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 02:58:00 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 02:58:00 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 02:58:00 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 02:58:02 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:03 INFO - Downloading docopt-0.6.1.tar.gz 02:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:03 INFO - Running setup.py install for blobuploader 02:58:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:03 INFO - Running setup.py install for requests 02:58:03 INFO - Running setup.py install for docopt 02:58:03 INFO - Successfully installed blobuploader requests docopt 02:58:03 INFO - Cleaning up... 02:58:03 INFO - Return code: 0 02:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:03 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')]} 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:03 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')]} 02:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:03 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 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:58:03 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 02:58:03 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 02:58:03 INFO - Using env: {'DISPLAY': ':0', 02:58:03 INFO - 'HOME': '/home/cltbld', 02:58:03 INFO - 'LANG': 'en_US.UTF-8', 02:58:03 INFO - 'LANGUAGE': 'en_US:en', 02:58:03 INFO - 'LOGNAME': 'cltbld', 02:58:03 INFO - 'MAIL': '/var/mail/cltbld', 02:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:03 INFO - 'MOZ_NO_REMOTE': '1', 02:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:03 INFO - 'NO_EM_RESTART': '1', 02:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:03 INFO - 'PWD': '/builds/slave/test', 02:58:03 INFO - 'SHELL': '/bin/bash', 02:58:03 INFO - 'SHLVL': '1', 02:58:03 INFO - 'TERM': 'linux', 02:58:03 INFO - 'TMOUT': '86400', 02:58:03 INFO - 'USER': 'cltbld', 02:58:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:03 INFO - '_': '/tools/buildbot/bin/python'} 02:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:03 INFO - Running setup.py (path:/tmp/pip-Jd43II-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:04 INFO - Running setup.py (path:/tmp/pip-BjVg_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:04 INFO - Running setup.py (path:/tmp/pip-hMv1IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:04 INFO - Running setup.py (path:/tmp/pip-s7NvMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:04 INFO - Running setup.py (path:/tmp/pip-5DruR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:04 INFO - Running setup.py (path:/tmp/pip-4MDtUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:04 INFO - Running setup.py (path:/tmp/pip-yIERMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:04 INFO - Running setup.py (path:/tmp/pip-emp6Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:04 INFO - Running setup.py (path:/tmp/pip-v2Xnpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:04 INFO - Running setup.py (path:/tmp/pip-rbOLqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:04 INFO - Running setup.py (path:/tmp/pip-pNkpYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:04 INFO - Running setup.py (path:/tmp/pip-0HJJI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:04 INFO - Running setup.py (path:/tmp/pip-wdYmfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:04 INFO - Running setup.py (path:/tmp/pip-FMkyM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:04 INFO - Running setup.py (path:/tmp/pip-sloGMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:05 INFO - Running setup.py (path:/tmp/pip-KDt5uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:05 INFO - Running setup.py (path:/tmp/pip-bq6owp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:05 INFO - Running setup.py install for manifestparser 02:58:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozcrash 02:58:05 INFO - Running setup.py install for mozdebug 02:58:05 INFO - Running setup.py install for mozdevice 02:58:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozfile 02:58:05 INFO - Running setup.py install for mozhttpd 02:58:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozinfo 02:58:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozInstall 02:58:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozleak 02:58:06 INFO - Running setup.py install for mozlog 02:58:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Running setup.py install for moznetwork 02:58:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Running setup.py install for mozprocess 02:58:06 INFO - Running setup.py install for mozprofile 02:58:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Running setup.py install for mozrunner 02:58:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Running setup.py install for mozscreenshot 02:58:06 INFO - Running setup.py install for moztest 02:58:06 INFO - Running setup.py install for mozversion 02:58:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:06 INFO - Cleaning up... 02:58:06 INFO - Return code: 0 02:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:06 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 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:58:06 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 02:58:06 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 02:58:06 INFO - Using env: {'DISPLAY': ':0', 02:58:06 INFO - 'HOME': '/home/cltbld', 02:58:06 INFO - 'LANG': 'en_US.UTF-8', 02:58:06 INFO - 'LANGUAGE': 'en_US:en', 02:58:06 INFO - 'LOGNAME': 'cltbld', 02:58:06 INFO - 'MAIL': '/var/mail/cltbld', 02:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:06 INFO - 'MOZ_NO_REMOTE': '1', 02:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:06 INFO - 'NO_EM_RESTART': '1', 02:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:06 INFO - 'PWD': '/builds/slave/test', 02:58:06 INFO - 'SHELL': '/bin/bash', 02:58:06 INFO - 'SHLVL': '1', 02:58:06 INFO - 'TERM': 'linux', 02:58:06 INFO - 'TMOUT': '86400', 02:58:06 INFO - 'USER': 'cltbld', 02:58:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:06 INFO - '_': '/tools/buildbot/bin/python'} 02:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:07 INFO - Running setup.py (path:/tmp/pip-e6w0yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:07 INFO - Running setup.py (path:/tmp/pip-kQBkwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:07 INFO - Running setup.py (path:/tmp/pip-RIBx7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:07 INFO - Running setup.py (path:/tmp/pip-bUBrZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:07 INFO - Running setup.py (path:/tmp/pip-AyUMhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:07 INFO - Running setup.py (path:/tmp/pip-l1o_bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:07 INFO - Running setup.py (path:/tmp/pip-voX34N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:07 INFO - Running setup.py (path:/tmp/pip-JpHrbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:07 INFO - Running setup.py (path:/tmp/pip-flWtUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:07 INFO - Running setup.py (path:/tmp/pip-qla3vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:07 INFO - Running setup.py (path:/tmp/pip-pqHpOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:07 INFO - Running setup.py (path:/tmp/pip-sGDOC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:08 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)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:08 INFO - Running setup.py (path:/tmp/pip-xSBxSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:08 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)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:08 INFO - Running setup.py (path:/tmp/pip-Ai4Jx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:08 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)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:08 INFO - Running setup.py (path:/tmp/pip-PxsmT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:08 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)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:08 INFO - Running setup.py (path:/tmp/pip-cTg7VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:08 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)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:08 INFO - Running setup.py (path:/tmp/pip-rxyfiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:08 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)) 02:58:08 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)) 02:58:08 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)) 02:58:08 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)) 02:58:08 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)) 02:58:08 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)) 02:58:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:10 INFO - Downloading blessings-1.6.tar.gz 02:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:10 INFO - Installing collected packages: blessings 02:58:10 INFO - Running setup.py install for blessings 02:58:10 INFO - Successfully installed blessings 02:58:10 INFO - Cleaning up... 02:58:10 INFO - Return code: 0 02:58:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:10 INFO - Reading from file tmpfile_stdout 02:58:10 INFO - Current package versions: 02:58:10 INFO - argparse == 1.2.1 02:58:10 INFO - blessings == 1.6 02:58:10 INFO - blobuploader == 1.2.4 02:58:10 INFO - docopt == 0.6.1 02:58:10 INFO - manifestparser == 1.1 02:58:10 INFO - mozInstall == 1.12 02:58:10 INFO - mozcrash == 0.17 02:58:10 INFO - mozdebug == 0.1 02:58:10 INFO - mozdevice == 0.48 02:58:10 INFO - mozfile == 1.2 02:58:10 INFO - mozhttpd == 0.7 02:58:10 INFO - mozinfo == 0.9 02:58:10 INFO - mozleak == 0.1 02:58:10 INFO - mozlog == 3.2 02:58:10 INFO - moznetwork == 0.27 02:58:10 INFO - mozprocess == 0.22 02:58:10 INFO - mozprofile == 0.28 02:58:10 INFO - mozrunner == 6.11 02:58:10 INFO - mozscreenshot == 0.1 02:58:10 INFO - mozsystemmonitor == 0.3 02:58:10 INFO - moztest == 0.7 02:58:10 INFO - mozversion == 1.4 02:58:10 INFO - psutil == 3.1.1 02:58:10 INFO - requests == 1.2.3 02:58:10 INFO - wsgiref == 0.1.2 02:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:10 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 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:58:10 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 02:58:10 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 02:58:10 INFO - Using env: {'DISPLAY': ':0', 02:58:10 INFO - 'HOME': '/home/cltbld', 02:58:10 INFO - 'LANG': 'en_US.UTF-8', 02:58:10 INFO - 'LANGUAGE': 'en_US:en', 02:58:10 INFO - 'LOGNAME': 'cltbld', 02:58:10 INFO - 'MAIL': '/var/mail/cltbld', 02:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:10 INFO - 'MOZ_NO_REMOTE': '1', 02:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:10 INFO - 'NO_EM_RESTART': '1', 02:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:10 INFO - 'PWD': '/builds/slave/test', 02:58:10 INFO - 'SHELL': '/bin/bash', 02:58:10 INFO - 'SHLVL': '1', 02:58:10 INFO - 'TERM': 'linux', 02:58:10 INFO - 'TMOUT': '86400', 02:58:10 INFO - 'USER': 'cltbld', 02:58:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:10 INFO - '_': '/tools/buildbot/bin/python'} 02:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 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)) 02:58:11 INFO - Cleaning up... 02:58:11 INFO - Return code: 0 02:58:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:11 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 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:58:11 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 02:58:11 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 02:58:11 INFO - Using env: {'DISPLAY': ':0', 02:58:11 INFO - 'HOME': '/home/cltbld', 02:58:11 INFO - 'LANG': 'en_US.UTF-8', 02:58:11 INFO - 'LANGUAGE': 'en_US:en', 02:58:11 INFO - 'LOGNAME': 'cltbld', 02:58:11 INFO - 'MAIL': '/var/mail/cltbld', 02:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:11 INFO - 'MOZ_NO_REMOTE': '1', 02:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:11 INFO - 'NO_EM_RESTART': '1', 02:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:11 INFO - 'PWD': '/builds/slave/test', 02:58:11 INFO - 'SHELL': '/bin/bash', 02:58:11 INFO - 'SHLVL': '1', 02:58:11 INFO - 'TERM': 'linux', 02:58:11 INFO - 'TMOUT': '86400', 02:58:11 INFO - 'USER': 'cltbld', 02:58:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:11 INFO - '_': '/tools/buildbot/bin/python'} 02:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:11 INFO - Downloading/unpacking jsonschema 02:58:11 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 02:58:11 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 02:58:11 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 02:58:11 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 02:58:11 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 02:58:11 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 02:58:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:58:13 INFO - Downloading/unpacking functools32 (from jsonschema) 02:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:58:13 INFO - warning: no files found matching '*.txt' 02:58:13 INFO - no previously-included directories found matching 'build' 02:58:13 INFO - no previously-included directories found matching 'dist' 02:58:13 INFO - no previously-included directories found matching '.git*' 02:58:13 INFO - Installing collected packages: jsonschema, functools32 02:58:13 INFO - Running setup.py install for functools32 02:58:13 INFO - warning: no files found matching '*.txt' 02:58:13 INFO - no previously-included directories found matching 'build' 02:58:13 INFO - no previously-included directories found matching 'dist' 02:58:13 INFO - no previously-included directories found matching '.git*' 02:58:13 INFO - Successfully installed jsonschema functools32 02:58:13 INFO - Cleaning up... 02:58:13 INFO - Return code: 0 02:58:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f116aaf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', '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 02:58:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:58:13 INFO - Using env: {'DISPLAY': ':0', 02:58:13 INFO - 'HOME': '/home/cltbld', 02:58:13 INFO - 'LANG': 'en_US.UTF-8', 02:58:13 INFO - 'LANGUAGE': 'en_US:en', 02:58:13 INFO - 'LOGNAME': 'cltbld', 02:58:13 INFO - 'MAIL': '/var/mail/cltbld', 02:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:13 INFO - 'MOZ_NO_REMOTE': '1', 02:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:13 INFO - 'NO_EM_RESTART': '1', 02:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:13 INFO - 'PWD': '/builds/slave/test', 02:58:13 INFO - 'SHELL': '/bin/bash', 02:58:13 INFO - 'SHLVL': '1', 02:58:13 INFO - 'TERM': 'linux', 02:58:13 INFO - 'TMOUT': '86400', 02:58:13 INFO - 'USER': 'cltbld', 02:58:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:13 INFO - '_': '/tools/buildbot/bin/python'} 02:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:13 INFO - Downloading/unpacking flake8 02:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:58:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:58:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:58:16 INFO - no previously-included directories found matching 'docs/_build' 02:58:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:58:16 INFO - Running setup.py install for pep8 02:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:58:16 INFO - no previously-included directories found matching 'docs/_build' 02:58:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:58:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:58:16 INFO - Cleaning up... 02:58:16 INFO - Return code: 0 02:58:16 INFO - Running post-action listener: _resource_record_post_action 02:58:16 INFO - Running post-action listener: _start_resource_monitoring 02:58:16 INFO - Starting resource monitoring. 02:58:16 INFO - ##### 02:58:16 INFO - ##### Finished create-virtualenv step (success) 02:58:16 INFO - ##### 02:58:16 INFO - ##### 02:58:16 INFO - ##### Running install step. 02:58:16 INFO - ##### 02:58:16 INFO - Running pre-action listener: _resource_record_pre_action 02:58:16 INFO - Running main action method: install 02:58:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:16 INFO - Reading from file tmpfile_stdout 02:58:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:17 INFO - Reading from file tmpfile_stdout 02:58:17 INFO - Output received: 02:58:17 INFO - Usage: mozinstall [options] installer 02:58:17 INFO - Options: 02:58:17 INFO - -h, --help show this help message and exit 02:58:17 INFO - -d DEST, --destination=DEST 02:58:17 INFO - Directory to install application into. [default: 02:58:17 INFO - "/builds/slave/test"] 02:58:17 INFO - --app=APP Application being installed. [default: firefox] 02:58:17 INFO - mkdir: /builds/slave/test/build/application 02:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:58:33 INFO - Reading from file tmpfile_stdout 02:58:33 INFO - Output received: 02:58:33 INFO - /builds/slave/test/build/application/firefox/firefox 02:58:33 INFO - Running post-action listener: _resource_record_post_action 02:58:33 INFO - ##### 02:58:33 INFO - ##### Finished install step (success) 02:58:33 INFO - ##### 02:58:33 INFO - ##### 02:58:33 INFO - ##### Running run-tests step. 02:58:33 INFO - ##### 02:58:33 INFO - Running pre-action listener: _resource_record_pre_action 02:58:33 INFO - Running main action method: run_tests 02:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:33 INFO - Python 2.7.3 02:58:33 INFO - Return code: 0 02:58:33 INFO - grabbing minidump binary from tooltool 02:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:33 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ce9c0>, '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 0x14cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cfd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:33 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 02:58:33 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 02:58:33 INFO - Calling ['/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'] with output_timeout 600 02:58:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:33 INFO - Return code: 0 02:58:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:58:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:58:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:58:34 INFO - Return code: 0 02:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 02:58:34 INFO - Using env: {'DISPLAY': ':0', 02:58:34 INFO - 'HOME': '/home/cltbld', 02:58:34 INFO - 'LANG': 'en_US.UTF-8', 02:58:34 INFO - 'LANGUAGE': 'en_US:en', 02:58:34 INFO - 'LOGNAME': 'cltbld', 02:58:34 INFO - 'MAIL': '/var/mail/cltbld', 02:58:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:34 INFO - 'MOZ_NO_REMOTE': '1', 02:58:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:34 INFO - 'NO_EM_RESTART': '1', 02:58:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:34 INFO - 'PWD': '/builds/slave/test', 02:58:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:34 INFO - 'SHELL': '/bin/bash', 02:58:34 INFO - 'SHLVL': '1', 02:58:34 INFO - 'TERM': 'linux', 02:58:34 INFO - 'TMOUT': '86400', 02:58:34 INFO - 'USER': 'cltbld', 02:58:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479', 02:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:34 INFO - '_': '/tools/buildbot/bin/python'} 02:58:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:58:35 INFO - mozversion application_buildid: 20160601002322 02:58:35 INFO - mozversion application_changeset: b6fe7fa88db0a4103d175bf5b02cd47c2c6722e6 02:58:35 INFO - mozversion application_display_name: Nightly 02:58:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:35 INFO - mozversion application_name: Firefox 02:58:35 INFO - mozversion application_remotingname: firefox 02:58:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:58:35 INFO - mozversion application_vendor: Mozilla 02:58:35 INFO - mozversion application_version: 49.0a1 02:58:35 INFO - mozversion platform_buildid: 20160601002322 02:58:35 INFO - mozversion platform_changeset: b6fe7fa88db0a4103d175bf5b02cd47c2c6722e6 02:58:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:58:35 INFO - mozversion platform_version: 49.0a1 02:58:35 INFO - using testdate: 1464775115 02:58:35 INFO - actual date: 1464775115 02:58:35 INFO - starting webserver on 'localhost:35242' 02:58:35 INFO - SUITE-START | Running 2 tests 02:58:35 INFO - TEST-START | dromaeo_css 02:58:35 INFO - operating with platform_type : linux_ 02:58:35 INFO - Initialising browser for dromaeo_css test... 02:58:35 INFO - TEST-INFO | started process 3276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwA1Qjq/profile http://localhost:35242/getInfo.html) 02:58:39 INFO - PROCESS | 3276 | __metrics Screen width/height:1600/1200 02:58:39 INFO - PROCESS | 3276 | colorDepth:24 02:58:39 INFO - PROCESS | 3276 | Browser inner width/height: 1024/697 02:58:39 INFO - PROCESS | 3276 | __metrics 02:58:42 ERROR - PROCESS | 3276 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:58:42 INFO - TEST-INFO | 3276: exit 0 02:58:42 INFO - Browser initialized. 02:58:42 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:42 INFO - TEST-INFO | started process 3359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwA1Qjq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:54 INFO - PROCESS | 3359 | RSS: Main: 156246016 02:58:54 INFO - PROCESS | 3359 | 02:59:45 INFO - PROCESS | 3359 | 1464775185781 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] 03:01:54 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:35242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35242/tests/dromaeo/cssquery-ext.html) 03:01:55 INFO - PROCESS | 3359 | RSS: Main: 262512640 03:01:55 INFO - PROCESS | 3359 | 03:04:57 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:35242/tests/dromaeo/cssquery-ext.html (next: http://localhost:35242/tests/dromaeo/cssquery-jquery.html) 03:04:58 INFO - PROCESS | 3359 | RSS: Main: 241278976 03:04:58 INFO - PROCESS | 3359 | 03:08:00 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:35242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35242/tests/dromaeo/cssquery-mootools.html) 03:08:00 INFO - PROCESS | 3359 | RSS: Main: 240185344 03:08:00 INFO - PROCESS | 3359 | 03:11:02 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:35242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35242/tests/dromaeo/cssquery-prototype.html) 03:11:03 INFO - PROCESS | 3359 | RSS: Main: 233652224 03:11:03 INFO - PROCESS | 3359 | 03:14:06 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:35242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35242/tests/dromaeo/cssquery-yui.html) 03:14:06 INFO - PROCESS | 3359 | RSS: Main: 200765440 03:14:06 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:35242/tests/dromaeo/cssquery-yui.html (next: http://localhost:35242/tests/dromaeo/cssquery-dojo.html) 03:17:09 INFO - PROCESS | 3359 | RSS: Main: 270733312 03:17:09 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | __start_tp_report 03:17:09 INFO - PROCESS | 3359 | _x_x_mozilla_page_load 03:17:09 INFO - PROCESS | 3359 | _x_x_mozilla_page_load_details 03:17:09 INFO - PROCESS | 3359 | |i|pagename|runs| 03:17:09 INFO - PROCESS | 3359 | |0;dojo.html;3161.889333873315;3180.7773455858087;3201.135693362792;3208.8716451341948;3249.41510528105;5454.10007348787;5505.284313039304;5526.972365138168;5614.017546929286;5640.266765320508;5486.61593688441;5546.389897111315;5547.77808887645;5558.749856256468;5587;4841.806327746895;5010.3737032870895;5012.774425150858;5022.723750193738;5155.9484405155845;5052.115879721053;5072.934683716424;5107;5119.897602047957;5132.3071385363055;4848.369711937443;4876.146674331995;4906.705597664151;4913.778879950411;4918.458969513351;4901;4990.226514890198;4993.275974983607;5005.374328208974;5033.295338652591;4805.663603547753;4919.975400122977;4952.7523623819025;4966.379202599675;5019.397672279313;5455.509004189602;5485.9725701371635;5547.195656629807;5548.72256387179;5550.361708403545;5896.941030589682;5899.734511946973;5971.552133589998;5975.850603734898;6017.548683848685;5772;5849.444302791228;5860.765569377219;6046.788362407295;6070.180525629072;5537.224788529609;5571.526420254283;5588.189712491707;5590.105583106683;5593.412691667398;6051.628232978235;6056.881152294354;6074.849764978889;6094.8171554853425;6096.359882212304;5735.827925162252;5761;5798.507126894261;5827.562932780059;5880.705964701748;5923.822285331447;5934.13954976526;5973.910391344133;5992.161097446361;5997.190379298826;5841.240638716939;5893.263342082239;5896.380880007538;5913.408659134052;5919.4080591940465;5714.79998200061;5795.681237531892;5829.067349224104;5855.326637436664;5913.76344946206;4456;4461.063176732858;4464.955350446454;4475.820967161277;4497.527759585262;3967.563568007517;3980.6616437602547;3993;3993.820278087493;3994.4807175067053;5529;5598.804041858515;5638.154276858504;5654.434556544313;5674.432556744375;6024.277086749618;6025.548083893638;6028.065649824284;6031.155638210654;6091.2081429414775;5470.480304371078;5550.472705093091;5671.404502527258;5681.545476361881;5688.5733569981585;5052.343195384577;5064.41759197697;5093.719845408464;5109.105906466353;5159.974200128975;6163.044728067157;6166.4758495527485;6168.228971378578;6176.227971503562;6187.195664563668;5773.6824474654295;5874.206982057368;5919;5947.881042379215;5960.612560183574;6166.81499555014;6169.56813023084;6171.47542458896;6179.3820617937845;6182.69086545662;5799.884002320015;5837.591368604157;5849.5612829037145;5852.94147058524;5856.267966504187;5788.13178023283;5914.2311499504785;5954.672493012926;5971.104334349882;5997.610155339889;5857.677827719516;5861.120831875082;5864.413558644102;5869.383714709894;5901.085331773582;5780.335261444988;5852.151438041375;5859.531237500904;5860.677662728591;5863.706814659165;5602.299712535933;5627.43725627434;5674.347450043298;5693.28833895763;5731.942680573141;5867.618604790675;5919.940800591939;5920.703964801829;5921.911171332347;5932.317783454958;5686.459786320293;5754.395788442321;5760.8271751847515;5761.711914404179;5766.048601980626 03:17:09 INFO - PROCESS | 3359 | |1;ext.html;581.9854503637412;620.6710443464963;628.2084573437468;639.7249182851375;652.4486808646692;31706.68293317066;32283.838580807093;34031.82984085079;34063.14842128948;34162;44905.55094449055;45901.31148032782;45934.540654593526;49074;49107;8599.484030958147;8805.25155361795;8814.955925220396;8816.162464565889;8820.8676869847;8671.523066231355;8769;8792.296616270683;8803.119688031209;8814.515201663906;8784.51685157316;8843.425177363482;8844.73465796027;8845.469271843709;8846.20384165425;8736.301095912311;8800;8818.603162857687;8820.558972051373;8828.42615230008;8696.869546956801;8760.73717788461;8772.736817895473;8774.64901403943;8775.824483510358;42466.15067698629;42917.35623965612;42924.356134658;42932.3560146598;43057;3553.982230088859;3715.9071023224365;3743.382341913581;3780.281746468162;4282.807273672693;32658.836705816557;32720.345593088245;33223.50164747507;33226;33317.666823331696;4168.791560421967;4262.957370426287;4382.123575284956;4444.755538445384;4530.524294949016;326094;326459;327615;328122;329212;60539;60619.69690151521;60698.39301607016;60741;60933.390666092775;63012.36987630065;63528.68235658885;63535.682321588094;63603.36396636067;63612;16911.661766764842;17130.828691713174;17144.228509716842;17153.313867445162;17162.056086915338;13223.140495867738;13288.402021909038;13312.667183320495;13324.133931294435;13324.866751332556;18285.40476659429;19373.720794565877;19382.601856844038;19441.715538884502;19522.21911123539;6970.302969702989;7185.425165986709;7353.595552244571;7367.410607151415;7484.176740558534;767.4627760567513;1080.1628737728324;1126.318577260762;1142.3774043146504;1214.872438393956;32293.51559726606;32519.837400812845;32892.67107328944;33017.15922301979;33155;1177.1348059176498;1199.688081098903;1231.599730087725;1252.4551819958347;1257.9245245285313;16524.786179524144;17276.568085797706;17279.481615551555;17300.65398692019;17521.386751463637;575493;577236;578043;579962;581455;58741;59280.407195928354;59328.51678708067;59386;59428.405715943154;1282.4677758730022;1323.808047833078;1376.8072469854028;1416.199847086393;1432.5415866922692;29848.318813127597;33296.334073317914;33509.497357540145;33596.66403335935;33750.49374259437;51261;51314;51811.222831658306;51863.22205167001;51882;405912;408374;410118;410575;410696;24500.632490513013;26700.7329926706;27178.864105680135;27452.725472745016;27472.725272747815;47559.76220118877;47718.284225735944;47880.76059619679;48845.755771220916;49365;40211.79894100628;40747;41230.38154427626;41298.38052429276;41309.38035929524;34911;35028.474572880914;35287.29425411529;35545.644543554234;36081;40867.795661021504;40873.795631021654;41031.17937641171;41598.58401416068;41757;36842.447363290106;39259.82220533388;39310.80344598259;39630.80184599174;39940.40089398603;27992.30019249535;28203.71796282093;28323.43353132967;28406.147815565568;28452.57321140226 03:17:09 INFO - PROCESS | 3359 | |2;jquery.html;395.23521984959126;398.3268276612525;399.33510704676735;403.65689164210426;418.1490666493684;14039.649008774786;17100.74348884768;18020.369287074955;19544.31594894179;19570.90214548929;14328.355224014918;17310.480685579452;18096.366627168052;18159.636807263847;18874.245030198777;5586.832395028156;5686.289213848269;5715.942840571583;5730.512906402961;5778.364379918226;4119.9176016479805;5672.517835983926;5673.347565030033;5723.055695810186;5979.46184843364;6009.248843894513;6028.939710602904;6049.243844519435;6051.1830902828;6057.061155520902;6000.399960003986;6004.699765011754;6080.787172448987;6087.665178415185;6186.536009799283;5389.191621256804;5593.496585307301;5616.66300022;5621.887562248732;5624.043912534838;21496.462588435257;22073.33779986603;22086.779132208794;22147.667784983238;22167.889160554256;2271.068861766684;2314.7685231476885;2325.988370058156;2350.2361732437025;2403.495265994126;13201.537946171838;13714.862851371458;13735.862641373658;13992.93003534986;14426.06230595008;1901.5151136460115;1966.360932696865;1991.0442987366146;1997.131247907165;2002.6495363311362;73960;75040;75042.24957750407;76742.6162869182;77147.22852771512;10298.897011029794;10461.68614941553;10729.195310351599;10864.293820901616;10952.4523773811;14841.554753357417;14906.70186596262;14916.105033698013;14935.850641493664;14954.177520236273;8035.678572857137;8096.190380961974;8223;8239.752807415787;8323.500589964622;6652.70062847173;7770.339521140653;7773.1060927994;7860.3318717909615;7951.244631759973;6106.236720409949;6511.511636627272;6514.120593719787;6629.303923088103;6669.899466587959;1840.3926704187854;1898.715192721103;1948.2596613287144;1987.0561483295608;2017.3846976672255;886.8226354728951;967.5307475874196;1094.0809719835217;1128.7686024364984;1161.651504548649;18127.456176314732;18858.52853678669;19052.33316833932;19104.14031368592;19314.806851931302;1019.3119644240109;1048.1352883870684;1082.9350238985528;1089.096050278267;1101.9779604408027;10412.947935260427;10886.836697449544;10930.781384372427;11001.779964400666;11009.724756881142;492481;493246;500878;503356;520357;76558.61720691361;78108;78953;79593.20406795974;79925.60037199892;1045.1899777672365;1046.3094357724017;1062.2829590026702;1078.2613909472193;1081.567373050786;16497.587560311087;16651.16744162763;16651.41720039793;16784.832151678325;17095;27622.861885690443;36540.72107476225;36759.81620091882;38403.61596384112;38862.6113738859;48738.26892596685;49640;50743;50996.74501627468;52219.47780522146;5708.4862362387585;7035.366816986291;7771.494852834548;8202.195516986254;8427.620757065824;10758.569657213624;12762.489500419879;13078.28069456189;13157.276349800853;13201.669958251121;11284.153688473561;11511;11611.88388116108;11765.294082355085;11842;11269.943650281695;11420.714482138013;11459.942700286445;11477.827832582685;11875.940620296844;11480.425978701198;11601.5359385627;11629.302241865515;11679.766404671689;11890.643280701594;7678.462507624413;7711;7718.151003389735;7843.372530197685;8047.919520804951;10673.57305707763;11407.771844563229;11717.472713727731;11743.647690569296;11807 03:17:09 INFO - PROCESS | 3359 | |3;mootools.html;1315.5987423835738;1493.253373313343;1547.9212275653654;1703.1739606290946;1825.4523642907125;8445.451045682026;8788.78028049299;8804.77988050299;9024.639014439432;9026.548672566361;8699.608517616707;8880.422772519798;8883.555822208897;8883.733487995354;8884.866726999084;2084.7498300203997;2306.1351993002622;2330.6270996640583;2355.8468699534474;2389.95220095598;2333.183385814968;2370.7629237076326;2371.9644205336936;2376.702912135983;2392.055138220402;2323.3030090972725;2361.2207971369494;2361.740208577055;2370.3363058343607;2378.9762102379013;2069.668852983523;2298.5517824024237;2364.2552595932398;2366.2546297916274;2372.727136379304;2301.0910690277415;2303.1823702585507;2308.653701944705;2308.9191878284346;2323.848949818256;8828.690995815115;8886.422382545114;8892.822143557092;8906.86639700405;8909.198172164472;5378.8924221515745;5505.504504594565;5507.394186639466;5514.558835293167;5515.200295957104;3270.5584746059217;3404.7616666833333;3460.169559305774;3461.7403694723;3496.3007398520144;1107.402002918423;1150.3213104268439;1157.6179860645966;1171.2152857585438;1182.9112816538793;12314.261144331369;12521.499140034388;12536.373181340896;12543.937280313632;12557.623271301783;4573.47405048417;4766.618670506351;4818.132736107465;4826;4831.661783675179;10692.358458492516;10715.83926241107;10721.249512534203;10725.78548429027;10731.356118632906;4825.034993001414;5478.835634930959;5484.314460692413;5484.808031718871;5486.396496385394;4801.615870730333;4939.209726443752;4952.678075925053;4977.726225057584;4979.402471703346;4028.8589899353383;4095.3242714952294;4148.959014797036;4192.517860446027;4201;1282.1922189020856;1293.7412517496539;1297.2087026913575;1303.3027330378202;1324.6555895467247;947.6020071569957;957.1385752822515;959.3572306554486;963.2625413395979;977.3988996766938;5597.244372009808;5654.236678048493;5742.7415766290615;5871.295444546682;6054.061620448838;438.8222769778181;446.1077844311377;457.03109408054473;458.99311510327374;1028.280203857303;4030.5087117766616;4102.892219100826;4112.09533902541;4127.9174416511505;4137.606927341898;10821.83767243492;11057.612983545698;11140.275882067639;11144.777104457866;11219.887801121884;10364.948175259075;11013.2841365311;11129;11148.442577871074;11149;8030.799230019296;8273.710420135267;8315.916840831514;8334.958325208456;8337.791555211168;5591.8881622368135;5856.736446859987;6007.459328660441;6010.429009244115;6184.474319682698;9895.356801807859;10130.189584833048;10360.948195258976;10364.170866330825;10371.377717336984;10257.179425645782;10497.895021049997;10501.89498105009;10520.736981575521;10584.206184536037;6992.825179370557;7670.463067585216;7928.246816552418;7934.523928564305;8036.357091432788;8786.297096232158;8809.64761409562;8870.911290887008;8876.378653494194;8885.37802353855;7490.662920168715;7782.88325675104;7819.828279448104;7852.685892564234;7856.45004849655;7446.329830315298;7522.887156692764;7627.046619172604;7736.2650548197835;7739.7678069658;7145.17830449505;7213.819654508679;7239.276072392719;7242.96378518104;7245.347918687344;5043.36957880265;5182.455842136521;5283.524482796567;5318.8936221276135;5352.518273355417;4858.489858564941;4942.505749425029;4992.2511623256805;5030.84907452777;5145.742712864417 03:17:09 INFO - PROCESS | 3359 | |4;prototype.html;316.3562151022668;330.90238379678;333.3882325931915;336.7373448710007;337.20251604954285;5137.280780690697;5206.921896171556;5228.144008876841;5271.367435907697;5301.575873930086;5155.355580552431;5182.404023537294;5184.818531351403;5220.6606570572885;5249.816256431026;4087.386891966199;4090.3455447128467;4101.569335219789;4102.835886564534;4117.3618089196225;3929.744566603176;4086.8160932758096;4095.385692146172;4136.751794892301;4137.710360274782;3928.6464218220353;3983.721139520235;3983.780892050936;3984.4620976168135;3987.6809855211513;4020.8592699255387;4020.899477513071;4025.9597404025876;4026;4031.689700847207;3550.5916819565823;3553.7690050146916;3556.5020897074432;3561.7684850484634;3572.481695279522;4800;5043.52086551777;5052.242163675442;5079.974600127012;5119.513646203604;4648.1865673507;4648.628109751212;4653;4658.58072773452;4666.603338716213;5438.755256013489;5455.099908515091;5498.230247765316;5499.075323636735;5507.917381239285;3853.499045124116;3893.7274390792654;3935.468711723909;3948.7828169450668;3956.287868183726;5417.591426229169;5422.783088676449;5637.887242255173;5638.4361563843695;5661.575381846378;3914.1388894443176;3942.3495123304906;3947.4276229946495;3953.3081710700512;3960.1683646433994;3817.1983883384246;3932.2528719543766;3990.660793832557;4012.6188012139382;4023.939640905389;4555.111753208159;4568.834947088538;4570.702904311209;4593.839215627437;4599.2871104978785;5410.296661433988;5421.403645598981;5422.91865622016;5452.536534394541;5453.700046497402;1331.8934485241157;1352.4319785689836;1354.3282196165237;1378.200643626694;1387.3063468265866;864.7535452396037;877.7667377334855;886.2998231397124;887.8801361816072;888.5379602606608;4674.275487299406;4706.952930470651;4733.573978341966;4767.76161191939;4784.952150478521;5031.547160755549;5042.6384876083985;5046.722430266297;5049.520295571915;5052.671576347526;4586.334981427674;4791.928121078186;4797.848516356049;4799.616030717534;4804.591609713214;2651.3106592286144;2651.840889546633;2652.2441104285185;2653.9469210616066;2701.986490067537;5028.84913452597;5037.773300201499;5107.897842043139;5134.948650513522;5176.249443830623;4813.975930120327;5000.39995200571;5016.749162541858;5036.697798132123;5074.238864170404;5040.437464385979;5050.520200580939;5055.241713742968;5108.438071812097;5120.746871376582;4902.431222008923;4956.256561515802;4967.7019378837385;4975.925361119514;5336.279602253646;5170.27616133734;5510;5519.199716041071;5539.667619942817;5539.7784088636;5709.942900570941;5730.283714535683;5732.7706891723865;5740.942590574041;5765.509931655856;3801.201747633028;3943;3958.524977002663;3963.8612648557164;3967.682585393219;5539.113741801292;5575.330960284792;5588.916166257428;5597.356304025089;5665.461781130786;5480.808171713971;5501.972490137524;5502.862428439321;5507.862303442446;5526.613137080527;5192.3769147702515;5434.945650543444;5445.2104444854485;5449.482299181572;5491.670499770026;5251.36983561975;5310.548603368602;5333.666583354161;5335.813246536352;5339.519443250126;5426.538744206787;5429.294191755047;5466.590005749665;5471.753771080232;5475.342958844964;5122.206058061007;5325.973370133124;5359.276497672764;5477.0830209426385;5479.643823151482 03:17:09 INFO - PROCESS | 3359 | |5;yui.html;754.441713132282;803.8553060449119;817.5544328341053;821.2403526737766;841.1798496465947;13886.4445422183;13998.790018149735;14446.349914253857;14820.184889831055;15182.620434489143;13727.725445491084;13833.239171845544;13873.653158671039;13874.375653095609;13886.236257005861;669.8492839111185;763.3664058831184;776.5806464509159;788.9723859664913;789.104366543971;795.1015352651496;797.9361651067901;798.1340245833248;798.1619299735283;798.5767543202084;839.6935118681668;842.7556008757483;843.1105184030845;844.1769274956898;844.1769274956929;700.7862601906392;816.2898278497686;835.8620827563444;837.4849467577426;838.0153319849184;601.6089541797822;602.1569802276804;602.7227475361339;602.9909551356733;603.7916918663054;13824.723505529933;13860.93069534656;13864.514741983981;13870.722585548232;13871.930640346734;13282.667933301647;13756.312184390741;13761.532079922421;13958.790618140736;14255.50105746294;11001.944990275077;11320.26418282809;11609.07127429812;11657.94171029148;11781.175317727762;4546.522615125397;4562.931556026662;4573.314002899559;4754.738489383082;4758.666893317469;57925.46968894017;58977.41022589762;59429.70285148547;59599.70200148971;60828;10508.842367364496;10632.681019569425;10817.675469735921;10852.565897364175;11133.832992505118;17889.10554472271;18029.368972086177;18430.539236518925;18450;18460.81539184618;8212.58937053145;8252.876206856901;8264.876026859602;8273.379496537784;8433.704820331383;4697.78859951303;4771.06964141989;4787.138315103315;4796.37647105881;5059.241113832954;3284.5730055092686;3343.7993720376853;3355.261842394669;3357.916052098717;3360.630330663625;616.8612062285949;621.6860485454816;635.4122436745992;672.909157263773;683.2006552333781;653.7940548727136;690.3924546399137;744;754.4869488747595;763.2367632367632;9374.437533747998;9915.157211636948;9965.35225210359;10026.949865250626;10040.748981275381;568.1109064314335;617.3517806303364;660.21764209412;709.1667290933133;713.2225873797482;4388.868333949987;4618.399608050931;4738.526147385234;4846.079244943449;5052.9747351263;68576.6571167141;74569;75069.24930750622;75097;75235.24764752282;54281.185782213295;55382.723086385115;64382.356176438574;65992;69101.65449172823;55910;56144.71927640335;57795.42204577901;59160.40839591635;60976.39023609707;8954.373193876367;9153.267738580764;9337.579808908751;9365.953170234105;9413.623455061721;37269.440958386185;37755.24489510249;38166.80916595399;38209.6179038206;38428.03929901775;45196.54803451923;45552.772236138604;45769;46062.539374607164;50524.74737626289;12751.298678572768;12778.74442511126;12922.870771292542;12927.741445171232;13379.197248165141;13673.453061877413;13813.723725525635;13965.022448428512;14361.856381436051;14589.562313130624;13518.391672374963;13631.318434078057;13796;13798.17210967345;13943.059859891651;13190.631732573356;13519.459221631418;13783.173009619455;13830.654233643836;14041.535380973986;12512.937435312766;12631.747365052832;13004;13303.733925321632;13737.381817818423;10812.945935270272;10832.945835270773;10997.175211859303;11190.160737944849;11436.542538298374;11153.665390038312;11160.832587511031;11210.383428911487;11249.550017999189;11294.887051129712 03:17:09 INFO - PROCESS | 3359 | __end_tp_report 03:17:09 INFO - PROCESS | 3359 | __start_cc_report 03:17:09 INFO - PROCESS | 3359 | _x_x_mozilla_cycle_collect,930 03:17:09 INFO - PROCESS | 3359 | __end_cc_report 03:17:09 INFO - PROCESS | 3359 | __startTimestamp1464776229586__endTimestamp 03:17:09 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | ------- Summary: start ------- 03:17:09 INFO - PROCESS | 3359 | Number of tests: 6 03:17:09 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | [#0] dojo.html Cycles:165 Average:5502.97 Median:5735.83 stddev:646.71 (11.3%) stddev-sans-first:622.07 03:17:09 INFO - PROCESS | 3359 | Values: 3161.9 3180.8 3201.1 3208.9 3249.4 5454.1 5505.3 5527.0 5614.0 5640.3 5486.6 5546.4 5547.8 5558.7 5587.0 4841.8 5010.4 5012.8 5022.7 5155.9 5052.1 5072.9 5107.0 5119.9 5132.3 4848.4 4876.1 4906.7 4913.8 4918.5 4901.0 4990.2 4993.3 5005.4 5033.3 4805.7 4920.0 4952.8 4966.4 5019.4 5455.5 5486.0 5547.2 5548.7 5550.4 5896.9 5899.7 5971.6 5975.9 6017.5 5772.0 5849.4 5860.8 6046.8 6070.2 5537.2 5571.5 5588.2 5590.1 5593.4 6051.6 6056.9 6074.8 6094.8 6096.4 5735.8 5761.0 5798.5 5827.6 5880.7 5923.8 5934.1 5973.9 5992.2 5997.2 5841.2 5893.3 5896.4 5913.4 5919.4 5714.8 5795.7 5829.1 5855.3 5913.8 4456.0 4461.1 4465.0 4475.8 4497.5 3967.6 3980.7 3993.0 3993.8 3994.5 5529.0 5598.8 5638.2 5654.4 5674.4 6024.3 6025.5 6028.1 6031.2 6091.2 5470.5 5550.5 5671.4 5681.5 5688.6 5052.3 5064.4 5093.7 5109.1 5160.0 6163.0 6166.5 6168.2 6176.2 6187.2 5773.7 5874.2 5919.0 5947.9 5960.6 6166.8 6169.6 6171.5 6179.4 6182.7 5799.9 5837.6 5849.6 5852.9 5856.3 5788.1 5914.2 5954.7 5971.1 5997.6 5857.7 5861.1 5864.4 5869.4 5901.1 5780.3 5852.2 5859.5 5860.7 5863.7 5602.3 5627.4 5674.3 5693.3 5731.9 5867.6 5919.9 5920.7 5921.9 5932.3 5686.5 5754.4 5760.8 5761.7 5766.0 03:17:09 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | [#1] ext.html Cycles:180 Average:60055.37 Median:225803.09 stddev:119740.85 (53.0%) stddev-sans-first:119993.50 03:17:09 INFO - PROCESS | 3359 | Values: 582.0 620.7 628.2 639.7 652.4 31706.7 32283.8 34031.8 34063.1 34162.0 44905.6 45901.3 45934.5 49074.0 49107.0 8599.5 8805.3 8815.0 8816.2 8820.9 8671.5 8769.0 8792.3 8803.1 8814.5 8784.5 8843.4 8844.7 8845.5 8846.2 8736.3 8800.0 8818.6 8820.6 8828.4 8696.9 8760.7 8772.7 8774.6 8775.8 42466.2 42917.4 42924.4 42932.4 43057.0 3554.0 3715.9 3743.4 3780.3 4282.8 32658.8 32720.3 33223.5 33226.0 33317.7 4168.8 4263.0 4382.1 4444.8 4530.5 326094.0 326459.0 327615.0 328122.0 329212.0 60539.0 60619.7 60698.4 60741.0 60933.4 63012.4 63528.7 63535.7 63603.4 63612.0 16911.7 17130.8 17144.2 17153.3 17162.1 13223.1 13288.4 13312.7 13324.1 13324.9 18285.4 19373.7 19382.6 19441.7 19522.2 6970.3 7185.4 7353.6 7367.4 7484.2 767.5 1080.2 1126.3 1142.4 1214.9 32293.5 32519.8 32892.7 33017.2 33155.0 1177.1 1199.7 1231.6 1252.5 1257.9 16524.8 17276.6 17279.5 17300.7 17521.4 575493.0 577236.0 578043.0 579962.0 581455.0 58741.0 59280.4 59328.5 59386.0 59428.4 1282.5 1323.8 1376.8 1416.2 1432.5 29848.3 33296.3 33509.5 33596.7 33750.5 51261.0 51314.0 51811.2 51863.2 51882.0 405912.0 408374.0 410118.0 410575.0 410696.0 24500.6 26700.7 27178.9 27452.7 27472.7 47559.8 47718.3 47880.8 48845.8 49365.0 40211.8 40747.0 41230.4 41298.4 41309.4 34911.0 35028.5 35287.3 35545.6 36081.0 40867.8 40873.8 41031.2 41598.6 41757.0 36842.4 39259.8 39310.8 39630.8 39940.4 27992.3 28203.7 28323.4 28406.1 28452.6 03:17:09 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | [#2] jquery.html Cycles:180 Average:28339.14 Median:22117.22 stddev:82309.24 (372.1%) stddev-sans-first:82513.39 03:17:09 INFO - PROCESS | 3359 | Values: 395.2 398.3 399.3 403.7 418.1 14039.6 17100.7 18020.4 19544.3 19570.9 14328.4 17310.5 18096.4 18159.6 18874.2 5586.8 5686.3 5715.9 5730.5 5778.4 4119.9 5672.5 5673.3 5723.1 5979.5 6009.2 6028.9 6049.2 6051.2 6057.1 6000.4 6004.7 6080.8 6087.7 6186.5 5389.2 5593.5 5616.7 5621.9 5624.0 21496.5 22073.3 22086.8 22147.7 22167.9 2271.1 2314.8 2326.0 2350.2 2403.5 13201.5 13714.9 13735.9 13992.9 14426.1 1901.5 1966.4 1991.0 1997.1 2002.6 73960.0 75040.0 75042.2 76742.6 77147.2 10298.9 10461.7 10729.2 10864.3 10952.5 14841.6 14906.7 14916.1 14935.9 14954.2 8035.7 8096.2 8223.0 8239.8 8323.5 6652.7 7770.3 7773.1 7860.3 7951.2 6106.2 6511.5 6514.1 6629.3 6669.9 1840.4 1898.7 1948.3 1987.1 2017.4 886.8 967.5 1094.1 1128.8 1161.7 18127.5 18858.5 19052.3 19104.1 19314.8 1019.3 1048.1 1082.9 1089.1 1102.0 10412.9 10886.8 10930.8 11001.8 11009.7 492481.0 493246.0 500878.0 503356.0 520357.0 76558.6 78108.0 78953.0 79593.2 79925.6 1045.2 1046.3 1062.3 1078.3 1081.6 16497.6 16651.2 16651.4 16784.8 17095.0 27622.9 36540.7 36759.8 38403.6 38862.6 48738.3 49640.0 50743.0 50996.7 52219.5 5708.5 7035.4 7771.5 8202.2 8427.6 10758.6 12762.5 13078.3 13157.3 13201.7 11284.2 11511.0 11611.9 11765.3 11842.0 11269.9 11420.7 11459.9 11477.8 11875.9 11480.4 11601.5 11629.3 11679.8 11890.6 7678.5 7711.0 7718.2 7843.4 8047.9 10673.6 11407.8 11717.5 11743.6 11807.0 03:17:09 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | [#3] mootools.html Cycles:180 Average:5867.11 Median:4784.12 stddev:3370.81 (70.5%) stddev-sans-first:3362.91 03:17:09 INFO - PROCESS | 3359 | Values: 1315.6 1493.3 1547.9 1703.2 1825.5 8445.5 8788.8 8804.8 9024.6 9026.5 8699.6 8880.4 8883.6 8883.7 8884.9 2084.7 2306.1 2330.6 2355.8 2390.0 2333.2 2370.8 2372.0 2376.7 2392.1 2323.3 2361.2 2361.7 2370.3 2379.0 2069.7 2298.6 2364.3 2366.3 2372.7 2301.1 2303.2 2308.7 2308.9 2323.8 8828.7 8886.4 8892.8 8906.9 8909.2 5378.9 5505.5 5507.4 5514.6 5515.2 3270.6 3404.8 3460.2 3461.7 3496.3 1107.4 1150.3 1157.6 1171.2 1182.9 12314.3 12521.5 12536.4 12543.9 12557.6 4573.5 4766.6 4818.1 4826.0 4831.7 10692.4 10715.8 10721.2 10725.8 10731.4 4825.0 5478.8 5484.3 5484.8 5486.4 4801.6 4939.2 4952.7 4977.7 4979.4 4028.9 4095.3 4149.0 4192.5 4201.0 1282.2 1293.7 1297.2 1303.3 1324.7 947.6 957.1 959.4 963.3 977.4 5597.2 5654.2 5742.7 5871.3 6054.1 438.8 446.1 457.0 459.0 1028.3 4030.5 4102.9 4112.1 4127.9 4137.6 10821.8 11057.6 11140.3 11144.8 11219.9 10364.9 11013.3 11129.0 11148.4 11149.0 8030.8 8273.7 8315.9 8335.0 8337.8 5591.9 5856.7 6007.5 6010.4 6184.5 9895.4 10130.2 10360.9 10364.2 10371.4 10257.2 10497.9 10501.9 10520.7 10584.2 6992.8 7670.5 7928.2 7934.5 8036.4 8786.3 8809.6 8870.9 8876.4 8885.4 7490.7 7782.9 7819.8 7852.7 7856.5 7446.3 7522.9 7627.0 7736.3 7739.8 7145.2 7213.8 7239.3 7243.0 7245.3 5043.4 5182.5 5283.5 5318.9 5352.5 4858.5 4942.5 4992.3 5030.8 5145.7 03:17:09 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | [#4] prototype.html Cycles:180 Average:4455.42 Median:5037.24 stddev:1299.23 (25.8%) stddev-sans-first:1265.18 03:17:09 INFO - PROCESS | 3359 | Values: 316.4 330.9 333.4 336.7 337.2 5137.3 5206.9 5228.1 5271.4 5301.6 5155.4 5182.4 5184.8 5220.7 5249.8 4087.4 4090.3 4101.6 4102.8 4117.4 3929.7 4086.8 4095.4 4136.8 4137.7 3928.6 3983.7 3983.8 3984.5 3987.7 4020.9 4020.9 4026.0 4026.0 4031.7 3550.6 3553.8 3556.5 3561.8 3572.5 4800.0 5043.5 5052.2 5080.0 5119.5 4648.2 4648.6 4653.0 4658.6 4666.6 5438.8 5455.1 5498.2 5499.1 5507.9 3853.5 3893.7 3935.5 3948.8 3956.3 5417.6 5422.8 5637.9 5638.4 5661.6 3914.1 3942.3 3947.4 3953.3 3960.2 3817.2 3932.3 3990.7 4012.6 4023.9 4555.1 4568.8 4570.7 4593.8 4599.3 5410.3 5421.4 5422.9 5452.5 5453.7 1331.9 1352.4 1354.3 1378.2 1387.3 864.8 877.8 886.3 887.9 888.5 4674.3 4707.0 4733.6 4767.8 4785.0 5031.5 5042.6 5046.7 5049.5 5052.7 4586.3 4791.9 4797.8 4799.6 4804.6 2651.3 2651.8 2652.2 2653.9 2702.0 5028.8 5037.8 5107.9 5134.9 5176.2 4814.0 5000.4 5016.7 5036.7 5074.2 5040.4 5050.5 5055.2 5108.4 5120.7 4902.4 4956.3 4967.7 4975.9 5336.3 5170.3 5510.0 5519.2 5539.7 5539.8 5709.9 5730.3 5732.8 5740.9 5765.5 3801.2 3943.0 3958.5 3963.9 3967.7 5539.1 5575.3 5588.9 5597.4 5665.5 5480.8 5502.0 5502.9 5507.9 5526.6 5192.4 5434.9 5445.2 5449.5 5491.7 5251.4 5310.5 5333.7 5335.8 5339.5 5426.5 5429.3 5466.6 5471.8 5475.3 5122.2 5326.0 5359.3 5477.1 5479.6 03:17:09 INFO - PROCESS | 3359 | 03:17:09 INFO - PROCESS | 3359 | [#5] yui.html Cycles:180 Average:15979.67 Median:4658.09 stddev:19400.86 (416.5%) stddev-sans-first:19421.60 03:17:09 INFO - PROCESS | 3359 | Values: 754.4 803.9 817.6 821.2 841.2 13886.4 13998.8 14446.3 14820.2 15182.6 13727.7 13833.2 13873.7 13874.4 13886.2 669.8 763.4 776.6 789.0 789.1 795.1 797.9 798.1 798.2 798.6 839.7 842.8 843.1 844.2 844.2 700.8 816.3 835.9 837.5 838.0 601.6 602.2 602.7 603.0 603.8 13824.7 13860.9 13864.5 13870.7 13871.9 13282.7 13756.3 13761.5 13958.8 14255.5 11001.9 11320.3 11609.1 11657.9 11781.2 4546.5 4562.9 4573.3 4754.7 4758.7 57925.5 58977.4 59429.7 59599.7 60828.0 10508.8 10632.7 10817.7 10852.6 11133.8 17889.1 18029.4 18430.5 18450.0 18460.8 8212.6 8252.9 8264.9 8273.4 8433.7 4697.8 4771.1 4787.1 4796.4 5059.2 3284.6 3343.8 3355.3 3357.9 3360.6 616.9 621.7 635.4 672.9 683.2 653.8 690.4 744.0 754.5 763.2 9374.4 9915.2 9965.4 10026.9 10040.7 568.1 617.4 660.2 709.2 713.2 4388.9 4618.4 4738.5 4846.1 5053.0 68576.7 74569.0 75069.2 75097.0 75235.2 54281.2 55382.7 64382.4 65992.0 69101.7 55910.0 56144.7 57795.4 59160.4 60976.4 8954.4 9153.3 9337.6 9366.0 9413.6 37269.4 37755.2 38166.8 38209.6 38428.0 45196.5 45552.8 45769.0 46062.5 50524.7 12751.3 12778.7 12922.9 12927.7 13379.2 13673.5 13813.7 13965.0 14361.9 14589.6 13518.4 13631.3 13796.0 13798.2 13943.1 13190.6 13519.5 13783.2 13830.7 14041.5 12512.9 12631.7 13004.0 13303.7 13737.4 10812.9 10832.9 10997.2 11190.2 11436.5 11153.7 11160.8 11210.4 11249.6 11294.9 03:17:09 INFO - PROCESS | 3359 | -------- Summary: end -------- 03:17:09 INFO - PROCESS | 3359 | 03:17:10 INFO - TEST-INFO | 3359: exit 0 03:17:10 INFO - TEST-OK | dromaeo_css | took 1115028ms 03:17:10 INFO - TEST-START | kraken 03:17:10 INFO - operating with platform_type : linux_ 03:17:10 INFO - Initialising browser for kraken test... 03:17:10 INFO - TEST-INFO | started process 3538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZxxKtL/profile http://localhost:35242/getInfo.html) 03:17:14 INFO - PROCESS | 3538 | __metrics Screen width/height:1600/1200 03:17:14 INFO - PROCESS | 3538 | colorDepth:24 03:17:14 INFO - PROCESS | 3538 | Browser inner width/height: 1024/697 03:17:14 INFO - PROCESS | 3538 | __metrics 03:17:15 ERROR - PROCESS | 3538 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:17:15 INFO - TEST-INFO | 3538: exit 0 03:17:15 INFO - Browser initialized. 03:17:15 INFO - Running cycle 1/1 for kraken test... 03:17:15 INFO - TEST-INFO | started process 3620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZxxKtL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:27 INFO - PROCESS | 3620 | RSS: Main: 156065792 03:17:27 INFO - PROCESS | 3620 | 03:17:30 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35242/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:31 INFO - PROCESS | 3620 | RSS: Main: 214196224 03:17:31 INFO - PROCESS | 3620 | 03:17:33 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35242/tests/kraken/driver.html?testName=audio-dft) 03:17:34 INFO - PROCESS | 3620 | RSS: Main: 197754880 03:17:34 INFO - PROCESS | 3620 | 03:17:37 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35242/tests/kraken/driver.html?testName=audio-fft) 03:17:38 INFO - PROCESS | 3620 | RSS: Main: 269012992 03:17:38 INFO - PROCESS | 3620 | 03:17:40 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35242/tests/kraken/driver.html?testName=audio-oscillator) 03:17:40 INFO - PROCESS | 3620 | RSS: Main: 179146752 03:17:40 INFO - PROCESS | 3620 | 03:17:42 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:43 INFO - PROCESS | 3620 | RSS: Main: 183119872 03:17:43 INFO - PROCESS | 3620 | 03:17:46 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35242/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:47 INFO - PROCESS | 3620 | RSS: Main: 217878528 03:17:47 INFO - PROCESS | 3620 | 03:17:50 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35242/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:50 INFO - PROCESS | 3620 | RSS: Main: 219987968 03:17:50 INFO - PROCESS | 3620 | 03:17:53 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35242/tests/kraken/driver.html?testName=json-parse-financial) 03:17:54 INFO - PROCESS | 3620 | RSS: Main: 220053504 03:17:54 INFO - PROCESS | 3620 | 03:17:55 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:56 INFO - PROCESS | 3620 | RSS: Main: 209301504 03:17:56 INFO - PROCESS | 3620 | 03:17:58 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35242/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:58 INFO - PROCESS | 3620 | RSS: Main: 209072128 03:17:58 INFO - PROCESS | 3620 | 03:18:00 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:18:01 INFO - PROCESS | 3620 | RSS: Main: 217190400 03:18:01 INFO - PROCESS | 3620 | 03:18:04 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:18:04 INFO - PROCESS | 3620 | RSS: Main: 225742848 03:18:04 INFO - PROCESS | 3620 | 03:18:07 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:07 INFO - PROCESS | 3620 | RSS: Main: 226770944 03:18:07 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:35242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35242/tests/kraken/driver.html?testName=ai-astar) 03:18:09 INFO - PROCESS | 3620 | RSS: Main: 268607488 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | __start_tp_report 03:18:09 INFO - PROCESS | 3620 | _x_x_mozilla_page_load 03:18:09 INFO - PROCESS | 3620 | _x_x_mozilla_page_load_details 03:18:09 INFO - PROCESS | 3620 | |i|pagename|runs| 03:18:09 INFO - PROCESS | 3620 | |0;ai-astar;108;105;109;110;110;109;109;111;111;110 03:18:09 INFO - PROCESS | 3620 | |1;audio-beat-detection;156;133;130;181;135;128;147;129;153;124 03:18:09 INFO - PROCESS | 3620 | |2;audio-dft;160;161;159;161;162;160;161;161;160;160 03:18:09 INFO - PROCESS | 3620 | |3;audio-fft;72;74;73;125;75;75;75;75;98;73 03:18:09 INFO - PROCESS | 3620 | |4;audio-oscillator;82;81;107;82;83;83;121;82;82;121 03:18:09 INFO - PROCESS | 3620 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 03:18:09 INFO - PROCESS | 3620 | |6;imaging-darkroom;146;145;147;146;144;148;146;146;146;146 03:18:09 INFO - PROCESS | 3620 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 03:18:09 INFO - PROCESS | 3620 | |8;json-parse-financial;53;53;53;53;52;53;53;53;52;52 03:18:09 INFO - PROCESS | 3620 | |9;json-stringify-tinderbox;60;62;60;60;61;60;60;61;61;62 03:18:09 INFO - PROCESS | 3620 | |10;stanford-crypto-aes;85;78;79;79;80;80;79;81;118;79 03:18:09 INFO - PROCESS | 3620 | |11;stanford-crypto-ccm;128;122;130;123;127;127;119;118;130;120 03:18:09 INFO - PROCESS | 3620 | |12;stanford-crypto-pbkdf2;167;167;167;166;169;167;165;162;160;164 03:18:09 INFO - PROCESS | 3620 | |13;stanford-crypto-sha256-iterative;63;64;63;62;62;64;62;61;61;60 03:18:09 INFO - PROCESS | 3620 | __end_tp_report 03:18:09 INFO - PROCESS | 3620 | __start_cc_report 03:18:09 INFO - PROCESS | 3620 | _x_x_mozilla_cycle_collect,1587 03:18:09 INFO - PROCESS | 3620 | __end_cc_report 03:18:09 INFO - PROCESS | 3620 | __startTimestamp1464776289887__endTimestamp 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | ------- Summary: start ------- 03:18:09 INFO - PROCESS | 3620 | Number of tests: 14 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.75 (1.6%) stddev-sans-first:1.80 03:18:09 INFO - PROCESS | 3620 | Values: 108.0 105.0 109.0 110.0 110.0 109.0 109.0 111.0 111.0 110.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:141.00 stddev:17.72 (12.6%) stddev-sans-first:18.01 03:18:09 INFO - PROCESS | 3620 | Values: 156.0 133.0 130.0 181.0 135.0 128.0 147.0 129.0 153.0 124.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 03:18:09 INFO - PROCESS | 3620 | Values: 160.0 161.0 159.0 161.0 162.0 160.0 161.0 161.0 160.0 160.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:17.08 (22.8%) stddev-sans-first:17.76 03:18:09 INFO - PROCESS | 3620 | Values: 72.0 74.0 73.0 125.0 75.0 75.0 75.0 75.0 98.0 73.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:82.00 stddev:16.96 (20.7%) stddev-sans-first:17.56 03:18:09 INFO - PROCESS | 3620 | Values: 82.0 81.0 107.0 82.0 83.0 83.0 121.0 82.0 82.0 121.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:18:09 INFO - PROCESS | 3620 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 03:18:09 INFO - PROCESS | 3620 | Values: 146.0 145.0 147.0 146.0 144.0 148.0 146.0 146.0 146.0 146.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:18:09 INFO - PROCESS | 3620 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 03:18:09 INFO - PROCESS | 3620 | Values: 53.0 53.0 53.0 53.0 52.0 53.0 53.0 53.0 52.0 52.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 03:18:09 INFO - PROCESS | 3620 | Values: 60.0 62.0 60.0 60.0 61.0 60.0 60.0 61.0 61.0 62.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:79.50 stddev:12.17 (15.3%) stddev-sans-first:12.90 03:18:09 INFO - PROCESS | 3620 | Values: 85.0 78.0 79.0 79.0 80.0 80.0 79.0 81.0 118.0 79.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:127.00 stddev:4.55 (3.6%) stddev-sans-first:4.64 03:18:09 INFO - PROCESS | 3620 | Values: 128.0 122.0 130.0 123.0 127.0 127.0 119.0 118.0 130.0 120.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:167.00 stddev:2.72 (1.6%) stddev-sans-first:2.82 03:18:09 INFO - PROCESS | 3620 | Values: 167.0 167.0 167.0 166.0 169.0 167.0 165.0 162.0 160.0 164.0 03:18:09 INFO - PROCESS | 3620 | 03:18:09 INFO - PROCESS | 3620 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.32 (2.1%) stddev-sans-first:1.36 03:18:09 INFO - PROCESS | 3620 | Values: 63.0 64.0 63.0 62.0 62.0 64.0 62.0 61.0 61.0 60.0 03:18:09 INFO - PROCESS | 3620 | -------- Summary: end -------- 03:18:09 INFO - PROCESS | 3620 | 03:18:10 INFO - TEST-INFO | 3620: exit 0 03:18:10 INFO - TEST-OK | kraken | took 60470ms 03:18:10 INFO - SUITE-END | took 1175s 03:18:11 INFO - Completed test suite (00:19:35) 03:18:11 INFO - javascript benchmark 03:18:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.889333873315, 3180.7773455858087, 3201.135693362792, 3208.8716451341948, 3249.41510528105, 5454.10007348787, 5505.284313039304, 5526.972365138168, 5614.017546929286, 5640.266765320508, 5486.61593688441, 5546.389897111315, 5547.77808887645, 5558.749856256468, 5587.0, 4841.806327746895, 5010.3737032870895, 5012.774425150858, 5022.723750193738, 5155.9484405155845, 5052.115879721053, 5072.934683716424, 5107.0, 5119.897602047957, 5132.3071385363055, 4848.369711937443, 4876.146674331995, 4906.705597664151, 4913.778879950411, 4918.458969513351, 4901.0, 4990.226514890198, 4993.275974983607, 5005.374328208974, 5033.295338652591, 4805.663603547753, 4919.975400122977, 4952.7523623819025, 4966.379202599675, 5019.397672279313, 5455.509004189602, 5485.9725701371635, 5547.195656629807, 5548.72256387179, 5550.361708403545, 5896.941030589682, 5899.734511946973, 5971.552133589998, 5975.850603734898, 6017.548683848685, 5772.0, 5849.444302791228, 5860.765569377219, 6046.788362407295, 6070.180525629072, 5537.224788529609, 5571.526420254283, 5588.189712491707, 5590.105583106683, 5593.412691667398, 6051.628232978235, 6056.881152294354, 6074.849764978889, 6094.8171554853425, 6096.359882212304, 5735.827925162252, 5761.0, 5798.507126894261, 5827.562932780059, 5880.705964701748, 5923.822285331447, 5934.13954976526, 5973.910391344133, 5992.161097446361, 5997.190379298826, 5841.240638716939, 5893.263342082239, 5896.380880007538, 5913.408659134052, 5919.4080591940465, 5714.79998200061, 5795.681237531892, 5829.067349224104, 5855.326637436664, 5913.76344946206, 4456.0, 4461.063176732858, 4464.955350446454, 4475.820967161277, 4497.527759585262, 3967.563568007517, 3980.6616437602547, 3993.0, 3993.820278087493, 3994.4807175067053, 5529.0, 5598.804041858515, 5638.154276858504, 5654.434556544313, 5674.432556744375, 6024.277086749618, 6025.548083893638, 6028.065649824284, 6031.155638210654, 6091.2081429414775, 5470.480304371078, 5550.472705093091, 5671.404502527258, 5681.545476361881, 5688.5733569981585, 5052.343195384577, 5064.41759197697, 5093.719845408464, 5109.105906466353, 5159.974200128975, 6163.044728067157, 6166.4758495527485, 6168.228971378578, 6176.227971503562, 6187.195664563668, 5773.6824474654295, 5874.206982057368, 5919.0, 5947.881042379215, 5960.612560183574, 6166.81499555014, 6169.56813023084, 6171.47542458896, 6179.3820617937845, 6182.69086545662, 5799.884002320015, 5837.591368604157, 5849.5612829037145, 5852.94147058524, 5856.267966504187, 5788.13178023283, 5914.2311499504785, 5954.672493012926, 5971.104334349882, 5997.610155339889, 5857.677827719516, 5861.120831875082, 5864.413558644102, 5869.383714709894, 5901.085331773582, 5780.335261444988, 5852.151438041375, 5859.531237500904, 5860.677662728591, 5863.706814659165, 5602.299712535933, 5627.43725627434, 5674.347450043298, 5693.28833895763, 5731.942680573141, 5867.618604790675, 5919.940800591939, 5920.703964801829, 5921.911171332347, 5932.317783454958, 5686.459786320293, 5754.395788442321, 5760.8271751847515, 5761.711914404179, 5766.048601980626], "value": 5457.937446840628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.9854503637412, 620.6710443464963, 628.2084573437468, 639.7249182851375, 652.4486808646692, 31706.68293317066, 32283.838580807093, 34031.82984085079, 34063.14842128948, 34162.0, 44905.55094449055, 45901.31148032782, 45934.540654593526, 49074.0, 49107.0, 8599.484030958147, 8805.25155361795, 8814.955925220396, 8816.162464565889, 8820.8676869847, 8671.523066231355, 8769.0, 8792.296616270683, 8803.119688031209, 8814.515201663906, 8784.51685157316, 8843.425177363482, 8844.73465796027, 8845.469271843709, 8846.20384165425, 8736.301095912311, 8800.0, 8818.603162857687, 8820.558972051373, 8828.42615230008, 8696.869546956801, 8760.73717788461, 8772.736817895473, 8774.64901403943, 8775.824483510358, 42466.15067698629, 42917.35623965612, 42924.356134658, 42932.3560146598, 43057.0, 3553.982230088859, 3715.9071023224365, 3743.382341913581, 3780.281746468162, 4282.807273672693, 32658.836705816557, 32720.345593088245, 33223.50164747507, 33226.0, 33317.666823331696, 4168.791560421967, 4262.957370426287, 4382.123575284956, 4444.755538445384, 4530.524294949016, 326094.0, 326459.0, 327615.0, 328122.0, 329212.0, 60539.0, 60619.69690151521, 60698.39301607016, 60741.0, 60933.390666092775, 63012.36987630065, 63528.68235658885, 63535.682321588094, 63603.36396636067, 63612.0, 16911.661766764842, 17130.828691713174, 17144.228509716842, 17153.313867445162, 17162.056086915338, 13223.140495867738, 13288.402021909038, 13312.667183320495, 13324.133931294435, 13324.866751332556, 18285.40476659429, 19373.720794565877, 19382.601856844038, 19441.715538884502, 19522.21911123539, 6970.302969702989, 7185.425165986709, 7353.595552244571, 7367.410607151415, 7484.176740558534, 767.4627760567513, 1080.1628737728324, 1126.318577260762, 1142.3774043146504, 1214.872438393956, 32293.51559726606, 32519.837400812845, 32892.67107328944, 33017.15922301979, 33155.0, 1177.1348059176498, 1199.688081098903, 1231.599730087725, 1252.4551819958347, 1257.9245245285313, 16524.786179524144, 17276.568085797706, 17279.481615551555, 17300.65398692019, 17521.386751463637, 575493.0, 577236.0, 578043.0, 579962.0, 581455.0, 58741.0, 59280.407195928354, 59328.51678708067, 59386.0, 59428.405715943154, 1282.4677758730022, 1323.808047833078, 1376.8072469854028, 1416.199847086393, 1432.5415866922692, 29848.318813127597, 33296.334073317914, 33509.497357540145, 33596.66403335935, 33750.49374259437, 51261.0, 51314.0, 51811.222831658306, 51863.22205167001, 51882.0, 405912.0, 408374.0, 410118.0, 410575.0, 410696.0, 24500.632490513013, 26700.7329926706, 27178.864105680135, 27452.725472745016, 27472.725272747815, 47559.76220118877, 47718.284225735944, 47880.76059619679, 48845.755771220916, 49365.0, 40211.79894100628, 40747.0, 41230.38154427626, 41298.38052429276, 41309.38035929524, 34911.0, 35028.474572880914, 35287.29425411529, 35545.644543554234, 36081.0, 40867.795661021504, 40873.795631021654, 41031.17937641171, 41598.58401416068, 41757.0, 36842.447363290106, 39259.82220533388, 39310.80344598259, 39630.80184599174, 39940.40089398603, 27992.30019249535, 28203.71796282093, 28323.43353132967, 28406.147815565568, 28452.57321140226], "value": 20196.396713301394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.23521984959126, 398.3268276612525, 399.33510704676735, 403.65689164210426, 418.1490666493684, 14039.649008774786, 17100.74348884768, 18020.369287074955, 19544.31594894179, 19570.90214548929, 14328.355224014918, 17310.480685579452, 18096.366627168052, 18159.636807263847, 18874.245030198777, 5586.832395028156, 5686.289213848269, 5715.942840571583, 5730.512906402961, 5778.364379918226, 4119.9176016479805, 5672.517835983926, 5673.347565030033, 5723.055695810186, 5979.46184843364, 6009.248843894513, 6028.939710602904, 6049.243844519435, 6051.1830902828, 6057.061155520902, 6000.399960003986, 6004.699765011754, 6080.787172448987, 6087.665178415185, 6186.536009799283, 5389.191621256804, 5593.496585307301, 5616.66300022, 5621.887562248732, 5624.043912534838, 21496.462588435257, 22073.33779986603, 22086.779132208794, 22147.667784983238, 22167.889160554256, 2271.068861766684, 2314.7685231476885, 2325.988370058156, 2350.2361732437025, 2403.495265994126, 13201.537946171838, 13714.862851371458, 13735.862641373658, 13992.93003534986, 14426.06230595008, 1901.5151136460115, 1966.360932696865, 1991.0442987366146, 1997.131247907165, 2002.6495363311362, 73960.0, 75040.0, 75042.24957750407, 76742.6162869182, 77147.22852771512, 10298.897011029794, 10461.68614941553, 10729.195310351599, 10864.293820901616, 10952.4523773811, 14841.554753357417, 14906.70186596262, 14916.105033698013, 14935.850641493664, 14954.177520236273, 8035.678572857137, 8096.190380961974, 8223.0, 8239.752807415787, 8323.500589964622, 6652.70062847173, 7770.339521140653, 7773.1060927994, 7860.3318717909615, 7951.244631759973, 6106.236720409949, 6511.511636627272, 6514.120593719787, 6629.303923088103, 6669.899466587959, 1840.3926704187854, 1898.715192721103, 1948.2596613287144, 1987.0561483295608, 2017.3846976672255, 886.8226354728951, 967.5307475874196, 1094.0809719835217, 1128.7686024364984, 1161.651504548649, 18127.456176314732, 18858.52853678669, 19052.33316833932, 19104.14031368592, 19314.806851931302, 1019.3119644240109, 1048.1352883870684, 1082.9350238985528, 1089.096050278267, 1101.9779604408027, 10412.947935260427, 10886.836697449544, 10930.781384372427, 11001.779964400666, 11009.724756881142, 492481.0, 493246.0, 500878.0, 503356.0, 520357.0, 76558.61720691361, 78108.0, 78953.0, 79593.20406795974, 79925.60037199892, 1045.1899777672365, 1046.3094357724017, 1062.2829590026702, 1078.2613909472193, 1081.567373050786, 16497.587560311087, 16651.16744162763, 16651.41720039793, 16784.832151678325, 17095.0, 27622.861885690443, 36540.72107476225, 36759.81620091882, 38403.61596384112, 38862.6113738859, 48738.26892596685, 49640.0, 50743.0, 50996.74501627468, 52219.47780522146, 5708.4862362387585, 7035.366816986291, 7771.494852834548, 8202.195516986254, 8427.620757065824, 10758.569657213624, 12762.489500419879, 13078.28069456189, 13157.276349800853, 13201.669958251121, 11284.153688473561, 11511.0, 11611.88388116108, 11765.294082355085, 11842.0, 11269.943650281695, 11420.714482138013, 11459.942700286445, 11477.827832582685, 11875.940620296844, 11480.425978701198, 11601.5359385627, 11629.302241865515, 11679.766404671689, 11890.643280701594, 7678.462507624413, 7711.0, 7718.151003389735, 7843.372530197685, 8047.919520804951, 10673.57305707763, 11407.771844563229, 11717.472713727731, 11743.647690569296, 11807.0], "value": 9137.504560112688, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.5987423835738, 1493.253373313343, 1547.9212275653654, 1703.1739606290946, 1825.4523642907125, 8445.451045682026, 8788.78028049299, 8804.77988050299, 9024.639014439432, 9026.548672566361, 8699.608517616707, 8880.422772519798, 8883.555822208897, 8883.733487995354, 8884.866726999084, 2084.7498300203997, 2306.1351993002622, 2330.6270996640583, 2355.8468699534474, 2389.95220095598, 2333.183385814968, 2370.7629237076326, 2371.9644205336936, 2376.702912135983, 2392.055138220402, 2323.3030090972725, 2361.2207971369494, 2361.740208577055, 2370.3363058343607, 2378.9762102379013, 2069.668852983523, 2298.5517824024237, 2364.2552595932398, 2366.2546297916274, 2372.727136379304, 2301.0910690277415, 2303.1823702585507, 2308.653701944705, 2308.9191878284346, 2323.848949818256, 8828.690995815115, 8886.422382545114, 8892.822143557092, 8906.86639700405, 8909.198172164472, 5378.8924221515745, 5505.504504594565, 5507.394186639466, 5514.558835293167, 5515.200295957104, 3270.5584746059217, 3404.7616666833333, 3460.169559305774, 3461.7403694723, 3496.3007398520144, 1107.402002918423, 1150.3213104268439, 1157.6179860645966, 1171.2152857585438, 1182.9112816538793, 12314.261144331369, 12521.499140034388, 12536.373181340896, 12543.937280313632, 12557.623271301783, 4573.47405048417, 4766.618670506351, 4818.132736107465, 4826.0, 4831.661783675179, 10692.358458492516, 10715.83926241107, 10721.249512534203, 10725.78548429027, 10731.356118632906, 4825.034993001414, 5478.835634930959, 5484.314460692413, 5484.808031718871, 5486.396496385394, 4801.615870730333, 4939.209726443752, 4952.678075925053, 4977.726225057584, 4979.402471703346, 4028.8589899353383, 4095.3242714952294, 4148.959014797036, 4192.517860446027, 4201.0, 1282.1922189020856, 1293.7412517496539, 1297.2087026913575, 1303.3027330378202, 1324.6555895467247, 947.6020071569957, 957.1385752822515, 959.3572306554486, 963.2625413395979, 977.3988996766938, 5597.244372009808, 5654.236678048493, 5742.7415766290615, 5871.295444546682, 6054.061620448838, 438.8222769778181, 446.1077844311377, 457.03109408054473, 458.99311510327374, 1028.280203857303, 4030.5087117766616, 4102.892219100826, 4112.09533902541, 4127.9174416511505, 4137.606927341898, 10821.83767243492, 11057.612983545698, 11140.275882067639, 11144.777104457866, 11219.887801121884, 10364.948175259075, 11013.2841365311, 11129.0, 11148.442577871074, 11149.0, 8030.799230019296, 8273.710420135267, 8315.916840831514, 8334.958325208456, 8337.791555211168, 5591.8881622368135, 5856.736446859987, 6007.459328660441, 6010.429009244115, 6184.474319682698, 9895.356801807859, 10130.189584833048, 10360.948195258976, 10364.170866330825, 10371.377717336984, 10257.179425645782, 10497.895021049997, 10501.89498105009, 10520.736981575521, 10584.206184536037, 6992.825179370557, 7670.463067585216, 7928.246816552418, 7934.523928564305, 8036.357091432788, 8786.297096232158, 8809.64761409562, 8870.911290887008, 8876.378653494194, 8885.37802353855, 7490.662920168715, 7782.88325675104, 7819.828279448104, 7852.685892564234, 7856.45004849655, 7446.329830315298, 7522.887156692764, 7627.046619172604, 7736.2650548197835, 7739.7678069658, 7145.17830449505, 7213.819654508679, 7239.276072392719, 7242.96378518104, 7245.347918687344, 5043.36957880265, 5182.455842136521, 5283.524482796567, 5318.8936221276135, 5352.518273355417, 4858.489858564941, 4942.505749425029, 4992.2511623256805, 5030.84907452777, 5145.742712864417], "value": 4629.552528239099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.3562151022668, 330.90238379678, 333.3882325931915, 336.7373448710007, 337.20251604954285, 5137.280780690697, 5206.921896171556, 5228.144008876841, 5271.367435907697, 5301.575873930086, 5155.355580552431, 5182.404023537294, 5184.818531351403, 5220.6606570572885, 5249.816256431026, 4087.386891966199, 4090.3455447128467, 4101.569335219789, 4102.835886564534, 4117.3618089196225, 3929.744566603176, 4086.8160932758096, 4095.385692146172, 4136.751794892301, 4137.710360274782, 3928.6464218220353, 3983.721139520235, 3983.780892050936, 3984.4620976168135, 3987.6809855211513, 4020.8592699255387, 4020.899477513071, 4025.9597404025876, 4026.0, 4031.689700847207, 3550.5916819565823, 3553.7690050146916, 3556.5020897074432, 3561.7684850484634, 3572.481695279522, 4800.0, 5043.52086551777, 5052.242163675442, 5079.974600127012, 5119.513646203604, 4648.1865673507, 4648.628109751212, 4653.0, 4658.58072773452, 4666.603338716213, 5438.755256013489, 5455.099908515091, 5498.230247765316, 5499.075323636735, 5507.917381239285, 3853.499045124116, 3893.7274390792654, 3935.468711723909, 3948.7828169450668, 3956.287868183726, 5417.591426229169, 5422.783088676449, 5637.887242255173, 5638.4361563843695, 5661.575381846378, 3914.1388894443176, 3942.3495123304906, 3947.4276229946495, 3953.3081710700512, 3960.1683646433994, 3817.1983883384246, 3932.2528719543766, 3990.660793832557, 4012.6188012139382, 4023.939640905389, 4555.111753208159, 4568.834947088538, 4570.702904311209, 4593.839215627437, 4599.2871104978785, 5410.296661433988, 5421.403645598981, 5422.91865622016, 5452.536534394541, 5453.700046497402, 1331.8934485241157, 1352.4319785689836, 1354.3282196165237, 1378.200643626694, 1387.3063468265866, 864.7535452396037, 877.7667377334855, 886.2998231397124, 887.8801361816072, 888.5379602606608, 4674.275487299406, 4706.952930470651, 4733.573978341966, 4767.76161191939, 4784.952150478521, 5031.547160755549, 5042.6384876083985, 5046.722430266297, 5049.520295571915, 5052.671576347526, 4586.334981427674, 4791.928121078186, 4797.848516356049, 4799.616030717534, 4804.591609713214, 2651.3106592286144, 2651.840889546633, 2652.2441104285185, 2653.9469210616066, 2701.986490067537, 5028.84913452597, 5037.773300201499, 5107.897842043139, 5134.948650513522, 5176.249443830623, 4813.975930120327, 5000.39995200571, 5016.749162541858, 5036.697798132123, 5074.238864170404, 5040.437464385979, 5050.520200580939, 5055.241713742968, 5108.438071812097, 5120.746871376582, 4902.431222008923, 4956.256561515802, 4967.7019378837385, 4975.925361119514, 5336.279602253646, 5170.27616133734, 5510.0, 5519.199716041071, 5539.667619942817, 5539.7784088636, 5709.942900570941, 5730.283714535683, 5732.7706891723865, 5740.942590574041, 5765.509931655856, 3801.201747633028, 3943.0, 3958.524977002663, 3963.8612648557164, 3967.682585393219, 5539.113741801292, 5575.330960284792, 5588.916166257428, 5597.356304025089, 5665.461781130786, 5480.808171713971, 5501.972490137524, 5502.862428439321, 5507.862303442446, 5526.613137080527, 5192.3769147702515, 5434.945650543444, 5445.2104444854485, 5449.482299181572, 5491.670499770026, 5251.36983561975, 5310.548603368602, 5333.666583354161, 5335.813246536352, 5339.519443250126, 5426.538744206787, 5429.294191755047, 5466.590005749665, 5471.753771080232, 5475.342958844964, 5122.206058061007, 5325.973370133124, 5359.276497672764, 5477.0830209426385, 5479.643823151482], "value": 4042.691094147847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.441713132282, 803.8553060449119, 817.5544328341053, 821.2403526737766, 841.1798496465947, 13886.4445422183, 13998.790018149735, 14446.349914253857, 14820.184889831055, 15182.620434489143, 13727.725445491084, 13833.239171845544, 13873.653158671039, 13874.375653095609, 13886.236257005861, 669.8492839111185, 763.3664058831184, 776.5806464509159, 788.9723859664913, 789.104366543971, 795.1015352651496, 797.9361651067901, 798.1340245833248, 798.1619299735283, 798.5767543202084, 839.6935118681668, 842.7556008757483, 843.1105184030845, 844.1769274956898, 844.1769274956929, 700.7862601906392, 816.2898278497686, 835.8620827563444, 837.4849467577426, 838.0153319849184, 601.6089541797822, 602.1569802276804, 602.7227475361339, 602.9909551356733, 603.7916918663054, 13824.723505529933, 13860.93069534656, 13864.514741983981, 13870.722585548232, 13871.930640346734, 13282.667933301647, 13756.312184390741, 13761.532079922421, 13958.790618140736, 14255.50105746294, 11001.944990275077, 11320.26418282809, 11609.07127429812, 11657.94171029148, 11781.175317727762, 4546.522615125397, 4562.931556026662, 4573.314002899559, 4754.738489383082, 4758.666893317469, 57925.46968894017, 58977.41022589762, 59429.70285148547, 59599.70200148971, 60828.0, 10508.842367364496, 10632.681019569425, 10817.675469735921, 10852.565897364175, 11133.832992505118, 17889.10554472271, 18029.368972086177, 18430.539236518925, 18450.0, 18460.81539184618, 8212.58937053145, 8252.876206856901, 8264.876026859602, 8273.379496537784, 8433.704820331383, 4697.78859951303, 4771.06964141989, 4787.138315103315, 4796.37647105881, 5059.241113832954, 3284.5730055092686, 3343.7993720376853, 3355.261842394669, 3357.916052098717, 3360.630330663625, 616.8612062285949, 621.6860485454816, 635.4122436745992, 672.909157263773, 683.2006552333781, 653.7940548727136, 690.3924546399137, 744.0, 754.4869488747595, 763.2367632367632, 9374.437533747998, 9915.157211636948, 9965.35225210359, 10026.949865250626, 10040.748981275381, 568.1109064314335, 617.3517806303364, 660.21764209412, 709.1667290933133, 713.2225873797482, 4388.868333949987, 4618.399608050931, 4738.526147385234, 4846.079244943449, 5052.9747351263, 68576.6571167141, 74569.0, 75069.24930750622, 75097.0, 75235.24764752282, 54281.185782213295, 55382.723086385115, 64382.356176438574, 65992.0, 69101.65449172823, 55910.0, 56144.71927640335, 57795.42204577901, 59160.40839591635, 60976.39023609707, 8954.373193876367, 9153.267738580764, 9337.579808908751, 9365.953170234105, 9413.623455061721, 37269.440958386185, 37755.24489510249, 38166.80916595399, 38209.6179038206, 38428.03929901775, 45196.54803451923, 45552.772236138604, 45769.0, 46062.539374607164, 50524.74737626289, 12751.298678572768, 12778.74442511126, 12922.870771292542, 12927.741445171232, 13379.197248165141, 13673.453061877413, 13813.723725525635, 13965.022448428512, 14361.856381436051, 14589.562313130624, 13518.391672374963, 13631.318434078057, 13796.0, 13798.17210967345, 13943.059859891651, 13190.631732573356, 13519.459221631418, 13783.173009619455, 13830.654233643836, 14041.535380973986, 12512.937435312766, 12631.747365052832, 13004.0, 13303.733925321632, 13737.381817818423, 10812.945935270272, 10832.945835270773, 10997.175211859303, 11190.160737944849, 11436.542538298374, 11153.665390038312, 11160.832587511031, 11210.383428911487, 11249.550017999189, 11294.887051129712], "value": 6962.154350712435, "unit": "score"}], "name": "dromaeo_css", "value": 7128.885835037745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 105.0, 109.0, 110.0, 110.0, 109.0, 109.0, 111.0, 111.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 130.0, 181.0, 135.0, 128.0, 147.0, 129.0, 153.0, 124.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 161.0, 162.0, 160.0, 161.0, 161.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 125.0, 75.0, 75.0, 75.0, 75.0, 98.0, 73.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 107.0, 82.0, 83.0, 83.0, 121.0, 82.0, 82.0, 121.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 144.0, 148.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 79.0, 79.0, 80.0, 80.0, 79.0, 81.0, 118.0, 79.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 130.0, 123.0, 127.0, 127.0, 119.0, 118.0, 130.0, 120.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 166.0, 169.0, 167.0, 165.0, 162.0, 160.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 62.0, 64.0, 62.0, 61.0, 61.0, 60.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1492.2000000000003, "alertThreshold": 2.0}]} 03:18:11 INFO - Return code: 0 03:18:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:18:11 ERROR - # TBPL SUCCESS # 03:18:11 INFO - Running post-action listener: _resource_record_post_action 03:18:11 INFO - ##### 03:18:11 INFO - ##### Finished run-tests step (success) 03:18:11 INFO - ##### 03:18:11 INFO - Running post-run listener: _resource_record_post_run 03:18:11 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7831552; Write bytes: 434200576; Read time: 1780; Write time: 373596 03:18:11 INFO - TinderboxPrint: CPU usage
13.2% 03:18:11 INFO - TinderboxPrint: I/O read bytes / time
7,831,552 / 1,780 03:18:11 INFO - TinderboxPrint: I/O write bytes / time
434,200,576 / 373,596 03:18:11 INFO - TinderboxPrint: CPU idle
8,270.2 (86.8%) 03:18:11 INFO - TinderboxPrint: CPU user
1,212.3 (12.7%) 03:18:11 INFO - TinderboxPrint: Swap in / out
0 / 0 03:18:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15466496; Read time: 0; Write time: 10080 03:18:11 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6070272; Write bytes: 408043520; Read time: 1724; Write time: 361948 03:18:11 INFO - Running post-run listener: _upload_blobber_files 03:18:11 INFO - Blob upload gear active. 03:18:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:18:11 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 03:18:11 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:18:11 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:18:12 INFO - (blobuploader) - INFO - Open directory for files ... 03:18:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:18:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:18:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:13 INFO - (blobuploader) - INFO - Done attempting. 03:18:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:17 INFO - (blobuploader) - INFO - Done attempting. 03:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:17 INFO - (blobuploader) - INFO - Done attempting. 03:18:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:18 INFO - Return code: 0 03:18:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5ac32810c16e4e4e19ae7a186e6f7c0ceaa7026df81c9132a8096db415238e338ac223070f499a4062b016072e5be08959272ba7c422c1d45ee00ec623c225f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55e65cc6015aac4e09b94725b8222e025c512f78b4c6da43e80dac09a7b3ef77a927dcc554cb57931384fcac812b6526f1ee96f8f89de53265fa877029ee509d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bca41b11cdaa0fc8eeb640660c42da4869cfd1763f245b032d3c6d287075b54ccf823655bb192b60d4f5de68d35d59e41a7e96ba348a8ca96bef4b445c236a5c"} 03:18:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:18 INFO - Contents: 03:18:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5ac32810c16e4e4e19ae7a186e6f7c0ceaa7026df81c9132a8096db415238e338ac223070f499a4062b016072e5be08959272ba7c422c1d45ee00ec623c225f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55e65cc6015aac4e09b94725b8222e025c512f78b4c6da43e80dac09a7b3ef77a927dcc554cb57931384fcac812b6526f1ee96f8f89de53265fa877029ee509d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bca41b11cdaa0fc8eeb640660c42da4869cfd1763f245b032d3c6d287075b54ccf823655bb192b60d4f5de68d35d59e41a7e96ba348a8ca96bef4b445c236a5c"} 03:18:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:18 INFO - Copying logs to upload dir... 03:18:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.556335 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-01 03:18:18.082326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 03:18:18.086101) ========= 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=ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5ac32810c16e4e4e19ae7a186e6f7c0ceaa7026df81c9132a8096db415238e338ac223070f499a4062b016072e5be08959272ba7c422c1d45ee00ec623c225f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55e65cc6015aac4e09b94725b8222e025c512f78b4c6da43e80dac09a7b3ef77a927dcc554cb57931384fcac812b6526f1ee96f8f89de53265fa877029ee509d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bca41b11cdaa0fc8eeb640660c42da4869cfd1763f245b032d3c6d287075b54ccf823655bb192b60d4f5de68d35d59e41a7e96ba348a8ca96bef4b445c236a5c"} build_url:https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5ac32810c16e4e4e19ae7a186e6f7c0ceaa7026df81c9132a8096db415238e338ac223070f499a4062b016072e5be08959272ba7c422c1d45ee00ec623c225f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55e65cc6015aac4e09b94725b8222e025c512f78b4c6da43e80dac09a7b3ef77a927dcc554cb57931384fcac812b6526f1ee96f8f89de53265fa877029ee509d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bca41b11cdaa0fc8eeb640660c42da4869cfd1763f245b032d3c6d287075b54ccf823655bb192b60d4f5de68d35d59e41a7e96ba348a8ca96bef4b445c236a5c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 03:18:18.111773) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:18:18.112103) ========= 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=ed14279e38b05397cf4aa391000001a4-1464775055.344076-1510586479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:18:18.197478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 03:18:18.197811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 03:18:18.198127) ========= ========= Total master_lag: 0.27 =========