builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1462936234.22 results: success (0) buildid: 20160510173021 builduid: b6a075f48b8b4a7e8410db36d3376e88 revision: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.224484) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.225087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.225524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.235819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.236217) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 20:10:34-- 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% 23.6M=0s 2016-05-10 20:10:34 (23.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089928 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.339176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.339941) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009466 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.390077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.390874) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 027b0144a1a6c2d62dfb1656e41597acfe6a22ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 027b0144a1a6c2d62dfb1656e41597acfe6a22ef --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=934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 20:10:34,593 truncating revision to first 12 chars 2016-05-10 20:10:34,593 Setting DEBUG logging. 2016-05-10 20:10:34,593 attempt 1/10 2016-05-10 20:10:34,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/027b0144a1a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 20:10:34,834 unpacking tar archive at: fx-team-027b0144a1a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.483223 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.885742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.886481) ========= script_repo_revision: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.887403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.888075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:34.961786) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-10 20:10:34.962560) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:10:35 INFO - MultiFileLogger online at 20160510 20:10:35 in /builds/slave/test 20:10:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:10:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:10:35 INFO - {'append_to_log': False, 20:10:35 INFO - 'base_work_dir': '/builds/slave/test', 20:10:35 INFO - 'blob_upload_branch': 'Fx-Team', 20:10:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:10:35 INFO - 'branch': 'Fx-Team', 20:10:35 INFO - 'buildbot_json_path': 'buildprops.json', 20:10:35 INFO - 'config_files': ('talos/linux_config.py',), 20:10:35 INFO - 'default_actions': ('clobber', 20:10:35 INFO - 'read-buildbot-config', 20:10:35 INFO - 'download-and-extract', 20:10:35 INFO - 'populate-webroot', 20:10:35 INFO - 'create-virtualenv', 20:10:35 INFO - 'install', 20:10:35 INFO - 'run-tests'), 20:10:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:10:35 INFO - 'download_minidump_stackwalk': True, 20:10:35 INFO - 'download_symbols': 'ondemand', 20:10:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:10:35 INFO - 'tooltool.py': '/tools/tooltool.py', 20:10:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:10:35 INFO - '/tools/misc-python/virtualenv.py')}, 20:10:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:10:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:10:35 INFO - 'installer_path': 'installer.exe', 20:10:35 INFO - 'log_level': 'info', 20:10:35 INFO - 'log_name': 'talos', 20:10:35 INFO - 'log_to_console': True, 20:10:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:10:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:10:35 INFO - 'opt_config_files': (), 20:10:35 INFO - 'pip_index': False, 20:10:35 INFO - 'sps_profile': False, 20:10:35 INFO - 'sps_profile_interval': 0, 20:10:35 INFO - 'suite': 'dromaeojs-e10s', 20:10:35 INFO - 'system_bits': '32', 20:10:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:10:35 INFO - 'title': 'talos-linux64-ix-057', 20:10:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:10:35 INFO - 'use_talos_json': True, 20:10:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:10:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:10:35 INFO - 'work_dir': 'build'} 20:10:35 INFO - ##### 20:10:35 INFO - ##### Running clobber step. 20:10:35 INFO - ##### 20:10:35 INFO - Running pre-action listener: _resource_record_pre_action 20:10:35 INFO - Running main action method: clobber 20:10:35 INFO - rmtree: /builds/slave/test/build 20:10:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:10:36 INFO - Running post-action listener: _resource_record_post_action 20:10:36 INFO - ##### 20:10:36 INFO - ##### Finished clobber step (success) 20:10:36 INFO - ##### 20:10:36 INFO - ##### 20:10:36 INFO - ##### Running read-buildbot-config step. 20:10:36 INFO - ##### 20:10:36 INFO - Running pre-action listener: _resource_record_pre_action 20:10:36 INFO - Running main action method: read_buildbot_config 20:10:36 INFO - Using buildbot properties: 20:10:36 INFO - { 20:10:36 INFO - "project": "", 20:10:36 INFO - "product": "firefox", 20:10:36 INFO - "script_repo_revision": "production", 20:10:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:10:36 INFO - "repository": "", 20:10:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:10:36 INFO - "buildid": "20160510173021", 20:10:36 INFO - "pgo_build": "True", 20:10:36 INFO - "basedir": "/builds/slave/test", 20:10:36 INFO - "buildnumber": 449, 20:10:36 INFO - "slavename": "talos-linux64-ix-057", 20:10:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:10:36 INFO - "platform": "ubuntu64_hw", 20:10:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:10:36 INFO - "branch": "fx-team", 20:10:36 INFO - "repo_path": "integration/fx-team", 20:10:36 INFO - "revision": "027b0144a1a6c2d62dfb1656e41597acfe6a22ef", 20:10:36 INFO - "stage_platform": "linux64-pgo", 20:10:36 INFO - "builduid": "b6a075f48b8b4a7e8410db36d3376e88", 20:10:36 INFO - "slavebuilddir": "test" 20:10:36 INFO - } 20:10:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:10:36 INFO - Running post-action listener: _resource_record_post_action 20:10:36 INFO - ##### 20:10:36 INFO - ##### Finished read-buildbot-config step (success) 20:10:36 INFO - ##### 20:10:36 INFO - ##### 20:10:36 INFO - ##### Running download-and-extract step. 20:10:36 INFO - ##### 20:10:36 INFO - Running pre-action listener: _resource_record_pre_action 20:10:36 INFO - Running main action method: download_and_extract 20:10:36 INFO - mkdir: /builds/slave/test/build/tests 20:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:36 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:39 INFO - Downloaded 1361 bytes. 20:10:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:39 INFO - Using the following test package requirements: 20:10:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:10:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:10:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:39 INFO - u'jsshell-linux-x86_64.zip'], 20:10:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:10:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:10:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:10:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:10:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:10:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:10: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')]} 20:10:39 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:10:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:41 INFO - Downloaded 23903496 bytes. 20:10:41 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'] 20:10:41 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 20:10:43 INFO - Return code: 0 20:10:43 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 20:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:43 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:44 INFO - Downloaded 23903496 bytes. 20:10:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:10:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:10:46 INFO - Return code: 0 20:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:46 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:10:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:10:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:10:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:47 INFO - Downloaded 10840152 bytes. 20:10:47 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'] 20:10:47 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 20:10:47 INFO - Return code: 0 20:10: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')]} 20:10:47 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:10:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:10:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:10:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:50 INFO - Downloaded 58334754 bytes. 20:10:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:10:50 INFO - mkdir: /builds/slave/test/properties 20:10:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:10:50 INFO - Writing to file /builds/slave/test/properties/build_url 20:10:50 INFO - Contents: 20:10:50 INFO - build_url:https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:10:51 INFO - Running post-action listener: _resource_record_post_action 20:10:51 INFO - Running post-action listener: set_extra_try_arguments 20:10:51 INFO - ##### 20:10:51 INFO - ##### Finished download-and-extract step (success) 20:10:51 INFO - ##### 20:10:51 INFO - ##### 20:10:51 INFO - ##### Running populate-webroot step. 20:10:51 INFO - ##### 20:10:51 INFO - Running pre-action listener: _resource_record_pre_action 20:10:51 INFO - Running main action method: populate_webroot 20:10:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:10:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:10:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:10:51 INFO - '--tppagecycles', 20:10:51 INFO - '7'], 20:10:51 INFO - 'tests': ['tsvgm']}}, 20:10:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:10:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:10:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:10:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:10:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:51 INFO - 'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:51 INFO - 'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['damp', 'tps']}, 20:10:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:51 INFO - 'tests': ['damp', 'tps']}, 20:10:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['dromaeo_dom']}, 20:10:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:10:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['a11yr', 20:10:51 INFO - 'ts_paint', 20:10:51 INFO - 'tpaint', 20:10:51 INFO - 'sessionrestore', 20:10:51 INFO - 'sessionrestore_no_auto_restore', 20:10:51 INFO - 'tabpaint']}, 20:10:51 INFO - 'other-e10s': {'tests': ['a11yr', 20:10:51 INFO - 'ts_paint', 20:10:51 INFO - 'tpaint', 20:10:51 INFO - 'sessionrestore', 20:10:51 INFO - 'sessionrestore_no_auto_restore', 20:10:51 INFO - 'tabpaint']}, 20:10:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:10:51 INFO - 'ts_paint', 20:10:51 INFO - 'tpaint', 20:10:51 INFO - 'sessionrestore', 20:10:51 INFO - 'sessionrestore_no_auto_restore', 20:10:51 INFO - 'tabpaint']}, 20:10:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:10:51 INFO - 'ts_paint', 20:10:51 INFO - 'tpaint', 20:10:51 INFO - 'sessionrestore', 20:10:51 INFO - 'sessionrestore_no_auto_restore', 20:10:51 INFO - 'tabpaint']}, 20:10:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['a11yr', 20:10:51 INFO - 'ts_paint', 20:10:51 INFO - 'tpaint', 20:10:51 INFO - 'sessionrestore', 20:10:51 INFO - 'sessionrestore_no_auto_restore', 20:10:51 INFO - 'tabpaint']}, 20:10:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['a11yr', 20:10:51 INFO - 'ts_paint', 20:10:51 INFO - 'tpaint', 20:10:51 INFO - 'sessionrestore', 20:10:51 INFO - 'sessionrestore_no_auto_restore', 20:10:51 INFO - 'tabpaint']}, 20:10:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['tsvgx', 20:10:51 INFO - 'tsvgr_opacity', 20:10:51 INFO - 'tart', 20:10:51 INFO - 'tscrollx', 20:10:51 INFO - 'cart']}, 20:10:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:10:51 INFO - 'tsvgr_opacity', 20:10:51 INFO - 'tart', 20:10:51 INFO - 'tscrollx', 20:10:51 INFO - 'cart']}, 20:10:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:51 INFO - 'talos_options': ['--disable-e10s'], 20:10:51 INFO - 'tests': ['tp5o']}, 20:10:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:51 INFO - 'tests': ['tp5o']}, 20:10:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:51 INFO - 'talos_options': ['--disable-e10s', 20:10:51 INFO - '--xperf_path', 20:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:51 INFO - 'tests': ['tp5n']}, 20:10:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:51 INFO - 'talos_options': ['--xperf_path', 20:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:51 INFO - 'tests': ['tp5n']}}, 20:10:51 INFO - 'talos.zip': {'path': '', 20:10:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:10:51 INFO - Running post-action listener: _resource_record_post_action 20:10:51 INFO - ##### 20:10:51 INFO - ##### Finished populate-webroot step (success) 20:10:51 INFO - ##### 20:10:51 INFO - ##### 20:10:51 INFO - ##### Running create-virtualenv step. 20:10:51 INFO - ##### 20:10:51 INFO - Running pre-action listener: _resource_record_pre_action 20:10:51 INFO - Running main action method: create_virtualenv 20:10:51 INFO - Creating virtualenv /builds/slave/test/build/venv 20:10:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:10:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:10:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:10:51 INFO - Using real prefix '/usr' 20:10:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:10:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:10:53 INFO - Installing pip.................done. 20:10:53 INFO - Return code: 0 20:10:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:10: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')]} 20:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:10:53 INFO - Using env: {'DISPLAY': ':0', 20:10:53 INFO - 'HOME': '/home/cltbld', 20:10:53 INFO - 'LANG': 'en_US.UTF-8', 20:10:53 INFO - 'LANGUAGE': 'en_US:en', 20:10:53 INFO - 'LOGNAME': 'cltbld', 20:10:53 INFO - 'MAIL': '/var/mail/cltbld', 20:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:53 INFO - 'MOZ_NO_REMOTE': '1', 20:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:53 INFO - 'NO_EM_RESTART': '1', 20:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:53 INFO - 'PWD': '/builds/slave/test', 20:10:53 INFO - 'SHELL': '/bin/bash', 20:10:53 INFO - 'SHLVL': '1', 20:10:53 INFO - 'TERM': 'linux', 20:10:53 INFO - 'TMOUT': '86400', 20:10:53 INFO - 'USER': 'cltbld', 20:10:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:53 INFO - '_': '/tools/buildbot/bin/python'} 20:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:10:53 INFO - Cleaning up... 20:10:53 INFO - Return code: 0 20:10:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:10: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')]} 20:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:10:53 INFO - Using env: {'DISPLAY': ':0', 20:10:53 INFO - 'HOME': '/home/cltbld', 20:10:53 INFO - 'LANG': 'en_US.UTF-8', 20:10:53 INFO - 'LANGUAGE': 'en_US:en', 20:10:53 INFO - 'LOGNAME': 'cltbld', 20:10:53 INFO - 'MAIL': '/var/mail/cltbld', 20:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:53 INFO - 'MOZ_NO_REMOTE': '1', 20:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:53 INFO - 'NO_EM_RESTART': '1', 20:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:53 INFO - 'PWD': '/builds/slave/test', 20:10:53 INFO - 'SHELL': '/bin/bash', 20:10:53 INFO - 'SHLVL': '1', 20:10:53 INFO - 'TERM': 'linux', 20:10:53 INFO - 'TMOUT': '86400', 20:10:53 INFO - 'USER': 'cltbld', 20:10:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:53 INFO - '_': '/tools/buildbot/bin/python'} 20:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:54 INFO - Downloading/unpacking psutil>=0.7.1 20:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:10:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:55 INFO - Installing collected packages: psutil 20:10:55 INFO - Running setup.py install for psutil 20:10:56 INFO - building 'psutil._psutil_linux' extension 20:10:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:10:56 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 20:10:56 INFO - building 'psutil._psutil_posix' extension 20:10:56 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 20:10:56 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 20:10:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:56 INFO - Successfully installed psutil 20:10:56 INFO - Cleaning up... 20:10:56 INFO - Return code: 0 20:10:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:10: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')]} 20:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:10:56 INFO - Using env: {'DISPLAY': ':0', 20:10:56 INFO - 'HOME': '/home/cltbld', 20:10:56 INFO - 'LANG': 'en_US.UTF-8', 20:10:56 INFO - 'LANGUAGE': 'en_US:en', 20:10:56 INFO - 'LOGNAME': 'cltbld', 20:10:56 INFO - 'MAIL': '/var/mail/cltbld', 20:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:56 INFO - 'MOZ_NO_REMOTE': '1', 20:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:56 INFO - 'NO_EM_RESTART': '1', 20:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:56 INFO - 'PWD': '/builds/slave/test', 20:10:56 INFO - 'SHELL': '/bin/bash', 20:10:56 INFO - 'SHLVL': '1', 20:10:56 INFO - 'TERM': 'linux', 20:10:56 INFO - 'TMOUT': '86400', 20:10:56 INFO - 'USER': 'cltbld', 20:10:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:56 INFO - '_': '/tools/buildbot/bin/python'} 20:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:10:56 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 20:10:56 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 20:10:56 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 20:10:56 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 20:10:56 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 20:10:56 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 20:10:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:10:58 INFO - Installing collected packages: mozsystemmonitor 20:10:58 INFO - Running setup.py install for mozsystemmonitor 20:10:58 INFO - Successfully installed mozsystemmonitor 20:10:58 INFO - Cleaning up... 20:10:58 INFO - Return code: 0 20:10:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:10:58 INFO - Using env: {'DISPLAY': ':0', 20:10:58 INFO - 'HOME': '/home/cltbld', 20:10:58 INFO - 'LANG': 'en_US.UTF-8', 20:10:58 INFO - 'LANGUAGE': 'en_US:en', 20:10:58 INFO - 'LOGNAME': 'cltbld', 20:10:58 INFO - 'MAIL': '/var/mail/cltbld', 20:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:58 INFO - 'MOZ_NO_REMOTE': '1', 20:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:58 INFO - 'NO_EM_RESTART': '1', 20:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:58 INFO - 'PWD': '/builds/slave/test', 20:10:58 INFO - 'SHELL': '/bin/bash', 20:10:58 INFO - 'SHLVL': '1', 20:10:58 INFO - 'TERM': 'linux', 20:10:58 INFO - 'TMOUT': '86400', 20:10:58 INFO - 'USER': 'cltbld', 20:10:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:58 INFO - '_': '/tools/buildbot/bin/python'} 20:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:00 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:01 INFO - Downloading docopt-0.6.1.tar.gz 20:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:01 INFO - Running setup.py install for blobuploader 20:11:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:01 INFO - Running setup.py install for requests 20:11:01 INFO - Running setup.py install for docopt 20:11:01 INFO - Successfully installed blobuploader requests docopt 20:11:01 INFO - Cleaning up... 20:11:01 INFO - Return code: 0 20:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:01 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 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:11:01 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 20:11:01 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 20:11:01 INFO - Using env: {'DISPLAY': ':0', 20:11:01 INFO - 'HOME': '/home/cltbld', 20:11:01 INFO - 'LANG': 'en_US.UTF-8', 20:11:01 INFO - 'LANGUAGE': 'en_US:en', 20:11:01 INFO - 'LOGNAME': 'cltbld', 20:11:01 INFO - 'MAIL': '/var/mail/cltbld', 20:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:01 INFO - 'MOZ_NO_REMOTE': '1', 20:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:01 INFO - 'NO_EM_RESTART': '1', 20:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:01 INFO - 'PWD': '/builds/slave/test', 20:11:01 INFO - 'SHELL': '/bin/bash', 20:11:01 INFO - 'SHLVL': '1', 20:11:01 INFO - 'TERM': 'linux', 20:11:01 INFO - 'TMOUT': '86400', 20:11:01 INFO - 'USER': 'cltbld', 20:11:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:01 INFO - '_': '/tools/buildbot/bin/python'} 20:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:02 INFO - Running setup.py (path:/tmp/pip-QDtcoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:02 INFO - Running setup.py (path:/tmp/pip-ypJJEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:02 INFO - Running setup.py (path:/tmp/pip-sznCBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:02 INFO - Running setup.py (path:/tmp/pip-cO4gXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:02 INFO - Running setup.py (path:/tmp/pip-K7fnN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:02 INFO - Running setup.py (path:/tmp/pip-itkaXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:02 INFO - Running setup.py (path:/tmp/pip-hRjM8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:02 INFO - Running setup.py (path:/tmp/pip-jWKzlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:02 INFO - Running setup.py (path:/tmp/pip-2YRvIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:02 INFO - Running setup.py (path:/tmp/pip-0clGbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:02 INFO - Running setup.py (path:/tmp/pip-G8Ftjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:02 INFO - Running setup.py (path:/tmp/pip-cRCME8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:02 INFO - Running setup.py (path:/tmp/pip-7n8Rvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:02 INFO - Running setup.py (path:/tmp/pip-yQkSLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:02 INFO - Running setup.py (path:/tmp/pip-QETlr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:02 INFO - Running setup.py (path:/tmp/pip-nBfikM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:03 INFO - Running setup.py (path:/tmp/pip-7UBnnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:03 INFO - Running setup.py install for manifestparser 20:11:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Running setup.py install for mozcrash 20:11:03 INFO - Running setup.py install for mozdebug 20:11:03 INFO - Running setup.py install for mozdevice 20:11:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Running setup.py install for mozfile 20:11:03 INFO - Running setup.py install for mozhttpd 20:11:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Running setup.py install for mozinfo 20:11:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Running setup.py install for mozInstall 20:11:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:03 INFO - Running setup.py install for mozleak 20:11:03 INFO - Running setup.py install for mozlog 20:11:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for moznetwork 20:11:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for mozprocess 20:11:04 INFO - Running setup.py install for mozprofile 20:11:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for mozrunner 20:11:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for mozscreenshot 20:11:04 INFO - Running setup.py install for moztest 20:11:04 INFO - Running setup.py install for mozversion 20:11:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:04 INFO - Cleaning up... 20:11:04 INFO - Return code: 0 20:11:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:04 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 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:11:04 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 20:11:04 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 20:11:04 INFO - Using env: {'DISPLAY': ':0', 20:11:04 INFO - 'HOME': '/home/cltbld', 20:11:04 INFO - 'LANG': 'en_US.UTF-8', 20:11:04 INFO - 'LANGUAGE': 'en_US:en', 20:11:04 INFO - 'LOGNAME': 'cltbld', 20:11:04 INFO - 'MAIL': '/var/mail/cltbld', 20:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:04 INFO - 'MOZ_NO_REMOTE': '1', 20:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:04 INFO - 'NO_EM_RESTART': '1', 20:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:04 INFO - 'PWD': '/builds/slave/test', 20:11:04 INFO - 'SHELL': '/bin/bash', 20:11:04 INFO - 'SHLVL': '1', 20:11:04 INFO - 'TERM': 'linux', 20:11:04 INFO - 'TMOUT': '86400', 20:11:04 INFO - 'USER': 'cltbld', 20:11:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:04 INFO - '_': '/tools/buildbot/bin/python'} 20:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:04 INFO - Running setup.py (path:/tmp/pip-TwWpyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:04 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)) 20:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:04 INFO - Running setup.py (path:/tmp/pip-Ug83F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:05 INFO - Running setup.py (path:/tmp/pip-AUEf29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:05 INFO - Running setup.py (path:/tmp/pip-sHMEHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:05 INFO - Running setup.py (path:/tmp/pip-0ABrWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:05 INFO - Running setup.py (path:/tmp/pip-vkhIHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:05 INFO - Running setup.py (path:/tmp/pip-2RuLNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:05 INFO - Running setup.py (path:/tmp/pip-cAe6M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:05 INFO - Running setup.py (path:/tmp/pip-LgSDj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:05 INFO - Running setup.py (path:/tmp/pip-tZz3qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:05 INFO - Running setup.py (path:/tmp/pip-2etJpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:05 INFO - Running setup.py (path:/tmp/pip-oZ_u3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:05 INFO - Running setup.py (path:/tmp/pip-1i4Dx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:05 INFO - Running setup.py (path:/tmp/pip-UekWNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:05 INFO - Running setup.py (path:/tmp/pip-CikFLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:05 INFO - Running setup.py (path:/tmp/pip-eY9tfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:05 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)) 20:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:05 INFO - Running setup.py (path:/tmp/pip-YC9x0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:05 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)) 20:11:05 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)) 20:11:05 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)) 20:11:05 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)) 20:11:05 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)) 20:11:05 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)) 20:11:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:07 INFO - Downloading blessings-1.6.tar.gz 20:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:07 INFO - Installing collected packages: blessings 20:11:07 INFO - Running setup.py install for blessings 20:11:07 INFO - Successfully installed blessings 20:11:07 INFO - Cleaning up... 20:11:08 INFO - Return code: 0 20:11:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:08 INFO - Reading from file tmpfile_stdout 20:11:08 INFO - Current package versions: 20:11:08 INFO - argparse == 1.2.1 20:11:08 INFO - blessings == 1.6 20:11:08 INFO - blobuploader == 1.2.4 20:11:08 INFO - docopt == 0.6.1 20:11:08 INFO - manifestparser == 1.1 20:11:08 INFO - mozInstall == 1.12 20:11:08 INFO - mozcrash == 0.17 20:11:08 INFO - mozdebug == 0.1 20:11:08 INFO - mozdevice == 0.48 20:11:08 INFO - mozfile == 1.2 20:11:08 INFO - mozhttpd == 0.7 20:11:08 INFO - mozinfo == 0.9 20:11:08 INFO - mozleak == 0.1 20:11:08 INFO - mozlog == 3.1 20:11:08 INFO - moznetwork == 0.27 20:11:08 INFO - mozprocess == 0.22 20:11:08 INFO - mozprofile == 0.28 20:11:08 INFO - mozrunner == 6.11 20:11:08 INFO - mozscreenshot == 0.1 20:11:08 INFO - mozsystemmonitor == 0.0 20:11:08 INFO - moztest == 0.7 20:11:08 INFO - mozversion == 1.4 20:11:08 INFO - psutil == 3.1.1 20:11:08 INFO - requests == 1.2.3 20:11:08 INFO - wsgiref == 0.1.2 20:11:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:08 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 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:11:08 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 20:11:08 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 20:11:08 INFO - Using env: {'DISPLAY': ':0', 20:11:08 INFO - 'HOME': '/home/cltbld', 20:11:08 INFO - 'LANG': 'en_US.UTF-8', 20:11:08 INFO - 'LANGUAGE': 'en_US:en', 20:11:08 INFO - 'LOGNAME': 'cltbld', 20:11:08 INFO - 'MAIL': '/var/mail/cltbld', 20:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:08 INFO - 'MOZ_NO_REMOTE': '1', 20:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:08 INFO - 'NO_EM_RESTART': '1', 20:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:08 INFO - 'PWD': '/builds/slave/test', 20:11:08 INFO - 'SHELL': '/bin/bash', 20:11:08 INFO - 'SHLVL': '1', 20:11:08 INFO - 'TERM': 'linux', 20:11:08 INFO - 'TMOUT': '86400', 20:11:08 INFO - 'USER': 'cltbld', 20:11:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:08 INFO - '_': '/tools/buildbot/bin/python'} 20:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 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)) 20:11:08 INFO - Cleaning up... 20:11:08 INFO - Return code: 0 20:11:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:08 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 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:11:08 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 20:11:08 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 20:11:08 INFO - Using env: {'DISPLAY': ':0', 20:11:08 INFO - 'HOME': '/home/cltbld', 20:11:08 INFO - 'LANG': 'en_US.UTF-8', 20:11:08 INFO - 'LANGUAGE': 'en_US:en', 20:11:08 INFO - 'LOGNAME': 'cltbld', 20:11:08 INFO - 'MAIL': '/var/mail/cltbld', 20:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:08 INFO - 'MOZ_NO_REMOTE': '1', 20:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:08 INFO - 'NO_EM_RESTART': '1', 20:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:08 INFO - 'PWD': '/builds/slave/test', 20:11:08 INFO - 'SHELL': '/bin/bash', 20:11:08 INFO - 'SHLVL': '1', 20:11:08 INFO - 'TERM': 'linux', 20:11:08 INFO - 'TMOUT': '86400', 20:11:08 INFO - 'USER': 'cltbld', 20:11:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:08 INFO - '_': '/tools/buildbot/bin/python'} 20:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:08 INFO - Downloading/unpacking jsonschema 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:11:10 INFO - Downloading/unpacking functools32 (from jsonschema) 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:10 INFO - Downloading functools32-3.2.3-2.tar.gz 20:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:11:10 INFO - warning: no files found matching '*.txt' 20:11:10 INFO - no previously-included directories found matching 'build' 20:11:10 INFO - no previously-included directories found matching 'dist' 20:11:10 INFO - no previously-included directories found matching '.git*' 20:11:10 INFO - Installing collected packages: jsonschema, functools32 20:11:10 INFO - Running setup.py install for functools32 20:11:10 INFO - warning: no files found matching '*.txt' 20:11:10 INFO - no previously-included directories found matching 'build' 20:11:10 INFO - no previously-included directories found matching 'dist' 20:11:10 INFO - no previously-included directories found matching '.git*' 20:11:10 INFO - Successfully installed jsonschema functools32 20:11:10 INFO - Cleaning up... 20:11:10 INFO - Return code: 0 20:11:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:10 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 0x7f9131919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', '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 20:11:10 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 20:11:10 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 20:11:10 INFO - Using env: {'DISPLAY': ':0', 20:11:10 INFO - 'HOME': '/home/cltbld', 20:11:10 INFO - 'LANG': 'en_US.UTF-8', 20:11:10 INFO - 'LANGUAGE': 'en_US:en', 20:11:10 INFO - 'LOGNAME': 'cltbld', 20:11:10 INFO - 'MAIL': '/var/mail/cltbld', 20:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:10 INFO - 'MOZ_NO_REMOTE': '1', 20:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:10 INFO - 'NO_EM_RESTART': '1', 20:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:10 INFO - 'PWD': '/builds/slave/test', 20:11:10 INFO - 'SHELL': '/bin/bash', 20:11:10 INFO - 'SHLVL': '1', 20:11:10 INFO - 'TERM': 'linux', 20:11:10 INFO - 'TMOUT': '86400', 20:11:10 INFO - 'USER': 'cltbld', 20:11:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:10 INFO - '_': '/tools/buildbot/bin/python'} 20:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:11 INFO - Downloading/unpacking flake8 20:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:11:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:11:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:11:13 INFO - no previously-included directories found matching 'docs/_build' 20:11:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:11:13 INFO - Running setup.py install for pep8 20:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:11:13 INFO - no previously-included directories found matching 'docs/_build' 20:11:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:11:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:11:13 INFO - Cleaning up... 20:11:13 INFO - Return code: 0 20:11:13 INFO - Running post-action listener: _resource_record_post_action 20:11:13 INFO - Running post-action listener: _start_resource_monitoring 20:11:13 INFO - Starting resource monitoring. 20:11:13 INFO - ##### 20:11:13 INFO - ##### Finished create-virtualenv step (success) 20:11:13 INFO - ##### 20:11:13 INFO - ##### 20:11:13 INFO - ##### Running install step. 20:11:13 INFO - ##### 20:11:13 INFO - Running pre-action listener: _resource_record_pre_action 20:11:13 INFO - Running main action method: install 20:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:14 INFO - Reading from file tmpfile_stdout 20:11:14 INFO - Detecting whether we're running mozinstall >=1.0... 20:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:11:14 INFO - Reading from file tmpfile_stdout 20:11:14 INFO - Output received: 20:11:14 INFO - Usage: mozinstall [options] installer 20:11:14 INFO - Options: 20:11:14 INFO - -h, --help show this help message and exit 20:11:14 INFO - -d DEST, --destination=DEST 20:11:14 INFO - Directory to install application into. [default: 20:11:14 INFO - "/builds/slave/test"] 20:11:14 INFO - --app=APP Application being installed. [default: firefox] 20:11:14 INFO - mkdir: /builds/slave/test/build/application 20:11:14 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'] 20:11:14 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 20:11:30 INFO - Reading from file tmpfile_stdout 20:11:30 INFO - Output received: 20:11:30 INFO - /builds/slave/test/build/application/firefox/firefox 20:11:30 INFO - Running post-action listener: _resource_record_post_action 20:11:30 INFO - ##### 20:11:30 INFO - ##### Finished install step (success) 20:11:30 INFO - ##### 20:11:30 INFO - ##### 20:11:30 INFO - ##### Running run-tests step. 20:11:30 INFO - ##### 20:11:30 INFO - Running pre-action listener: _resource_record_pre_action 20:11:30 INFO - Running main action method: run_tests 20:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:30 INFO - Python 2.7.3 20:11:30 INFO - Return code: 0 20:11:30 INFO - grabbing minidump binary from tooltool 20:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:30 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 0x22a89c0>, '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 0x22a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:30 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 20:11:30 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 20:11:30 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 20:11:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:30 INFO - Return code: 0 20:11:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:11:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:11:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:11:31 INFO - Return code: 0 20:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:11:31 INFO - Using env: {'DISPLAY': ':0', 20:11:31 INFO - 'HOME': '/home/cltbld', 20:11:31 INFO - 'LANG': 'en_US.UTF-8', 20:11:31 INFO - 'LANGUAGE': 'en_US:en', 20:11:31 INFO - 'LOGNAME': 'cltbld', 20:11:31 INFO - 'MAIL': '/var/mail/cltbld', 20:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:31 INFO - 'MOZ_NO_REMOTE': '1', 20:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:31 INFO - 'NO_EM_RESTART': '1', 20:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:31 INFO - 'PWD': '/builds/slave/test', 20:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:31 INFO - 'SHELL': '/bin/bash', 20:11:31 INFO - 'SHLVL': '1', 20:11:31 INFO - 'TERM': 'linux', 20:11:31 INFO - 'TMOUT': '86400', 20:11:31 INFO - 'USER': 'cltbld', 20:11:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542', 20:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:31 INFO - '_': '/tools/buildbot/bin/python'} 20:11:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:11:31 INFO - mozversion application_buildid: 20160510173021 20:11:31 INFO - mozversion application_changeset: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef 20:11:31 INFO - mozversion application_display_name: Nightly 20:11:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:31 INFO - mozversion application_name: Firefox 20:11:31 INFO - mozversion application_remotingname: firefox 20:11:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:11:31 INFO - mozversion application_vendor: Mozilla 20:11:31 INFO - mozversion application_version: 49.0a1 20:11:31 INFO - mozversion platform_buildid: 20160510173021 20:11:31 INFO - mozversion platform_changeset: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef 20:11:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:11:31 INFO - mozversion platform_version: 49.0a1 20:11:31 INFO - using testdate: 1462936291 20:11:31 INFO - actual date: 1462936291 20:11:31 INFO - starting webserver on 'localhost:35934' 20:11:31 INFO - SUITE-START | Running 2 tests 20:11:31 INFO - TEST-START | dromaeo_css 20:11:31 INFO - operating with platform_type : linux_ 20:11:31 INFO - Initialising browser for dromaeo_css test... 20:11:31 INFO - TEST-INFO | started process 23868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7tz9KX/profile http://localhost:35934/getInfo.html) 20:11:35 INFO - PROCESS | 23868 | 20:11:35 INFO - PROCESS | 23868 | (process:23935): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:11:35 INFO - PROCESS | 23868 | __metrics Screen width/height:1600/1200 20:11:35 INFO - PROCESS | 23868 | colorDepth:24 20:11:35 INFO - PROCESS | 23868 | Browser inner width/height: 1024/697 20:11:35 INFO - PROCESS | 23868 | __metrics 20:11:36 ERROR - PROCESS | 23868 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:11:37 INFO - TEST-INFO | 23868: exit 0 20:11:37 INFO - Browser initialized. 20:11:37 INFO - Running cycle 1/1 for dromaeo_css test... 20:11:37 INFO - TEST-INFO | started process 23986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7tz9KX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:38 INFO - PROCESS | 23986 | 20:11:38 INFO - PROCESS | 23986 | (process:24048): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:11:48 INFO - PROCESS | 23986 | RSS: Main: 162344960 20:11:48 INFO - PROCESS | 23986 | 20:12:38 INFO - PROCESS | 23986 | 1462936358311 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] 20:14:46 INFO - PROCESS | 23986 | Cycle 1(1): loaded http://localhost:35934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35934/tests/dromaeo/cssquery-ext.html) 20:14:47 INFO - PROCESS | 23986 | RSS: Main: 164548608 20:14:47 INFO - PROCESS | 23986 | 20:17:49 INFO - PROCESS | 23986 | Cycle 1(1): loaded http://localhost:35934/tests/dromaeo/cssquery-ext.html (next: http://localhost:35934/tests/dromaeo/cssquery-jquery.html) 20:17:49 INFO - PROCESS | 23986 | RSS: Main: 165216256 20:17:49 INFO - PROCESS | 23986 | 20:20:51 INFO - PROCESS | 23986 | Cycle 1(1): loaded http://localhost:35934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35934/tests/dromaeo/cssquery-mootools.html) 20:20:52 INFO - PROCESS | 23986 | RSS: Main: 166572032 20:20:52 INFO - PROCESS | 23986 | 20:23:53 INFO - PROCESS | 23986 | Cycle 1(1): loaded http://localhost:35934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35934/tests/dromaeo/cssquery-prototype.html) 20:23:54 INFO - PROCESS | 23986 | RSS: Main: 164216832 20:23:54 INFO - PROCESS | 23986 | 20:26:56 INFO - PROCESS | 23986 | Cycle 1(1): loaded http://localhost:35934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35934/tests/dromaeo/cssquery-yui.html) 20:26:57 INFO - PROCESS | 23986 | RSS: Main: 165601280 20:26:57 INFO - PROCESS | 23986 | 20:29:59 INFO - PROCESS | 23986 | Cycle 1(1): loaded http://localhost:35934/tests/dromaeo/cssquery-yui.html (next: http://localhost:35934/tests/dromaeo/cssquery-dojo.html) 20:30:00 INFO - PROCESS | 23986 | RSS: Main: 167391232 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - PROCESS | 23986 | __start_tp_report 20:30:00 INFO - PROCESS | 23986 | _x_x_mozilla_page_load 20:30:00 INFO - PROCESS | 23986 | _x_x_mozilla_page_load_details 20:30:00 INFO - PROCESS | 23986 | |i|pagename|runs| 20:30:00 INFO - PROCESS | 23986 | |0;dojo.html;3183.3633273345336;3231.3052693670884;3233.353329334133;3243.3675433290505;3262.42907491189;5479.095949168387;5492.505674489295;5544.417836127209;5561.638493497925;5609.158626206071;5335.226392173142;5419.024575576394;5477.0415177344;5498.340199176105;5542.002439560877;4909.459959404463;4980.103581355354;5091.338126043609;5112.258722485238;5174.534291913727;781.33766290272;4870.707757534542;4917.385326834145;5002.8249011284615;5126.641135120543;4959.156943319645;4980.228064649967;4994.051130285252;5007.998400319914;5022.623303252252;5026.045051440215;5036.647434679574;5050.671706339076;5074.162763144113;5079.822206222764;4879.438864530589;4960.677555958851;4969.627277954168;4983.202687570008;5061.569766569846;5233.21501774733;5351.357837059539;5450;5466.371367292772;5467.097928841737;5704.201411802351;5810.622309549865;5855.945929732647;5898.823035308905;5901.9671557477695;5878.353381128072;5918.112283157518;5920.851978700523;5989.760409583611;6021.5182785377065;5604.355499117612;5606.887862242773;5611.0741727615305;5611.494965453129;5631.465010823965;5870.178175055496;5936.940630593639;6095.994160963392;6096.847578810476;6109.572329936951;5728.885422291614;5770.07678771403;5770.509506691894;5781.82654520365;5802.94197058024;5854;5937.910931336033;5959.22530071088;5978.910316345258;5992.280926288873;5591.804286849941;5624.493795558419;5639.464250896158;5788.27646544182;5955.583109182316;5794.913076303858;5812.476877081083;5825.271841019872;5931.991561434566;5966.85082872923;4441.600255976978;4464.866054018385;4466.843660471868;4479.260921947907;4514.210013247669;3919.470871432377;3940.054386947112;3953.584873588232;3956.1098752780395;3982.920341593152;5488.396276409591;5513.641613295123;5519.751611177507;5548.945700316927;5676.489115979582;5980.611260268069;6001.729922153513;6009.308929473166;6018.879622407615;6025.728842202111;5516.503514683698;5549.861253468695;5638.887222255532;5653.095504719226;5715.942840571624;4934.18585933317;4963.70217786934;4978.10394129053;4979.875503112378;5002.624803139779;5936.257967754031;6146.754129834846;6165.599236049642;6217.347178546278;6218.160548326008;5837.328707198726;5915.792947246826;5989.071693887455;6081.604695694766;6094.3600921904335;6173.907391389043;6219.222597175353;6259.029850373199;6273.027680709497;6277.71750271248;5773.16289138081;5824.271966004249;5951.137085122719;5956.821295361146;6039.245094363205;5933.643981361132;5952.375000625046;5987.072003839412;6017.789377371771;6053.303870055;5798.072308430631;5804.593678442468;5808.7095645218415;5816.3892791258;5818.0981947798155;5575.860603484945;5765.019946609171;5776.162456443876;5827.475527202572;5847.093700476433;5679.5172410345585;5708.914366284592;5730.856728581819;5742.96626607198;5766.192733017297;5740.856478588069;5836.445537673914;5837.824865254049;5852.4440178183;5866.208061911588;5512.118061110203;5599.356074051536;5675.914861277001;5683.8010669626365;5718.370979192202 20:30:00 INFO - PROCESS | 23986 | |1;ext.html;570.3554982869357;598.1924402057222;604.2386592892954;609.6403122157926;632.8291361332438;36517.26965460689;39961.400578991335;40165.79917100414;40337.39493907594;40568.391474127835;39965.40051899224;40090.398644020366;40487.79756101215;41438.58561414385;41576.58423415765;8517.701880434186;8542.359323050765;8670.306375489945;8694;8723.735058416525;8608.354373421987;8693.087225841291;8707.782305442352;8711.912880871174;8714.128587141267;8685.131486851327;8699.869501957475;8707.216350528452;8744.16930391615;8746.825063498727;8622.698205562807;8634.870476942819;8638.049814520398;8668.739937801876;8685.565721713952;8522.360822938304;8552.572371381468;8574.914250857537;8621.396502244845;8622.396432249745;33470.497942530885;38017.42973855395;38242.235155297014;38273.425898611546;38355.424668629996;3382.400557921722;3471.6007659119273;3616.222512159872;3665.248624032067;3684.5394325709285;29391.41217175666;30037.098887033422;30889.227769305722;32470.18824529382;32602.510962335586;4386.846460373871;4396.89007774805;4412.360207769888;4427.800748966304;4460.684098191042;280027;284438;286523;287572;287989;34995.65004349924;60365.396346036854;61650.691746541874;61653;61783.691081544304;35211.82394088065;37387.25225495475;38050.23899521994;38356.616433835865;38436.23127537434;14007.929960350337;14149;14151.929240353733;14228.28858557068;14250;11334.149938754626;11388.202825802115;11416.31502109876;11442.599509017311;11492.310461372177;8683.348748843862;8685.913140868637;8719.912800872036;8767.649294028168;8784.95607521971;3428.4857271409487;3461.428864237423;3464.2032332563654;3474.0793689672255;3489.616142224353;1042.1685849258035;1072.2012100984816;1114.2311804854623;1168.9357085360386;1175.7001964498997;31064;31489.527657085164;31528.527072093937;31609.209769755482;31664.525032124537;1123.7920984617872;1129.0290350298737;1136.494260054268;1165.953361865516;1171.3381939204492;15334.386624535116;15639.218039098227;15816.130112843673;15859.52421427359;16056.75914861278;470337;471495;472814;475316;476890;54977.45022549803;55918;55935.44064559384;55987.720061399436;56001.7199914006;1399.6221020324456;1421.9857801421854;1441.668416264265;1444.6316189371644;1455.4542046732474;28321.29196770015;28751.5687264687;29132.126036218946;29394.55908161422;29399.85300073486;47136.52863471459;53666;56221.15668264897;56476.152857706344;60988.08517872324;425591;425607;430116;431626;432014;43659;43901.56098438975;44402;44490;44601.10797784091;47738.522614774796;47805.28292075552;47971.76014119907;48515.514844852514;48901.2664810021;40252;41122.58877411307;41214;41748.165036699706;42018;37884.242315152995;38809.6119038806;38855.80572097235;39543;39865.80067099646;40504.392434112924;41509.79245103755;41908.371374428796;42006;42361.1527769449;33606.32787344288;36381.81809090938;36632.81683591672;36882.8155859219;36920.44619330766;28059.158225253275;28249.717502824707;28356.43287134287;28362.85818570894;28492.43015139727 20:30:00 INFO - PROCESS | 23986 | |2;jquery.html;380.2660864531453;381.7099004756385;382.37481717392063;390.1650467998482;400.6414259237982;14883.702325953474;17025.57436064099;18064.367747128854;19593;19640.31258905937;18116.4565063048;18490.260389584433;19119.71320430195;19158.42524724257;19185.61628767424;4992.725400102993;5469.07025805614;5656.830295091133;5660.066089095294;5682.062459694145;5642.689652069134;5652.660840349572;5668.404817494165;5671.432856714317;5686.2039314496005;5378.8924221515545;5595.300587426572;5627.409122042168;5631.915521267184;5638.915416268759;5366.6779993200535;5547.972260138694;5587.245721827542;5592.7762889484575;5594.0769772987405;4961.727105009223;5010.148274793294;5031.195008798574;5032.144535428986;5049.444561098277;21315.786842131536;21930.232441864457;22613.886930565408;22998.54002919949;23090.307290781304;2343.367290831466;2374.1215750172373;2383.74970628085;2444.6210837320245;2469.962950555743;14282.285885705673;14306.28468576567;14436.350364233635;14935.103893766409;14942.252887355697;1777.4934143768965;1827.762390889176;1830.7345434911997;1835.6879330513711;1861.0694652673662;81852;82607;82648.17351826465;82681.58659206725;82988;10383.428911409794;10555.155587552978;10785.622503212508;10895.128389728803;10994.28537145083;13138.146020508637;13569.796453053212;15012.324445399983;15016.62458438526;15062.924685376503;7392.186859445456;7556.395488360918;7590.468667193243;7640.770776876702;7872.685092596346;7281.817954551178;7303.269673032654;7385.446091543048;7397.741079062314;7454.701811927571;6678.632675202911;6729.4279986200745;6765.154355705537;6777.288384719632;6819.079424277758;1899.040984302918;1914.9138288777037;1939.5442071113278;1942.8348590369976;1979.8713083649805;973.6932866147141;1033.6847261585137;1114.8829372915889;1155.6879642496647;1157.2709193208225;18858.434246972614;19166.8083319165;19479.415617531497;19872.70190947137;19915.60168796616;1021.8007488539812;1060.7189094889861;1085.375908852413;1095.4413249242784;1099.0438318662814;10843;11171.106311495061;11198.216124871344;11204.831927521094;11303.830442543369;359613;367897;367922;454804;456279;87039;97290.51354743181;103969.48015260027;104012.47993760134;104397;905.2169873059756;929.8140371925642;941.6045260990401;946.2666433514082;969.4813274898037;17491.21289541948;17656.82343176603;17768.733468998234;17787.377441789475;17821;32009.679903201602;39758.40362394509;41416.79291603523;41690.58309416867;42013.159736805705;50568;53078.73460632672;53153.73423133014;53443.465565343846;53548;8350.707725229588;8560.91439085601;8587.914120858712;8614.396992210484;8751.343649226461;9979.800403992025;13460.192388456724;13548.86451135476;13692.52076177329;13829.861701382857;11114.277571957797;11402;11488.02351800073;11509.251898626562;11719.94063331117;11127.610533631285;11161.330320180816;11379.203455758017;11621.88378116208;11853.644390668294;11784.351860647746;12224.938875305566;12291.56979505713;12316.630501084981;12379.133460657667;8167.714130005421;8168.183181681784;8369.49783013021;8372.539510326747;8631.82736345257;11017.724556886142;11723;11819.881801181878;12333.198342107735;12412.441440135035 20:30:00 INFO - PROCESS | 23986 | |3;mootools.html;1508.3514088941754;1508.9471868484602;1702.1744453939846;1819.3086627081707;1821.2259789589439;7653.808654783619;8359.540225287607;8472.872906906401;8885.11148885112;8921.420107693004;8513.106123856998;8662.090480499552;8808.691695790632;8816.603252853622;8832.823343533126;2164.145162660744;2206.9558608827815;2219.3120132758895;2224.6996655451467;2230.119102954332;2195.3304242206123;2217.39021769014;2235.4634887627017;2247.5280191159877;2265.6035193841094;2191.3316438486336;2195.2426412887608;2205.9889700551475;2235.4634887626935;2248.6289762189217;2168.56628674265;2178.6514157734687;2182.6289530779727;2184.159098746994;2200.7359116905996;2144.5818065477083;2154.2998525479284;2159.2010955946243;2171.467990342376;2173.5870184665023;8640.827183456358;8703.129687031309;8710;8738.082501337332;8749.343799215085;5039.09296326661;5151.2530683050745;5157;5169.922451163236;5177.48225177483;3251.723603493706;3404.21703008307;3493.9301213975577;3494.5981212160673;3530.505729197914;1075.3655343347384;1104.7072525780675;1105.3865104866795;1105.4417519152857;1113.7271368514685;12350.57769959616;12376.690582735504;12431.875681243162;12474.43865026076;12580.622581322576;4664.86005419838;4731.621470282369;4800.615950723934;4801.847556586464;4819.084373968934;10403.115735162444;10420.47897605132;10447.216458765472;10451.477426128664;10503.107235884883;5129.358830146231;5208.374995000549;5214.374275087014;5217.3999990000875;5222.21666749983;4223.429836972031;4731.95268047322;4829.637777166727;4849.393825771778;4893.853184404474;3893.968098453912;3940.8029598520534;3991.9201615967518;3997.140614767839;4007.0783719744622;1209.830623712681;1303.9543615973396;1308.2869835939246;1309.7904335306305;1316.1642357103117;1001.8998100190068;1012.4532752313816;1019.7603563162651;1038.065740833256;1039.9792004159874;6061.212042434543;6069.908951365733;6099.451049405486;6325.96837015812;6336.778212762623;957.5786653872274;978.9853152202722;1003.4380746781826;1029.3720830293514;1035.0374152038676;3788.6969042477085;3923.4507168996365;4013.2174226026227;4044.373122166069;4143.240895155736;10598.099161571352;11071.280366776135;11145.554177832795;11174.050205732603;11174.27367221128;10884.61903833362;10891.618793342195;10967.287126336763;10983.83524247121;11056.281341712764;8070.2333278338465;8109.391795615353;8234;8235.547044912588;8242.793930151674;5776.653400795965;5812.476877081083;5869.236999190249;5977.910331344946;5986.521078313637;9583.712488625353;10049.69850904474;10095.29332946716;10149;10246.692599222035;10012.899871001197;10149.695509134737;10184.338018028804;10244.487775611338;10290.897091028994;6627.304133066152;6963.338482844122;7118.430525558047;7153.678084486315;7302.488825782144;8765.868511972198;8768.736937891874;8822.07368226327;8835.20483156519;8856.46861188305;7594.658240379085;7630.7329243476215;7757;7798.220177982156;7866.488678235896;7515.549067055994;7564.243575642392;7584.54492730438;7664.846703066019;7684.500507466997;6797.25230224665;6845.281245469154;6847.897281540681;6856.142982127234;6892.758753443806;5200.973995130152;5205;5286.259923610774;5347.812826551052;5371.785128594813;5055.646104772778;5109.335786347751;5204.323437953042;5210.609204309616;5271.525562699376 20:30:00 INFO - PROCESS | 23986 | |4;prototype.html;316.4320045518293;320.80751549070555;325.12054891518443;327.98360081995895;328.476080651361;5097.949020509794;5395.568354531638;5472.480114389132;5487.12206047032;5514.393416724167;5340.198970154479;5382.300300960869;5414.8917021659545;5454.318210223722;5467.507924286813;4174.831047306759;4199.3281075028;4215.388768628547;4255.531891491949;4260.36094585813;4096.713230073896;4202.936955945664;4204.915901681965;4238.4490016298;4253.021804984855;4125.504939407276;4131.814068366931;4157.792110394484;4178.498580170384;4190.120074784299;4210.32634778434;4216.177845320164;4220.240356735771;4228.809703563332;4233.5554766749665;3697.6487233712755;3710.5157936825217;3711.294853977736;3715.758475699071;3723.1622884850963;4927.1870141426625;5280.471952804727;5298.443663415363;5299.735013249322;5356.705381204032;4742.359781429497;4754.762261886926;4762.52374762521;4771.165046116916;4772.331873537708;5420.891582168374;5626.127950167731;5671.6880571568545;5716.71416429181;5717.171010203498;4007.699422543321;4008.699347548916;4013.3779264214095;4042.2521833460905;4061.1065565575823;5898.705064746746;5983.132445795335;5983.461488466059;5990.4839967213875;5991.910121348184;4028.295048366524;4129.587041295847;4140.296149654566;4150.294449943456;4163.584381310369;4153.293940030142;4171.040660648007;4182.264360290445;4189.371594260885;4194.643455306272;4788.090262850047;4808.639352048541;4821.734804585712;4840.806367745321;4855.465898751135;5256.868578285574;5748.5688573357165;5786.508146807569;5791.305043394736;5813.389594092644;1414.8160739104057;1433.6487560547732;1437.641428849727;1442.898997070195;1446.4864972934668;893.5755516129786;899.6896070855545;914.6021480655936;914.8947870994788;918.1736437206434;4755.9286610700865;4826.565609095198;4848.345473361122;4870.09903167915;4882.194437917704;5051.696898186121;5075.8984820303385;5088.771005304696;5135.229715542699;5154.819581314636;4655.371524844103;4781.641376896677;4792.856214313576;4856.538628830255;4860.684055536379;2757.1728481455884;2761.6271803306295;2776.430831679501;2781.805273630867;2788.4562510310293;4553.271476563734;5176.8964620707375;5186.351706036746;5215.009148261894;5284.573165245362;4913.557779799835;5094.930064686383;5099.260607212008;5142.2286657001005;5208.557272631869;5201.7919283229;5247.895042099137;5268.025415298182;5352.705601191894;5364.678119312854;5068.530126263342;5113.74431278442;5149.845504634867;5157.458466860926;5195.792168313225;4737.986355798841;4997;5010.448850626501;5064.898702026013;5085.516875896784;5306.071437498345;5308.487081181845;5312.061097699235;5321.993073913227;5337.733113344395;3647.4893514907403;3654.4103315058037;3680.300742858848;3705.7405981581032;3718.6467285607823;4848.109237397488;5033.874153146201;5130.692158470503;5685.51673107774;5930.466258036798;5789.797357092481;5789.813088316969;5790.363060063305;5805.448482394166;5810.663547384041;5582.972085139549;5713.514351280188;5754.647657800329;5758.856028599151;5792.102224155263;5496.340439147168;5658.519025882846;5687.630304030225;5688.374278829243;5708.229389032427;5839.686070634073;5864.472197502245;5869.236999190078;5874.765009399576;5882.764689412375;5334.333208348957;5664.716764161858;5681.744321505459;5691.686957217393;5698.800541981011 20:30:00 INFO - PROCESS | 23986 | |5;yui.html;833.9916600833993;837.706802619083;856.6444925355978;863.3654264115874;872.7076429396152;15799.921000394996;15818.446354377598;16083.115428651434;16136.112513811766;16137.919310403446;14501.49244776433;14534.200618965979;14549.92725036376;14568.927155364208;14642.34109465074;840.2311884625576;843.616154649636;850.6257246811414;851.4805968359295;852.0542198160068;830.6013113705425;856.8500512410335;857.9013413457438;860.1914200651399;863.7063398444527;891.0109778146252;896.1844721303615;899.8155378147464;900.5047224026791;906.0893801729253;891.5364010714457;892.281713220857;892.4466830565026;895.7760559860035;897.6005677473527;650.5218664281749;651.0754728285846;651.2087813306807;652.7519542573839;652.9967350163266;14651.853481465261;14654.267286635732;14723;14732.631684207874;14735.92632036833;13494.325283735774;13546.187228766206;13551.95496275078;13697.794533082011;13731.862681373159;11467.541298348056;11470.942645286803;11570.42147892602;11710.414479276002;11715;3774.792386418746;3801.5248093988253;3820.2359528094216;3847.634474724897;3916.921661566753;50808.237876431886;50991.490085099416;51266.48733512692;51436.97126057495;51965.22052169221;10562.31344962575;10755.516001779939;10816.945915270373;11071.446427678584;11152.944235278772;18904.149313280934;18963.90518047401;19139.2344306229;19202.51993700141;19273.325433609756;8586.398952073296;8650.178233067849;8676.089010653917;8755.56222188888;8807.559622018873;4832.299316599074;4850.927236091461;4881.682690625098;4917.680350777259;4967.677100988424;3335.6497567755523;3381.7632765706167;3415.7438192135687;3418.9145271368416;3442.4836274559016;649.8927676933253;682.9043933849265;717.9317964793337;726.5241266970143;726.7056841979007;648.4391001783423;674.2010717300016;690.9911529167372;736.5507040705165;740.3891789273871;9804.117629413387;9917.553710083064;10025.398476091312;10119.544620491948;10145.188384929188;657.6481582353418;661.2759028863387;667.2993356975156;715.6135686729212;794.9403794715304;4535.206338890681;4600.838970636011;4604.493505714368;4629.166749985035;4629.583337499574;58816.11775823366;59224.703876480344;60506;60833.695831520556;61547.6922615384;53432.198517022276;53865.1920221197;55239.72380138154;55488.44511554913;56445.43554564484;49946.75026624916;50012.49987500079;50113.74943125334;50405.74797125991;50488.495115048376;9010.549472526478;9081.59132839037;9122.224610908148;9183.586738596645;9197.954010229905;34520.65479345275;34755.30489390148;35194.82402587971;35337.46993795044;35441.645583544865;45458.31812522881;45603;46405.07189856117;46798;46956.7652161737;10521.421321827373;11340.149488788538;11509.309441433541;11641.126915481203;11792.23350482216;12698.365081745691;12935;13122.409491573093;13190.802137967747;13231.735365292448;12003.579874704343;12089.895663902898;12585.748285034431;12831.10182287231;12926.418311176209;11122.277051991594;12316.938415307866;12619.369031548202;12679;12941.352932353533;11958.222715523463;12454.937725311316;12544.937275313565;12576.245425274512;12901.741965160832;9673.697924436266;9935.552900119657;10058.245631577807;10321.535530900977;10394.584216631552;9826.312158148861;9915;10100.545475453475;10469.57212349828;10511.737206569896 20:30:00 INFO - PROCESS | 23986 | __end_tp_report 20:30:00 INFO - PROCESS | 23986 | __start_cc_report 20:30:00 INFO - PROCESS | 23986 | _x_x_mozilla_cycle_collect,293 20:30:00 INFO - PROCESS | 23986 | __end_cc_report 20:30:00 INFO - PROCESS | 23986 | __startTimestamp1462937400092__endTimestamp 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - PROCESS | 23986 | ------- Summary: start ------- 20:30:00 INFO - PROCESS | 23986 | Number of tests: 6 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - PROCESS | 23986 | [#0] dojo.html Cycles:165 Average:5458.39 Median:5704.20 stddev:737.62 (12.9%) stddev-sans-first:717.97 20:30:00 INFO - PROCESS | 23986 | Values: 3183.4 3231.3 3233.4 3243.4 3262.4 5479.1 5492.5 5544.4 5561.6 5609.2 5335.2 5419.0 5477.0 5498.3 5542.0 4909.5 4980.1 5091.3 5112.3 5174.5 781.3 4870.7 4917.4 5002.8 5126.6 4959.2 4980.2 4994.1 5008.0 5022.6 5026.0 5036.6 5050.7 5074.2 5079.8 4879.4 4960.7 4969.6 4983.2 5061.6 5233.2 5351.4 5450.0 5466.4 5467.1 5704.2 5810.6 5855.9 5898.8 5902.0 5878.4 5918.1 5920.9 5989.8 6021.5 5604.4 5606.9 5611.1 5611.5 5631.5 5870.2 5936.9 6096.0 6096.8 6109.6 5728.9 5770.1 5770.5 5781.8 5802.9 5854.0 5937.9 5959.2 5978.9 5992.3 5591.8 5624.5 5639.5 5788.3 5955.6 5794.9 5812.5 5825.3 5932.0 5966.9 4441.6 4464.9 4466.8 4479.3 4514.2 3919.5 3940.1 3953.6 3956.1 3982.9 5488.4 5513.6 5519.8 5548.9 5676.5 5980.6 6001.7 6009.3 6018.9 6025.7 5516.5 5549.9 5638.9 5653.1 5715.9 4934.2 4963.7 4978.1 4979.9 5002.6 5936.3 6146.8 6165.6 6217.3 6218.2 5837.3 5915.8 5989.1 6081.6 6094.4 6173.9 6219.2 6259.0 6273.0 6277.7 5773.2 5824.3 5951.1 5956.8 6039.2 5933.6 5952.4 5987.1 6017.8 6053.3 5798.1 5804.6 5808.7 5816.4 5818.1 5575.9 5765.0 5776.2 5827.5 5847.1 5679.5 5708.9 5730.9 5743.0 5766.2 5740.9 5836.4 5837.8 5852.4 5866.2 5512.1 5599.4 5675.9 5683.8 5718.4 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - PROCESS | 23986 | [#1] ext.html Cycles:180 Average:55241.78 Median:40208.90 stddev:107058.06 (266.3%) stddev-sans-first:107279.69 20:30:00 INFO - PROCESS | 23986 | Values: 570.4 598.2 604.2 609.6 632.8 36517.3 39961.4 40165.8 40337.4 40568.4 39965.4 40090.4 40487.8 41438.6 41576.6 8517.7 8542.4 8670.3 8694.0 8723.7 8608.4 8693.1 8707.8 8711.9 8714.1 8685.1 8699.9 8707.2 8744.2 8746.8 8622.7 8634.9 8638.0 8668.7 8685.6 8522.4 8552.6 8574.9 8621.4 8622.4 33470.5 38017.4 38242.2 38273.4 38355.4 3382.4 3471.6 3616.2 3665.2 3684.5 29391.4 30037.1 30889.2 32470.2 32602.5 4386.8 4396.9 4412.4 4427.8 4460.7 280027.0 284438.0 286523.0 287572.0 287989.0 34995.7 60365.4 61650.7 61653.0 61783.7 35211.8 37387.3 38050.2 38356.6 38436.2 14007.9 14149.0 14151.9 14228.3 14250.0 11334.1 11388.2 11416.3 11442.6 11492.3 8683.3 8685.9 8719.9 8767.6 8785.0 3428.5 3461.4 3464.2 3474.1 3489.6 1042.2 1072.2 1114.2 1168.9 1175.7 31064.0 31489.5 31528.5 31609.2 31664.5 1123.8 1129.0 1136.5 1166.0 1171.3 15334.4 15639.2 15816.1 15859.5 16056.8 470337.0 471495.0 472814.0 475316.0 476890.0 54977.5 55918.0 55935.4 55987.7 56001.7 1399.6 1422.0 1441.7 1444.6 1455.5 28321.3 28751.6 29132.1 29394.6 29399.9 47136.5 53666.0 56221.2 56476.2 60988.1 425591.0 425607.0 430116.0 431626.0 432014.0 43659.0 43901.6 44402.0 44490.0 44601.1 47738.5 47805.3 47971.8 48515.5 48901.3 40252.0 41122.6 41214.0 41748.2 42018.0 37884.2 38809.6 38855.8 39543.0 39865.8 40504.4 41509.8 41908.4 42006.0 42361.2 33606.3 36381.8 36632.8 36882.8 36920.4 28059.2 28249.7 28356.4 28362.9 28492.4 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - PROCESS | 23986 | [#2] jquery.html Cycles:180 Average:26604.73 Median:12716.84 stddev:67337.06 (529.5%) stddev-sans-first:67497.17 20:30:00 INFO - PROCESS | 23986 | Values: 380.3 381.7 382.4 390.2 400.6 14883.7 17025.6 18064.4 19593.0 19640.3 18116.5 18490.3 19119.7 19158.4 19185.6 4992.7 5469.1 5656.8 5660.1 5682.1 5642.7 5652.7 5668.4 5671.4 5686.2 5378.9 5595.3 5627.4 5631.9 5638.9 5366.7 5548.0 5587.2 5592.8 5594.1 4961.7 5010.1 5031.2 5032.1 5049.4 21315.8 21930.2 22613.9 22998.5 23090.3 2343.4 2374.1 2383.7 2444.6 2470.0 14282.3 14306.3 14436.4 14935.1 14942.3 1777.5 1827.8 1830.7 1835.7 1861.1 81852.0 82607.0 82648.2 82681.6 82988.0 10383.4 10555.2 10785.6 10895.1 10994.3 13138.1 13569.8 15012.3 15016.6 15062.9 7392.2 7556.4 7590.5 7640.8 7872.7 7281.8 7303.3 7385.4 7397.7 7454.7 6678.6 6729.4 6765.2 6777.3 6819.1 1899.0 1914.9 1939.5 1942.8 1979.9 973.7 1033.7 1114.9 1155.7 1157.3 18858.4 19166.8 19479.4 19872.7 19915.6 1021.8 1060.7 1085.4 1095.4 1099.0 10843.0 11171.1 11198.2 11204.8 11303.8 359613.0 367897.0 367922.0 454804.0 456279.0 87039.0 97290.5 103969.5 104012.5 104397.0 905.2 929.8 941.6 946.3 969.5 17491.2 17656.8 17768.7 17787.4 17821.0 32009.7 39758.4 41416.8 41690.6 42013.2 50568.0 53078.7 53153.7 53443.5 53548.0 8350.7 8560.9 8587.9 8614.4 8751.3 9979.8 13460.2 13548.9 13692.5 13829.9 11114.3 11402.0 11488.0 11509.3 11719.9 11127.6 11161.3 11379.2 11621.9 11853.6 11784.4 12224.9 12291.6 12316.6 12379.1 8167.7 8168.2 8369.5 8372.5 8631.8 11017.7 11723.0 11819.9 12333.2 12412.4 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - PROCESS | 23986 | [#3] mootools.html Cycles:180 Average:5776.82 Median:4093.81 stddev:3308.63 (80.8%) stddev-sans-first:3302.36 20:30:00 INFO - PROCESS | 23986 | Values: 1508.4 1508.9 1702.2 1819.3 1821.2 7653.8 8359.5 8472.9 8885.1 8921.4 8513.1 8662.1 8808.7 8816.6 8832.8 2164.1 2207.0 2219.3 2224.7 2230.1 2195.3 2217.4 2235.5 2247.5 2265.6 2191.3 2195.2 2206.0 2235.5 2248.6 2168.6 2178.7 2182.6 2184.2 2200.7 2144.6 2154.3 2159.2 2171.5 2173.6 8640.8 8703.1 8710.0 8738.1 8749.3 5039.1 5151.3 5157.0 5169.9 5177.5 3251.7 3404.2 3493.9 3494.6 3530.5 1075.4 1104.7 1105.4 1105.4 1113.7 12350.6 12376.7 12431.9 12474.4 12580.6 4664.9 4731.6 4800.6 4801.8 4819.1 10403.1 10420.5 10447.2 10451.5 10503.1 5129.4 5208.4 5214.4 5217.4 5222.2 4223.4 4732.0 4829.6 4849.4 4893.9 3894.0 3940.8 3991.9 3997.1 4007.1 1209.8 1304.0 1308.3 1309.8 1316.2 1001.9 1012.5 1019.8 1038.1 1040.0 6061.2 6069.9 6099.5 6326.0 6336.8 957.6 979.0 1003.4 1029.4 1035.0 3788.7 3923.5 4013.2 4044.4 4143.2 10598.1 11071.3 11145.6 11174.1 11174.3 10884.6 10891.6 10967.3 10983.8 11056.3 8070.2 8109.4 8234.0 8235.5 8242.8 5776.7 5812.5 5869.2 5977.9 5986.5 9583.7 10049.7 10095.3 10149.0 10246.7 10012.9 10149.7 10184.3 10244.5 10290.9 6627.3 6963.3 7118.4 7153.7 7302.5 8765.9 8768.7 8822.1 8835.2 8856.5 7594.7 7630.7 7757.0 7798.2 7866.5 7515.5 7564.2 7584.5 7664.8 7684.5 6797.3 6845.3 6847.9 6856.1 6892.8 5201.0 5205.0 5286.3 5347.8 5371.8 5055.6 5109.3 5204.3 5210.6 5271.5 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - PROCESS | 23986 | [#4] prototype.html Cycles:180 Average:4568.18 Median:5072.21 stddev:1334.17 (26.3%) stddev-sans-first:1299.19 20:30:00 INFO - PROCESS | 23986 | Values: 316.4 320.8 325.1 328.0 328.5 5097.9 5395.6 5472.5 5487.1 5514.4 5340.2 5382.3 5414.9 5454.3 5467.5 4174.8 4199.3 4215.4 4255.5 4260.4 4096.7 4202.9 4204.9 4238.4 4253.0 4125.5 4131.8 4157.8 4178.5 4190.1 4210.3 4216.2 4220.2 4228.8 4233.6 3697.6 3710.5 3711.3 3715.8 3723.2 4927.2 5280.5 5298.4 5299.7 5356.7 4742.4 4754.8 4762.5 4771.2 4772.3 5420.9 5626.1 5671.7 5716.7 5717.2 4007.7 4008.7 4013.4 4042.3 4061.1 5898.7 5983.1 5983.5 5990.5 5991.9 4028.3 4129.6 4140.3 4150.3 4163.6 4153.3 4171.0 4182.3 4189.4 4194.6 4788.1 4808.6 4821.7 4840.8 4855.5 5256.9 5748.6 5786.5 5791.3 5813.4 1414.8 1433.6 1437.6 1442.9 1446.5 893.6 899.7 914.6 914.9 918.2 4755.9 4826.6 4848.3 4870.1 4882.2 5051.7 5075.9 5088.8 5135.2 5154.8 4655.4 4781.6 4792.9 4856.5 4860.7 2757.2 2761.6 2776.4 2781.8 2788.5 4553.3 5176.9 5186.4 5215.0 5284.6 4913.6 5094.9 5099.3 5142.2 5208.6 5201.8 5247.9 5268.0 5352.7 5364.7 5068.5 5113.7 5149.8 5157.5 5195.8 4738.0 4997.0 5010.4 5064.9 5085.5 5306.1 5308.5 5312.1 5322.0 5337.7 3647.5 3654.4 3680.3 3705.7 3718.6 4848.1 5033.9 5130.7 5685.5 5930.5 5789.8 5789.8 5790.4 5805.4 5810.7 5583.0 5713.5 5754.6 5758.9 5792.1 5496.3 5658.5 5687.6 5688.4 5708.2 5839.7 5864.5 5869.2 5874.8 5882.8 5334.3 5664.7 5681.7 5691.7 5698.8 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - PROCESS | 23986 | [#5] yui.html Cycles:180 Average:14773.83 Median:25517.33 stddev:16787.78 (65.8%) stddev-sans-first:16802.23 20:30:00 INFO - PROCESS | 23986 | Values: 834.0 837.7 856.6 863.4 872.7 15799.9 15818.4 16083.1 16136.1 16137.9 14501.5 14534.2 14549.9 14568.9 14642.3 840.2 843.6 850.6 851.5 852.1 830.6 856.9 857.9 860.2 863.7 891.0 896.2 899.8 900.5 906.1 891.5 892.3 892.4 895.8 897.6 650.5 651.1 651.2 652.8 653.0 14651.9 14654.3 14723.0 14732.6 14735.9 13494.3 13546.2 13552.0 13697.8 13731.9 11467.5 11470.9 11570.4 11710.4 11715.0 3774.8 3801.5 3820.2 3847.6 3916.9 50808.2 50991.5 51266.5 51437.0 51965.2 10562.3 10755.5 10816.9 11071.4 11152.9 18904.1 18963.9 19139.2 19202.5 19273.3 8586.4 8650.2 8676.1 8755.6 8807.6 4832.3 4850.9 4881.7 4917.7 4967.7 3335.6 3381.8 3415.7 3418.9 3442.5 649.9 682.9 717.9 726.5 726.7 648.4 674.2 691.0 736.6 740.4 9804.1 9917.6 10025.4 10119.5 10145.2 657.6 661.3 667.3 715.6 794.9 4535.2 4600.8 4604.5 4629.2 4629.6 58816.1 59224.7 60506.0 60833.7 61547.7 53432.2 53865.2 55239.7 55488.4 56445.4 49946.8 50012.5 50113.7 50405.7 50488.5 9010.5 9081.6 9122.2 9183.6 9198.0 34520.7 34755.3 35194.8 35337.5 35441.6 45458.3 45603.0 46405.1 46798.0 46956.8 10521.4 11340.1 11509.3 11641.1 11792.2 12698.4 12935.0 13122.4 13190.8 13231.7 12003.6 12089.9 12585.7 12831.1 12926.4 11122.3 12316.9 12619.4 12679.0 12941.4 11958.2 12454.9 12544.9 12576.2 12901.7 9673.7 9935.6 10058.2 10321.5 10394.6 9826.3 9915.0 10100.5 10469.6 10511.7 20:30:00 INFO - PROCESS | 23986 | -------- Summary: end -------- 20:30:00 INFO - PROCESS | 23986 | 20:30:00 INFO - TEST-INFO | 23986: exit 0 20:30:00 INFO - TEST-OK | dromaeo_css | took 1108805ms 20:30:00 INFO - TEST-START | kraken 20:30:00 INFO - operating with platform_type : linux_ 20:30:00 INFO - Initialising browser for kraken test... 20:30:00 INFO - TEST-INFO | started process 24224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwb0jdA/profile http://localhost:35934/getInfo.html) 20:30:03 INFO - PROCESS | 24224 | 20:30:03 INFO - PROCESS | 24224 | (process:24290): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:30:04 INFO - PROCESS | 24224 | __metrics Screen width/height:1600/1200 20:30:04 INFO - PROCESS | 24224 | colorDepth:24 20:30:04 INFO - PROCESS | 24224 | Browser inner width/height: 1024/697 20:30:04 INFO - PROCESS | 24224 | __metrics 20:30:05 ERROR - PROCESS | 24224 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:30:05 INFO - TEST-INFO | 24224: exit 0 20:30:05 INFO - Browser initialized. 20:30:05 INFO - Running cycle 1/1 for kraken test... 20:30:05 INFO - TEST-INFO | started process 24341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwb0jdA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:07 INFO - PROCESS | 24341 | 20:30:07 INFO - PROCESS | 24341 | (process:24402): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:30:17 INFO - PROCESS | 24341 | RSS: Main: 162226176 20:30:17 INFO - PROCESS | 24341 | 20:30:19 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35934/tests/kraken/driver.html?testName=audio-beat-detection) 20:30:20 INFO - PROCESS | 24341 | RSS: Main: 166522880 20:30:20 INFO - PROCESS | 24341 | 20:30:23 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35934/tests/kraken/driver.html?testName=audio-dft) 20:30:23 INFO - PROCESS | 24341 | RSS: Main: 166625280 20:30:23 INFO - PROCESS | 24341 | 20:30:26 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35934/tests/kraken/driver.html?testName=audio-fft) 20:30:27 INFO - PROCESS | 24341 | RSS: Main: 161873920 20:30:27 INFO - PROCESS | 24341 | 20:30:29 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35934/tests/kraken/driver.html?testName=audio-oscillator) 20:30:30 INFO - PROCESS | 24341 | RSS: Main: 162074624 20:30:30 INFO - PROCESS | 24341 | 20:30:32 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:30:32 INFO - PROCESS | 24341 | RSS: Main: 162435072 20:30:32 INFO - PROCESS | 24341 | 20:30:36 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35934/tests/kraken/driver.html?testName=imaging-darkroom) 20:30:36 INFO - PROCESS | 24341 | RSS: Main: 162758656 20:30:36 INFO - PROCESS | 24341 | 20:30:40 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35934/tests/kraken/driver.html?testName=imaging-desaturate) 20:30:40 INFO - PROCESS | 24341 | RSS: Main: 160952320 20:30:40 INFO - PROCESS | 24341 | 20:30:43 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35934/tests/kraken/driver.html?testName=json-parse-financial) 20:30:44 INFO - PROCESS | 24341 | RSS: Main: 162336768 20:30:44 INFO - PROCESS | 24341 | 20:30:45 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:30:46 INFO - PROCESS | 24341 | RSS: Main: 162582528 20:30:46 INFO - PROCESS | 24341 | 20:30:48 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35934/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:30:48 INFO - PROCESS | 24341 | RSS: Main: 162611200 20:30:48 INFO - PROCESS | 24341 | 20:30:51 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:30:51 INFO - PROCESS | 24341 | RSS: Main: 162779136 20:30:51 INFO - PROCESS | 24341 | 20:30:54 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:30:55 INFO - PROCESS | 24341 | RSS: Main: 163028992 20:30:55 INFO - PROCESS | 24341 | 20:30:57 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:30:58 INFO - PROCESS | 24341 | RSS: Main: 162578432 20:30:58 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | Cycle 1(1): loaded http://localhost:35934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35934/tests/kraken/driver.html?testName=ai-astar) 20:31:00 INFO - PROCESS | 24341 | RSS: Main: 164233216 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | __start_tp_report 20:31:00 INFO - PROCESS | 24341 | _x_x_mozilla_page_load 20:31:00 INFO - PROCESS | 24341 | _x_x_mozilla_page_load_details 20:31:00 INFO - PROCESS | 24341 | |i|pagename|runs| 20:31:00 INFO - PROCESS | 24341 | |0;ai-astar;111;115;104;113;115;116;109;112;112;112 20:31:00 INFO - PROCESS | 24341 | |1;audio-beat-detection;158;130;160;209;139;155;155;140;181;133 20:31:00 INFO - PROCESS | 24341 | |2;audio-dft;163;165;163;161;162;166;165;180;165;161 20:31:00 INFO - PROCESS | 24341 | |3;audio-fft;77;78;78;161;78;76;77;77;166;78 20:31:00 INFO - PROCESS | 24341 | |4;audio-oscillator;94;93;174;93;95;96;138;94;93;140 20:31:00 INFO - PROCESS | 24341 | |5;imaging-gaussian-blur;119;120;118;119;119;119;120;119;120;118 20:31:00 INFO - PROCESS | 24341 | |6;imaging-darkroom;149;147;149;148;150;148;148;148;149;149 20:31:00 INFO - PROCESS | 24341 | |7;imaging-desaturate;99;95;100;96;96;96;97;96;96;96 20:31:00 INFO - PROCESS | 24341 | |8;json-parse-financial;58;59;59;61;59;58;58;59;58;58 20:31:00 INFO - PROCESS | 24341 | |9;json-stringify-tinderbox;59;60;59;59;59;60;60;60;60;60 20:31:00 INFO - PROCESS | 24341 | |10;stanford-crypto-aes;84;82;85;84;83;83;84;82;137;83 20:31:00 INFO - PROCESS | 24341 | |11;stanford-crypto-ccm;148;134;134;134;133;137;133;131;155;134 20:31:00 INFO - PROCESS | 24341 | |12;stanford-crypto-pbkdf2;170;176;171;168;170;172;175;174;177;170 20:31:00 INFO - PROCESS | 24341 | |13;stanford-crypto-sha256-iterative;66;68;68;66;66;66;66;66;66;65 20:31:00 INFO - PROCESS | 24341 | __end_tp_report 20:31:00 INFO - PROCESS | 24341 | __start_cc_report 20:31:00 INFO - PROCESS | 24341 | _x_x_mozilla_cycle_collect,732 20:31:00 INFO - PROCESS | 24341 | __end_cc_report 20:31:00 INFO - PROCESS | 24341 | __startTimestamp1462937460337__endTimestamp 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | ------- Summary: start ------- 20:31:00 INFO - PROCESS | 24341 | Number of tests: 14 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:3.48 (3.1%) stddev-sans-first:3.67 20:31:00 INFO - PROCESS | 24341 | Values: 111.0 115.0 104.0 113.0 115.0 116.0 109.0 112.0 112.0 112.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:156.50 stddev:24.05 (15.4%) stddev-sans-first:25.50 20:31:00 INFO - PROCESS | 24341 | Values: 158.0 130.0 160.0 209.0 139.0 155.0 155.0 140.0 181.0 133.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:5.53 (3.3%) stddev-sans-first:5.81 20:31:00 INFO - PROCESS | 24341 | Values: 163.0 165.0 163.0 161.0 162.0 166.0 165.0 180.0 165.0 161.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.50 stddev:36.34 (46.9%) stddev-sans-first:37.98 20:31:00 INFO - PROCESS | 24341 | Values: 77.0 78.0 78.0 161.0 78.0 76.0 77.0 77.0 166.0 78.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:93.50 stddev:29.00 (31.0%) stddev-sans-first:30.10 20:31:00 INFO - PROCESS | 24341 | Values: 94.0 93.0 174.0 93.0 95.0 96.0 138.0 94.0 93.0 140.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:119.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 20:31:00 INFO - PROCESS | 24341 | Values: 119.0 120.0 118.0 119.0 119.0 119.0 120.0 119.0 120.0 118.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 20:31:00 INFO - PROCESS | 24341 | Values: 149.0 147.0 149.0 148.0 150.0 148.0 148.0 148.0 149.0 149.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.57 (1.6%) stddev-sans-first:1.42 20:31:00 INFO - PROCESS | 24341 | Values: 99.0 95.0 100.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 20:31:00 INFO - PROCESS | 24341 | Values: 58.0 59.0 59.0 61.0 59.0 58.0 58.0 59.0 58.0 58.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 20:31:00 INFO - PROCESS | 24341 | Values: 59.0 60.0 59.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:83.50 stddev:17.00 (20.4%) stddev-sans-first:17.94 20:31:00 INFO - PROCESS | 24341 | Values: 84.0 82.0 85.0 84.0 83.0 83.0 84.0 82.0 137.0 83.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:134.00 stddev:7.80 (5.8%) stddev-sans-first:7.25 20:31:00 INFO - PROCESS | 24341 | Values: 148.0 134.0 134.0 134.0 133.0 137.0 133.0 131.0 155.0 134.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:3.02 (1.7%) stddev-sans-first:3.09 20:31:00 INFO - PROCESS | 24341 | Values: 170.0 176.0 171.0 168.0 170.0 172.0 175.0 174.0 177.0 170.0 20:31:00 INFO - PROCESS | 24341 | 20:31:00 INFO - PROCESS | 24341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 20:31:00 INFO - PROCESS | 24341 | Values: 66.0 68.0 68.0 66.0 66.0 66.0 66.0 66.0 66.0 65.0 20:31:00 INFO - PROCESS | 24341 | -------- Summary: end -------- 20:31:00 INFO - PROCESS | 24341 | 20:31:01 INFO - TEST-INFO | 24341: exit 0 20:31:01 INFO - TEST-OK | kraken | took 60514ms 20:31:01 INFO - SUITE-END | took 1169s 20:31:01 INFO - Completed test suite (00:19:29) 20:31:01 INFO - javascript benchmark 20:31:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.3633273345336, 3231.3052693670884, 3233.353329334133, 3243.3675433290505, 3262.42907491189, 5479.095949168387, 5492.505674489295, 5544.417836127209, 5561.638493497925, 5609.158626206071, 5335.226392173142, 5419.024575576394, 5477.0415177344, 5498.340199176105, 5542.002439560877, 4909.459959404463, 4980.103581355354, 5091.338126043609, 5112.258722485238, 5174.534291913727, 781.33766290272, 4870.707757534542, 4917.385326834145, 5002.8249011284615, 5126.641135120543, 4959.156943319645, 4980.228064649967, 4994.051130285252, 5007.998400319914, 5022.623303252252, 5026.045051440215, 5036.647434679574, 5050.671706339076, 5074.162763144113, 5079.822206222764, 4879.438864530589, 4960.677555958851, 4969.627277954168, 4983.202687570008, 5061.569766569846, 5233.21501774733, 5351.357837059539, 5450.0, 5466.371367292772, 5467.097928841737, 5704.201411802351, 5810.622309549865, 5855.945929732647, 5898.823035308905, 5901.9671557477695, 5878.353381128072, 5918.112283157518, 5920.851978700523, 5989.760409583611, 6021.5182785377065, 5604.355499117612, 5606.887862242773, 5611.0741727615305, 5611.494965453129, 5631.465010823965, 5870.178175055496, 5936.940630593639, 6095.994160963392, 6096.847578810476, 6109.572329936951, 5728.885422291614, 5770.07678771403, 5770.509506691894, 5781.82654520365, 5802.94197058024, 5854.0, 5937.910931336033, 5959.22530071088, 5978.910316345258, 5992.280926288873, 5591.804286849941, 5624.493795558419, 5639.464250896158, 5788.27646544182, 5955.583109182316, 5794.913076303858, 5812.476877081083, 5825.271841019872, 5931.991561434566, 5966.85082872923, 4441.600255976978, 4464.866054018385, 4466.843660471868, 4479.260921947907, 4514.210013247669, 3919.470871432377, 3940.054386947112, 3953.584873588232, 3956.1098752780395, 3982.920341593152, 5488.396276409591, 5513.641613295123, 5519.751611177507, 5548.945700316927, 5676.489115979582, 5980.611260268069, 6001.729922153513, 6009.308929473166, 6018.879622407615, 6025.728842202111, 5516.503514683698, 5549.861253468695, 5638.887222255532, 5653.095504719226, 5715.942840571624, 4934.18585933317, 4963.70217786934, 4978.10394129053, 4979.875503112378, 5002.624803139779, 5936.257967754031, 6146.754129834846, 6165.599236049642, 6217.347178546278, 6218.160548326008, 5837.328707198726, 5915.792947246826, 5989.071693887455, 6081.604695694766, 6094.3600921904335, 6173.907391389043, 6219.222597175353, 6259.029850373199, 6273.027680709497, 6277.71750271248, 5773.16289138081, 5824.271966004249, 5951.137085122719, 5956.821295361146, 6039.245094363205, 5933.643981361132, 5952.375000625046, 5987.072003839412, 6017.789377371771, 6053.303870055, 5798.072308430631, 5804.593678442468, 5808.7095645218415, 5816.3892791258, 5818.0981947798155, 5575.860603484945, 5765.019946609171, 5776.162456443876, 5827.475527202572, 5847.093700476433, 5679.5172410345585, 5708.914366284592, 5730.856728581819, 5742.96626607198, 5766.192733017297, 5740.856478588069, 5836.445537673914, 5837.824865254049, 5852.4440178183, 5866.208061911588, 5512.118061110203, 5599.356074051536, 5675.914861277001, 5683.8010669626365, 5718.370979192202], "value": 5409.524305095956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3554982869357, 598.1924402057222, 604.2386592892954, 609.6403122157926, 632.8291361332438, 36517.26965460689, 39961.400578991335, 40165.79917100414, 40337.39493907594, 40568.391474127835, 39965.40051899224, 40090.398644020366, 40487.79756101215, 41438.58561414385, 41576.58423415765, 8517.701880434186, 8542.359323050765, 8670.306375489945, 8694.0, 8723.735058416525, 8608.354373421987, 8693.087225841291, 8707.782305442352, 8711.912880871174, 8714.128587141267, 8685.131486851327, 8699.869501957475, 8707.216350528452, 8744.16930391615, 8746.825063498727, 8622.698205562807, 8634.870476942819, 8638.049814520398, 8668.739937801876, 8685.565721713952, 8522.360822938304, 8552.572371381468, 8574.914250857537, 8621.396502244845, 8622.396432249745, 33470.497942530885, 38017.42973855395, 38242.235155297014, 38273.425898611546, 38355.424668629996, 3382.400557921722, 3471.6007659119273, 3616.222512159872, 3665.248624032067, 3684.5394325709285, 29391.41217175666, 30037.098887033422, 30889.227769305722, 32470.18824529382, 32602.510962335586, 4386.846460373871, 4396.89007774805, 4412.360207769888, 4427.800748966304, 4460.684098191042, 280027.0, 284438.0, 286523.0, 287572.0, 287989.0, 34995.65004349924, 60365.396346036854, 61650.691746541874, 61653.0, 61783.691081544304, 35211.82394088065, 37387.25225495475, 38050.23899521994, 38356.616433835865, 38436.23127537434, 14007.929960350337, 14149.0, 14151.929240353733, 14228.28858557068, 14250.0, 11334.149938754626, 11388.202825802115, 11416.31502109876, 11442.599509017311, 11492.310461372177, 8683.348748843862, 8685.913140868637, 8719.912800872036, 8767.649294028168, 8784.95607521971, 3428.4857271409487, 3461.428864237423, 3464.2032332563654, 3474.0793689672255, 3489.616142224353, 1042.1685849258035, 1072.2012100984816, 1114.2311804854623, 1168.9357085360386, 1175.7001964498997, 31064.0, 31489.527657085164, 31528.527072093937, 31609.209769755482, 31664.525032124537, 1123.7920984617872, 1129.0290350298737, 1136.494260054268, 1165.953361865516, 1171.3381939204492, 15334.386624535116, 15639.218039098227, 15816.130112843673, 15859.52421427359, 16056.75914861278, 470337.0, 471495.0, 472814.0, 475316.0, 476890.0, 54977.45022549803, 55918.0, 55935.44064559384, 55987.720061399436, 56001.7199914006, 1399.6221020324456, 1421.9857801421854, 1441.668416264265, 1444.6316189371644, 1455.4542046732474, 28321.29196770015, 28751.5687264687, 29132.126036218946, 29394.55908161422, 29399.85300073486, 47136.52863471459, 53666.0, 56221.15668264897, 56476.152857706344, 60988.08517872324, 425591.0, 425607.0, 430116.0, 431626.0, 432014.0, 43659.0, 43901.56098438975, 44402.0, 44490.0, 44601.10797784091, 47738.522614774796, 47805.28292075552, 47971.76014119907, 48515.514844852514, 48901.2664810021, 40252.0, 41122.58877411307, 41214.0, 41748.165036699706, 42018.0, 37884.242315152995, 38809.6119038806, 38855.80572097235, 39543.0, 39865.80067099646, 40504.392434112924, 41509.79245103755, 41908.371374428796, 42006.0, 42361.1527769449, 33606.32787344288, 36381.81809090938, 36632.81683591672, 36882.8155859219, 36920.44619330766, 28059.158225253275, 28249.717502824707, 28356.43287134287, 28362.85818570894, 28492.43015139727], "value": 18691.601109056155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.2660864531453, 381.7099004756385, 382.37481717392063, 390.1650467998482, 400.6414259237982, 14883.702325953474, 17025.57436064099, 18064.367747128854, 19593.0, 19640.31258905937, 18116.4565063048, 18490.260389584433, 19119.71320430195, 19158.42524724257, 19185.61628767424, 4992.725400102993, 5469.07025805614, 5656.830295091133, 5660.066089095294, 5682.062459694145, 5642.689652069134, 5652.660840349572, 5668.404817494165, 5671.432856714317, 5686.2039314496005, 5378.8924221515545, 5595.300587426572, 5627.409122042168, 5631.915521267184, 5638.915416268759, 5366.6779993200535, 5547.972260138694, 5587.245721827542, 5592.7762889484575, 5594.0769772987405, 4961.727105009223, 5010.148274793294, 5031.195008798574, 5032.144535428986, 5049.444561098277, 21315.786842131536, 21930.232441864457, 22613.886930565408, 22998.54002919949, 23090.307290781304, 2343.367290831466, 2374.1215750172373, 2383.74970628085, 2444.6210837320245, 2469.962950555743, 14282.285885705673, 14306.28468576567, 14436.350364233635, 14935.103893766409, 14942.252887355697, 1777.4934143768965, 1827.762390889176, 1830.7345434911997, 1835.6879330513711, 1861.0694652673662, 81852.0, 82607.0, 82648.17351826465, 82681.58659206725, 82988.0, 10383.428911409794, 10555.155587552978, 10785.622503212508, 10895.128389728803, 10994.28537145083, 13138.146020508637, 13569.796453053212, 15012.324445399983, 15016.62458438526, 15062.924685376503, 7392.186859445456, 7556.395488360918, 7590.468667193243, 7640.770776876702, 7872.685092596346, 7281.817954551178, 7303.269673032654, 7385.446091543048, 7397.741079062314, 7454.701811927571, 6678.632675202911, 6729.4279986200745, 6765.154355705537, 6777.288384719632, 6819.079424277758, 1899.040984302918, 1914.9138288777037, 1939.5442071113278, 1942.8348590369976, 1979.8713083649805, 973.6932866147141, 1033.6847261585137, 1114.8829372915889, 1155.6879642496647, 1157.2709193208225, 18858.434246972614, 19166.8083319165, 19479.415617531497, 19872.70190947137, 19915.60168796616, 1021.8007488539812, 1060.7189094889861, 1085.375908852413, 1095.4413249242784, 1099.0438318662814, 10843.0, 11171.106311495061, 11198.216124871344, 11204.831927521094, 11303.830442543369, 359613.0, 367897.0, 367922.0, 454804.0, 456279.0, 87039.0, 97290.51354743181, 103969.48015260027, 104012.47993760134, 104397.0, 905.2169873059756, 929.8140371925642, 941.6045260990401, 946.2666433514082, 969.4813274898037, 17491.21289541948, 17656.82343176603, 17768.733468998234, 17787.377441789475, 17821.0, 32009.679903201602, 39758.40362394509, 41416.79291603523, 41690.58309416867, 42013.159736805705, 50568.0, 53078.73460632672, 53153.73423133014, 53443.465565343846, 53548.0, 8350.707725229588, 8560.91439085601, 8587.914120858712, 8614.396992210484, 8751.343649226461, 9979.800403992025, 13460.192388456724, 13548.86451135476, 13692.52076177329, 13829.861701382857, 11114.277571957797, 11402.0, 11488.02351800073, 11509.251898626562, 11719.94063331117, 11127.610533631285, 11161.330320180816, 11379.203455758017, 11621.88378116208, 11853.644390668294, 11784.351860647746, 12224.938875305566, 12291.56979505713, 12316.630501084981, 12379.133460657667, 8167.714130005421, 8168.183181681784, 8369.49783013021, 8372.539510326747, 8631.82736345257, 11017.724556886142, 11723.0, 11819.881801181878, 12333.198342107735, 12412.441440135035], "value": 9206.831360730952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.3514088941754, 1508.9471868484602, 1702.1744453939846, 1819.3086627081707, 1821.2259789589439, 7653.808654783619, 8359.540225287607, 8472.872906906401, 8885.11148885112, 8921.420107693004, 8513.106123856998, 8662.090480499552, 8808.691695790632, 8816.603252853622, 8832.823343533126, 2164.145162660744, 2206.9558608827815, 2219.3120132758895, 2224.6996655451467, 2230.119102954332, 2195.3304242206123, 2217.39021769014, 2235.4634887627017, 2247.5280191159877, 2265.6035193841094, 2191.3316438486336, 2195.2426412887608, 2205.9889700551475, 2235.4634887626935, 2248.6289762189217, 2168.56628674265, 2178.6514157734687, 2182.6289530779727, 2184.159098746994, 2200.7359116905996, 2144.5818065477083, 2154.2998525479284, 2159.2010955946243, 2171.467990342376, 2173.5870184665023, 8640.827183456358, 8703.129687031309, 8710.0, 8738.082501337332, 8749.343799215085, 5039.09296326661, 5151.2530683050745, 5157.0, 5169.922451163236, 5177.48225177483, 3251.723603493706, 3404.21703008307, 3493.9301213975577, 3494.5981212160673, 3530.505729197914, 1075.3655343347384, 1104.7072525780675, 1105.3865104866795, 1105.4417519152857, 1113.7271368514685, 12350.57769959616, 12376.690582735504, 12431.875681243162, 12474.43865026076, 12580.622581322576, 4664.86005419838, 4731.621470282369, 4800.615950723934, 4801.847556586464, 4819.084373968934, 10403.115735162444, 10420.47897605132, 10447.216458765472, 10451.477426128664, 10503.107235884883, 5129.358830146231, 5208.374995000549, 5214.374275087014, 5217.3999990000875, 5222.21666749983, 4223.429836972031, 4731.95268047322, 4829.637777166727, 4849.393825771778, 4893.853184404474, 3893.968098453912, 3940.8029598520534, 3991.9201615967518, 3997.140614767839, 4007.0783719744622, 1209.830623712681, 1303.9543615973396, 1308.2869835939246, 1309.7904335306305, 1316.1642357103117, 1001.8998100190068, 1012.4532752313816, 1019.7603563162651, 1038.065740833256, 1039.9792004159874, 6061.212042434543, 6069.908951365733, 6099.451049405486, 6325.96837015812, 6336.778212762623, 957.5786653872274, 978.9853152202722, 1003.4380746781826, 1029.3720830293514, 1035.0374152038676, 3788.6969042477085, 3923.4507168996365, 4013.2174226026227, 4044.373122166069, 4143.240895155736, 10598.099161571352, 11071.280366776135, 11145.554177832795, 11174.050205732603, 11174.27367221128, 10884.61903833362, 10891.618793342195, 10967.287126336763, 10983.83524247121, 11056.281341712764, 8070.2333278338465, 8109.391795615353, 8234.0, 8235.547044912588, 8242.793930151674, 5776.653400795965, 5812.476877081083, 5869.236999190249, 5977.910331344946, 5986.521078313637, 9583.712488625353, 10049.69850904474, 10095.29332946716, 10149.0, 10246.692599222035, 10012.899871001197, 10149.695509134737, 10184.338018028804, 10244.487775611338, 10290.897091028994, 6627.304133066152, 6963.338482844122, 7118.430525558047, 7153.678084486315, 7302.488825782144, 8765.868511972198, 8768.736937891874, 8822.07368226327, 8835.20483156519, 8856.46861188305, 7594.658240379085, 7630.7329243476215, 7757.0, 7798.220177982156, 7866.488678235896, 7515.549067055994, 7564.243575642392, 7584.54492730438, 7664.846703066019, 7684.500507466997, 6797.25230224665, 6845.281245469154, 6847.897281540681, 6856.142982127234, 6892.758753443806, 5200.973995130152, 5205.0, 5286.259923610774, 5347.812826551052, 5371.785128594813, 5055.646104772778, 5109.335786347751, 5204.323437953042, 5210.609204309616, 5271.525562699376], "value": 4620.786811286452, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.4320045518293, 320.80751549070555, 325.12054891518443, 327.98360081995895, 328.476080651361, 5097.949020509794, 5395.568354531638, 5472.480114389132, 5487.12206047032, 5514.393416724167, 5340.198970154479, 5382.300300960869, 5414.8917021659545, 5454.318210223722, 5467.507924286813, 4174.831047306759, 4199.3281075028, 4215.388768628547, 4255.531891491949, 4260.36094585813, 4096.713230073896, 4202.936955945664, 4204.915901681965, 4238.4490016298, 4253.021804984855, 4125.504939407276, 4131.814068366931, 4157.792110394484, 4178.498580170384, 4190.120074784299, 4210.32634778434, 4216.177845320164, 4220.240356735771, 4228.809703563332, 4233.5554766749665, 3697.6487233712755, 3710.5157936825217, 3711.294853977736, 3715.758475699071, 3723.1622884850963, 4927.1870141426625, 5280.471952804727, 5298.443663415363, 5299.735013249322, 5356.705381204032, 4742.359781429497, 4754.762261886926, 4762.52374762521, 4771.165046116916, 4772.331873537708, 5420.891582168374, 5626.127950167731, 5671.6880571568545, 5716.71416429181, 5717.171010203498, 4007.699422543321, 4008.699347548916, 4013.3779264214095, 4042.2521833460905, 4061.1065565575823, 5898.705064746746, 5983.132445795335, 5983.461488466059, 5990.4839967213875, 5991.910121348184, 4028.295048366524, 4129.587041295847, 4140.296149654566, 4150.294449943456, 4163.584381310369, 4153.293940030142, 4171.040660648007, 4182.264360290445, 4189.371594260885, 4194.643455306272, 4788.090262850047, 4808.639352048541, 4821.734804585712, 4840.806367745321, 4855.465898751135, 5256.868578285574, 5748.5688573357165, 5786.508146807569, 5791.305043394736, 5813.389594092644, 1414.8160739104057, 1433.6487560547732, 1437.641428849727, 1442.898997070195, 1446.4864972934668, 893.5755516129786, 899.6896070855545, 914.6021480655936, 914.8947870994788, 918.1736437206434, 4755.9286610700865, 4826.565609095198, 4848.345473361122, 4870.09903167915, 4882.194437917704, 5051.696898186121, 5075.8984820303385, 5088.771005304696, 5135.229715542699, 5154.819581314636, 4655.371524844103, 4781.641376896677, 4792.856214313576, 4856.538628830255, 4860.684055536379, 2757.1728481455884, 2761.6271803306295, 2776.430831679501, 2781.805273630867, 2788.4562510310293, 4553.271476563734, 5176.8964620707375, 5186.351706036746, 5215.009148261894, 5284.573165245362, 4913.557779799835, 5094.930064686383, 5099.260607212008, 5142.2286657001005, 5208.557272631869, 5201.7919283229, 5247.895042099137, 5268.025415298182, 5352.705601191894, 5364.678119312854, 5068.530126263342, 5113.74431278442, 5149.845504634867, 5157.458466860926, 5195.792168313225, 4737.986355798841, 4997.0, 5010.448850626501, 5064.898702026013, 5085.516875896784, 5306.071437498345, 5308.487081181845, 5312.061097699235, 5321.993073913227, 5337.733113344395, 3647.4893514907403, 3654.4103315058037, 3680.300742858848, 3705.7405981581032, 3718.6467285607823, 4848.109237397488, 5033.874153146201, 5130.692158470503, 5685.51673107774, 5930.466258036798, 5789.797357092481, 5789.813088316969, 5790.363060063305, 5805.448482394166, 5810.663547384041, 5582.972085139549, 5713.514351280188, 5754.647657800329, 5758.856028599151, 5792.102224155263, 5496.340439147168, 5658.519025882846, 5687.630304030225, 5688.374278829243, 5708.229389032427, 5839.686070634073, 5864.472197502245, 5869.236999190078, 5874.765009399576, 5882.764689412375, 5334.333208348957, 5664.716764161858, 5681.744321505459, 5691.686957217393, 5698.800541981011], "value": 4143.074745580783, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.9916600833993, 837.706802619083, 856.6444925355978, 863.3654264115874, 872.7076429396152, 15799.921000394996, 15818.446354377598, 16083.115428651434, 16136.112513811766, 16137.919310403446, 14501.49244776433, 14534.200618965979, 14549.92725036376, 14568.927155364208, 14642.34109465074, 840.2311884625576, 843.616154649636, 850.6257246811414, 851.4805968359295, 852.0542198160068, 830.6013113705425, 856.8500512410335, 857.9013413457438, 860.1914200651399, 863.7063398444527, 891.0109778146252, 896.1844721303615, 899.8155378147464, 900.5047224026791, 906.0893801729253, 891.5364010714457, 892.281713220857, 892.4466830565026, 895.7760559860035, 897.6005677473527, 650.5218664281749, 651.0754728285846, 651.2087813306807, 652.7519542573839, 652.9967350163266, 14651.853481465261, 14654.267286635732, 14723.0, 14732.631684207874, 14735.92632036833, 13494.325283735774, 13546.187228766206, 13551.95496275078, 13697.794533082011, 13731.862681373159, 11467.541298348056, 11470.942645286803, 11570.42147892602, 11710.414479276002, 11715.0, 3774.792386418746, 3801.5248093988253, 3820.2359528094216, 3847.634474724897, 3916.921661566753, 50808.237876431886, 50991.490085099416, 51266.48733512692, 51436.97126057495, 51965.22052169221, 10562.31344962575, 10755.516001779939, 10816.945915270373, 11071.446427678584, 11152.944235278772, 18904.149313280934, 18963.90518047401, 19139.2344306229, 19202.51993700141, 19273.325433609756, 8586.398952073296, 8650.178233067849, 8676.089010653917, 8755.56222188888, 8807.559622018873, 4832.299316599074, 4850.927236091461, 4881.682690625098, 4917.680350777259, 4967.677100988424, 3335.6497567755523, 3381.7632765706167, 3415.7438192135687, 3418.9145271368416, 3442.4836274559016, 649.8927676933253, 682.9043933849265, 717.9317964793337, 726.5241266970143, 726.7056841979007, 648.4391001783423, 674.2010717300016, 690.9911529167372, 736.5507040705165, 740.3891789273871, 9804.117629413387, 9917.553710083064, 10025.398476091312, 10119.544620491948, 10145.188384929188, 657.6481582353418, 661.2759028863387, 667.2993356975156, 715.6135686729212, 794.9403794715304, 4535.206338890681, 4600.838970636011, 4604.493505714368, 4629.166749985035, 4629.583337499574, 58816.11775823366, 59224.703876480344, 60506.0, 60833.695831520556, 61547.6922615384, 53432.198517022276, 53865.1920221197, 55239.72380138154, 55488.44511554913, 56445.43554564484, 49946.75026624916, 50012.49987500079, 50113.74943125334, 50405.74797125991, 50488.495115048376, 9010.549472526478, 9081.59132839037, 9122.224610908148, 9183.586738596645, 9197.954010229905, 34520.65479345275, 34755.30489390148, 35194.82402587971, 35337.46993795044, 35441.645583544865, 45458.31812522881, 45603.0, 46405.07189856117, 46798.0, 46956.7652161737, 10521.421321827373, 11340.149488788538, 11509.309441433541, 11641.126915481203, 11792.23350482216, 12698.365081745691, 12935.0, 13122.409491573093, 13190.802137967747, 13231.735365292448, 12003.579874704343, 12089.895663902898, 12585.748285034431, 12831.10182287231, 12926.418311176209, 11122.277051991594, 12316.938415307866, 12619.369031548202, 12679.0, 12941.352932353533, 11958.222715523463, 12454.937725311316, 12544.937275313565, 12576.245425274512, 12901.741965160832, 9673.697924436266, 9935.552900119657, 10058.245631577807, 10321.535530900977, 10394.584216631552, 9826.312158148861, 9915.0, 10100.545475453475, 10469.57212349828, 10511.737206569896], "value": 6842.422520585478, "unit": "score"}], "name": "dromaeo_css", "value": 7042.084223380531, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 104.0, 113.0, 115.0, 116.0, 109.0, 112.0, 112.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 160.0, 209.0, 139.0, 155.0, 155.0, 140.0, 181.0, 133.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 161.0, 162.0, 166.0, 165.0, 180.0, 165.0, 161.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 161.0, 78.0, 76.0, 77.0, 77.0, 166.0, 78.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 174.0, 93.0, 95.0, 96.0, 138.0, 94.0, 93.0, 140.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 118.0, 119.0, 119.0, 119.0, 120.0, 119.0, 120.0, 118.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 149.0, 148.0, 150.0, 148.0, 148.0, 148.0, 149.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 100.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 61.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 85.0, 84.0, 83.0, 83.0, 84.0, 82.0, 137.0, 83.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 134.0, 134.0, 134.0, 133.0, 137.0, 133.0, 131.0, 155.0, 134.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 176.0, 171.0, 168.0, 170.0, 172.0, 175.0, 174.0, 177.0, 170.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1585.8, "alertThreshold": 2.0}]} 20:31:01 INFO - Return code: 0 20:31:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:31:01 ERROR - # TBPL SUCCESS # 20:31:01 INFO - Running post-action listener: _resource_record_post_action 20:31:01 INFO - ##### 20:31:01 INFO - ##### Finished run-tests step (success) 20:31:01 INFO - ##### 20:31:01 INFO - Running post-run listener: _resource_record_post_run 20:31:02 INFO - Total resource usage - Wall time: 1187s; CPU: 26.0%; Read bytes: 0; Write bytes: 558465024; Read time: 0; Write time: 398944 20:31:02 INFO - install - Wall time: 17s; CPU: 26.0%; Read bytes: 0; Write bytes: 244211712; Read time: 0; Write time: 225464 20:31:02 INFO - run-tests - Wall time: 1171s; CPU: 26.0%; Read bytes: 0; Write bytes: 295878656; Read time: 0; Write time: 163104 20:31:02 INFO - Running post-run listener: _upload_blobber_files 20:31:02 INFO - Blob upload gear active. 20:31:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:02 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 20:31:02 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:31:02 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:31:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:03 INFO - (blobuploader) - INFO - Done attempting. 20:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:31:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:04 INFO - (blobuploader) - INFO - Done attempting. 20:31:04 INFO - (blobuploader) - INFO - Iteration through files over. 20:31:04 INFO - Return code: 0 20:31:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:31:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:31:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158bc438908606dea7b70de5ee210eda7f4c3723a17ef2a73e98b45668931ae22587f7b014be4930cc60a7cb084b2ff12b931df6f22f1065955c3ac32840623e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3470b0b77706a1e635bcadbe20ca588123a757caae99a2a6a947ef5a9f37a5b8890fb4f2adbd59f384388ad92028db58844d1f6fd7ba58efddba30adcfb9548"} 20:31:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:31:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:31:04 INFO - Contents: 20:31:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158bc438908606dea7b70de5ee210eda7f4c3723a17ef2a73e98b45668931ae22587f7b014be4930cc60a7cb084b2ff12b931df6f22f1065955c3ac32840623e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3470b0b77706a1e635bcadbe20ca588123a757caae99a2a6a947ef5a9f37a5b8890fb4f2adbd59f384388ad92028db58844d1f6fd7ba58efddba30adcfb9548"} 20:31:04 INFO - Running post-run listener: copy_logs_to_upload_dir 20:31:04 INFO - Copying logs to upload dir... 20:31:04 INFO - mkdir: /builds/slave/test/build/upload/logs 20:31:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.423516 ========= master_lag: 0.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-10 20:31:04.974527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 20:31:04.982079) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158bc438908606dea7b70de5ee210eda7f4c3723a17ef2a73e98b45668931ae22587f7b014be4930cc60a7cb084b2ff12b931df6f22f1065955c3ac32840623e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3470b0b77706a1e635bcadbe20ca588123a757caae99a2a6a947ef5a9f37a5b8890fb4f2adbd59f384388ad92028db58844d1f6fd7ba58efddba30adcfb9548"} build_url:https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005416 build_url: 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158bc438908606dea7b70de5ee210eda7f4c3723a17ef2a73e98b45668931ae22587f7b014be4930cc60a7cb084b2ff12b931df6f22f1065955c3ac32840623e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3470b0b77706a1e635bcadbe20ca588123a757caae99a2a6a947ef5a9f37a5b8890fb4f2adbd59f384388ad92028db58844d1f6fd7ba58efddba30adcfb9548"}' ========= master_lag: 0.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 20:31:05.251665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:31:05.252034) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462936151.702118-1950409542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002128 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:31:05.261241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 20:31:05.264594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 20:31:05.264926) ========= ========= Total master_lag: 0.93 =========