builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1464341016.65 results: success (0) buildid: 20160526234010 builduid: 1fac386594054b37b7b6ee75bad88733 revision: 919296e383f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.645768) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.646147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.646417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.668169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.668426) ========= 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=fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 02:23:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-05-27 02:23:37 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.806262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.806542) ========= 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=fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016137 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.855252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:36.855581) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 919296e383f6 --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 919296e383f6 --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=fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 02:23:37,428 Setting DEBUG logging. 2016-05-27 02:23:37,428 attempt 1/10 2016-05-27 02:23:37,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/919296e383f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 02:23:37,755 unpacking tar archive at: mozilla-inbound-919296e383f6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674434 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:37.543494) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:37.543900) ========= script_repo_revision: 919296e383f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:37.544355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:37.544625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 02:23:37.555070) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-27 02:23:37.555478) ========= /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=fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:23:38 INFO - MultiFileLogger online at 20160527 02:23:38 in /builds/slave/test 02:23:38 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:23:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:23:38 INFO - {'append_to_log': False, 02:23:38 INFO - 'base_work_dir': '/builds/slave/test', 02:23:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:23:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:23:38 INFO - 'branch': 'Mozilla-Inbound', 02:23:38 INFO - 'buildbot_json_path': 'buildprops.json', 02:23:38 INFO - 'config_files': ('talos/linux_config.py',), 02:23:38 INFO - 'default_actions': ('clobber', 02:23:38 INFO - 'read-buildbot-config', 02:23:38 INFO - 'download-and-extract', 02:23:38 INFO - 'populate-webroot', 02:23:38 INFO - 'create-virtualenv', 02:23:38 INFO - 'install', 02:23:38 INFO - 'run-tests'), 02:23:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:23:38 INFO - 'download_minidump_stackwalk': True, 02:23:38 INFO - 'download_symbols': 'ondemand', 02:23:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:23:38 INFO - 'tooltool.py': '/tools/tooltool.py', 02:23:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:23:38 INFO - '/tools/misc-python/virtualenv.py')}, 02:23:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:23:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:23:38 INFO - 'installer_path': 'installer.exe', 02:23:38 INFO - 'log_level': 'info', 02:23:38 INFO - 'log_name': 'talos', 02:23:38 INFO - 'log_to_console': True, 02:23:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:23:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:23:38 INFO - 'opt_config_files': (), 02:23:38 INFO - 'pip_index': False, 02:23:38 INFO - 'sps_profile': False, 02:23:38 INFO - 'sps_profile_interval': 0, 02:23:38 INFO - 'suite': 'dromaeojs', 02:23:38 INFO - 'system_bits': '32', 02:23:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:23:38 INFO - 'title': 'talos-linux64-ix-048', 02:23:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:23:38 INFO - 'use_talos_json': True, 02:23:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:23:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:23:38 INFO - 'work_dir': 'build'} 02:23:38 INFO - ##### 02:23:38 INFO - ##### Running clobber step. 02:23:38 INFO - ##### 02:23:38 INFO - Running pre-action listener: _resource_record_pre_action 02:23:38 INFO - Running main action method: clobber 02:23:38 INFO - rmtree: /builds/slave/test/build 02:23:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:23:39 INFO - Running post-action listener: _resource_record_post_action 02:23:39 INFO - ##### 02:23:39 INFO - ##### Finished clobber step (success) 02:23:39 INFO - ##### 02:23:39 INFO - ##### 02:23:39 INFO - ##### Running read-buildbot-config step. 02:23:39 INFO - ##### 02:23:39 INFO - Running pre-action listener: _resource_record_pre_action 02:23:39 INFO - Running main action method: read_buildbot_config 02:23:39 INFO - Using buildbot properties: 02:23:39 INFO - { 02:23:39 INFO - "project": "", 02:23:39 INFO - "product": "firefox", 02:23:39 INFO - "script_repo_revision": "production", 02:23:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:23:39 INFO - "repository": "", 02:23:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 02:23:39 INFO - "buildid": "20160526234010", 02:23:39 INFO - "pgo_build": "True", 02:23:39 INFO - "basedir": "/builds/slave/test", 02:23:39 INFO - "buildnumber": 1859, 02:23:39 INFO - "slavename": "talos-linux64-ix-048", 02:23:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:23:39 INFO - "platform": "ubuntu64_hw", 02:23:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:23:39 INFO - "branch": "mozilla-inbound", 02:23:39 INFO - "repo_path": "integration/mozilla-inbound", 02:23:39 INFO - "revision": "919296e383f6", 02:23:39 INFO - "stage_platform": "linux64-pgo", 02:23:39 INFO - "builduid": "1fac386594054b37b7b6ee75bad88733", 02:23:39 INFO - "slavebuilddir": "test" 02:23:39 INFO - } 02:23:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:23:39 INFO - Running post-action listener: _resource_record_post_action 02:23:39 INFO - ##### 02:23:39 INFO - ##### Finished read-buildbot-config step (success) 02:23:39 INFO - ##### 02:23:39 INFO - ##### 02:23:39 INFO - ##### Running download-and-extract step. 02:23:39 INFO - ##### 02:23:39 INFO - Running pre-action listener: _resource_record_pre_action 02:23:39 INFO - Running main action method: download_and_extract 02:23:39 INFO - mkdir: /builds/slave/test/build/tests 02:23: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:23:39 INFO - https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:23:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:23:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:23:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:47 INFO - Downloaded 1361 bytes. 02:23:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:23:47 INFO - Using the following test package requirements: 02:23:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:23:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:23:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:23:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:47 INFO - u'jsshell-linux-x86_64.zip'], 02:23:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:23:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:23:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:23:47 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:23:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:23:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:23:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:47 INFO - https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:51 INFO - Downloaded 24410585 bytes. 02:23:51 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:23:51 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:23:53 INFO - Return code: 0 02:23:53 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:23: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:23:53 INFO - https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:54 INFO - Downloaded 24410585 bytes. 02:23:54 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:23:54 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:23:56 INFO - Return code: 0 02:23:56 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:23:56 INFO - https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:23:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:57 INFO - Downloaded 10834034 bytes. 02:23:57 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:23:57 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:23:57 INFO - Return code: 0 02:23: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:23:57 INFO - https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:23:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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:23:59 INFO - Downloaded 58683660 bytes. 02:23:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:59 INFO - mkdir: /builds/slave/test/properties 02:23:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:23:59 INFO - Writing to file /builds/slave/test/properties/build_url 02:23:59 INFO - Contents: 02:23:59 INFO - build_url:https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:59 INFO - Running post-action listener: _resource_record_post_action 02:23:59 INFO - Running post-action listener: set_extra_try_arguments 02:23:59 INFO - ##### 02:23:59 INFO - ##### Finished download-and-extract step (success) 02:23:59 INFO - ##### 02:23:59 INFO - ##### 02:23:59 INFO - ##### Running populate-webroot step. 02:23:59 INFO - ##### 02:23:59 INFO - Running pre-action listener: _resource_record_pre_action 02:23:59 INFO - Running main action method: populate_webroot 02:23:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:23:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:23:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:23:59 INFO - '--tppagecycles', 02:23:59 INFO - '7'], 02:23:59 INFO - 'tests': ['tsvgm']}}, 02:23:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:23:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:23:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:23:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:23:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:59 INFO - 'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:59 INFO - 'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['damp', 'tps']}, 02:23:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:59 INFO - 'tests': ['damp', 'tps']}, 02:23:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['dromaeo_dom']}, 02:23:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:23:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['a11yr', 02:23:59 INFO - 'ts_paint', 02:23:59 INFO - 'tpaint', 02:23:59 INFO - 'sessionrestore', 02:23:59 INFO - 'sessionrestore_no_auto_restore', 02:23:59 INFO - 'tabpaint']}, 02:23:59 INFO - 'other-e10s': {'tests': ['a11yr', 02:23:59 INFO - 'ts_paint', 02:23:59 INFO - 'tpaint', 02:23:59 INFO - 'sessionrestore', 02:23:59 INFO - 'sessionrestore_no_auto_restore', 02:23:59 INFO - 'tabpaint']}, 02:23:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:23:59 INFO - 'ts_paint', 02:23:59 INFO - 'tpaint', 02:23:59 INFO - 'sessionrestore', 02:23:59 INFO - 'sessionrestore_no_auto_restore', 02:23:59 INFO - 'tabpaint']}, 02:23:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:23:59 INFO - 'ts_paint', 02:23:59 INFO - 'tpaint', 02:23:59 INFO - 'sessionrestore', 02:23:59 INFO - 'sessionrestore_no_auto_restore', 02:23:59 INFO - 'tabpaint']}, 02:23:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['a11yr', 02:23:59 INFO - 'ts_paint', 02:23:59 INFO - 'tpaint', 02:23:59 INFO - 'sessionrestore', 02:23:59 INFO - 'sessionrestore_no_auto_restore', 02:23:59 INFO - 'tabpaint']}, 02:23:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['a11yr', 02:23:59 INFO - 'ts_paint', 02:23:59 INFO - 'tpaint', 02:23:59 INFO - 'sessionrestore', 02:23:59 INFO - 'sessionrestore_no_auto_restore', 02:23:59 INFO - 'tabpaint']}, 02:23:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['tsvgx', 02:23:59 INFO - 'tsvgr_opacity', 02:23:59 INFO - 'tart', 02:23:59 INFO - 'tscrollx', 02:23:59 INFO - 'cart']}, 02:23:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:23:59 INFO - 'tsvgr_opacity', 02:23:59 INFO - 'tart', 02:23:59 INFO - 'tscrollx', 02:23:59 INFO - 'cart']}, 02:23:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:59 INFO - 'talos_options': ['--disable-e10s'], 02:23:59 INFO - 'tests': ['tp5o']}, 02:23:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:59 INFO - 'tests': ['tp5o']}, 02:23:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:59 INFO - 'talos_options': ['--disable-e10s', 02:23:59 INFO - '--xperf_path', 02:23:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:59 INFO - 'tests': ['tp5n']}, 02:23:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:59 INFO - 'talos_options': ['--xperf_path', 02:23:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:59 INFO - 'tests': ['tp5n']}}, 02:23:59 INFO - 'talos.zip': {'path': '', 02:23:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:23:59 INFO - Running post-action listener: _resource_record_post_action 02:23:59 INFO - ##### 02:23:59 INFO - ##### Finished populate-webroot step (success) 02:23:59 INFO - ##### 02:23:59 INFO - ##### 02:23:59 INFO - ##### Running create-virtualenv step. 02:23:59 INFO - ##### 02:23:59 INFO - Running pre-action listener: _resource_record_pre_action 02:23:59 INFO - Running main action method: create_virtualenv 02:23:59 INFO - Creating virtualenv /builds/slave/test/build/venv 02:23:59 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:23:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:24:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:24:00 INFO - Using real prefix '/usr' 02:24:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:24:00 INFO - Installing distribute.............................................................................................................................................................................................done. 02:24:02 INFO - Installing pip.................done. 02:24:02 INFO - Return code: 0 02:24:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:24:02 INFO - Using env: {'DISPLAY': ':0', 02:24:02 INFO - 'HOME': '/home/cltbld', 02:24:02 INFO - 'LANG': 'en_US.UTF-8', 02:24:02 INFO - 'LANGUAGE': 'en_US:en', 02:24:02 INFO - 'LOGNAME': 'cltbld', 02:24:02 INFO - 'MAIL': '/var/mail/cltbld', 02:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:02 INFO - 'MOZ_NO_REMOTE': '1', 02:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:02 INFO - 'NO_EM_RESTART': '1', 02:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:02 INFO - 'PWD': '/builds/slave/test', 02:24:02 INFO - 'SHELL': '/bin/bash', 02:24:02 INFO - 'SHLVL': '1', 02:24:02 INFO - 'TERM': 'linux', 02:24:02 INFO - 'TMOUT': '86400', 02:24:02 INFO - 'USER': 'cltbld', 02:24:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:02 INFO - '_': '/tools/buildbot/bin/python'} 02:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:02 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:24:02 INFO - Cleaning up... 02:24:02 INFO - Return code: 0 02:24:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:24:02 INFO - Using env: {'DISPLAY': ':0', 02:24:02 INFO - 'HOME': '/home/cltbld', 02:24:02 INFO - 'LANG': 'en_US.UTF-8', 02:24:02 INFO - 'LANGUAGE': 'en_US:en', 02:24:02 INFO - 'LOGNAME': 'cltbld', 02:24:02 INFO - 'MAIL': '/var/mail/cltbld', 02:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:02 INFO - 'MOZ_NO_REMOTE': '1', 02:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:02 INFO - 'NO_EM_RESTART': '1', 02:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:02 INFO - 'PWD': '/builds/slave/test', 02:24:02 INFO - 'SHELL': '/bin/bash', 02:24:02 INFO - 'SHLVL': '1', 02:24:02 INFO - 'TERM': 'linux', 02:24:02 INFO - 'TMOUT': '86400', 02:24:02 INFO - 'USER': 'cltbld', 02:24:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:02 INFO - '_': '/tools/buildbot/bin/python'} 02:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:02 INFO - Downloading/unpacking psutil>=3.1.1 02:24: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:24: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:24: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:24: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:24: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:24: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:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:24:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:04 INFO - Installing collected packages: psutil 02:24:04 INFO - Running setup.py install for psutil 02:24:05 INFO - building 'psutil._psutil_linux' extension 02:24:05 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:24:05 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:24:05 INFO - building 'psutil._psutil_posix' extension 02:24:05 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:24:05 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:24:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:05 INFO - Successfully installed psutil 02:24:05 INFO - Cleaning up... 02:24:05 INFO - Return code: 0 02:24:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:05 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 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:05 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:24:05 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:24:05 INFO - Using env: {'DISPLAY': ':0', 02:24:05 INFO - 'HOME': '/home/cltbld', 02:24:05 INFO - 'LANG': 'en_US.UTF-8', 02:24:05 INFO - 'LANGUAGE': 'en_US:en', 02:24:05 INFO - 'LOGNAME': 'cltbld', 02:24:05 INFO - 'MAIL': '/var/mail/cltbld', 02:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:05 INFO - 'MOZ_NO_REMOTE': '1', 02:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:05 INFO - 'NO_EM_RESTART': '1', 02:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:05 INFO - 'PWD': '/builds/slave/test', 02:24:05 INFO - 'SHELL': '/bin/bash', 02:24:05 INFO - 'SHLVL': '1', 02:24:05 INFO - 'TERM': 'linux', 02:24:05 INFO - 'TMOUT': '86400', 02:24:05 INFO - 'USER': 'cltbld', 02:24:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:05 INFO - '_': '/tools/buildbot/bin/python'} 02:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:24:05 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:24:05 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:24:05 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:24:05 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:24:05 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:24:05 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:24:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:24:07 INFO - Installing collected packages: mozsystemmonitor 02:24:07 INFO - Running setup.py install for mozsystemmonitor 02:24:07 INFO - Successfully installed mozsystemmonitor 02:24:07 INFO - Cleaning up... 02:24:07 INFO - Return code: 0 02:24:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:07 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 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:07 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:24:07 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:24:07 INFO - Using env: {'DISPLAY': ':0', 02:24:07 INFO - 'HOME': '/home/cltbld', 02:24:07 INFO - 'LANG': 'en_US.UTF-8', 02:24:07 INFO - 'LANGUAGE': 'en_US:en', 02:24:07 INFO - 'LOGNAME': 'cltbld', 02:24:07 INFO - 'MAIL': '/var/mail/cltbld', 02:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:07 INFO - 'MOZ_NO_REMOTE': '1', 02:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:07 INFO - 'NO_EM_RESTART': '1', 02:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:07 INFO - 'PWD': '/builds/slave/test', 02:24:07 INFO - 'SHELL': '/bin/bash', 02:24:07 INFO - 'SHLVL': '1', 02:24:07 INFO - 'TERM': 'linux', 02:24:07 INFO - 'TMOUT': '86400', 02:24:07 INFO - 'USER': 'cltbld', 02:24:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:07 INFO - '_': '/tools/buildbot/bin/python'} 02:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:24: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:24: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:24: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:24: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:24: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:24: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:24:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:24:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:10 INFO - Downloading docopt-0.6.1.tar.gz 02:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:10 INFO - Running setup.py install for blobuploader 02:24:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:24:10 INFO - Running setup.py install for requests 02:24:11 INFO - Running setup.py install for docopt 02:24:11 INFO - Successfully installed blobuploader requests docopt 02:24:11 INFO - Cleaning up... 02:24:11 INFO - Return code: 0 02:24:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24: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:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:11 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 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:11 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:24:11 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:24:11 INFO - Using env: {'DISPLAY': ':0', 02:24:11 INFO - 'HOME': '/home/cltbld', 02:24:11 INFO - 'LANG': 'en_US.UTF-8', 02:24:11 INFO - 'LANGUAGE': 'en_US:en', 02:24:11 INFO - 'LOGNAME': 'cltbld', 02:24:11 INFO - 'MAIL': '/var/mail/cltbld', 02:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:11 INFO - 'MOZ_NO_REMOTE': '1', 02:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:11 INFO - 'NO_EM_RESTART': '1', 02:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:11 INFO - 'PWD': '/builds/slave/test', 02:24:11 INFO - 'SHELL': '/bin/bash', 02:24:11 INFO - 'SHLVL': '1', 02:24:11 INFO - 'TERM': 'linux', 02:24:11 INFO - 'TMOUT': '86400', 02:24:11 INFO - 'USER': 'cltbld', 02:24:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:11 INFO - '_': '/tools/buildbot/bin/python'} 02:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:11 INFO - Running setup.py (path:/tmp/pip-ZlBZ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:11 INFO - Running setup.py (path:/tmp/pip-CMAMq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:11 INFO - Running setup.py (path:/tmp/pip-OTr6iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:11 INFO - Running setup.py (path:/tmp/pip-FxRWKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:11 INFO - Running setup.py (path:/tmp/pip-y0AUC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:11 INFO - Running setup.py (path:/tmp/pip-jlEPQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:11 INFO - Running setup.py (path:/tmp/pip-9gq9zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:11 INFO - Running setup.py (path:/tmp/pip-RIjv0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:12 INFO - Running setup.py (path:/tmp/pip-jNzHjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:12 INFO - Running setup.py (path:/tmp/pip-iErNla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:12 INFO - Running setup.py (path:/tmp/pip-Z83QeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:12 INFO - Running setup.py (path:/tmp/pip-4U9sYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:12 INFO - Running setup.py (path:/tmp/pip-sbA9Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:12 INFO - Running setup.py (path:/tmp/pip-Vm8Q0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:12 INFO - Running setup.py (path:/tmp/pip-dm6rl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:12 INFO - Running setup.py (path:/tmp/pip-EqoCMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:12 INFO - Running setup.py (path:/tmp/pip-BayzYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:24:12 INFO - Running setup.py install for manifestparser 02:24:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:24:12 INFO - Running setup.py install for mozcrash 02:24:12 INFO - Running setup.py install for mozdebug 02:24:13 INFO - Running setup.py install for mozdevice 02:24:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Running setup.py install for mozfile 02:24:13 INFO - Running setup.py install for mozhttpd 02:24:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Running setup.py install for mozinfo 02:24:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Running setup.py install for mozInstall 02:24:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Running setup.py install for mozleak 02:24:13 INFO - Running setup.py install for mozlog 02:24:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Running setup.py install for moznetwork 02:24:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:24:13 INFO - Running setup.py install for mozprocess 02:24:13 INFO - Running setup.py install for mozprofile 02:24:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:24:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:24:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:24:14 INFO - Running setup.py install for mozrunner 02:24:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:24:14 INFO - Running setup.py install for mozscreenshot 02:24:14 INFO - Running setup.py install for moztest 02:24:14 INFO - Running setup.py install for mozversion 02:24:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:24:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:24:14 INFO - Cleaning up... 02:24:14 INFO - Return code: 0 02:24:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:14 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 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:14 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:24:14 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:24:14 INFO - Using env: {'DISPLAY': ':0', 02:24:14 INFO - 'HOME': '/home/cltbld', 02:24:14 INFO - 'LANG': 'en_US.UTF-8', 02:24:14 INFO - 'LANGUAGE': 'en_US:en', 02:24:14 INFO - 'LOGNAME': 'cltbld', 02:24:14 INFO - 'MAIL': '/var/mail/cltbld', 02:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:14 INFO - 'MOZ_NO_REMOTE': '1', 02:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:14 INFO - 'NO_EM_RESTART': '1', 02:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:14 INFO - 'PWD': '/builds/slave/test', 02:24:14 INFO - 'SHELL': '/bin/bash', 02:24:14 INFO - 'SHLVL': '1', 02:24:14 INFO - 'TERM': 'linux', 02:24:14 INFO - 'TMOUT': '86400', 02:24:14 INFO - 'USER': 'cltbld', 02:24:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:14 INFO - '_': '/tools/buildbot/bin/python'} 02:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:14 INFO - Running setup.py (path:/tmp/pip-MLrt3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:14 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:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:14 INFO - Running setup.py (path:/tmp/pip-Bs7iQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:14 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:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:14 INFO - Running setup.py (path:/tmp/pip-y3DMGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:14 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:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:14 INFO - Running setup.py (path:/tmp/pip-2Hdpby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:15 INFO - Running setup.py (path:/tmp/pip-CvOv5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:15 INFO - Running setup.py (path:/tmp/pip-e8SGYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:15 INFO - Running setup.py (path:/tmp/pip-xl0cQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:15 INFO - Running setup.py (path:/tmp/pip-jnqnA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:15 INFO - Running setup.py (path:/tmp/pip-jdN3Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:15 INFO - Running setup.py (path:/tmp/pip-sZBpgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:15 INFO - Running setup.py (path:/tmp/pip-zPItOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:15 INFO - Running setup.py (path:/tmp/pip-sMwGQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:15 INFO - Running setup.py (path:/tmp/pip-8Cfxw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:15 INFO - Running setup.py (path:/tmp/pip-OJO8M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:15 INFO - Running setup.py (path:/tmp/pip-kHAPeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:15 INFO - Running setup.py (path:/tmp/pip-UnV3cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:15 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:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:15 INFO - Running setup.py (path:/tmp/pip-Gd7lNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:24: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:24: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:24: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:24: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:24: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:24: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:24:17 INFO - Downloading blessings-1.6.tar.gz 02:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:24:17 INFO - Installing collected packages: blessings 02:24:17 INFO - Running setup.py install for blessings 02:24:18 INFO - Successfully installed blessings 02:24:18 INFO - Cleaning up... 02:24:18 INFO - Return code: 0 02:24:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:24:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:18 INFO - Reading from file tmpfile_stdout 02:24:18 INFO - Current package versions: 02:24:18 INFO - argparse == 1.2.1 02:24:18 INFO - blessings == 1.6 02:24:18 INFO - blobuploader == 1.2.4 02:24:18 INFO - docopt == 0.6.1 02:24:18 INFO - manifestparser == 1.1 02:24:18 INFO - mozInstall == 1.12 02:24:18 INFO - mozcrash == 0.17 02:24:18 INFO - mozdebug == 0.1 02:24:18 INFO - mozdevice == 0.48 02:24:18 INFO - mozfile == 1.2 02:24:18 INFO - mozhttpd == 0.7 02:24:18 INFO - mozinfo == 0.9 02:24:18 INFO - mozleak == 0.1 02:24:18 INFO - mozlog == 3.2 02:24:18 INFO - moznetwork == 0.27 02:24:18 INFO - mozprocess == 0.22 02:24:18 INFO - mozprofile == 0.28 02:24:18 INFO - mozrunner == 6.11 02:24:18 INFO - mozscreenshot == 0.1 02:24:18 INFO - mozsystemmonitor == 0.3 02:24:18 INFO - moztest == 0.7 02:24:18 INFO - mozversion == 1.4 02:24:18 INFO - psutil == 3.1.1 02:24:18 INFO - requests == 1.2.3 02:24:18 INFO - wsgiref == 0.1.2 02:24:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:18 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:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:18 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:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:18 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 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:18 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:24:18 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:24:18 INFO - Using env: {'DISPLAY': ':0', 02:24:18 INFO - 'HOME': '/home/cltbld', 02:24:18 INFO - 'LANG': 'en_US.UTF-8', 02:24:18 INFO - 'LANGUAGE': 'en_US:en', 02:24:18 INFO - 'LOGNAME': 'cltbld', 02:24:18 INFO - 'MAIL': '/var/mail/cltbld', 02:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:18 INFO - 'MOZ_NO_REMOTE': '1', 02:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:18 INFO - 'NO_EM_RESTART': '1', 02:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:18 INFO - 'PWD': '/builds/slave/test', 02:24:18 INFO - 'SHELL': '/bin/bash', 02:24:18 INFO - 'SHLVL': '1', 02:24:18 INFO - 'TERM': 'linux', 02:24:18 INFO - 'TMOUT': '86400', 02:24:18 INFO - 'USER': 'cltbld', 02:24:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:18 INFO - '_': '/tools/buildbot/bin/python'} 02:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:18 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:24:18 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:24:18 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:24:18 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:24:18 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:24:18 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:24:18 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:24:18 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:24:18 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:24:18 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:24:18 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:24:18 INFO - Cleaning up... 02:24:18 INFO - Return code: 0 02:24:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:24:18 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:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:18 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:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:18 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 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:18 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:24:18 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:24:18 INFO - Using env: {'DISPLAY': ':0', 02:24:18 INFO - 'HOME': '/home/cltbld', 02:24:18 INFO - 'LANG': 'en_US.UTF-8', 02:24:18 INFO - 'LANGUAGE': 'en_US:en', 02:24:18 INFO - 'LOGNAME': 'cltbld', 02:24:18 INFO - 'MAIL': '/var/mail/cltbld', 02:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:18 INFO - 'MOZ_NO_REMOTE': '1', 02:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:18 INFO - 'NO_EM_RESTART': '1', 02:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:18 INFO - 'PWD': '/builds/slave/test', 02:24:18 INFO - 'SHELL': '/bin/bash', 02:24:18 INFO - 'SHLVL': '1', 02:24:18 INFO - 'TERM': 'linux', 02:24:18 INFO - 'TMOUT': '86400', 02:24:18 INFO - 'USER': 'cltbld', 02:24:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:18 INFO - '_': '/tools/buildbot/bin/python'} 02:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:18 INFO - Downloading/unpacking jsonschema 02:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:20 INFO - Downloading/unpacking functools32 (from jsonschema) 02:24:20 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:24:20 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:24:20 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:24:20 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:24:20 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:24:20 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:24:20 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:20 INFO - warning: no files found matching '*.txt' 02:24:20 INFO - no previously-included directories found matching 'build' 02:24:20 INFO - no previously-included directories found matching 'dist' 02:24:20 INFO - no previously-included directories found matching '.git*' 02:24:20 INFO - Installing collected packages: jsonschema, functools32 02:24:20 INFO - Running setup.py install for functools32 02:24:21 INFO - warning: no files found matching '*.txt' 02:24:21 INFO - no previously-included directories found matching 'build' 02:24:21 INFO - no previously-included directories found matching 'dist' 02:24:21 INFO - no previously-included directories found matching '.git*' 02:24:21 INFO - Successfully installed jsonschema functools32 02:24:21 INFO - Cleaning up... 02:24:21 INFO - Return code: 0 02:24:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37b98e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, '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': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', '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:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:24:21 INFO - Using env: {'DISPLAY': ':0', 02:24:21 INFO - 'HOME': '/home/cltbld', 02:24:21 INFO - 'LANG': 'en_US.UTF-8', 02:24:21 INFO - 'LANGUAGE': 'en_US:en', 02:24:21 INFO - 'LOGNAME': 'cltbld', 02:24:21 INFO - 'MAIL': '/var/mail/cltbld', 02:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:21 INFO - 'MOZ_NO_REMOTE': '1', 02:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:21 INFO - 'NO_EM_RESTART': '1', 02:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:21 INFO - 'PWD': '/builds/slave/test', 02:24:21 INFO - 'SHELL': '/bin/bash', 02:24:21 INFO - 'SHLVL': '1', 02:24:21 INFO - 'TERM': 'linux', 02:24:21 INFO - 'TMOUT': '86400', 02:24:21 INFO - 'USER': 'cltbld', 02:24:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:21 INFO - '_': '/tools/buildbot/bin/python'} 02:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:21 INFO - Downloading/unpacking flake8 02:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:24:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:24:23 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:24:23 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:24:23 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:24:23 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:24:23 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:24:23 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:24:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:24:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:24:23 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:24:23 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:24:23 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:24:23 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:24:23 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:24:23 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:24:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:24:23 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:24:23 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:24:23 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:24:23 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:24:23 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:24:23 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:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:24:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:23 INFO - no previously-included directories found matching 'docs/_build' 02:24:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:24:24 INFO - Running setup.py install for pep8 02:24:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:24 INFO - no previously-included directories found matching 'docs/_build' 02:24:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:24:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:24:24 INFO - Cleaning up... 02:24:24 INFO - Return code: 0 02:24:24 INFO - Running post-action listener: _resource_record_post_action 02:24:24 INFO - Running post-action listener: _start_resource_monitoring 02:24:24 INFO - Starting resource monitoring. 02:24:24 INFO - ##### 02:24:24 INFO - ##### Finished create-virtualenv step (success) 02:24:24 INFO - ##### 02:24:24 INFO - ##### 02:24:24 INFO - ##### Running install step. 02:24:24 INFO - ##### 02:24:24 INFO - Running pre-action listener: _resource_record_pre_action 02:24:24 INFO - Running main action method: install 02:24:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:24 INFO - Reading from file tmpfile_stdout 02:24:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:24:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:24:24 INFO - Reading from file tmpfile_stdout 02:24:24 INFO - Output received: 02:24:24 INFO - Usage: mozinstall [options] installer 02:24:24 INFO - Options: 02:24:24 INFO - -h, --help show this help message and exit 02:24:24 INFO - -d DEST, --destination=DEST 02:24:24 INFO - Directory to install application into. [default: 02:24:24 INFO - "/builds/slave/test"] 02:24:24 INFO - --app=APP Application being installed. [default: firefox] 02:24:24 INFO - mkdir: /builds/slave/test/build/application 02:24:24 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:24:24 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:24:41 INFO - Reading from file tmpfile_stdout 02:24:41 INFO - Output received: 02:24:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:24:41 INFO - Running post-action listener: _resource_record_post_action 02:24:41 INFO - ##### 02:24:41 INFO - ##### Finished install step (success) 02:24:41 INFO - ##### 02:24:41 INFO - ##### 02:24:41 INFO - ##### Running run-tests step. 02:24:41 INFO - ##### 02:24:41 INFO - Running pre-action listener: _resource_record_pre_action 02:24:41 INFO - Running main action method: run_tests 02:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:24:41 INFO - Python 2.7.3 02:24:41 INFO - Return code: 0 02:24:41 INFO - grabbing minidump binary from tooltool 02:24: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:24:41 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 0x111a9c0>, '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 0x111b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:24:41 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:24:41 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:24:41 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:24:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:24:41 INFO - Return code: 0 02:24:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:24:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:24:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:24:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:24:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:24:42 INFO - Return code: 0 02:24:42 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/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:24:42 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/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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:24:42 INFO - Using env: {'DISPLAY': ':0', 02:24:42 INFO - 'HOME': '/home/cltbld', 02:24:42 INFO - 'LANG': 'en_US.UTF-8', 02:24:42 INFO - 'LANGUAGE': 'en_US:en', 02:24:42 INFO - 'LOGNAME': 'cltbld', 02:24:42 INFO - 'MAIL': '/var/mail/cltbld', 02:24:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:24:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:42 INFO - 'MOZ_NO_REMOTE': '1', 02:24:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:42 INFO - 'NO_EM_RESTART': '1', 02:24:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:42 INFO - 'PWD': '/builds/slave/test', 02:24:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:24:42 INFO - 'SHELL': '/bin/bash', 02:24:42 INFO - 'SHLVL': '1', 02:24:42 INFO - 'TERM': 'linux', 02:24:42 INFO - 'TMOUT': '86400', 02:24:42 INFO - 'USER': 'cltbld', 02:24:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378', 02:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:42 INFO - '_': '/tools/buildbot/bin/python'} 02:24:42 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/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:24:42 INFO - mozversion application_buildid: 20160526234010 02:24:42 INFO - mozversion application_changeset: 919296e383f6802ec3c3d54f9b39e3498c8d5fba 02:24:42 INFO - mozversion application_display_name: Nightly 02:24:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:24:42 INFO - mozversion application_name: Firefox 02:24:42 INFO - mozversion application_remotingname: firefox 02:24:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:24:42 INFO - mozversion application_vendor: Mozilla 02:24:42 INFO - mozversion application_version: 49.0a1 02:24:42 INFO - mozversion platform_buildid: 20160526234010 02:24:42 INFO - mozversion platform_changeset: 919296e383f6802ec3c3d54f9b39e3498c8d5fba 02:24:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:24:42 INFO - mozversion platform_version: 49.0a1 02:24:42 INFO - using testdate: 1464341082 02:24:42 INFO - actual date: 1464341082 02:24:42 INFO - starting webserver on 'localhost:49777' 02:24:42 INFO - SUITE-START | Running 2 tests 02:24:42 INFO - TEST-START | dromaeo_css 02:24:42 INFO - operating with platform_type : linux_ 02:24:42 INFO - Initialising browser for dromaeo_css test... 02:24:42 INFO - TEST-INFO | started process 1286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQVg6Zh/profile http://localhost:49777/getInfo.html) 02:24:46 INFO - PROCESS | 1286 | __metrics Screen width/height:1600/1200 02:24:46 INFO - PROCESS | 1286 | colorDepth:24 02:24:46 INFO - PROCESS | 1286 | Browser inner width/height: 1024/697 02:24:46 INFO - PROCESS | 1286 | __metrics 02:24:47 ERROR - PROCESS | 1286 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:24:49 INFO - TEST-INFO | 1286: exit 0 02:24:49 INFO - Browser initialized. 02:24:49 INFO - Running cycle 1/1 for dromaeo_css test... 02:24:49 INFO - TEST-INFO | started process 1368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQVg6Zh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:00 INFO - PROCESS | 1368 | RSS: Main: 154992640 02:25:00 INFO - PROCESS | 1368 | 02:25:52 INFO - PROCESS | 1368 | 1464341152075 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] 02:27:59 INFO - PROCESS | 1368 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49777/tests/dromaeo/cssquery-ext.html) 02:28:00 INFO - PROCESS | 1368 | RSS: Main: 243191808 02:28:00 INFO - PROCESS | 1368 | 02:31:03 INFO - PROCESS | 1368 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-ext.html (next: http://localhost:49777/tests/dromaeo/cssquery-jquery.html) 02:31:04 INFO - PROCESS | 1368 | RSS: Main: 239632384 02:31:04 INFO - PROCESS | 1368 | 02:34:06 INFO - PROCESS | 1368 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49777/tests/dromaeo/cssquery-mootools.html) 02:34:06 INFO - PROCESS | 1368 | RSS: Main: 250331136 02:34:06 INFO - PROCESS | 1368 | 02:37:08 INFO - PROCESS | 1368 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49777/tests/dromaeo/cssquery-prototype.html) 02:37:09 INFO - PROCESS | 1368 | RSS: Main: 238129152 02:37:09 INFO - PROCESS | 1368 | 02:40:11 INFO - PROCESS | 1368 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49777/tests/dromaeo/cssquery-yui.html) 02:40:12 INFO - PROCESS | 1368 | RSS: Main: 226971648 02:40:12 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-yui.html (next: http://localhost:49777/tests/dromaeo/cssquery-dojo.html) 02:43:15 INFO - PROCESS | 1368 | RSS: Main: 268447744 02:43:15 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | __start_tp_report 02:43:15 INFO - PROCESS | 1368 | _x_x_mozilla_page_load 02:43:15 INFO - PROCESS | 1368 | _x_x_mozilla_page_load_details 02:43:15 INFO - PROCESS | 1368 | |i|pagename|runs| 02:43:15 INFO - PROCESS | 1368 | |0;dojo.html;3146.354997225569;3159.6050493688304;3163.383140287644;3194.089684439935;3222.6293976192746;5269.65747226431;5324.840254792362;5377.112776391896;5442.401335853053;5470.890582188354;5298.894022119555;5330.546903513206;5338.67967921924;5349.839504814852;5378.0857254266775;4856.7571621418965;4941.703497790126;4943.752812359386;4944.530269624398;5110;5012.248162775576;5040.798368065273;5073.695578265298;5083.110455670261;5119.820806271781;4824.1316563018645;4847.927281090787;4869.634777391692;4889.804407823701;4922.26166075088;4816.590589799871;4817.349657796188;4821.614270858358;4838.419389673261;4925.852224433237;4837.201861692816;4855.295982082614;4864.951350486485;4871.56155945963;4898.118338699032;5134.743262836843;5186.040582492214;5234.7120908350025;5285.920711189336;5315.574754019708;5800.1299805029585;5808.4191580842;5822.767089316422;5834.795782147605;5839.795607153772;5814.767409303665;5830.242068531106;5858.589898707092;5861.736221870026;5866.237389139427;5181.041507321158;5286.07493688603;5354.036273470735;5357.196420536911;5445.618806683534;5975.43233392827;6040.063790112539;6040.305364883095;6048.697565121726;6074.75700971965;5769.711514424346;5813.767449302065;5814.912776308359;5816.534677225812;5832.679202643811;5629.437056294338;5668.829935101953;5716.742746576331;5719.742611582489;5747.942520574825;5732.914006289909;5735.541156707453;5742.397048309951;5744.425557444306;5746.856328591819;5500.092484740053;5684.147377893349;5742.483176514133;5749.885002300014;5754.683492407958;4401.735895846259;4416.094700586372;4419.823207071681;4432.29083346663;4435.334699795057;3928.7839168845417;3938.03518138058;3945.506811648544;3974.046228905042;3991.2416640838146;5351.732413379315;5413.2150838128255;5563.833085007456;5571.470710282598;5577.525910297589;5788.27646544182;5841.707914604252;5842.649441033552;5846.269216347957;5847.766089356378;5529.612927095065;5529.751161197756;5534.4742249486235;5547.972260138674;5552.250446189712;4843.564079232886;4991.575716064175;4994.950050499521;5022.824201152942;5023.321851550067;6030.396960304022;6061.787837425757;6098.220442830385;6103.428585615297;6133.1413602095745;5888.116782482662;5894.263217097863;5902.61632993854;5905.940940590711;5909.2908850938165;5752.022156233534;5948.821535353946;5955.434233747787;6075.210222671025;6091.543134264859;5714.05718056516;5722;5727.713614319184;5734.254546908875;5773.6824474654295;5753.971230143822;5776.249087618583;5825.475707186373;5835.241418615553;5844.064949608042;5486.149646804752;5648.971755141198;5686.374498805211;5694.914576281276;5709.25779648643;5695.686737229492;5699.800506982236;5702.6293290935955;5707.0583353747825;5711.286089238845;5615.101583746581;5624.521915637217;5638.746256418389;5644.491995720405;5647;5511.862203444946;5564.972175139261;5604.8038318658655;5606.887862242651;5690.231818704588;5527.474889885454;5530;5532.391436942014;5545.722713864371;5571.1086226203615 02:43:15 INFO - PROCESS | 1368 | |1;ext.html;606.2119244981523;634.5970308853878;637.197131614166;642.6915080761236;653.1509038250274;30687.38625227497;43787.56212437875;44881.877953051146;44993;45283.09433811322;46164;46661.533384666145;46664.53335466644;46701.766491167495;46732.532674673246;8667.39328247023;8845.292376609856;8846.20384165425;8852.070532594082;8854.114588541126;8714.520701361422;8824.205821476065;8857.202851743341;8857.42426742263;8860.822783544325;8911.197992180703;8913.910860891372;8925.77685557863;8926.107389261088;8935.865962010575;8875.778105547348;8890.333225008086;8912.821743565093;8937.865932011026;8938.955305223464;8778.60496277669;8880.1563851434;8882.111788821067;8884.244839188677;8885.333599979962;42763.57236427627;43063.78468107671;43098.56901430977;43165.56834431647;43224;3554.893353199408;3711.66595006448;4296.656267498593;4335.588119128678;4369.104333611634;31639.36721265585;32054;32400.18999525007;32458.513122303186;33944;3987.142764305688;4086.8160932758096;4246.044639955985;4256.297710877732;4366.847160349373;378121;381117.9999999972;381799;382130;385120;59727;60665.69667151636;63376.366236337046;63703;64071;61214.081788773205;66215;66959;67046;67107;15843.920780396254;15883.444079457164;15982.120983345794;15988.840111598734;15988.840111598967;10800.459977001276;11594.536218551164;11687.649370518899;11771.587994420326;11772;19861;19915.402537923885;19940.70088948667;20023.997600239858;20053.197872085246;6940.410065144419;6991.580505169706;7028.718851245995;7211.603361815046;7230.132384113835;1006.2754816532085;1024.9846252306222;1061.6125114333213;1144.9523685827376;1171.4377098992532;33469.665303347145;33504.832475837466;33727.32545349079;33749.66250337465;34307.828460857534;1121.265571050963;1156.8900954409319;1167.206299716201;1188.5542921404474;1228.7788198124424;17051.147442628066;17159.828401715822;17279.91360043217;17295.319225520063;17315.30738770435;583088;585400;591649;591807;592244;58384;59211.703941480875;59215.70392148098;59218;59245;1241.5344245907784;1340.9061365704308;1343.6573673713335;1376.7521846067805;1377.793331000358;32450.350992979536;34001.14997124993;34367.96896093121;34456.31087378289;34580.65419345875;49602.75198623984;50048.49951500438;50142.24786628131;50191.24713129379;50243.24635130403;308278;313754;314570;314869;315018;25662.486750265263;26233.213003609922;26240;27643.44713105767;27838.443231134857;43718.56281437272;48343;48501.75749121232;49674.75162624164;49725.25412118893;40168.39747403733;41650.58349416467;42413.78793106015;42727.78636106799;43130.78434607807;40464.3930341051;40743.59256407398;40965;41302.79348603238;41629.79185104055;40987.7950610245;41990.58009419989;42071.36892946547;42191.1561768769;42393.36409953792;35655.64344356523;36701.63298366982;36940.63059369372;37221.6277837229;37467.81266093652;27915.16254512368;28179;28258.15225543237;28498.287542811595;28560.42879142447 02:43:15 INFO - PROCESS | 1368 | |2;jquery.html;385.6875930496298;398.15988264761364;398.958109398513;408.25085967250095;419.7565412061005;13165.744338474824;18438.170282337294;19855.801441985575;20050.799492005077;20077.698834517494;15562.221888905566;17689.82310176898;18960.81039189611;18978.240870365167;19027.714584281246;5437.293151890259;5586.972065139668;5616.550675945935;5623.690697011662;5627.099664053752;3876.7480113792653;5611.466910643482;5622.634528755638;5641.887162256773;5652.858678533049;6023;6255.530835187356;6272.59228150171;6282.591631543935;6291.591046581981;6194.566380353377;6247.750089996417;6271.059341098826;6271.655058971754;6286.119943207955;5412.91880621791;5512.586556008276;5529.917051244234;5564.165375193713;5592.105263157875;23226;23436.882815585985;23933;23992.64011039836;24214.15250466243;2558.322044658167;2621.2267381122615;2640.234332043705;2701.2571542825685;2884.884604615813;9702.757431064209;10443.164546836311;14841.035332703448;14857.851421485755;15281.312340944683;1918.980810191894;1939.2049259803555;1968.724378586999;1979.901004949761;2037.8675386099856;62346.37653623451;86857.56571217166;87200.12799871984;87817.56091219503;88223.55888220582;10649.361038337725;10732.678019659423;10885.564577416973;10956.12351011917;10988.450577471094;14630.63423414402;14771.556853294418;14783;14788.482403116055;14789.778153327708;7588.696452141963;7864.606769661608;7922;7959.84080318402;8007.359411247203;7538.54768713868;7603.0876294843865;7659.119201291811;7716.382689384835;7726.111497177896;4150.481189851269;4475.328700694922;4488.214562451558;4501.842435514741;4828.348172996601;1888.2069530797098;1952.4533130723137;1964.9978510959227;1972.723818665388;1982.4647345217;877.3814460805245;970.6457143142702;1035.3011717090933;1047.350642601592;1114.1755101225035;19773.110210040584;19910.402687919384;20021.899890500456;20146.39560813178;20184.192632294544;975.3562648651856;1017.8931212222758;1022.6420752736483;1023.513830930317;1090.460222190021;8590.398672092893;11147.554097836159;11457.484413201259;11489.253198542068;11496.367699776592;518921;529852;532242;533282;536992;90354;90515.54742226379;91051.08948910426;93414.53292733493;96042.51978740061;998.3959704378747;1037.2946396450336;1039.9116075133547;1053.6996955867694;1054.2409465185208;17580.296788128842;17726.379576714753;17975.64048718992;17995.910020449814;18299.536037116733;39587.406188907764;39696;40435.3934690974;41015.794921025205;42684.5731542693;57241;58031.41968580429;58082.419175809395;58266;59201;8607.139286071342;8655.956720216358;8846.513441760508;8865.202131808168;8865.64537418496;8311.418200725891;12746.298953557272;12860.356982150668;13333.133346332457;13619.25094119833;11678.182527223353;11833.290002599872;11930.22453540517;11979.555104760491;12372;11557.88442115568;11978.76042479163;12073.939630301793;12125.333106679218;12398.194117382342;12159.696007599881;12255.938720306342;12289.56986505468;12340.691482713004;12460.501579936701;8738.825223495622;8748.956255218684;8806.295496360148;8858.512781797062;8876.911230887867;11432.657020289405;12260.386980650754;12376.443060062138;12429;12469 02:43:15 INFO - PROCESS | 1368 | |3;mootools.html;1323.3515577367093;1484.8069750932377;1535.8157021157463;1681.983180168198;1809.2129923483285;8616.698415555456;9023.54882255887;9036.141566551183;9268.72193834186;9275.397099188547;8901.510416927067;9121.589528471219;9125.361224714272;9128.452292862416;9133;2061.7938206179338;2124.0123342645666;2126.6916297136904;2392.28231530541;2426.611742121261;2329.452578644017;2410.421498840283;2413.215704895907;2421.685180926477;2427.2111563741855;2374.9287521374386;2375.774301441369;2395.3053614451787;2401.3636386357543;2418.6492958521003;1989.8507611929163;2307.4346785037687;2309.84985975911;2346.7066616672832;2349.0721165139757;2364.8581085134947;2401;2405.6632071510003;2406.2300063979533;2406.470576473173;8869.33479988997;8918.821623567557;8932.598033088527;8936.731898043068;8937.597808098652;5120.5903527718065;5267.762950667191;5267.841964741064;5270.341207349082;5276.630635855492;3079.13784140441;3105.1305634422397;3249.496328069153;3282.4091663500562;3290.2925870937866;1005.939643621385;1018.9032041956002;1023.2376879225025;1027.861238732769;1037.2376303416982;12898.484060637564;12902.548410805577;12916.289604071771;12919.612411627666;12923.483060677656;4743;4858.78135483904;4984.252362145635;4987.62592805541;5046;9565;9573.28200384974;9630.518474076409;9642.035796420301;9652.131308182297;5280.788768449296;5309.2301616266195;5312.07038768214;5315.6013299002725;5315.681059136464;4915.16442204826;4955.430125535538;4963.925541116886;4971.37857767779;5007.524285192901;3555.8933232003083;3594.137407022296;3646.908827279339;3675.46705727668;3709.350863598859;1015.1371334365878;1022.1414012229615;1029.0892560084378;1030.8144533983955;1076.741582020325;874.3922973533333;903.3631289940707;976.1166144639113;1004.1815920025302;1022.5143057047992;6080.361562036011;6119.694015299217;6206.658633775095;6241.375862413813;6358;959.7936443664646;961.2598299309493;976.8876579193342;987.883691428681;1031.3450958641167;4098.569650186747;4329.783510824509;4337.674674399433;4360.171567402183;4360.302351623725;11134.33194008362;11572.59495917639;11609.477573509212;11611.593594224161;11634.76730465386;10783.56865725378;11064.668059958214;11087.889121108847;11274.605388811353;11531.13516486267;8257.79355516117;8353.122922093215;8373.916260837314;8386.245237928493;8392.286655634218;6034.487068599218;6331.303556608861;6356.872862542816;6372.36276372359;6428.357164283534;10112.544935477774;10570.735731606464;10700.411477368509;10739.677809665722;10745;9684.56419461112;10279.383237005804;10780.784384312114;10813.189010824377;10832.620858269922;7763.378929685725;7933.563653999086;8095.352371810123;8096.311813495919;8101.35189184852;8705.434146780439;8784.648614055366;8789.208971192624;8797.12028797115;8807.735767926972;7782.182870798485;7967.641456134372;8029.397795165269;8116.2695357418115;8166.224208700164;7798.220177982156;7886.369090472863;7890.48711833729;7978.4016198786485;7987.440879138405;6809;6824.317568243136;6853.828654283683;6856.314368563303;6858.2455929848675;5269.104252277046;5312.389075256395;5346.599005074557;5432.864178395572;5500.147477141049;5225.764840582259;5348.411674715856;5360.758765855624;5369.3556773187465;5417.702026388586 02:43:15 INFO - PROCESS | 1368 | |4;prototype.html;317.56969306589554;329.15899875817286;334.9145967778216;336.79960423547993;337.701134495971;5165.354330708661;5240.397354304247;5320.2551642769995;5330.413654498007;5398.838034858955;5250.553702935245;5264.8157314494;5303.7082960437165;5318.494742999409;5346.4118946915805;4123.463949686537;4135.689823263252;4161.167766446722;4185.681510324246;4212.389203565481;3924.802110817937;3925.3130702127155;4119.3409054551275;4122.464079669654;4136.5242997055275;4070.857519986801;4101.384792281152;4128.60778226068;4129.050318426749;4132.5454200037975;4103.8563650272245;4113.91772164558;4115.115250221187;4140.627343539096;4151.46031015969;3461.048211741766;3665.981670091659;3696.4270538066644;3700.4449332600057;3705.110773414388;5012.172991456406;5035.571976381975;5078.923816142761;5097.235414687826;5101.974490127563;4694.037722266961;4697.577218050392;4705.552972467644;4712.363830882821;4718.976405117986;5274.129768588216;5489.39616642169;5528.668279903179;5542.63972841764;5547.278853748987;3908.609139086069;3930.449737036817;3931.9606803932165;3932.7836968966694;3934.4688467056867;5759.164921086419;5766.625169363978;5781.306243250795;5794.362620111784;5828.06750919855;3792.033031576985;3975;3993.0434087297017;4034.5965403460004;4046.7774272414713;4009.7970608817236;4015.4779878616177;4039.434479172918;4042.9797851010558;4043.696722745806;4590.885227869263;4591.931121033187;4606.677532572688;4647.883802904955;4665.393498845128;5342.813001544927;5489.34127904654;5508.862278443071;5515.61390702655;5566.2207290979295;1339.9464021439228;1383.5641772841523;1389.4997800791707;1421.204125689617;1424.7364237616075;883.8201001662852;900.7658008917729;905.2260317428504;909.9727008189765;918.1323649151622;4742.549457801503;4755.548222918817;4806.82749385404;4812.278158276286;4813.3983252093485;4950.405951285797;5016.799328026911;5043.747812609428;5080.618953578496;5082.872928176826;4413.646908247332;4741.075490279362;4799.648172395501;4813.711177329372;4815.170235310629;2657.614645876337;2665.840049596992;2684.7916739496113;2700.6489156409934;2714.0772137473355;5160.664556803796;5166.483351664803;5181.455947125498;5209.713465759344;5229.529342359206;4763.476017638057;5103.617228707862;5112.769925353368;5128.948710512922;5154.407243167008;5177.534021938043;5188.8962220755375;5189.792408303626;5205.687658740488;5214.983078299771;5011.4487406386;5054.924176137434;5076.598678885082;5109.386873575195;5147.40804807452;4772.260299653559;5006.023825354021;5015.269731942474;5024.723640199824;5062.569681577107;5105.310783044241;5107.668001579886;5186.481351864783;5210.404820673723;5244.501772331775;3681.7422780405113;3717.8141092945784;3732.402815549499;3738.6822120120096;3739.9065023374633;5144.588432925282;5186.974065129651;5196.298499702491;5369.785208591613;5849.61977471463;5515.641483303572;5574.247476590608;5628.8478452066975;5642.238297829905;5662.915056274077;5582.441755824548;5594.049011668108;5599.384067752625;5609.326880774333;5621.690807005654;5265.5778341961595;5477.726113694379;5531.695756733418;5548.167774833646;5549.445055494418;5619.719014049199;5636.027390413323;5648.887022259614;5668.234788303526;5674.808290259092;5271.762770675252;5529.861753456034;5537;5548.944510555004;5551.694656793915 02:43:15 INFO - PROCESS | 1368 | |5;yui.html;794.0352471746827;825.8059356051328;838.7693384319315;846.6401779243823;866.4931015356017;14490.420383184673;15438.84561154388;15443.45947891824;15462.768058479132;15482.690346193069;13320.933395333033;13886.097403668755;14189.645258868508;14198.361073751681;14200.431982720678;682.9009793579928;802.5746354432131;805.7381351060899;810.720301495983;818.153211426174;808.4300568099476;815.571824791983;815.9061707903608;815.9224873636995;816.5019338203691;847.2798121596625;848.440029580477;849.5030407211758;850.9064002959669;851.0680804519042;694.5207806613421;839.236294971573;845.3701992015957;847.478800537668;861.4314552395389;626.5707990026846;626.7054484392328;627.0187157099125;627.1251604012423;627.7959663109508;13876.236806975612;13929.373178207004;13948.302584870717;13957.58127256184;13958.720825583432;13227.272500012496;13689.383977720927;13819.654508637264;13855.792163117561;13927.303634818218;11548.826767598493;11824;12351.75296494074;12374.257544547356;12696.047796415305;4565.08698260346;4599.264117741145;4623.2371658676275;4752.192127338326;4839.806407743686;55079.72460137714;58314.7084264576;59365.70317148387;60348;60941.390586094014;10570.577176912991;10732.78534429307;10741.462926853626;10970.670879873616;11053.834192487118;19298.13158407875;19347.613047738967;19366.4190074298;19424.805751942582;19442.319518817058;8614.310855131574;8656.22094011542;8675.956620216859;8722.040575536812;8987.370884038055;4758.976205118952;4796.592289655348;4812.374391329105;4860.076585448754;5040.445550989388;3556.9644303556634;3657.213699054663;3665.17533554948;3666.395044817629;3667.743257971916;582.5019608234983;689.8447849233883;698.5110422704026;710.637574836837;710.715713714508;728.9575906453822;731.4696844787593;739.1167554772103;743.5835931878165;757.7310054930531;9734.9026509734;10237.283390162616;10425.11386532138;10491.68524944253;10507.211959103099;686.7836631461074;731.915829679583;758.8558173946932;768.6088180393506;769.0931854766553;4762.547557981986;4930.9013819723405;4946.283797276261;5012.223105418666;5018.84943451697;73422.26577734262;75315;76590.61704691441;76735.23264767393;77185.61407192927;64587.67706161439;65805;66187.33812661908;67561;69180;60509;60624.09063864045;60942.69528652328;61003.38996609977;61054.69472652608;8971.641134354813;9084.636614535344;9159.862602061108;9239.122283383067;9282.489463079595;38706.99999999887;39182;39192.6080739189;39907.201855962136;40572.39141412822;48683.269750954474;54112;54884.45115548953;55440.168397473266;55927.72036139793;12132.150749447454;12502.937485312515;12660.873391266337;12795.656456071978;13164.078514503894;12503.187292825936;13014.47942082344;13382;13507.392167352296;13599.348127115118;11100.777984440105;12966.870331296566;13016.406943803702;13185.122695581204;13480.258585777485;12208.466730763696;12261.718207605069;12618.17981831178;12687.11190216713;12840;12294.75410491803;12356.320402377956;12361.134720569833;12432.440540175532;12905.483780648668;10123;10202;10269.486525673836;10276.691699249035;10757.354558726502;10359.84460233082;10854.837177442187;10929.398883061507;11042.392668403316;11112.722181945193 02:43:15 INFO - PROCESS | 1368 | __end_tp_report 02:43:15 INFO - PROCESS | 1368 | __start_cc_report 02:43:15 INFO - PROCESS | 1368 | _x_x_mozilla_cycle_collect,938 02:43:15 INFO - PROCESS | 1368 | __end_cc_report 02:43:15 INFO - PROCESS | 1368 | __startTimestamp1464342195559__endTimestamp 02:43:15 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | ------- Summary: start ------- 02:43:15 INFO - PROCESS | 1368 | Number of tests: 6 02:43:15 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | [#0] dojo.html Cycles:165 Average:5379.44 Median:5571.47 stddev:617.08 (11.1%) stddev-sans-first:593.58 02:43:15 INFO - PROCESS | 1368 | Values: 3146.4 3159.6 3163.4 3194.1 3222.6 5269.7 5324.8 5377.1 5442.4 5470.9 5298.9 5330.5 5338.7 5349.8 5378.1 4856.8 4941.7 4943.8 4944.5 5110.0 5012.2 5040.8 5073.7 5083.1 5119.8 4824.1 4847.9 4869.6 4889.8 4922.3 4816.6 4817.3 4821.6 4838.4 4925.9 4837.2 4855.3 4865.0 4871.6 4898.1 5134.7 5186.0 5234.7 5285.9 5315.6 5800.1 5808.4 5822.8 5834.8 5839.8 5814.8 5830.2 5858.6 5861.7 5866.2 5181.0 5286.1 5354.0 5357.2 5445.6 5975.4 6040.1 6040.3 6048.7 6074.8 5769.7 5813.8 5814.9 5816.5 5832.7 5629.4 5668.8 5716.7 5719.7 5747.9 5732.9 5735.5 5742.4 5744.4 5746.9 5500.1 5684.1 5742.5 5749.9 5754.7 4401.7 4416.1 4419.8 4432.3 4435.3 3928.8 3938.0 3945.5 3974.0 3991.2 5351.7 5413.2 5563.8 5571.5 5577.5 5788.3 5841.7 5842.6 5846.3 5847.8 5529.6 5529.8 5534.5 5548.0 5552.3 4843.6 4991.6 4995.0 5022.8 5023.3 6030.4 6061.8 6098.2 6103.4 6133.1 5888.1 5894.3 5902.6 5905.9 5909.3 5752.0 5948.8 5955.4 6075.2 6091.5 5714.1 5722.0 5727.7 5734.3 5773.7 5754.0 5776.2 5825.5 5835.2 5844.1 5486.1 5649.0 5686.4 5694.9 5709.3 5695.7 5699.8 5702.6 5707.1 5711.3 5615.1 5624.5 5638.7 5644.5 5647.0 5511.9 5565.0 5604.8 5606.9 5690.2 5527.5 5530.0 5532.4 5545.7 5571.1 02:43:15 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | [#1] ext.html Cycles:180 Average:59610.86 Median:42292.26 stddev:117939.01 (278.9%) stddev-sans-first:118186.66 02:43:15 INFO - PROCESS | 1368 | Values: 606.2 634.6 637.2 642.7 653.2 30687.4 43787.6 44881.9 44993.0 45283.1 46164.0 46661.5 46664.5 46701.8 46732.5 8667.4 8845.3 8846.2 8852.1 8854.1 8714.5 8824.2 8857.2 8857.4 8860.8 8911.2 8913.9 8925.8 8926.1 8935.9 8875.8 8890.3 8912.8 8937.9 8939.0 8778.6 8880.2 8882.1 8884.2 8885.3 42763.6 43063.8 43098.6 43165.6 43224.0 3554.9 3711.7 4296.7 4335.6 4369.1 31639.4 32054.0 32400.2 32458.5 33944.0 3987.1 4086.8 4246.0 4256.3 4366.8 378121.0 381118.0 381799.0 382130.0 385120.0 59727.0 60665.7 63376.4 63703.0 64071.0 61214.1 66215.0 66959.0 67046.0 67107.0 15843.9 15883.4 15982.1 15988.8 15988.8 10800.5 11594.5 11687.6 11771.6 11772.0 19861.0 19915.4 19940.7 20024.0 20053.2 6940.4 6991.6 7028.7 7211.6 7230.1 1006.3 1025.0 1061.6 1145.0 1171.4 33469.7 33504.8 33727.3 33749.7 34307.8 1121.3 1156.9 1167.2 1188.6 1228.8 17051.1 17159.8 17279.9 17295.3 17315.3 583088.0 585400.0 591649.0 591807.0 592244.0 58384.0 59211.7 59215.7 59218.0 59245.0 1241.5 1340.9 1343.7 1376.8 1377.8 32450.4 34001.1 34368.0 34456.3 34580.7 49602.8 50048.5 50142.2 50191.2 50243.2 308278.0 313754.0 314570.0 314869.0 315018.0 25662.5 26233.2 26240.0 27643.4 27838.4 43718.6 48343.0 48501.8 49674.8 49725.3 40168.4 41650.6 42413.8 42727.8 43130.8 40464.4 40743.6 40965.0 41302.8 41629.8 40987.8 41990.6 42071.4 42191.2 42393.4 35655.6 36701.6 36940.6 37221.6 37467.8 27915.2 28179.0 28258.2 28498.3 28560.4 02:43:15 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | [#2] jquery.html Cycles:180 Average:30237.31 Median:2670.75 stddev:87256.17 (3267.1%) stddev-sans-first:87472.15 02:43:15 INFO - PROCESS | 1368 | Values: 385.7 398.2 399.0 408.3 419.8 13165.7 18438.2 19855.8 20050.8 20077.7 15562.2 17689.8 18960.8 18978.2 19027.7 5437.3 5587.0 5616.6 5623.7 5627.1 3876.7 5611.5 5622.6 5641.9 5652.9 6023.0 6255.5 6272.6 6282.6 6291.6 6194.6 6247.8 6271.1 6271.7 6286.1 5412.9 5512.6 5529.9 5564.2 5592.1 23226.0 23436.9 23933.0 23992.6 24214.2 2558.3 2621.2 2640.2 2701.3 2884.9 9702.8 10443.2 14841.0 14857.9 15281.3 1919.0 1939.2 1968.7 1979.9 2037.9 62346.4 86857.6 87200.1 87817.6 88223.6 10649.4 10732.7 10885.6 10956.1 10988.5 14630.6 14771.6 14783.0 14788.5 14789.8 7588.7 7864.6 7922.0 7959.8 8007.4 7538.5 7603.1 7659.1 7716.4 7726.1 4150.5 4475.3 4488.2 4501.8 4828.3 1888.2 1952.5 1965.0 1972.7 1982.5 877.4 970.6 1035.3 1047.4 1114.2 19773.1 19910.4 20021.9 20146.4 20184.2 975.4 1017.9 1022.6 1023.5 1090.5 8590.4 11147.6 11457.5 11489.3 11496.4 518921.0 529852.0 532242.0 533282.0 536992.0 90354.0 90515.5 91051.1 93414.5 96042.5 998.4 1037.3 1039.9 1053.7 1054.2 17580.3 17726.4 17975.6 17995.9 18299.5 39587.4 39696.0 40435.4 41015.8 42684.6 57241.0 58031.4 58082.4 58266.0 59201.0 8607.1 8656.0 8846.5 8865.2 8865.6 8311.4 12746.3 12860.4 13333.1 13619.3 11678.2 11833.3 11930.2 11979.6 12372.0 11557.9 11978.8 12073.9 12125.3 12398.2 12159.7 12255.9 12289.6 12340.7 12460.5 8738.8 8749.0 8806.3 8858.5 8876.9 11432.7 12260.4 12376.4 12429.0 12469.0 02:43:15 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | [#3] mootools.html Cycles:180 Average:5922.32 Median:5026.76 stddev:3422.91 (68.1%) stddev-sans-first:3415.06 02:43:15 INFO - PROCESS | 1368 | Values: 1323.4 1484.8 1535.8 1682.0 1809.2 8616.7 9023.5 9036.1 9268.7 9275.4 8901.5 9121.6 9125.4 9128.5 9133.0 2061.8 2124.0 2126.7 2392.3 2426.6 2329.5 2410.4 2413.2 2421.7 2427.2 2374.9 2375.8 2395.3 2401.4 2418.6 1989.9 2307.4 2309.8 2346.7 2349.1 2364.9 2401.0 2405.7 2406.2 2406.5 8869.3 8918.8 8932.6 8936.7 8937.6 5120.6 5267.8 5267.8 5270.3 5276.6 3079.1 3105.1 3249.5 3282.4 3290.3 1005.9 1018.9 1023.2 1027.9 1037.2 12898.5 12902.5 12916.3 12919.6 12923.5 4743.0 4858.8 4984.3 4987.6 5046.0 9565.0 9573.3 9630.5 9642.0 9652.1 5280.8 5309.2 5312.1 5315.6 5315.7 4915.2 4955.4 4963.9 4971.4 5007.5 3555.9 3594.1 3646.9 3675.5 3709.4 1015.1 1022.1 1029.1 1030.8 1076.7 874.4 903.4 976.1 1004.2 1022.5 6080.4 6119.7 6206.7 6241.4 6358.0 959.8 961.3 976.9 987.9 1031.3 4098.6 4329.8 4337.7 4360.2 4360.3 11134.3 11572.6 11609.5 11611.6 11634.8 10783.6 11064.7 11087.9 11274.6 11531.1 8257.8 8353.1 8373.9 8386.2 8392.3 6034.5 6331.3 6356.9 6372.4 6428.4 10112.5 10570.7 10700.4 10739.7 10745.0 9684.6 10279.4 10780.8 10813.2 10832.6 7763.4 7933.6 8095.4 8096.3 8101.4 8705.4 8784.6 8789.2 8797.1 8807.7 7782.2 7967.6 8029.4 8116.3 8166.2 7798.2 7886.4 7890.5 7978.4 7987.4 6809.0 6824.3 6853.8 6856.3 6858.2 5269.1 5312.4 5346.6 5432.9 5500.1 5225.8 5348.4 5360.8 5369.4 5417.7 02:43:15 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | [#4] prototype.html Cycles:180 Average:4476.34 Median:5049.34 stddev:1300.53 (25.8%) stddev-sans-first:1266.17 02:43:15 INFO - PROCESS | 1368 | Values: 317.6 329.2 334.9 336.8 337.7 5165.4 5240.4 5320.3 5330.4 5398.8 5250.6 5264.8 5303.7 5318.5 5346.4 4123.5 4135.7 4161.2 4185.7 4212.4 3924.8 3925.3 4119.3 4122.5 4136.5 4070.9 4101.4 4128.6 4129.1 4132.5 4103.9 4113.9 4115.1 4140.6 4151.5 3461.0 3666.0 3696.4 3700.4 3705.1 5012.2 5035.6 5078.9 5097.2 5102.0 4694.0 4697.6 4705.6 4712.4 4719.0 5274.1 5489.4 5528.7 5542.6 5547.3 3908.6 3930.4 3932.0 3932.8 3934.5 5759.2 5766.6 5781.3 5794.4 5828.1 3792.0 3975.0 3993.0 4034.6 4046.8 4009.8 4015.5 4039.4 4043.0 4043.7 4590.9 4591.9 4606.7 4647.9 4665.4 5342.8 5489.3 5508.9 5515.6 5566.2 1339.9 1383.6 1389.5 1421.2 1424.7 883.8 900.8 905.2 910.0 918.1 4742.5 4755.5 4806.8 4812.3 4813.4 4950.4 5016.8 5043.7 5080.6 5082.9 4413.6 4741.1 4799.6 4813.7 4815.2 2657.6 2665.8 2684.8 2700.6 2714.1 5160.7 5166.5 5181.5 5209.7 5229.5 4763.5 5103.6 5112.8 5128.9 5154.4 5177.5 5188.9 5189.8 5205.7 5215.0 5011.4 5054.9 5076.6 5109.4 5147.4 4772.3 5006.0 5015.3 5024.7 5062.6 5105.3 5107.7 5186.5 5210.4 5244.5 3681.7 3717.8 3732.4 3738.7 3739.9 5144.6 5187.0 5196.3 5369.8 5849.6 5515.6 5574.2 5628.8 5642.2 5662.9 5582.4 5594.0 5599.4 5609.3 5621.7 5265.6 5477.7 5531.7 5548.2 5549.4 5619.7 5636.0 5648.9 5668.2 5674.8 5271.8 5529.9 5537.0 5548.9 5551.7 02:43:15 INFO - PROCESS | 1368 | 02:43:15 INFO - PROCESS | 1368 | [#5] yui.html Cycles:180 Average:16461.55 Median:4804.48 stddev:20409.73 (424.8%) stddev-sans-first:20433.07 02:43:15 INFO - PROCESS | 1368 | Values: 794.0 825.8 838.8 846.6 866.5 14490.4 15438.8 15443.5 15462.8 15482.7 13320.9 13886.1 14189.6 14198.4 14200.4 682.9 802.6 805.7 810.7 818.2 808.4 815.6 815.9 815.9 816.5 847.3 848.4 849.5 850.9 851.1 694.5 839.2 845.4 847.5 861.4 626.6 626.7 627.0 627.1 627.8 13876.2 13929.4 13948.3 13957.6 13958.7 13227.3 13689.4 13819.7 13855.8 13927.3 11548.8 11824.0 12351.8 12374.3 12696.0 4565.1 4599.3 4623.2 4752.2 4839.8 55079.7 58314.7 59365.7 60348.0 60941.4 10570.6 10732.8 10741.5 10970.7 11053.8 19298.1 19347.6 19366.4 19424.8 19442.3 8614.3 8656.2 8676.0 8722.0 8987.4 4759.0 4796.6 4812.4 4860.1 5040.4 3557.0 3657.2 3665.2 3666.4 3667.7 582.5 689.8 698.5 710.6 710.7 729.0 731.5 739.1 743.6 757.7 9734.9 10237.3 10425.1 10491.7 10507.2 686.8 731.9 758.9 768.6 769.1 4762.5 4930.9 4946.3 5012.2 5018.8 73422.3 75315.0 76590.6 76735.2 77185.6 64587.7 65805.0 66187.3 67561.0 69180.0 60509.0 60624.1 60942.7 61003.4 61054.7 8971.6 9084.6 9159.9 9239.1 9282.5 38707.0 39182.0 39192.6 39907.2 40572.4 48683.3 54112.0 54884.5 55440.2 55927.7 12132.2 12502.9 12660.9 12795.7 13164.1 12503.2 13014.5 13382.0 13507.4 13599.3 11100.8 12966.9 13016.4 13185.1 13480.3 12208.5 12261.7 12618.2 12687.1 12840.0 12294.8 12356.3 12361.1 12432.4 12905.5 10123.0 10202.0 10269.5 10276.7 10757.4 10359.8 10854.8 10929.4 11042.4 11112.7 02:43:15 INFO - PROCESS | 1368 | -------- Summary: end -------- 02:43:15 INFO - PROCESS | 1368 | 02:43:16 INFO - TEST-INFO | 1368: exit 0 02:43:16 INFO - TEST-OK | dromaeo_css | took 1113840ms 02:43:16 INFO - TEST-START | kraken 02:43:16 INFO - operating with platform_type : linux_ 02:43:16 INFO - Initialising browser for kraken test... 02:43:16 INFO - TEST-INFO | started process 1550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFMS9o/profile http://localhost:49777/getInfo.html) 02:43:20 INFO - PROCESS | 1550 | __metrics Screen width/height:1600/1200 02:43:20 INFO - PROCESS | 1550 | colorDepth:24 02:43:20 INFO - PROCESS | 1550 | Browser inner width/height: 1024/697 02:43:20 INFO - PROCESS | 1550 | __metrics 02:43:21 ERROR - PROCESS | 1550 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:43:22 INFO - TEST-INFO | 1550: exit 0 02:43:22 INFO - Browser initialized. 02:43:22 INFO - Running cycle 1/1 for kraken test... 02:43:22 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFMS9o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:34 INFO - PROCESS | 1632 | RSS: Main: 155586560 02:43:34 INFO - PROCESS | 1632 | 02:43:36 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-beat-detection) 02:43:37 INFO - PROCESS | 1632 | RSS: Main: 214499328 02:43:37 INFO - PROCESS | 1632 | 02:43:40 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-dft) 02:43:40 INFO - PROCESS | 1632 | RSS: Main: 197980160 02:43:40 INFO - PROCESS | 1632 | 02:43:44 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-fft) 02:43:44 INFO - PROCESS | 1632 | RSS: Main: 269144064 02:43:44 INFO - PROCESS | 1632 | 02:43:46 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-oscillator) 02:43:47 INFO - PROCESS | 1632 | RSS: Main: 179265536 02:43:47 INFO - PROCESS | 1632 | 02:43:49 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:43:50 INFO - PROCESS | 1632 | RSS: Main: 183685120 02:43:50 INFO - PROCESS | 1632 | 02:43:53 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-darkroom) 02:43:53 INFO - PROCESS | 1632 | RSS: Main: 217399296 02:43:53 INFO - PROCESS | 1632 | 02:43:57 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-desaturate) 02:43:57 INFO - PROCESS | 1632 | RSS: Main: 219557888 02:43:57 INFO - PROCESS | 1632 | 02:44:00 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49777/tests/kraken/driver.html?testName=json-parse-financial) 02:44:01 INFO - PROCESS | 1632 | RSS: Main: 220094464 02:44:01 INFO - PROCESS | 1632 | 02:44:02 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:44:03 INFO - PROCESS | 1632 | RSS: Main: 205225984 02:44:03 INFO - PROCESS | 1632 | 02:44:04 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:05 INFO - PROCESS | 1632 | RSS: Main: 208916480 02:44:05 INFO - PROCESS | 1632 | 02:44:07 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:44:08 INFO - PROCESS | 1632 | RSS: Main: 216342528 02:44:08 INFO - PROCESS | 1632 | 02:44:10 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:44:11 INFO - PROCESS | 1632 | RSS: Main: 224202752 02:44:11 INFO - PROCESS | 1632 | 02:44:14 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:14 INFO - PROCESS | 1632 | RSS: Main: 225394688 02:44:14 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49777/tests/kraken/driver.html?testName=ai-astar) 02:44:16 INFO - PROCESS | 1632 | RSS: Main: 266997760 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | __start_tp_report 02:44:16 INFO - PROCESS | 1632 | _x_x_mozilla_page_load 02:44:16 INFO - PROCESS | 1632 | _x_x_mozilla_page_load_details 02:44:16 INFO - PROCESS | 1632 | |i|pagename|runs| 02:44:16 INFO - PROCESS | 1632 | |0;ai-astar;109;105;108;109;110;108;110;109;107;110 02:44:16 INFO - PROCESS | 1632 | |1;audio-beat-detection;154;126;129;183;125;152;157;126;195;125 02:44:16 INFO - PROCESS | 1632 | |2;audio-dft;160;160;161;160;160;160;161;161;163;161 02:44:16 INFO - PROCESS | 1632 | |3;audio-fft;75;74;75;121;74;78;73;74;99;76 02:44:16 INFO - PROCESS | 1632 | |4;audio-oscillator;83;84;116;83;82;85;120;82;82;128 02:44:16 INFO - PROCESS | 1632 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;116;117;117 02:44:16 INFO - PROCESS | 1632 | |6;imaging-darkroom;147;146;145;145;145;145;145;145;145;145 02:44:16 INFO - PROCESS | 1632 | |7;imaging-desaturate;94;95;95;96;95;95;95;95;95;95 02:44:16 INFO - PROCESS | 1632 | |8;json-parse-financial;54;52;53;53;54;53;53;53;53;53 02:44:16 INFO - PROCESS | 1632 | |9;json-stringify-tinderbox;61;62;61;61;62;61;61;62;62;63 02:44:16 INFO - PROCESS | 1632 | |10;stanford-crypto-aes;84;85;79;79;80;80;80;81;109;85 02:44:16 INFO - PROCESS | 1632 | |11;stanford-crypto-ccm;138;119;128;119;119;124;122;130;150;123 02:44:16 INFO - PROCESS | 1632 | |12;stanford-crypto-pbkdf2;157;157;158;160;161;162;156;157;157;158 02:44:16 INFO - PROCESS | 1632 | |13;stanford-crypto-sha256-iterative;62;61;64;62;61;63;62;63;67;61 02:44:16 INFO - PROCESS | 1632 | __end_tp_report 02:44:16 INFO - PROCESS | 1632 | __start_cc_report 02:44:16 INFO - PROCESS | 1632 | _x_x_mozilla_cycle_collect,1647 02:44:16 INFO - PROCESS | 1632 | __end_cc_report 02:44:16 INFO - PROCESS | 1632 | __startTimestamp1464342256714__endTimestamp 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | ------- Summary: start ------- 02:44:16 INFO - PROCESS | 1632 | Number of tests: 14 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:1.58 (1.5%) stddev-sans-first:1.67 02:44:16 INFO - PROCESS | 1632 | Values: 109.0 105.0 108.0 109.0 110.0 108.0 110.0 109.0 107.0 110.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:153.00 stddev:25.71 (16.8%) stddev-sans-first:27.15 02:44:16 INFO - PROCESS | 1632 | Values: 154.0 126.0 129.0 183.0 125.0 152.0 157.0 126.0 195.0 125.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 02:44:16 INFO - PROCESS | 1632 | Values: 160.0 160.0 161.0 160.0 160.0 160.0 161.0 161.0 163.0 161.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:15.75 (21.0%) stddev-sans-first:16.51 02:44:16 INFO - PROCESS | 1632 | Values: 75.0 74.0 75.0 121.0 74.0 78.0 73.0 74.0 99.0 76.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:82.50 stddev:18.76 (22.7%) stddev-sans-first:19.43 02:44:16 INFO - PROCESS | 1632 | Values: 83.0 84.0 116.0 83.0 82.0 85.0 120.0 82.0 82.0 128.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 02:44:16 INFO - PROCESS | 1632 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.33 02:44:16 INFO - PROCESS | 1632 | Values: 147.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 02:44:16 INFO - PROCESS | 1632 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 02:44:16 INFO - PROCESS | 1632 | Values: 54.0 52.0 53.0 53.0 54.0 53.0 53.0 53.0 53.0 53.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 02:44:16 INFO - PROCESS | 1632 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 62.0 63.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:80.50 stddev:9.03 (11.2%) stddev-sans-first:9.58 02:44:16 INFO - PROCESS | 1632 | Values: 84.0 85.0 79.0 79.0 80.0 80.0 80.0 81.0 109.0 85.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:126.00 stddev:10.01 (7.9%) stddev-sans-first:9.82 02:44:16 INFO - PROCESS | 1632 | Values: 138.0 119.0 128.0 119.0 119.0 124.0 122.0 130.0 150.0 123.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:158.00 stddev:2.00 (1.3%) stddev-sans-first:2.07 02:44:16 INFO - PROCESS | 1632 | Values: 157.0 157.0 158.0 160.0 161.0 162.0 156.0 157.0 157.0 158.0 02:44:16 INFO - PROCESS | 1632 | 02:44:16 INFO - PROCESS | 1632 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:1.84 (2.9%) stddev-sans-first:1.94 02:44:16 INFO - PROCESS | 1632 | Values: 62.0 61.0 64.0 62.0 61.0 63.0 62.0 63.0 67.0 61.0 02:44:16 INFO - PROCESS | 1632 | -------- Summary: end -------- 02:44:16 INFO - PROCESS | 1632 | 02:44:17 INFO - TEST-INFO | 1632: exit 0 02:44:17 INFO - TEST-OK | kraken | took 61448ms 02:44:17 INFO - SUITE-END | took 1175s 02:44:17 INFO - Completed test suite (00:19:35) 02:44:17 INFO - javascript benchmark 02:44:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.354997225569, 3159.6050493688304, 3163.383140287644, 3194.089684439935, 3222.6293976192746, 5269.65747226431, 5324.840254792362, 5377.112776391896, 5442.401335853053, 5470.890582188354, 5298.894022119555, 5330.546903513206, 5338.67967921924, 5349.839504814852, 5378.0857254266775, 4856.7571621418965, 4941.703497790126, 4943.752812359386, 4944.530269624398, 5110.0, 5012.248162775576, 5040.798368065273, 5073.695578265298, 5083.110455670261, 5119.820806271781, 4824.1316563018645, 4847.927281090787, 4869.634777391692, 4889.804407823701, 4922.26166075088, 4816.590589799871, 4817.349657796188, 4821.614270858358, 4838.419389673261, 4925.852224433237, 4837.201861692816, 4855.295982082614, 4864.951350486485, 4871.56155945963, 4898.118338699032, 5134.743262836843, 5186.040582492214, 5234.7120908350025, 5285.920711189336, 5315.574754019708, 5800.1299805029585, 5808.4191580842, 5822.767089316422, 5834.795782147605, 5839.795607153772, 5814.767409303665, 5830.242068531106, 5858.589898707092, 5861.736221870026, 5866.237389139427, 5181.041507321158, 5286.07493688603, 5354.036273470735, 5357.196420536911, 5445.618806683534, 5975.43233392827, 6040.063790112539, 6040.305364883095, 6048.697565121726, 6074.75700971965, 5769.711514424346, 5813.767449302065, 5814.912776308359, 5816.534677225812, 5832.679202643811, 5629.437056294338, 5668.829935101953, 5716.742746576331, 5719.742611582489, 5747.942520574825, 5732.914006289909, 5735.541156707453, 5742.397048309951, 5744.425557444306, 5746.856328591819, 5500.092484740053, 5684.147377893349, 5742.483176514133, 5749.885002300014, 5754.683492407958, 4401.735895846259, 4416.094700586372, 4419.823207071681, 4432.29083346663, 4435.334699795057, 3928.7839168845417, 3938.03518138058, 3945.506811648544, 3974.046228905042, 3991.2416640838146, 5351.732413379315, 5413.2150838128255, 5563.833085007456, 5571.470710282598, 5577.525910297589, 5788.27646544182, 5841.707914604252, 5842.649441033552, 5846.269216347957, 5847.766089356378, 5529.612927095065, 5529.751161197756, 5534.4742249486235, 5547.972260138674, 5552.250446189712, 4843.564079232886, 4991.575716064175, 4994.950050499521, 5022.824201152942, 5023.321851550067, 6030.396960304022, 6061.787837425757, 6098.220442830385, 6103.428585615297, 6133.1413602095745, 5888.116782482662, 5894.263217097863, 5902.61632993854, 5905.940940590711, 5909.2908850938165, 5752.022156233534, 5948.821535353946, 5955.434233747787, 6075.210222671025, 6091.543134264859, 5714.05718056516, 5722.0, 5727.713614319184, 5734.254546908875, 5773.6824474654295, 5753.971230143822, 5776.249087618583, 5825.475707186373, 5835.241418615553, 5844.064949608042, 5486.149646804752, 5648.971755141198, 5686.374498805211, 5694.914576281276, 5709.25779648643, 5695.686737229492, 5699.800506982236, 5702.6293290935955, 5707.0583353747825, 5711.286089238845, 5615.101583746581, 5624.521915637217, 5638.746256418389, 5644.491995720405, 5647.0, 5511.862203444946, 5564.972175139261, 5604.8038318658655, 5606.887862242651, 5690.231818704588, 5527.474889885454, 5530.0, 5532.391436942014, 5545.722713864371, 5571.1086226203615], "value": 5337.929114890094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.2119244981523, 634.5970308853878, 637.197131614166, 642.6915080761236, 653.1509038250274, 30687.38625227497, 43787.56212437875, 44881.877953051146, 44993.0, 45283.09433811322, 46164.0, 46661.533384666145, 46664.53335466644, 46701.766491167495, 46732.532674673246, 8667.39328247023, 8845.292376609856, 8846.20384165425, 8852.070532594082, 8854.114588541126, 8714.520701361422, 8824.205821476065, 8857.202851743341, 8857.42426742263, 8860.822783544325, 8911.197992180703, 8913.910860891372, 8925.77685557863, 8926.107389261088, 8935.865962010575, 8875.778105547348, 8890.333225008086, 8912.821743565093, 8937.865932011026, 8938.955305223464, 8778.60496277669, 8880.1563851434, 8882.111788821067, 8884.244839188677, 8885.333599979962, 42763.57236427627, 43063.78468107671, 43098.56901430977, 43165.56834431647, 43224.0, 3554.893353199408, 3711.66595006448, 4296.656267498593, 4335.588119128678, 4369.104333611634, 31639.36721265585, 32054.0, 32400.18999525007, 32458.513122303186, 33944.0, 3987.142764305688, 4086.8160932758096, 4246.044639955985, 4256.297710877732, 4366.847160349373, 378121.0, 381117.9999999972, 381799.0, 382130.0, 385120.0, 59727.0, 60665.69667151636, 63376.366236337046, 63703.0, 64071.0, 61214.081788773205, 66215.0, 66959.0, 67046.0, 67107.0, 15843.920780396254, 15883.444079457164, 15982.120983345794, 15988.840111598734, 15988.840111598967, 10800.459977001276, 11594.536218551164, 11687.649370518899, 11771.587994420326, 11772.0, 19861.0, 19915.402537923885, 19940.70088948667, 20023.997600239858, 20053.197872085246, 6940.410065144419, 6991.580505169706, 7028.718851245995, 7211.603361815046, 7230.132384113835, 1006.2754816532085, 1024.9846252306222, 1061.6125114333213, 1144.9523685827376, 1171.4377098992532, 33469.665303347145, 33504.832475837466, 33727.32545349079, 33749.66250337465, 34307.828460857534, 1121.265571050963, 1156.8900954409319, 1167.206299716201, 1188.5542921404474, 1228.7788198124424, 17051.147442628066, 17159.828401715822, 17279.91360043217, 17295.319225520063, 17315.30738770435, 583088.0, 585400.0, 591649.0, 591807.0, 592244.0, 58384.0, 59211.703941480875, 59215.70392148098, 59218.0, 59245.0, 1241.5344245907784, 1340.9061365704308, 1343.6573673713335, 1376.7521846067805, 1377.793331000358, 32450.350992979536, 34001.14997124993, 34367.96896093121, 34456.31087378289, 34580.65419345875, 49602.75198623984, 50048.49951500438, 50142.24786628131, 50191.24713129379, 50243.24635130403, 308278.0, 313754.0, 314570.0, 314869.0, 315018.0, 25662.486750265263, 26233.213003609922, 26240.0, 27643.44713105767, 27838.443231134857, 43718.56281437272, 48343.0, 48501.75749121232, 49674.75162624164, 49725.25412118893, 40168.39747403733, 41650.58349416467, 42413.78793106015, 42727.78636106799, 43130.78434607807, 40464.3930341051, 40743.59256407398, 40965.0, 41302.79348603238, 41629.79185104055, 40987.7950610245, 41990.58009419989, 42071.36892946547, 42191.1561768769, 42393.36409953792, 35655.64344356523, 36701.63298366982, 36940.63059369372, 37221.6277837229, 37467.81266093652, 27915.16254512368, 28179.0, 28258.15225543237, 28498.287542811595, 28560.42879142447], "value": 20291.580920777138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6875930496298, 398.15988264761364, 398.958109398513, 408.25085967250095, 419.7565412061005, 13165.744338474824, 18438.170282337294, 19855.801441985575, 20050.799492005077, 20077.698834517494, 15562.221888905566, 17689.82310176898, 18960.81039189611, 18978.240870365167, 19027.714584281246, 5437.293151890259, 5586.972065139668, 5616.550675945935, 5623.690697011662, 5627.099664053752, 3876.7480113792653, 5611.466910643482, 5622.634528755638, 5641.887162256773, 5652.858678533049, 6023.0, 6255.530835187356, 6272.59228150171, 6282.591631543935, 6291.591046581981, 6194.566380353377, 6247.750089996417, 6271.059341098826, 6271.655058971754, 6286.119943207955, 5412.91880621791, 5512.586556008276, 5529.917051244234, 5564.165375193713, 5592.105263157875, 23226.0, 23436.882815585985, 23933.0, 23992.64011039836, 24214.15250466243, 2558.322044658167, 2621.2267381122615, 2640.234332043705, 2701.2571542825685, 2884.884604615813, 9702.757431064209, 10443.164546836311, 14841.035332703448, 14857.851421485755, 15281.312340944683, 1918.980810191894, 1939.2049259803555, 1968.724378586999, 1979.901004949761, 2037.8675386099856, 62346.37653623451, 86857.56571217166, 87200.12799871984, 87817.56091219503, 88223.55888220582, 10649.361038337725, 10732.678019659423, 10885.564577416973, 10956.12351011917, 10988.450577471094, 14630.63423414402, 14771.556853294418, 14783.0, 14788.482403116055, 14789.778153327708, 7588.696452141963, 7864.606769661608, 7922.0, 7959.84080318402, 8007.359411247203, 7538.54768713868, 7603.0876294843865, 7659.119201291811, 7716.382689384835, 7726.111497177896, 4150.481189851269, 4475.328700694922, 4488.214562451558, 4501.842435514741, 4828.348172996601, 1888.2069530797098, 1952.4533130723137, 1964.9978510959227, 1972.723818665388, 1982.4647345217, 877.3814460805245, 970.6457143142702, 1035.3011717090933, 1047.350642601592, 1114.1755101225035, 19773.110210040584, 19910.402687919384, 20021.899890500456, 20146.39560813178, 20184.192632294544, 975.3562648651856, 1017.8931212222758, 1022.6420752736483, 1023.513830930317, 1090.460222190021, 8590.398672092893, 11147.554097836159, 11457.484413201259, 11489.253198542068, 11496.367699776592, 518921.0, 529852.0, 532242.0, 533282.0, 536992.0, 90354.0, 90515.54742226379, 91051.08948910426, 93414.53292733493, 96042.51978740061, 998.3959704378747, 1037.2946396450336, 1039.9116075133547, 1053.6996955867694, 1054.2409465185208, 17580.296788128842, 17726.379576714753, 17975.64048718992, 17995.910020449814, 18299.536037116733, 39587.406188907764, 39696.0, 40435.3934690974, 41015.794921025205, 42684.5731542693, 57241.0, 58031.41968580429, 58082.419175809395, 58266.0, 59201.0, 8607.139286071342, 8655.956720216358, 8846.513441760508, 8865.202131808168, 8865.64537418496, 8311.418200725891, 12746.298953557272, 12860.356982150668, 13333.133346332457, 13619.25094119833, 11678.182527223353, 11833.290002599872, 11930.22453540517, 11979.555104760491, 12372.0, 11557.88442115568, 11978.76042479163, 12073.939630301793, 12125.333106679218, 12398.194117382342, 12159.696007599881, 12255.938720306342, 12289.56986505468, 12340.691482713004, 12460.501579936701, 8738.825223495622, 8748.956255218684, 8806.295496360148, 8858.512781797062, 8876.911230887867, 11432.657020289405, 12260.386980650754, 12376.443060062138, 12429.0, 12469.0], "value": 9364.874320506262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.3515577367093, 1484.8069750932377, 1535.8157021157463, 1681.983180168198, 1809.2129923483285, 8616.698415555456, 9023.54882255887, 9036.141566551183, 9268.72193834186, 9275.397099188547, 8901.510416927067, 9121.589528471219, 9125.361224714272, 9128.452292862416, 9133.0, 2061.7938206179338, 2124.0123342645666, 2126.6916297136904, 2392.28231530541, 2426.611742121261, 2329.452578644017, 2410.421498840283, 2413.215704895907, 2421.685180926477, 2427.2111563741855, 2374.9287521374386, 2375.774301441369, 2395.3053614451787, 2401.3636386357543, 2418.6492958521003, 1989.8507611929163, 2307.4346785037687, 2309.84985975911, 2346.7066616672832, 2349.0721165139757, 2364.8581085134947, 2401.0, 2405.6632071510003, 2406.2300063979533, 2406.470576473173, 8869.33479988997, 8918.821623567557, 8932.598033088527, 8936.731898043068, 8937.597808098652, 5120.5903527718065, 5267.762950667191, 5267.841964741064, 5270.341207349082, 5276.630635855492, 3079.13784140441, 3105.1305634422397, 3249.496328069153, 3282.4091663500562, 3290.2925870937866, 1005.939643621385, 1018.9032041956002, 1023.2376879225025, 1027.861238732769, 1037.2376303416982, 12898.484060637564, 12902.548410805577, 12916.289604071771, 12919.612411627666, 12923.483060677656, 4743.0, 4858.78135483904, 4984.252362145635, 4987.62592805541, 5046.0, 9565.0, 9573.28200384974, 9630.518474076409, 9642.035796420301, 9652.131308182297, 5280.788768449296, 5309.2301616266195, 5312.07038768214, 5315.6013299002725, 5315.681059136464, 4915.16442204826, 4955.430125535538, 4963.925541116886, 4971.37857767779, 5007.524285192901, 3555.8933232003083, 3594.137407022296, 3646.908827279339, 3675.46705727668, 3709.350863598859, 1015.1371334365878, 1022.1414012229615, 1029.0892560084378, 1030.8144533983955, 1076.741582020325, 874.3922973533333, 903.3631289940707, 976.1166144639113, 1004.1815920025302, 1022.5143057047992, 6080.361562036011, 6119.694015299217, 6206.658633775095, 6241.375862413813, 6358.0, 959.7936443664646, 961.2598299309493, 976.8876579193342, 987.883691428681, 1031.3450958641167, 4098.569650186747, 4329.783510824509, 4337.674674399433, 4360.171567402183, 4360.302351623725, 11134.33194008362, 11572.59495917639, 11609.477573509212, 11611.593594224161, 11634.76730465386, 10783.56865725378, 11064.668059958214, 11087.889121108847, 11274.605388811353, 11531.13516486267, 8257.79355516117, 8353.122922093215, 8373.916260837314, 8386.245237928493, 8392.286655634218, 6034.487068599218, 6331.303556608861, 6356.872862542816, 6372.36276372359, 6428.357164283534, 10112.544935477774, 10570.735731606464, 10700.411477368509, 10739.677809665722, 10745.0, 9684.56419461112, 10279.383237005804, 10780.784384312114, 10813.189010824377, 10832.620858269922, 7763.378929685725, 7933.563653999086, 8095.352371810123, 8096.311813495919, 8101.35189184852, 8705.434146780439, 8784.648614055366, 8789.208971192624, 8797.12028797115, 8807.735767926972, 7782.182870798485, 7967.641456134372, 8029.397795165269, 8116.2695357418115, 8166.224208700164, 7798.220177982156, 7886.369090472863, 7890.48711833729, 7978.4016198786485, 7987.440879138405, 6809.0, 6824.317568243136, 6853.828654283683, 6856.314368563303, 6858.2455929848675, 5269.104252277046, 5312.389075256395, 5346.599005074557, 5432.864178395572, 5500.147477141049, 5225.764840582259, 5348.411674715856, 5360.758765855624, 5369.3556773187465, 5417.702026388586], "value": 4681.2982778145215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.56969306589554, 329.15899875817286, 334.9145967778216, 336.79960423547993, 337.701134495971, 5165.354330708661, 5240.397354304247, 5320.2551642769995, 5330.413654498007, 5398.838034858955, 5250.553702935245, 5264.8157314494, 5303.7082960437165, 5318.494742999409, 5346.4118946915805, 4123.463949686537, 4135.689823263252, 4161.167766446722, 4185.681510324246, 4212.389203565481, 3924.802110817937, 3925.3130702127155, 4119.3409054551275, 4122.464079669654, 4136.5242997055275, 4070.857519986801, 4101.384792281152, 4128.60778226068, 4129.050318426749, 4132.5454200037975, 4103.8563650272245, 4113.91772164558, 4115.115250221187, 4140.627343539096, 4151.46031015969, 3461.048211741766, 3665.981670091659, 3696.4270538066644, 3700.4449332600057, 3705.110773414388, 5012.172991456406, 5035.571976381975, 5078.923816142761, 5097.235414687826, 5101.974490127563, 4694.037722266961, 4697.577218050392, 4705.552972467644, 4712.363830882821, 4718.976405117986, 5274.129768588216, 5489.39616642169, 5528.668279903179, 5542.63972841764, 5547.278853748987, 3908.609139086069, 3930.449737036817, 3931.9606803932165, 3932.7836968966694, 3934.4688467056867, 5759.164921086419, 5766.625169363978, 5781.306243250795, 5794.362620111784, 5828.06750919855, 3792.033031576985, 3975.0, 3993.0434087297017, 4034.5965403460004, 4046.7774272414713, 4009.7970608817236, 4015.4779878616177, 4039.434479172918, 4042.9797851010558, 4043.696722745806, 4590.885227869263, 4591.931121033187, 4606.677532572688, 4647.883802904955, 4665.393498845128, 5342.813001544927, 5489.34127904654, 5508.862278443071, 5515.61390702655, 5566.2207290979295, 1339.9464021439228, 1383.5641772841523, 1389.4997800791707, 1421.204125689617, 1424.7364237616075, 883.8201001662852, 900.7658008917729, 905.2260317428504, 909.9727008189765, 918.1323649151622, 4742.549457801503, 4755.548222918817, 4806.82749385404, 4812.278158276286, 4813.3983252093485, 4950.405951285797, 5016.799328026911, 5043.747812609428, 5080.618953578496, 5082.872928176826, 4413.646908247332, 4741.075490279362, 4799.648172395501, 4813.711177329372, 4815.170235310629, 2657.614645876337, 2665.840049596992, 2684.7916739496113, 2700.6489156409934, 2714.0772137473355, 5160.664556803796, 5166.483351664803, 5181.455947125498, 5209.713465759344, 5229.529342359206, 4763.476017638057, 5103.617228707862, 5112.769925353368, 5128.948710512922, 5154.407243167008, 5177.534021938043, 5188.8962220755375, 5189.792408303626, 5205.687658740488, 5214.983078299771, 5011.4487406386, 5054.924176137434, 5076.598678885082, 5109.386873575195, 5147.40804807452, 4772.260299653559, 5006.023825354021, 5015.269731942474, 5024.723640199824, 5062.569681577107, 5105.310783044241, 5107.668001579886, 5186.481351864783, 5210.404820673723, 5244.501772331775, 3681.7422780405113, 3717.8141092945784, 3732.402815549499, 3738.6822120120096, 3739.9065023374633, 5144.588432925282, 5186.974065129651, 5196.298499702491, 5369.785208591613, 5849.61977471463, 5515.641483303572, 5574.247476590608, 5628.8478452066975, 5642.238297829905, 5662.915056274077, 5582.441755824548, 5594.049011668108, 5599.384067752625, 5609.326880774333, 5621.690807005654, 5265.5778341961595, 5477.726113694379, 5531.695756733418, 5548.167774833646, 5549.445055494418, 5619.719014049199, 5636.027390413323, 5648.887022259614, 5668.234788303526, 5674.808290259092, 5271.762770675252, 5529.861753456034, 5537.0, 5548.944510555004, 5551.694656793915], "value": 4065.2447097866852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.0352471746827, 825.8059356051328, 838.7693384319315, 846.6401779243823, 866.4931015356017, 14490.420383184673, 15438.84561154388, 15443.45947891824, 15462.768058479132, 15482.690346193069, 13320.933395333033, 13886.097403668755, 14189.645258868508, 14198.361073751681, 14200.431982720678, 682.9009793579928, 802.5746354432131, 805.7381351060899, 810.720301495983, 818.153211426174, 808.4300568099476, 815.571824791983, 815.9061707903608, 815.9224873636995, 816.5019338203691, 847.2798121596625, 848.440029580477, 849.5030407211758, 850.9064002959669, 851.0680804519042, 694.5207806613421, 839.236294971573, 845.3701992015957, 847.478800537668, 861.4314552395389, 626.5707990026846, 626.7054484392328, 627.0187157099125, 627.1251604012423, 627.7959663109508, 13876.236806975612, 13929.373178207004, 13948.302584870717, 13957.58127256184, 13958.720825583432, 13227.272500012496, 13689.383977720927, 13819.654508637264, 13855.792163117561, 13927.303634818218, 11548.826767598493, 11824.0, 12351.75296494074, 12374.257544547356, 12696.047796415305, 4565.08698260346, 4599.264117741145, 4623.2371658676275, 4752.192127338326, 4839.806407743686, 55079.72460137714, 58314.7084264576, 59365.70317148387, 60348.0, 60941.390586094014, 10570.577176912991, 10732.78534429307, 10741.462926853626, 10970.670879873616, 11053.834192487118, 19298.13158407875, 19347.613047738967, 19366.4190074298, 19424.805751942582, 19442.319518817058, 8614.310855131574, 8656.22094011542, 8675.956620216859, 8722.040575536812, 8987.370884038055, 4758.976205118952, 4796.592289655348, 4812.374391329105, 4860.076585448754, 5040.445550989388, 3556.9644303556634, 3657.213699054663, 3665.17533554948, 3666.395044817629, 3667.743257971916, 582.5019608234983, 689.8447849233883, 698.5110422704026, 710.637574836837, 710.715713714508, 728.9575906453822, 731.4696844787593, 739.1167554772103, 743.5835931878165, 757.7310054930531, 9734.9026509734, 10237.283390162616, 10425.11386532138, 10491.68524944253, 10507.211959103099, 686.7836631461074, 731.915829679583, 758.8558173946932, 768.6088180393506, 769.0931854766553, 4762.547557981986, 4930.9013819723405, 4946.283797276261, 5012.223105418666, 5018.84943451697, 73422.26577734262, 75315.0, 76590.61704691441, 76735.23264767393, 77185.61407192927, 64587.67706161439, 65805.0, 66187.33812661908, 67561.0, 69180.0, 60509.0, 60624.09063864045, 60942.69528652328, 61003.38996609977, 61054.69472652608, 8971.641134354813, 9084.636614535344, 9159.862602061108, 9239.122283383067, 9282.489463079595, 38706.99999999887, 39182.0, 39192.6080739189, 39907.201855962136, 40572.39141412822, 48683.269750954474, 54112.0, 54884.45115548953, 55440.168397473266, 55927.72036139793, 12132.150749447454, 12502.937485312515, 12660.873391266337, 12795.656456071978, 13164.078514503894, 12503.187292825936, 13014.47942082344, 13382.0, 13507.392167352296, 13599.348127115118, 11100.777984440105, 12966.870331296566, 13016.406943803702, 13185.122695581204, 13480.258585777485, 12208.466730763696, 12261.718207605069, 12618.17981831178, 12687.11190216713, 12840.0, 12294.75410491803, 12356.320402377956, 12361.134720569833, 12432.440540175532, 12905.483780648668, 10123.0, 10202.0, 10269.486525673836, 10276.691699249035, 10757.354558726502, 10359.84460233082, 10854.837177442187, 10929.398883061507, 11042.392668403316, 11112.722181945193], "value": 7096.879859590389, "unit": "score"}], "name": "dromaeo_css", "value": 7180.031521628275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 108.0, 109.0, 110.0, 108.0, 110.0, 109.0, 107.0, 110.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 129.0, 183.0, 125.0, 152.0, 157.0, 126.0, 195.0, 125.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 163.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 121.0, 74.0, 78.0, 73.0, 74.0, 99.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 116.0, 83.0, 82.0, 85.0, 120.0, 82.0, 82.0, 128.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 63.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 79.0, 79.0, 80.0, 80.0, 80.0, 81.0, 109.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 119.0, 128.0, 119.0, 119.0, 124.0, 122.0, 130.0, 150.0, 123.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 158.0, 160.0, 161.0, 162.0, 156.0, 157.0, 157.0, 158.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 64.0, 62.0, 61.0, 63.0, 62.0, 63.0, 67.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1497.2, "alertThreshold": 2.0}]} 02:44:17 INFO - Return code: 0 02:44:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:44:18 ERROR - # TBPL SUCCESS # 02:44:18 INFO - Running post-action listener: _resource_record_post_action 02:44:18 INFO - ##### 02:44:18 INFO - ##### Finished run-tests step (success) 02:44:18 INFO - ##### 02:44:18 INFO - Running post-run listener: _resource_record_post_run 02:44:18 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537653248; Read time: 16; Write time: 584500 02:44:18 INFO - TinderboxPrint: CPU usage
13.2% 02:44:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:44:18 INFO - TinderboxPrint: I/O write bytes / time
537,653,248 / 584,500 02:44:18 INFO - TinderboxPrint: CPU idle
8,260.0 (86.7%) 02:44:18 INFO - TinderboxPrint: CPU user
1,213.3 (12.7%) 02:44:18 INFO - TinderboxPrint: Swap in / out
0 / 0 02:44:18 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247111680; Read time: 0; Write time: 254128 02:44:18 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290541568; Read time: 16; Write time: 330372 02:44:18 INFO - Running post-run listener: _upload_blobber_files 02:44:18 INFO - Blob upload gear active. 02:44:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:44:18 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 02:44:18 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'] 02:44:18 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 02:44:19 INFO - (blobuploader) - INFO - Open directory for files ... 02:44:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:44:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:44:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:23 INFO - (blobuploader) - INFO - Done attempting. 02:44:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:44:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:24 INFO - (blobuploader) - INFO - Done attempting. 02:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:44:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:25 INFO - (blobuploader) - INFO - Done attempting. 02:44:25 INFO - (blobuploader) - INFO - Iteration through files over. 02:44:25 INFO - Return code: 0 02:44:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:44:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:44:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1cf783a0776aa3734fd227461affe77c7019d9f13a0415f294d1decf4fbe567888bbd5607fd646732d379920a7391482e49a17bff2a5129b2e1c64d1a2676c08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/713aceb6320c814ede03961ab3e757737a0ac8a01f7fa6962ffe88626832dd52618d0ce63cab9871e4adff847348a1fefffa837674c0d3d7a3a46d42432ea193", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f21f839e386e031e874d80e84e81b6b913cc877090eccacbe81aeaedd8abcd1033505e1cc035197fc5b8fcce804d29cb89b4572443f48760d3b92d0fd0d2d8a"} 02:44:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:44:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:44:25 INFO - Contents: 02:44:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1cf783a0776aa3734fd227461affe77c7019d9f13a0415f294d1decf4fbe567888bbd5607fd646732d379920a7391482e49a17bff2a5129b2e1c64d1a2676c08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/713aceb6320c814ede03961ab3e757737a0ac8a01f7fa6962ffe88626832dd52618d0ce63cab9871e4adff847348a1fefffa837674c0d3d7a3a46d42432ea193", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f21f839e386e031e874d80e84e81b6b913cc877090eccacbe81aeaedd8abcd1033505e1cc035197fc5b8fcce804d29cb89b4572443f48760d3b92d0fd0d2d8a"} 02:44:25 INFO - Running post-run listener: copy_logs_to_upload_dir 02:44:25 INFO - Copying logs to upload dir... 02:44:25 INFO - mkdir: /builds/slave/test/build/upload/logs 02:44:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.792765 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-27 02:44:25.356992) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 02:44:25.360140) ========= 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=fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378 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/1cf783a0776aa3734fd227461affe77c7019d9f13a0415f294d1decf4fbe567888bbd5607fd646732d379920a7391482e49a17bff2a5129b2e1c64d1a2676c08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/713aceb6320c814ede03961ab3e757737a0ac8a01f7fa6962ffe88626832dd52618d0ce63cab9871e4adff847348a1fefffa837674c0d3d7a3a46d42432ea193", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f21f839e386e031e874d80e84e81b6b913cc877090eccacbe81aeaedd8abcd1033505e1cc035197fc5b8fcce804d29cb89b4572443f48760d3b92d0fd0d2d8a"} build_url:https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/NtiIHsAbSPC_OyCvktiBCQ/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/1cf783a0776aa3734fd227461affe77c7019d9f13a0415f294d1decf4fbe567888bbd5607fd646732d379920a7391482e49a17bff2a5129b2e1c64d1a2676c08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/713aceb6320c814ede03961ab3e757737a0ac8a01f7fa6962ffe88626832dd52618d0ce63cab9871e4adff847348a1fefffa837674c0d3d7a3a46d42432ea193", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f21f839e386e031e874d80e84e81b6b913cc877090eccacbe81aeaedd8abcd1033505e1cc035197fc5b8fcce804d29cb89b4572443f48760d3b92d0fd0d2d8a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 02:44:25.386119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:44:25.386465) ========= 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=fa44defc139c4ba8574fe040000001db-1464340958.603935-1338935378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:44:25.468600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 02:44:25.468928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 02:44:25.469237) ========= ========= Total master_lag: 0.17 =========