builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1463138681.2 results: success (0) buildid: 20160513030046 builduid: f13e940a58724e47b6786411ede947d8 revision: 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:41.203303) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:41.203739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:41.204061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:41.260250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:41.260538) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 04:24:41-- 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% 219M=0s 2016-05-13 04:24:41 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117364 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:41.392498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:41.393238) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019501 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:41.445064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 04:24:41.445440) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 --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=a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 04:24:41,825 truncating revision to first 12 chars 2016-05-13 04:24:41,825 Setting DEBUG logging. 2016-05-13 04:24:41,825 attempt 1/10 2016-05-13 04:24:41,825 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5a2deb5a9b09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 04:24:42,571 unpacking tar archive at: mozilla-central-5a2deb5a9b09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.056486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 04:24:42.516229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:42.516552) ========= script_repo_revision: 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:42.516995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:42.517302) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 04:24:42.527510) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-13 04:24:42.527851) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:24:42 INFO - MultiFileLogger online at 20160513 04:24:42 in /builds/slave/test 04:24:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:24:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:42 INFO - {'append_to_log': False, 04:24:42 INFO - 'base_work_dir': '/builds/slave/test', 04:24:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:24:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:42 INFO - 'branch': 'Firefox-Non-PGO', 04:24:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:42 INFO - 'config_files': ('talos/linux_config.py',), 04:24:42 INFO - 'default_actions': ('clobber', 04:24:42 INFO - 'read-buildbot-config', 04:24:42 INFO - 'download-and-extract', 04:24:42 INFO - 'populate-webroot', 04:24:42 INFO - 'create-virtualenv', 04:24:42 INFO - 'install', 04:24:42 INFO - 'run-tests'), 04:24:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:42 INFO - 'download_minidump_stackwalk': True, 04:24:42 INFO - 'download_symbols': 'ondemand', 04:24:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:42 INFO - 'installer_path': 'installer.exe', 04:24:42 INFO - 'log_level': 'info', 04:24:42 INFO - 'log_name': 'talos', 04:24:42 INFO - 'log_to_console': True, 04:24:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:24:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:24:42 INFO - 'opt_config_files': (), 04:24:42 INFO - 'pip_index': False, 04:24:42 INFO - 'sps_profile': False, 04:24:42 INFO - 'sps_profile_interval': 0, 04:24:42 INFO - 'suite': 'dromaeojs-e10s', 04:24:42 INFO - 'system_bits': '32', 04:24:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:42 INFO - 'title': 'talos-linux64-ix-002', 04:24:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:42 INFO - 'use_talos_json': True, 04:24:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:42 INFO - 'work_dir': 'build'} 04:24:42 INFO - ##### 04:24:42 INFO - ##### Running clobber step. 04:24:42 INFO - ##### 04:24:42 INFO - Running pre-action listener: _resource_record_pre_action 04:24:42 INFO - Running main action method: clobber 04:24:42 INFO - rmtree: /builds/slave/test/build 04:24:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:43 INFO - Running post-action listener: _resource_record_post_action 04:24:43 INFO - ##### 04:24:43 INFO - ##### Finished clobber step (success) 04:24:43 INFO - ##### 04:24:43 INFO - ##### 04:24:43 INFO - ##### Running read-buildbot-config step. 04:24:43 INFO - ##### 04:24:43 INFO - Running pre-action listener: _resource_record_pre_action 04:24:43 INFO - Running main action method: read_buildbot_config 04:24:43 INFO - Using buildbot properties: 04:24:43 INFO - { 04:24:43 INFO - "project": "", 04:24:43 INFO - "product": "firefox", 04:24:43 INFO - "script_repo_revision": "production", 04:24:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:24:43 INFO - "repository": "", 04:24:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:24:43 INFO - "buildid": "20160513030046", 04:24:43 INFO - "pgo_build": "False", 04:24:43 INFO - "basedir": "/builds/slave/test", 04:24:43 INFO - "buildnumber": 349, 04:24:43 INFO - "slavename": "talos-linux64-ix-002", 04:24:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:24:43 INFO - "platform": "ubuntu64_hw", 04:24:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:24:43 INFO - "branch": "mozilla-central", 04:24:43 INFO - "repo_path": "mozilla-central", 04:24:43 INFO - "revision": "5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4", 04:24:43 INFO - "stage_platform": "linux64", 04:24:43 INFO - "builduid": "f13e940a58724e47b6786411ede947d8", 04:24:43 INFO - "slavebuilddir": "test" 04:24:43 INFO - } 04:24:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:24:43 INFO - Running post-action listener: _resource_record_post_action 04:24:43 INFO - ##### 04:24:43 INFO - ##### Finished read-buildbot-config step (success) 04:24:43 INFO - ##### 04:24:43 INFO - ##### 04:24:43 INFO - ##### Running download-and-extract step. 04:24:43 INFO - ##### 04:24:43 INFO - Running pre-action listener: _resource_record_pre_action 04:24:43 INFO - Running main action method: download_and_extract 04:24:43 INFO - mkdir: /builds/slave/test/build/tests 04:24: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')]} 04:24:43 INFO - https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:24:51 INFO - Downloaded 1361 bytes. 04:24:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:24:51 INFO - Using the following test package requirements: 04:24:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:24:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:24:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:51 INFO - u'jsshell-linux-x86_64.zip'], 04:24:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:24:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:24:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:24:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:24:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:24:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:51 INFO - https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:24:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:24:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:24:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:24:54 INFO - Downloaded 22334134 bytes. 04:24:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:24:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:24:55 INFO - Return code: 0 04:24:55 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 04:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:55 INFO - https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:24:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:24:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:24:59 INFO - Downloaded 22334134 bytes. 04:24:59 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'] 04:24:59 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 04:25:01 INFO - Return code: 0 04:25: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')]} 04:25:01 INFO - https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:25:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:25:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:25:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:25:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:25:02 INFO - Downloaded 10840239 bytes. 04:25:02 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'] 04:25:02 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 04:25:02 INFO - Return code: 0 04:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:02 INFO - https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyj2x_uITkyYZceU9Ejz6w/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 04:25:04 INFO - Downloaded 54730663 bytes. 04:25:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:25:04 INFO - mkdir: /builds/slave/test/properties 04:25:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:04 INFO - Contents: 04:25:04 INFO - build_url:https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:25:05 INFO - Running post-action listener: _resource_record_post_action 04:25:05 INFO - Running post-action listener: set_extra_try_arguments 04:25:05 INFO - ##### 04:25:05 INFO - ##### Finished download-and-extract step (success) 04:25:05 INFO - ##### 04:25:05 INFO - ##### 04:25:05 INFO - ##### Running populate-webroot step. 04:25:05 INFO - ##### 04:25:05 INFO - Running pre-action listener: _resource_record_pre_action 04:25:05 INFO - Running main action method: populate_webroot 04:25:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:05 INFO - '--tppagecycles', 04:25:05 INFO - '7'], 04:25:05 INFO - 'tests': ['tsvgm']}}, 04:25:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:05 INFO - 'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:05 INFO - 'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['damp', 'tps']}, 04:25:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:05 INFO - 'tests': ['damp', 'tps']}, 04:25:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['dromaeo_dom']}, 04:25:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['a11yr', 04:25:05 INFO - 'ts_paint', 04:25:05 INFO - 'tpaint', 04:25:05 INFO - 'sessionrestore', 04:25:05 INFO - 'sessionrestore_no_auto_restore', 04:25:05 INFO - 'tabpaint']}, 04:25:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:05 INFO - 'ts_paint', 04:25:05 INFO - 'tpaint', 04:25:05 INFO - 'sessionrestore', 04:25:05 INFO - 'sessionrestore_no_auto_restore', 04:25:05 INFO - 'tabpaint']}, 04:25:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:05 INFO - 'ts_paint', 04:25:05 INFO - 'tpaint', 04:25:05 INFO - 'sessionrestore', 04:25:05 INFO - 'sessionrestore_no_auto_restore', 04:25:05 INFO - 'tabpaint']}, 04:25:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:05 INFO - 'ts_paint', 04:25:05 INFO - 'tpaint', 04:25:05 INFO - 'sessionrestore', 04:25:05 INFO - 'sessionrestore_no_auto_restore', 04:25:05 INFO - 'tabpaint']}, 04:25:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['a11yr', 04:25:05 INFO - 'ts_paint', 04:25:05 INFO - 'tpaint', 04:25:05 INFO - 'sessionrestore', 04:25:05 INFO - 'sessionrestore_no_auto_restore', 04:25:05 INFO - 'tabpaint']}, 04:25:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['a11yr', 04:25:05 INFO - 'ts_paint', 04:25:05 INFO - 'tpaint', 04:25:05 INFO - 'sessionrestore', 04:25:05 INFO - 'sessionrestore_no_auto_restore', 04:25:05 INFO - 'tabpaint']}, 04:25:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['tsvgx', 04:25:05 INFO - 'tsvgr_opacity', 04:25:05 INFO - 'tart', 04:25:05 INFO - 'tscrollx', 04:25:05 INFO - 'cart']}, 04:25:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:05 INFO - 'tsvgr_opacity', 04:25:05 INFO - 'tart', 04:25:05 INFO - 'tscrollx', 04:25:05 INFO - 'cart']}, 04:25:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:05 INFO - 'talos_options': ['--disable-e10s'], 04:25:05 INFO - 'tests': ['tp5o']}, 04:25:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:05 INFO - 'tests': ['tp5o']}, 04:25:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:05 INFO - 'talos_options': ['--disable-e10s', 04:25:05 INFO - '--xperf_path', 04:25:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:05 INFO - 'tests': ['tp5n']}, 04:25:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:05 INFO - 'talos_options': ['--xperf_path', 04:25:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:05 INFO - 'tests': ['tp5n']}}, 04:25:05 INFO - 'talos.zip': {'path': '', 04:25:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:05 INFO - Running post-action listener: _resource_record_post_action 04:25:05 INFO - ##### 04:25:05 INFO - ##### Finished populate-webroot step (success) 04:25:05 INFO - ##### 04:25:05 INFO - ##### 04:25:05 INFO - ##### Running create-virtualenv step. 04:25:05 INFO - ##### 04:25:05 INFO - Running pre-action listener: _resource_record_pre_action 04:25:05 INFO - Running main action method: create_virtualenv 04:25:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:25:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:05 INFO - Using real prefix '/usr' 04:25:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:07 INFO - Installing pip.................done. 04:25:07 INFO - Return code: 0 04:25:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:25:07 INFO - Using env: {'DISPLAY': ':0', 04:25:07 INFO - 'HOME': '/home/cltbld', 04:25:07 INFO - 'LANG': 'en_US.UTF-8', 04:25:07 INFO - 'LANGUAGE': 'en_US:en', 04:25:07 INFO - 'LOGNAME': 'cltbld', 04:25:07 INFO - 'MAIL': '/var/mail/cltbld', 04:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:07 INFO - 'MOZ_NO_REMOTE': '1', 04:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:07 INFO - 'NO_EM_RESTART': '1', 04:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:07 INFO - 'PWD': '/builds/slave/test', 04:25:07 INFO - 'SHELL': '/bin/bash', 04:25:07 INFO - 'SHLVL': '1', 04:25:07 INFO - 'TERM': 'linux', 04:25:07 INFO - 'TMOUT': '86400', 04:25:07 INFO - 'USER': 'cltbld', 04:25:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:07 INFO - '_': '/tools/buildbot/bin/python'} 04:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:25:08 INFO - Cleaning up... 04:25:08 INFO - Return code: 0 04:25:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:25: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 psutil>=3.1.1 04:25:08 INFO - Using env: {'DISPLAY': ':0', 04:25:08 INFO - 'HOME': '/home/cltbld', 04:25:08 INFO - 'LANG': 'en_US.UTF-8', 04:25:08 INFO - 'LANGUAGE': 'en_US:en', 04:25:08 INFO - 'LOGNAME': 'cltbld', 04:25:08 INFO - 'MAIL': '/var/mail/cltbld', 04:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:08 INFO - 'MOZ_NO_REMOTE': '1', 04:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:08 INFO - 'NO_EM_RESTART': '1', 04:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:08 INFO - 'PWD': '/builds/slave/test', 04:25:08 INFO - 'SHELL': '/bin/bash', 04:25:08 INFO - 'SHLVL': '1', 04:25:08 INFO - 'TERM': 'linux', 04:25:08 INFO - 'TMOUT': '86400', 04:25:08 INFO - 'USER': 'cltbld', 04:25:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:08 INFO - '_': '/tools/buildbot/bin/python'} 04:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:08 INFO - Downloading/unpacking psutil>=3.1.1 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:10 INFO - Installing collected packages: psutil 04:25:10 INFO - Running setup.py install for psutil 04:25:10 INFO - building 'psutil._psutil_linux' extension 04:25:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:25:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:25:10 INFO - building 'psutil._psutil_posix' extension 04:25:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:25:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:25:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:10 INFO - Successfully installed psutil 04:25:10 INFO - Cleaning up... 04:25:10 INFO - Return code: 0 04:25:10 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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', 'mozsystemmonitor==0.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25: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', 'mozsystemmonitor==0.1'] in /builds/slave/test/build 04:25: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 mozsystemmonitor==0.1 04:25:10 INFO - Using env: {'DISPLAY': ':0', 04:25:10 INFO - 'HOME': '/home/cltbld', 04:25:10 INFO - 'LANG': 'en_US.UTF-8', 04:25:10 INFO - 'LANGUAGE': 'en_US:en', 04:25:10 INFO - 'LOGNAME': 'cltbld', 04:25:10 INFO - 'MAIL': '/var/mail/cltbld', 04:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:10 INFO - 'MOZ_NO_REMOTE': '1', 04:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:10 INFO - 'NO_EM_RESTART': '1', 04:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:10 INFO - 'PWD': '/builds/slave/test', 04:25:10 INFO - 'SHELL': '/bin/bash', 04:25:10 INFO - 'SHLVL': '1', 04:25:10 INFO - 'TERM': 'linux', 04:25:10 INFO - 'TMOUT': '86400', 04:25:10 INFO - 'USER': 'cltbld', 04:25:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:10 INFO - '_': '/tools/buildbot/bin/python'} 04:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:11 INFO - Downloading/unpacking mozsystemmonitor==0.1 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:12 INFO - Downloading mozsystemmonitor-0.1.tar.gz 04:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 04:25:13 INFO - Installing collected packages: mozsystemmonitor 04:25:13 INFO - Running setup.py install for mozsystemmonitor 04:25:13 INFO - Successfully installed mozsystemmonitor 04:25:13 INFO - Cleaning up... 04:25:13 INFO - Return code: 0 04:25:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:25:13 INFO - Using env: {'DISPLAY': ':0', 04:25:13 INFO - 'HOME': '/home/cltbld', 04:25:13 INFO - 'LANG': 'en_US.UTF-8', 04:25:13 INFO - 'LANGUAGE': 'en_US:en', 04:25:13 INFO - 'LOGNAME': 'cltbld', 04:25:13 INFO - 'MAIL': '/var/mail/cltbld', 04:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:13 INFO - 'MOZ_NO_REMOTE': '1', 04:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:13 INFO - 'NO_EM_RESTART': '1', 04:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:13 INFO - 'PWD': '/builds/slave/test', 04:25:13 INFO - 'SHELL': '/bin/bash', 04:25:13 INFO - 'SHLVL': '1', 04:25:13 INFO - 'TERM': 'linux', 04:25:13 INFO - 'TMOUT': '86400', 04:25:13 INFO - 'USER': 'cltbld', 04:25:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:13 INFO - '_': '/tools/buildbot/bin/python'} 04:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:15 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:16 INFO - Downloading docopt-0.6.1.tar.gz 04:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:16 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:16 INFO - Running setup.py install for blobuploader 04:25:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:16 INFO - Running setup.py install for requests 04:25:16 INFO - Running setup.py install for docopt 04:25:16 INFO - Successfully installed blobuploader requests docopt 04:25:16 INFO - Cleaning up... 04:25:16 INFO - Return code: 0 04:25:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 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 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:16 INFO - Using env: {'DISPLAY': ':0', 04:25:16 INFO - 'HOME': '/home/cltbld', 04:25:16 INFO - 'LANG': 'en_US.UTF-8', 04:25:16 INFO - 'LANGUAGE': 'en_US:en', 04:25:16 INFO - 'LOGNAME': 'cltbld', 04:25:16 INFO - 'MAIL': '/var/mail/cltbld', 04:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:16 INFO - 'MOZ_NO_REMOTE': '1', 04:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:16 INFO - 'NO_EM_RESTART': '1', 04:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:16 INFO - 'PWD': '/builds/slave/test', 04:25:16 INFO - 'SHELL': '/bin/bash', 04:25:16 INFO - 'SHLVL': '1', 04:25:16 INFO - 'TERM': 'linux', 04:25:16 INFO - 'TMOUT': '86400', 04:25:16 INFO - 'USER': 'cltbld', 04:25:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:16 INFO - '_': '/tools/buildbot/bin/python'} 04:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:17 INFO - Running setup.py (path:/tmp/pip-t1mUW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:17 INFO - Running setup.py (path:/tmp/pip-zGPitk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:17 INFO - Running setup.py (path:/tmp/pip-wqAKte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:17 INFO - Running setup.py (path:/tmp/pip-Nli0Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:17 INFO - Running setup.py (path:/tmp/pip-Sq2BqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:17 INFO - Running setup.py (path:/tmp/pip-iPW9Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:17 INFO - Running setup.py (path:/tmp/pip-ygtnmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:17 INFO - Running setup.py (path:/tmp/pip-KJT7Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:17 INFO - Running setup.py (path:/tmp/pip-tmMj5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:17 INFO - Running setup.py (path:/tmp/pip-cKTaNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:17 INFO - Running setup.py (path:/tmp/pip-QxdXwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:17 INFO - Running setup.py (path:/tmp/pip-rP3eF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:17 INFO - Running setup.py (path:/tmp/pip-UEp8it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:18 INFO - Running setup.py (path:/tmp/pip-JAUuTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:18 INFO - Running setup.py (path:/tmp/pip-RQ7OIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:18 INFO - Running setup.py (path:/tmp/pip-dVox6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:18 INFO - Running setup.py (path:/tmp/pip-adpPEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:18 INFO - Running setup.py install for manifestparser 04:25:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:18 INFO - Running setup.py install for mozcrash 04:25:18 INFO - Running setup.py install for mozdebug 04:25:18 INFO - Running setup.py install for mozdevice 04:25:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:18 INFO - Running setup.py install for mozfile 04:25:18 INFO - Running setup.py install for mozhttpd 04:25:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:18 INFO - Running setup.py install for mozinfo 04:25:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Running setup.py install for mozInstall 04:25:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Running setup.py install for mozleak 04:25:19 INFO - Running setup.py install for mozlog 04:25:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Running setup.py install for moznetwork 04:25:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Running setup.py install for mozprocess 04:25:19 INFO - Running setup.py install for mozprofile 04:25:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Running setup.py install for mozrunner 04:25:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Running setup.py install for mozscreenshot 04:25:19 INFO - Running setup.py install for moztest 04:25:19 INFO - Running setup.py install for mozversion 04:25:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:20 INFO - Cleaning up... 04:25:20 INFO - Return code: 0 04:25:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:20 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 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:20 INFO - Using env: {'DISPLAY': ':0', 04:25:20 INFO - 'HOME': '/home/cltbld', 04:25:20 INFO - 'LANG': 'en_US.UTF-8', 04:25:20 INFO - 'LANGUAGE': 'en_US:en', 04:25:20 INFO - 'LOGNAME': 'cltbld', 04:25:20 INFO - 'MAIL': '/var/mail/cltbld', 04:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:20 INFO - 'MOZ_NO_REMOTE': '1', 04:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:20 INFO - 'NO_EM_RESTART': '1', 04:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:20 INFO - 'PWD': '/builds/slave/test', 04:25:20 INFO - 'SHELL': '/bin/bash', 04:25:20 INFO - 'SHLVL': '1', 04:25:20 INFO - 'TERM': 'linux', 04:25:20 INFO - 'TMOUT': '86400', 04:25:20 INFO - 'USER': 'cltbld', 04:25:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:20 INFO - '_': '/tools/buildbot/bin/python'} 04:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:20 INFO - Running setup.py (path:/tmp/pip-FB2Uin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:20 INFO - Running setup.py (path:/tmp/pip-t7zpfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:20 INFO - Running setup.py (path:/tmp/pip-vV5uPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:20 INFO - Running setup.py (path:/tmp/pip-btMTQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:20 INFO - Running setup.py (path:/tmp/pip-qMvdos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:20 INFO - Running setup.py (path:/tmp/pip-VTbI1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:20 INFO - Running setup.py (path:/tmp/pip-JMBAYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:20 INFO - Running setup.py (path:/tmp/pip-N1qhmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:20 INFO - Running setup.py (path:/tmp/pip-Y0cXDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:20 INFO - Running setup.py (path:/tmp/pip-E6qlxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:21 INFO - Running setup.py (path:/tmp/pip-kUfJUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:21 INFO - Running setup.py (path:/tmp/pip-emawKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:21 INFO - Running setup.py (path:/tmp/pip-BfBqSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:21 INFO - Running setup.py (path:/tmp/pip-DhbPHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:21 INFO - Running setup.py (path:/tmp/pip-DTGso2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:21 INFO - Running setup.py (path:/tmp/pip-ArNE2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:21 INFO - Running setup.py (path:/tmp/pip-fVXC1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:23 INFO - Downloading blessings-1.6.tar.gz 04:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:23 INFO - Installing collected packages: blessings 04:25:23 INFO - Running setup.py install for blessings 04:25:23 INFO - Successfully installed blessings 04:25:23 INFO - Cleaning up... 04:25:23 INFO - Return code: 0 04:25:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:23 INFO - Reading from file tmpfile_stdout 04:25:23 INFO - Current package versions: 04:25:23 INFO - argparse == 1.2.1 04:25:23 INFO - blessings == 1.6 04:25:23 INFO - blobuploader == 1.2.4 04:25:23 INFO - docopt == 0.6.1 04:25:23 INFO - manifestparser == 1.1 04:25:23 INFO - mozInstall == 1.12 04:25:23 INFO - mozcrash == 0.17 04:25:23 INFO - mozdebug == 0.1 04:25:23 INFO - mozdevice == 0.48 04:25:23 INFO - mozfile == 1.2 04:25:23 INFO - mozhttpd == 0.7 04:25:23 INFO - mozinfo == 0.9 04:25:23 INFO - mozleak == 0.1 04:25:23 INFO - mozlog == 3.2 04:25:23 INFO - moznetwork == 0.27 04:25:23 INFO - mozprocess == 0.22 04:25:23 INFO - mozprofile == 0.28 04:25:23 INFO - mozrunner == 6.11 04:25:23 INFO - mozscreenshot == 0.1 04:25:23 INFO - mozsystemmonitor == 0.1 04:25:23 INFO - moztest == 0.7 04:25:23 INFO - mozversion == 1.4 04:25:23 INFO - psutil == 3.1.1 04:25:23 INFO - requests == 1.2.3 04:25:23 INFO - wsgiref == 0.1.2 04:25:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:23 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 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:23 INFO - Using env: {'DISPLAY': ':0', 04:25:23 INFO - 'HOME': '/home/cltbld', 04:25:23 INFO - 'LANG': 'en_US.UTF-8', 04:25:23 INFO - 'LANGUAGE': 'en_US:en', 04:25:23 INFO - 'LOGNAME': 'cltbld', 04:25:23 INFO - 'MAIL': '/var/mail/cltbld', 04:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:23 INFO - 'MOZ_NO_REMOTE': '1', 04:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:23 INFO - 'NO_EM_RESTART': '1', 04:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:23 INFO - 'PWD': '/builds/slave/test', 04:25:23 INFO - 'SHELL': '/bin/bash', 04:25:23 INFO - 'SHLVL': '1', 04:25:23 INFO - 'TERM': 'linux', 04:25:23 INFO - 'TMOUT': '86400', 04:25:23 INFO - 'USER': 'cltbld', 04:25:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:23 INFO - '_': '/tools/buildbot/bin/python'} 04:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:24 INFO - Cleaning up... 04:25:24 INFO - Return code: 0 04:25:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:25:24 INFO - Using env: {'DISPLAY': ':0', 04:25:24 INFO - 'HOME': '/home/cltbld', 04:25:24 INFO - 'LANG': 'en_US.UTF-8', 04:25:24 INFO - 'LANGUAGE': 'en_US:en', 04:25:24 INFO - 'LOGNAME': 'cltbld', 04:25:24 INFO - 'MAIL': '/var/mail/cltbld', 04:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:24 INFO - 'MOZ_NO_REMOTE': '1', 04:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:24 INFO - 'NO_EM_RESTART': '1', 04:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:24 INFO - 'PWD': '/builds/slave/test', 04:25:24 INFO - 'SHELL': '/bin/bash', 04:25:24 INFO - 'SHLVL': '1', 04:25:24 INFO - 'TERM': 'linux', 04:25:24 INFO - 'TMOUT': '86400', 04:25:24 INFO - 'USER': 'cltbld', 04:25:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:24 INFO - '_': '/tools/buildbot/bin/python'} 04:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:24 INFO - Downloading/unpacking jsonschema 04:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:26 INFO - Downloading/unpacking functools32 (from jsonschema) 04:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:26 INFO - warning: no files found matching '*.txt' 04:25:26 INFO - no previously-included directories found matching 'build' 04:25:26 INFO - no previously-included directories found matching 'dist' 04:25:26 INFO - no previously-included directories found matching '.git*' 04:25:26 INFO - Installing collected packages: jsonschema, functools32 04:25:26 INFO - Running setup.py install for functools32 04:25:26 INFO - warning: no files found matching '*.txt' 04:25:26 INFO - no previously-included directories found matching 'build' 04:25:26 INFO - no previously-included directories found matching 'dist' 04:25:26 INFO - no previously-included directories found matching '.git*' 04:25:26 INFO - Successfully installed jsonschema functools32 04:25:26 INFO - Cleaning up... 04:25:26 INFO - Return code: 0 04:25:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c23b1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:25:26 INFO - Using env: {'DISPLAY': ':0', 04:25:26 INFO - 'HOME': '/home/cltbld', 04:25:26 INFO - 'LANG': 'en_US.UTF-8', 04:25:26 INFO - 'LANGUAGE': 'en_US:en', 04:25:26 INFO - 'LOGNAME': 'cltbld', 04:25:26 INFO - 'MAIL': '/var/mail/cltbld', 04:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:26 INFO - 'MOZ_NO_REMOTE': '1', 04:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:26 INFO - 'NO_EM_RESTART': '1', 04:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:26 INFO - 'PWD': '/builds/slave/test', 04:25:26 INFO - 'SHELL': '/bin/bash', 04:25:26 INFO - 'SHLVL': '1', 04:25:26 INFO - 'TERM': 'linux', 04:25:26 INFO - 'TMOUT': '86400', 04:25:26 INFO - 'USER': 'cltbld', 04:25:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:26 INFO - '_': '/tools/buildbot/bin/python'} 04:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:26 INFO - Downloading/unpacking flake8 04:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:25:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:25:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:29 INFO - no previously-included directories found matching 'docs/_build' 04:25:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:25:29 INFO - Running setup.py install for pep8 04:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:29 INFO - no previously-included directories found matching 'docs/_build' 04:25:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:25:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:25:29 INFO - Cleaning up... 04:25:29 INFO - Return code: 0 04:25:29 INFO - Running post-action listener: _resource_record_post_action 04:25:29 INFO - Running post-action listener: _start_resource_monitoring 04:25:29 INFO - Starting resource monitoring. 04:25:29 INFO - ##### 04:25:29 INFO - ##### Finished create-virtualenv step (success) 04:25:29 INFO - ##### 04:25:29 INFO - ##### 04:25:29 INFO - ##### Running install step. 04:25:29 INFO - ##### 04:25:29 INFO - Running pre-action listener: _resource_record_pre_action 04:25:29 INFO - Running main action method: install 04:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:29 INFO - Reading from file tmpfile_stdout 04:25:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:30 INFO - Reading from file tmpfile_stdout 04:25:30 INFO - Output received: 04:25:30 INFO - Usage: mozinstall [options] installer 04:25:30 INFO - Options: 04:25:30 INFO - -h, --help show this help message and exit 04:25:30 INFO - -d DEST, --destination=DEST 04:25:30 INFO - Directory to install application into. [default: 04:25:30 INFO - "/builds/slave/test"] 04:25:30 INFO - --app=APP Application being installed. [default: firefox] 04:25:30 INFO - mkdir: /builds/slave/test/build/application 04:25:30 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'] 04:25:30 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 04:25:45 INFO - Reading from file tmpfile_stdout 04:25:45 INFO - Output received: 04:25:45 INFO - /builds/slave/test/build/application/firefox/firefox 04:25:45 INFO - Running post-action listener: _resource_record_post_action 04:25:45 INFO - ##### 04:25:45 INFO - ##### Finished install step (success) 04:25:45 INFO - ##### 04:25:45 INFO - ##### 04:25:45 INFO - ##### Running run-tests step. 04:25:45 INFO - ##### 04:25:45 INFO - Running pre-action listener: _resource_record_pre_action 04:25:45 INFO - Running main action method: run_tests 04:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:45 INFO - Python 2.7.3 04:25:45 INFO - Return code: 0 04:25:45 INFO - grabbing minidump binary from tooltool 04:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:45 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 0x12e99c0>, '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 0x12ea8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ead50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:25:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:25:45 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 04:25:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:45 INFO - Return code: 0 04:25:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:25:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:25:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:25:46 INFO - Return code: 0 04:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 04:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 04:25:46 INFO - Using env: {'DISPLAY': ':0', 04:25:46 INFO - 'HOME': '/home/cltbld', 04:25:46 INFO - 'LANG': 'en_US.UTF-8', 04:25:46 INFO - 'LANGUAGE': 'en_US:en', 04:25:46 INFO - 'LOGNAME': 'cltbld', 04:25:46 INFO - 'MAIL': '/var/mail/cltbld', 04:25:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:46 INFO - 'MOZ_NO_REMOTE': '1', 04:25:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:46 INFO - 'NO_EM_RESTART': '1', 04:25:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:46 INFO - 'PWD': '/builds/slave/test', 04:25:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:46 INFO - 'SHELL': '/bin/bash', 04:25:46 INFO - 'SHLVL': '1', 04:25:46 INFO - 'TERM': 'linux', 04:25:46 INFO - 'TMOUT': '86400', 04:25:46 INFO - 'USER': 'cltbld', 04:25:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873', 04:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:46 INFO - '_': '/tools/buildbot/bin/python'} 04:25:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 04:25:47 INFO - mozversion application_buildid: 20160513030046 04:25:47 INFO - mozversion application_changeset: 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 04:25:47 INFO - mozversion application_display_name: Nightly 04:25:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:47 INFO - mozversion application_name: Firefox 04:25:47 INFO - mozversion application_remotingname: firefox 04:25:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:25:47 INFO - mozversion application_vendor: Mozilla 04:25:47 INFO - mozversion application_version: 49.0a1 04:25:47 INFO - mozversion platform_buildid: 20160513030046 04:25:47 INFO - mozversion platform_changeset: 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 04:25:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:25:47 INFO - mozversion platform_version: 49.0a1 04:25:47 INFO - using testdate: 1463138747 04:25:47 INFO - actual date: 1463138747 04:25:47 INFO - starting webserver on 'localhost:54273' 04:25:47 INFO - SUITE-START | Running 2 tests 04:25:47 INFO - TEST-START | dromaeo_css 04:25:47 INFO - operating with platform_type : linux_ 04:25:47 INFO - Initialising browser for dromaeo_css test... 04:25:47 INFO - TEST-INFO | started process 27128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJYUKd/profile http://localhost:54273/getInfo.html) 04:25:51 INFO - PROCESS | 27128 | 04:25:51 INFO - PROCESS | 27128 | (process:27196): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:52 INFO - PROCESS | 27128 | __metrics Screen width/height:1600/1200 04:25:52 INFO - PROCESS | 27128 | colorDepth:24 04:25:52 INFO - PROCESS | 27128 | Browser inner width/height: 1024/697 04:25:52 INFO - PROCESS | 27128 | __metrics 04:25:52 ERROR - PROCESS | 27128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 04:25:53 INFO - TEST-INFO | 27128: exit 0 04:25:53 INFO - Browser initialized. 04:25:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:53 INFO - TEST-INFO | started process 27247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJYUKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:55 INFO - PROCESS | 27247 | 04:25:55 INFO - PROCESS | 27247 | (process:27308): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:26:05 INFO - PROCESS | 27247 | RSS: Main: 164655104 04:26:05 INFO - PROCESS | 27247 | 04:26:55 INFO - PROCESS | 27247 | 1463138815282 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:29:07 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54273/tests/dromaeo/cssquery-ext.html) 04:29:09 INFO - PROCESS | 27247 | RSS: Main: 167776256 04:29:09 INFO - PROCESS | 27247 | 04:32:11 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-ext.html (next: http://localhost:54273/tests/dromaeo/cssquery-jquery.html) 04:32:11 INFO - PROCESS | 27247 | RSS: Main: 167272448 04:32:11 INFO - PROCESS | 27247 | 04:35:13 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54273/tests/dromaeo/cssquery-mootools.html) 04:35:14 INFO - PROCESS | 27247 | RSS: Main: 168312832 04:35:14 INFO - PROCESS | 27247 | 04:38:16 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54273/tests/dromaeo/cssquery-prototype.html) 04:38:16 INFO - PROCESS | 27247 | RSS: Main: 166166528 04:38:16 INFO - PROCESS | 27247 | 04:41:19 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54273/tests/dromaeo/cssquery-yui.html) 04:41:20 INFO - PROCESS | 27247 | RSS: Main: 167309312 04:41:20 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-yui.html (next: http://localhost:54273/tests/dromaeo/cssquery-dojo.html) 04:44:22 INFO - PROCESS | 27247 | RSS: Main: 169246720 04:44:22 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | __start_tp_report 04:44:22 INFO - PROCESS | 27247 | _x_x_mozilla_page_load 04:44:22 INFO - PROCESS | 27247 | _x_x_mozilla_page_load_details 04:44:22 INFO - PROCESS | 27247 | |i|pagename|runs| 04:44:22 INFO - PROCESS | 27247 | |0;dojo.html;2660.574308110702;2720.1703480438464;2725.918222453327;2728.0724553651767;2740.451909618077;4816.470188279286;4821.373221481203;4828.541288577584;4905.215165573509;4970.751462426873;4806.351142595749;4884.706917584947;4901.313816065754;4902.632302577312;4920.852374428764;4453.955460445402;4486.327050942352;4576.153411618844;4586.54134586542;4598.264277715566;4527;4617.699849509788;4647.53524647536;4647.72113673179;4660.976695116519;4406.713563618387;4484.260097083978;4514.616257618107;4519.254323036695;4598.977005114986;4431.8448854289945;4442.933355999663;4451.732896026248;4451.866444006685;4498;4438.7114837535455;4460.219461594241;4471.993801394693;4485.147821913826;4494.438195225597;4730.432348118248;4756.3816703828625;4801.759912004386;4808.110499557558;4809.23052311632;5199.506046925574;5231.921521177185;5255.054090263751;5264.499872512105;5301.416844147141;5115.360579927509;5304.20436934459;5307.071262529081;5307.6019298552765;5310.097283461782;4802.255650374198;4894.437139728905;4915.16442204826;4930.827421040318;4939.629527785431;5405.486478784509;5416.7020813855615;5435.646682965595;5439.918401223985;5446.972765136149;5073.188289873677;5161.200013997836;5191.662541934762;5194.662346947436;5204.34945631796;5227.424983251839;5239.554637855825;5251.76367063483;5262.657927234717;5274.050670879278;5030.346055012898;5107.080725469451;5169.4830516948;5183.714895680774;5184.948150518522;5192.662476938987;5195.68825870449;5205.687658740488;5218.634695571273;5247.081760691864;4391.231534481453;4441.977790111029;4485.237509623372;4519.480259770103;4535.183666939983;3904.7657140571655;3918.3338832398563;3923.7841918694176;3952.8616498422416;3963.742356746802;4500.009997800478;4552.317152427162;4575.862724118282;4595;4643.489216186217;5207.557357624569;5317.8936421271355;5350.38470575881;5373.704446255493;5400.945990540123;4563.657725670521;4580.587747102777;4583.931241031387;4592.311153326961;4600.217962946307;4689.788959496831;4824.95175048245;4831.8308859190465;4841.370621819141;4881.682690625098;4918.262260660929;4936.407631084293;4973.726445045557;4984.551390374883;4992.700437973734;5328.387235467971;5333.866653333543;5334.253204551288;5345.251664766858;5371.382291036581;4861.635377346643;4936.605071594192;4959.70241785494;4982.327385802871;4983.6760610560195;5152.407473140487;5195.636305458582;5219.399769026611;5222.399424066281;5275.419703832652;5303.257543943928;5303.363596368306;5319.521243088141;5333.73331333424;5373.570114390761;4963.652544322007;5023.422306434807;5040.647154699136;5137.255098010843;5155.510226528474;5007.3240112584335;5034.16936205522;5050.772715227897;5056.317397151338;5077.7461126944245;5021.271915572149;5045.31888195089;5056.089903817348;5059;5091;5046.697198168122;5102.260172275073;5125.974370128126;5142;5169.974150129226;5031.6226283029655;5040.395152581714;5053.898922021465;5099.26060721186;5099.6685215460875 04:44:22 INFO - PROCESS | 27247 | |1;ext.html;575.2205761193583;607.7994261893575;608.2093278737638;618.8298217990053;628.3339659960445;36464;40661.390079148834;40974;41082.17835643285;41382.37926431106;40970.180596388054;41358.17283654325;41554.58445415545;41576.58423415765;41656.79171604138;7829.960850195741;7968.083670377923;7997.280244777969;7999.200079992012;8006.67973281068;7661.195574464685;7662.310392064713;7682.500637458547;7732.690692372298;7742.225777422269;7728.459007869451;7798.766037018899;7799.844003119934;7801.063872335328;7814.53112813233;7665;7697.307242348215;7698.191689872567;7712.807179820493;7735.303822655988;7835.686572537092;7849.215078492105;7879.684812607489;7903.881441778378;7906.7627971160955;30056.699433005826;37685.81157094224;37915.62084379148;37935.24129517394;37968.240635187416;3215.6623554526905;3271.8200498972546;3326.7005969462866;3376.4935259710996;3388.9322213555592;30401.391972160432;30836.22909427282;31153.688463115304;32331.838340808146;32456.83771581127;3569.125564236753;3591.712662986955;3632.237230181665;3664.4136938090046;3782.224643947984;260754;268248;268491;269335.6533217341;269656;34576.48135277973;35555.11112222215;35630;62109.37890621036;63684.36315636784;36438.80953690306;36598;36750.26499470049;36771.63228367682;36863.4470482943;14727.631809204642;14734.115953042852;14844.109353438827;14945.77581336259;14968.401263949538;11745.11911606633;11747.88252117485;11776.411179440993;11826;11882.94058529719;8513.702020429255;8563.95718021406;8588.785280368042;8672.609732561923;8689;3363.6972672459597;3387.2209391840015;3415.470602056685;3420.2817408344526;3464.6015708193377;895.552223888056;913.2374467319729;924.9963789288697;930.7905721212672;1019.8470229465639;27468.450630987667;28002;28103.57844632332;28321.433571328456;28545.14456560317;982.6855406269925;1058.0424715632364;1069.3423544520065;1084.4631907205826;1091.6343025086526;14407;14506.782398264035;14834.925825370805;14898.851011489964;15279.694406111816;368950;370541;373679;373689;375165;51084;52452.47547524476;52500.21249681258;52558.21162682563;52572.21141682878;1235.3144005077088;1255.8555766087018;1262.8484581850237;1277.7252890628374;1298.8571257161893;26741.06406275771;27531.51364764268;27658.170254892386;27984.160475185778;28170;45123.548764511936;45279.09441811079;45299.54700452953;45511;45570.544294557956;315645;319095;322516;322865;323997;26677.86661066682;27496.862515687295;27616.58575121415;27710.44579108447;27835.721642783312;43531;43731.56268437275;44758.77620611876;45190.32214516719;45363.546364535934;37196.81401592975;38065.4290185653;38744.6125538741;39027.21945561016;39407.40888886726;37407;37956.43065353967;38456.2308753829;38460.80769596246;38564.22871542497;37475.25049499049;38803;39348.213035739696;39712.014399279346;41512.584874150874;31027.844860776455;34569.30861382708;34858.47712284369;35383.469247960784;35388.29223415466;26634.334141646614;26662.600060998713;26765.19704408871;26967.95480677914;27019 04:44:22 INFO - PROCESS | 27247 | |2;jquery.html;370.885025642051;373.458485196465;374.8313259033434;383.52634496396945;386.7234927027175;16259.187040647965;17506.29974801008;18028.107048759888;18244.726329105073;18262.17820198091;17305.307787688478;17566.912165439157;17612.88645362555;17705.82294177061;17795.37716179934;4948.999999999991;5112.795488180468;5139.383274007125;5141.228815677641;5147.613928955325;3642.5264715586936;5044.772985215674;5540.418256083114;5851.824445266649;5852.590318677694;5895.587308888379;5907.793227237047;5917.467427931485;5927.081302398135;5927.555433342495;5677.858053548653;5887.5584331174905;5903.49820265278;5909.143174239711;5920.733566989496;4510.188166130095;5163.070647283487;5165.302684137631;5178.14560597501;5212.609054320941;12145.271283722917;12232.938835305855;12344.876551234462;12383.257004579755;12400.13199076065;1769.3895606015903;1787.356551641408;1794.1836464408664;1873.3911478769319;2012.4163992442175;8461.788455288606;8852.291816654717;9205.033471485465;9210.263178945668;9241.122093401116;1711.3582406597525;1713.5202143399868;1727.4040456042644;1728.3086765293858;1744.3284335530784;73737.6313118431;76383.61808190924;77455.61272193659;77645;77901.83147252853;9511.524423778783;9702.5148742564;9788.168005719594;10008.899911000943;10155.847662284923;13173.47306107764;13250.668733281746;13294.268815215062;13346;13397.93301033508;7469.850602988018;7512.39900807934;7515.774526764206;7594.772156835304;7640.388768898475;7157.642117894085;7270.927290727131;7307.415406767552;7397.18630950595;7416.221296763762;4122.154958233555;4139.799458157101;4143.316352801814;4176.7076304658385;4227.852025179165;1647.4810434713027;1707.9573010674585;1807.701729214691;1838.2095698849623;1866.887986720801;768.8846672999094;883.1874675298612;902.5081330674667;917.1195652173988;953.880764904387;16366.918165409335;16882.74675879863;17492.387766428114;17713.7342939856;18486.168122434523;888.5339190335998;951.2912879904516;959.712086374085;975.8877729061107;1016.4307987527009;9610.66362677303;9868.605255789831;9870.654527091518;9894.30739848218;9907.702768916944;401425;402357;402876;403318;413157;51526;79870;80131.59934200291;81494.59252703817;86069.5696521526;965.9517024148764;976.2190247801731;976.2482888176206;986.7039888033705;991.4150651115876;15613.14127722986;15729.21353932276;15746.76379854326;15769.369225230863;15898.205089745697;33767.15582110467;34921.47617785786;37237.441438378984;38599.807000964815;39065.2186956265;51518.742406287725;51934;52470.21294680659;52495.21257181069;53425.65743425626;7684.423668224794;7858.410619203697;7923.207679232261;7925.960370198342;7953.204679532232;8522.446041007315;8642.956785216034;11547.884521155018;12275.815862762245;12400.13199076056;10426.739331516772;10460.790784184426;10536.736581585521;10542.103921166787;10569.048785609331;10156.695299141038;10793.568257269935;10813.729656758644;10848.511816968097;10974.396408197306;9558.330916835755;10376.584936602452;10495.597685412045;10716.89283107159;10878.891211087788;7800.45396822217;7810.6485208166905;8009.519428834288;8044.798880028046;8237.50574965504;10560.683179504627;10713.625023124465;10781.083607893417;10883.782324353628;11050.447477626247 04:44:22 INFO - PROCESS | 27247 | |3;mootools.html;1489.2479297954535;1524.7026829768197;1709.8375654312845;1821.772278465192;1859.851211903048;6873.621950792704;7749.961250193748;7810;8271.50370977741;8296.91703082969;7998.32014278787;8021.879671804928;8102.7569172924905;8116.513009219451;8119.431639785217;2184.148182208936;2214.568159208955;2232.151782322723;2232.821374290061;2235.16181431963;2179.2372669565684;2195.769444208359;2214.9114035438565;2243.371855880356;2251.887405629712;2195.1658369819447;2203.4160947348964;2205.106931692659;2210.3037543173928;2240.6639004149347;2140.689600007998;2148.0977989244475;2149.881756503392;2150.7204063471804;2151.376100930728;2125.883076430796;2151.376100930728;2153.2786516516985;2157.7626461089267;2195.4511372156962;8027.839443211103;8121.959390203011;8124.959375203145;8129.512229266263;8141.959290203511;4584.816607335702;4725.243960966263;4737.810487580493;4738.526147385269;4750.61995040396;2763.847988360639;2816.8169069010655;2924.1812292558116;2944.0873329267997;2980.821150730963;912.8251939753532;922.1424075609681;923.0999775219175;960.3229723045237;969.9369540979814;10350;10639.095676867475;10694.839577406345;10965.725856853564;10976.780464390748;3977.3238549446664;4031.133306339151;4079.1637714268504;4087.1008378156757;4112.198121366365;8742.650293988168;8748;8758.956205219061;8767.298616110824;8780.385373023955;4630.490646028934;4675.836345727883;4695.084458530554;4700.271457924027;4730.053989202173;3657.7256705747177;4165.604267594574;4256.170046840898;4345.478542574911;4380.080183161508;3368.882089126918;3404.8467818948207;3513.3851575974104;3550.467429885486;3558.5551806024246;975.7560609847538;985.6550207427343;992.4640694025146;995.571904081252;1002.7693630465034;821.9753407397787;959.9616015359447;962.5235508423375;963.2280514183568;980.7989362180735;5546.4453554644215;5570.5265052470995;5589.329280486368;5613.522850557667;5636.2954630671165;395.3614911917233;407.3258756757571;417.1032280596741;420.3106904676333;422.30741583802586;3931.8820435386983;4123.257813593582;4284.657227421799;4369.650427965755;4392.824287028547;9451.291153163404;9749.951250243703;9807.215422766161;9817.656382026595;9830.361026533395;9597;9648.855267170999;9711.514424278757;9717.222622190207;9736.95131524338;7210.9278907210255;7253.963730181421;7489.28851759082;7599.278068583476;7626.771196864103;5811.302643682785;5816.73824677882;5817.069268916953;5936.940630593812;5961.791337303173;8731.781705457415;8832.425892316978;9089.727308180765;9105.27157827359;9174.816503670023;9181.495017774087;9265.675701350421;9281.350305478552;9420.057994200799;9420.576074076545;6270.2475702915945;6832.248452670103;6862.348076932683;7045.612491313027;7067.929320706933;7836.412269079956;7921.603919804102;7949.364050875801;7971.92028079735;7972.681092756225;6749.932500675127;6881.552699074544;6924.723011079501;6929.514933954776;7012.4390048796995;6884.173899132136;6907.551009184387;6913.516053876381;7072.328128827753;7075.964620176866;6436.13112229843;6710;6724.831879203059;6738.797836064926;6789.830254243683;4925.138100832269;5047.369078865142;5061.342025536656;5144.614153938544;5156.948430515647;5048.697078175322;5062.974685126551;5083.517065878736;5132.46109158533;5160.329157209539 04:44:22 INFO - PROCESS | 27247 | |4;prototype.html;289.9304166999918;293.28146042196624;299.24291542397725;306.1840195877985;311.7038813127528;5100.183970564705;5106.361704786902;5132.923006154911;5135.7688903999315;5183.559397451221;4940.382452193476;4999.775010124544;4999.825006124786;5028.994201159764;5032.295478632995;3755.530558680165;3831.9233615327676;3981.542122655903;3982.1438390745984;3995.320795464778;3968.484097067377;3975.82108805103;3976.4234186043004;3993.2013597280516;4003.3194356959243;3961.247363001035;3962.841486340543;3972.324704800191;3978.323684973547;3990.7805070721097;3861.6331448512346;3976.224636195943;3984.920301593952;4006.659433948118;4012.3179059559943;3468.601110872257;3483.9651603483894;3498.6151523332414;3498.632643572439;3511.4908338290807;4753.453352864431;4839.782209800567;4861.465238823726;4893.730844803535;4899.4610592835115;4424.977875110636;4571.474280457724;4586.036932244199;4617.2381557043045;4625.167469855424;5344.812931547377;5350.571954243651;5365.222042803811;5368.731563421813;5386.272853164812;3867.323218436762;3870.0711829161082;3871.857801948432;3890.727649064567;3905.3556163233034;5328.46715328468;5571.721413929287;5632.605717599769;5642.971785141048;5659.801906933238;3951.4665520154986;3956.624120708528;3958.722889397772;3963.6432721054666;3971.602839716063;4022.6982976276895;4033.515978082649;4042.6956634718517;4046.393041043867;4048.67610591152;4572.497025327211;4593.311003349524;4604.654650901196;4606.539346065434;4610.40064791575;5074.188129899198;5323.1749078892835;5344.225087362311;5370.167624018283;5426.941746359501;1393.1153717389532;1401.3133564553295;1403.5929580421769;1404.810350602676;1413.7912085167034;877.8727084572829;886.9822603548022;910.3945875992523;921.4517362169498;926.8517037274139;4525.773711314487;4625.982283897537;4636.605888499448;4644.790984405709;4658.254679251371;5484.561235101182;5488.341399032061;5507.9449205507435;5527.811520523107;5537.698640819404;4476.2837945928495;4681.953180468152;4717.551832575899;4727.290906364073;4751.453582838018;2937.3390987028174;2938.720821521952;2947.2779169103705;2950.6164198654037;2951.3064429858964;5100.642954993189;5146.716930568779;5173.430922598511;5194.506521880416;5213.60897932649;5453.481919217668;5502.560899437852;5594.216809646653;5616.943830561642;5626.268585083994;5155.767990440514;5198.974005130026;5216.739163041832;5225.764840582183;5227.536289838851;5444.646098003617;5499.917501237404;5508.173773933942;5516.91724624139;5531.253280807039;5321.255024296679;5329.440408757025;5442.292501974718;5451.591130665137;5453.182022696468;5190.506901844319;5198.350206224222;5202.167653175474;5236.973815131052;5247.134222853187;3937.4684417603257;3941.2708648900043;3949.6050394960275;3954.9604503954592;3963.128111815396;5383.380911195262;5492.802878848493;5495.422980586981;5500.367457742411;5522.889542209053;5289.175234544076;5324.6006549508165;5337.786488540571;5359.678419294854;5369.3556773187465;5074.492550745043;5298.655587386807;5382.973085134549;5387.057264978692;5396.163594642837;5173.793048278178;5218.452062533379;5258.0798360286035;5259.500347466985;5280.155175171954;5129.794498292824;5247.1866860636665;5343.4122246553625;5345.33183352081;5347.946520534745;5192.506711862367;5243.711595862112;5252.1596544552685;5269.681340210295;5274.7890084396195 04:44:22 INFO - PROCESS | 27247 | |5;yui.html;696.3176087434312;718.6765955320108;742.9294217049381;789.9842003159936;828.2462958707575;11682.591109311175;12431.627051188456;12456.626301210956;12465;12483.188592741466;11983.221090629104;12027.158098933078;12031.21797083191;12037.759244815099;12054.15620906537;668.6389349751141;829.2371018662815;853.4282031039188;855.9572021398936;858.9398742088056;853.3002937591177;857.0315543435939;862.9989212513485;863.6761214544546;865.091653763549;905.7463910105181;906.0939060939061;909.5179554835947;911.3711539038076;911.8586619074055;904.4437670832457;909.236241557092;910.3309067835136;911.2618778789202;912.3886995712888;662.7382184037278;667.2093569120559;667.4860357524678;668.8729141463107;669.2838662630987;11627.59303424376;11681.182317237797;11687.357195354252;11690;11729.472173752201;12154.513819447211;12438.315892625902;12482.875171248354;12653.114282000264;12866.806997895039;9228.6308547658;9393;9614.663486777928;9716.854247186298;9724.076212759777;3273.9345213095844;3284.2282063715006;3297.225152089281;3315.2374953760527;3318.900432987014;44937.55062449366;45272.773636131606;45308.3203751944;45369.773151134366;46791;9071.228945539571;9178.86231706525;9230.630774769068;9470.621175152917;9627.807443851223;18535.35126270574;18555.628887422175;18588.814111858977;18626.813731862778;18707.532311692044;6360.554761166766;6552.705128269239;6555.573887697285;6594.934050659528;6598.241202261705;3643.6720695137565;3658.4695219193068;3658.743887927873;3660.5790334111384;3703.4629978652943;2688.180105067934;2794;2798.902038428686;2803.6215110960165;2818.281338258772;494.1722614620496;517.0228268572401;519.4104691175468;528.4292963599304;555.5611067256822;582.7115577788937;591.2166379547032;592.5674257791836;596.5466245653334;597.9940200597938;7730.613469326511;7765.72819951299;7838.451308408471;7844;8033.156518565466;576.8442520519436;604.4439116013191;611;611.3366996808423;631.2771876201723;3676.7793932364143;3692.132348898007;3726.5341832270965;3840.251151025523;3862.517185351831;58696.11955820666;59338;59363;59370.10944835831;60297;52362.73818630882;52418;53347;53552;54405;46052.7697361511;46084.53915460803;46643.766781165876;46823.76588117037;47229.29156062662;7860.803479913048;7963.124056353912;7979.680812767424;8063.758087257392;8102;30235.69764302329;30513.542296865122;30811;31115.377692446476;31800.84099579487;36965.63034369622;37297;40104.59895401126;40168.196636067696;40188.7990560057;10546.26176167661;10571.2600117991;10627;10770.623028193975;10875.945620271848;8244.340452763645;11848.28910265387;12001.1599188056;12083.214591051554;12210.938945305217;10590.205734570092;10770.353778772986;10995.835062473909;11426.02878755315;11460.541578336773;11015.118790496581;11297.887021129683;11347.773044539228;11757.706057348634;11779;11020.559177632806;11027.944860275647;11122.777544448903;11467.31196128235;11498.712532186762;9430.789133247144;9599.616015359308;9680.806383872143;9990.250731195045;10005.54975026111;8534.231919127309;8624;8919.241864441596;8981.236594889508;9135.588898499716 04:44:22 INFO - PROCESS | 27247 | __end_tp_report 04:44:22 INFO - PROCESS | 27247 | __start_cc_report 04:44:22 INFO - PROCESS | 27247 | _x_x_mozilla_cycle_collect,386 04:44:22 INFO - PROCESS | 27247 | __end_cc_report 04:44:22 INFO - PROCESS | 27247 | __startTimestamp1463139862689__endTimestamp 04:44:22 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | ------- Summary: start ------- 04:44:22 INFO - PROCESS | 27247 | Number of tests: 6 04:44:22 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | [#0] dojo.html Cycles:165 Average:4857.26 Median:4982.33 stddev:511.05 (10.3%) stddev-sans-first:482.69 04:44:22 INFO - PROCESS | 27247 | Values: 2660.6 2720.2 2725.9 2728.1 2740.5 4816.5 4821.4 4828.5 4905.2 4970.8 4806.4 4884.7 4901.3 4902.6 4920.9 4454.0 4486.3 4576.2 4586.5 4598.3 4527.0 4617.7 4647.5 4647.7 4661.0 4406.7 4484.3 4514.6 4519.3 4599.0 4431.8 4442.9 4451.7 4451.9 4498.0 4438.7 4460.2 4472.0 4485.1 4494.4 4730.4 4756.4 4801.8 4808.1 4809.2 5199.5 5231.9 5255.1 5264.5 5301.4 5115.4 5304.2 5307.1 5307.6 5310.1 4802.3 4894.4 4915.2 4930.8 4939.6 5405.5 5416.7 5435.6 5439.9 5447.0 5073.2 5161.2 5191.7 5194.7 5204.3 5227.4 5239.6 5251.8 5262.7 5274.1 5030.3 5107.1 5169.5 5183.7 5184.9 5192.7 5195.7 5205.7 5218.6 5247.1 4391.2 4442.0 4485.2 4519.5 4535.2 3904.8 3918.3 3923.8 3952.9 3963.7 4500.0 4552.3 4575.9 4595.0 4643.5 5207.6 5317.9 5350.4 5373.7 5400.9 4563.7 4580.6 4583.9 4592.3 4600.2 4689.8 4825.0 4831.8 4841.4 4881.7 4918.3 4936.4 4973.7 4984.6 4992.7 5328.4 5333.9 5334.3 5345.3 5371.4 4861.6 4936.6 4959.7 4982.3 4983.7 5152.4 5195.6 5219.4 5222.4 5275.4 5303.3 5303.4 5319.5 5333.7 5373.6 4963.7 5023.4 5040.6 5137.3 5155.5 5007.3 5034.2 5050.8 5056.3 5077.7 5021.3 5045.3 5056.1 5059.0 5091.0 5046.7 5102.3 5126.0 5142.0 5170.0 5031.6 5040.4 5053.9 5099.3 5099.7 04:44:22 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | [#1] ext.html Cycles:180 Average:47179.45 Median:203868.91 stddev:85012.38 (41.7%) stddev-sans-first:85178.85 04:44:22 INFO - PROCESS | 27247 | Values: 575.2 607.8 608.2 618.8 628.3 36464.0 40661.4 40974.0 41082.2 41382.4 40970.2 41358.2 41554.6 41576.6 41656.8 7830.0 7968.1 7997.3 7999.2 8006.7 7661.2 7662.3 7682.5 7732.7 7742.2 7728.5 7798.8 7799.8 7801.1 7814.5 7665.0 7697.3 7698.2 7712.8 7735.3 7835.7 7849.2 7879.7 7903.9 7906.8 30056.7 37685.8 37915.6 37935.2 37968.2 3215.7 3271.8 3326.7 3376.5 3388.9 30401.4 30836.2 31153.7 32331.8 32456.8 3569.1 3591.7 3632.2 3664.4 3782.2 260754.0 268248.0 268491.0 269335.7 269656.0 34576.5 35555.1 35630.0 62109.4 63684.4 36438.8 36598.0 36750.3 36771.6 36863.4 14727.6 14734.1 14844.1 14945.8 14968.4 11745.1 11747.9 11776.4 11826.0 11882.9 8513.7 8564.0 8588.8 8672.6 8689.0 3363.7 3387.2 3415.5 3420.3 3464.6 895.6 913.2 925.0 930.8 1019.8 27468.5 28002.0 28103.6 28321.4 28545.1 982.7 1058.0 1069.3 1084.5 1091.6 14407.0 14506.8 14834.9 14898.9 15279.7 368950.0 370541.0 373679.0 373689.0 375165.0 51084.0 52452.5 52500.2 52558.2 52572.2 1235.3 1255.9 1262.8 1277.7 1298.9 26741.1 27531.5 27658.2 27984.2 28170.0 45123.5 45279.1 45299.5 45511.0 45570.5 315645.0 319095.0 322516.0 322865.0 323997.0 26677.9 27496.9 27616.6 27710.4 27835.7 43531.0 43731.6 44758.8 45190.3 45363.5 37196.8 38065.4 38744.6 39027.2 39407.4 37407.0 37956.4 38456.2 38460.8 38564.2 37475.3 38803.0 39348.2 39712.0 41512.6 31027.8 34569.3 34858.5 35383.5 35388.3 26634.3 26662.6 26765.2 26968.0 27019.0 04:44:22 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | [#2] jquery.html Cycles:180 Average:24789.74 Median:4369.02 stddev:66903.86 (1531.3%) stddev-sans-first:67066.42 04:44:22 INFO - PROCESS | 27247 | Values: 370.9 373.5 374.8 383.5 386.7 16259.2 17506.3 18028.1 18244.7 18262.2 17305.3 17566.9 17612.9 17705.8 17795.4 4949.0 5112.8 5139.4 5141.2 5147.6 3642.5 5044.8 5540.4 5851.8 5852.6 5895.6 5907.8 5917.5 5927.1 5927.6 5677.9 5887.6 5903.5 5909.1 5920.7 4510.2 5163.1 5165.3 5178.1 5212.6 12145.3 12232.9 12344.9 12383.3 12400.1 1769.4 1787.4 1794.2 1873.4 2012.4 8461.8 8852.3 9205.0 9210.3 9241.1 1711.4 1713.5 1727.4 1728.3 1744.3 73737.6 76383.6 77455.6 77645.0 77901.8 9511.5 9702.5 9788.2 10008.9 10155.8 13173.5 13250.7 13294.3 13346.0 13397.9 7469.9 7512.4 7515.8 7594.8 7640.4 7157.6 7270.9 7307.4 7397.2 7416.2 4122.2 4139.8 4143.3 4176.7 4227.9 1647.5 1708.0 1807.7 1838.2 1866.9 768.9 883.2 902.5 917.1 953.9 16366.9 16882.7 17492.4 17713.7 18486.2 888.5 951.3 959.7 975.9 1016.4 9610.7 9868.6 9870.7 9894.3 9907.7 401425.0 402357.0 402876.0 403318.0 413157.0 51526.0 79870.0 80131.6 81494.6 86069.6 966.0 976.2 976.2 986.7 991.4 15613.1 15729.2 15746.8 15769.4 15898.2 33767.2 34921.5 37237.4 38599.8 39065.2 51518.7 51934.0 52470.2 52495.2 53425.7 7684.4 7858.4 7923.2 7926.0 7953.2 8522.4 8643.0 11547.9 12275.8 12400.1 10426.7 10460.8 10536.7 10542.1 10569.0 10156.7 10793.6 10813.7 10848.5 10974.4 9558.3 10376.6 10495.6 10716.9 10878.9 7800.5 7810.6 8009.5 8044.8 8237.5 10560.7 10713.6 10781.1 10883.8 11050.4 04:44:22 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | [#3] mootools.html Cycles:180 Average:5267.98 Median:5723.80 stddev:2941.75 (51.4%) stddev-sans-first:2936.29 04:44:22 INFO - PROCESS | 27247 | Values: 1489.2 1524.7 1709.8 1821.8 1859.9 6873.6 7750.0 7810.0 8271.5 8296.9 7998.3 8021.9 8102.8 8116.5 8119.4 2184.1 2214.6 2232.2 2232.8 2235.2 2179.2 2195.8 2214.9 2243.4 2251.9 2195.2 2203.4 2205.1 2210.3 2240.7 2140.7 2148.1 2149.9 2150.7 2151.4 2125.9 2151.4 2153.3 2157.8 2195.5 8027.8 8122.0 8125.0 8129.5 8142.0 4584.8 4725.2 4737.8 4738.5 4750.6 2763.8 2816.8 2924.2 2944.1 2980.8 912.8 922.1 923.1 960.3 969.9 10350.0 10639.1 10694.8 10965.7 10976.8 3977.3 4031.1 4079.2 4087.1 4112.2 8742.7 8748.0 8759.0 8767.3 8780.4 4630.5 4675.8 4695.1 4700.3 4730.1 3657.7 4165.6 4256.2 4345.5 4380.1 3368.9 3404.8 3513.4 3550.5 3558.6 975.8 985.7 992.5 995.6 1002.8 822.0 960.0 962.5 963.2 980.8 5546.4 5570.5 5589.3 5613.5 5636.3 395.4 407.3 417.1 420.3 422.3 3931.9 4123.3 4284.7 4369.7 4392.8 9451.3 9750.0 9807.2 9817.7 9830.4 9597.0 9648.9 9711.5 9717.2 9737.0 7210.9 7254.0 7489.3 7599.3 7626.8 5811.3 5816.7 5817.1 5936.9 5961.8 8731.8 8832.4 9089.7 9105.3 9174.8 9181.5 9265.7 9281.4 9420.1 9420.6 6270.2 6832.2 6862.3 7045.6 7067.9 7836.4 7921.6 7949.4 7971.9 7972.7 6749.9 6881.6 6924.7 6929.5 7012.4 6884.2 6907.6 6913.5 7072.3 7076.0 6436.1 6710.0 6724.8 6738.8 6789.8 4925.1 5047.4 5061.3 5144.6 5156.9 5048.7 5063.0 5083.5 5132.5 5160.3 04:44:22 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | [#4] prototype.html Cycles:180 Average:4439.56 Median:5074.34 stddev:1280.71 (25.2%) stddev-sans-first:1245.85 04:44:22 INFO - PROCESS | 27247 | Values: 289.9 293.3 299.2 306.2 311.7 5100.2 5106.4 5132.9 5135.8 5183.6 4940.4 4999.8 4999.8 5029.0 5032.3 3755.5 3831.9 3981.5 3982.1 3995.3 3968.5 3975.8 3976.4 3993.2 4003.3 3961.2 3962.8 3972.3 3978.3 3990.8 3861.6 3976.2 3984.9 4006.7 4012.3 3468.6 3484.0 3498.6 3498.6 3511.5 4753.5 4839.8 4861.5 4893.7 4899.5 4425.0 4571.5 4586.0 4617.2 4625.2 5344.8 5350.6 5365.2 5368.7 5386.3 3867.3 3870.1 3871.9 3890.7 3905.4 5328.5 5571.7 5632.6 5643.0 5659.8 3951.5 3956.6 3958.7 3963.6 3971.6 4022.7 4033.5 4042.7 4046.4 4048.7 4572.5 4593.3 4604.7 4606.5 4610.4 5074.2 5323.2 5344.2 5370.2 5426.9 1393.1 1401.3 1403.6 1404.8 1413.8 877.9 887.0 910.4 921.5 926.9 4525.8 4626.0 4636.6 4644.8 4658.3 5484.6 5488.3 5507.9 5527.8 5537.7 4476.3 4682.0 4717.6 4727.3 4751.5 2937.3 2938.7 2947.3 2950.6 2951.3 5100.6 5146.7 5173.4 5194.5 5213.6 5453.5 5502.6 5594.2 5616.9 5626.3 5155.8 5199.0 5216.7 5225.8 5227.5 5444.6 5499.9 5508.2 5516.9 5531.3 5321.3 5329.4 5442.3 5451.6 5453.2 5190.5 5198.4 5202.2 5237.0 5247.1 3937.5 3941.3 3949.6 3955.0 3963.1 5383.4 5492.8 5495.4 5500.4 5522.9 5289.2 5324.6 5337.8 5359.7 5369.4 5074.5 5298.7 5383.0 5387.1 5396.2 5173.8 5218.5 5258.1 5259.5 5280.2 5129.8 5247.2 5343.4 5345.3 5347.9 5192.5 5243.7 5252.2 5269.7 5274.8 04:44:22 INFO - PROCESS | 27247 | 04:44:22 INFO - PROCESS | 27247 | [#5] yui.html Cycles:180 Average:13258.87 Median:505.60 stddev:15748.45 (3114.8%) stddev-sans-first:15764.37 04:44:22 INFO - PROCESS | 27247 | Values: 696.3 718.7 742.9 790.0 828.2 11682.6 12431.6 12456.6 12465.0 12483.2 11983.2 12027.2 12031.2 12037.8 12054.2 668.6 829.2 853.4 856.0 858.9 853.3 857.0 863.0 863.7 865.1 905.7 906.1 909.5 911.4 911.9 904.4 909.2 910.3 911.3 912.4 662.7 667.2 667.5 668.9 669.3 11627.6 11681.2 11687.4 11690.0 11729.5 12154.5 12438.3 12482.9 12653.1 12866.8 9228.6 9393.0 9614.7 9716.9 9724.1 3273.9 3284.2 3297.2 3315.2 3318.9 44937.6 45272.8 45308.3 45369.8 46791.0 9071.2 9178.9 9230.6 9470.6 9627.8 18535.4 18555.6 18588.8 18626.8 18707.5 6360.6 6552.7 6555.6 6594.9 6598.2 3643.7 3658.5 3658.7 3660.6 3703.5 2688.2 2794.0 2798.9 2803.6 2818.3 494.2 517.0 519.4 528.4 555.6 582.7 591.2 592.6 596.5 598.0 7730.6 7765.7 7838.5 7844.0 8033.2 576.8 604.4 611.0 611.3 631.3 3676.8 3692.1 3726.5 3840.3 3862.5 58696.1 59338.0 59363.0 59370.1 60297.0 52362.7 52418.0 53347.0 53552.0 54405.0 46052.8 46084.5 46643.8 46823.8 47229.3 7860.8 7963.1 7979.7 8063.8 8102.0 30235.7 30513.5 30811.0 31115.4 31800.8 36965.6 37297.0 40104.6 40168.2 40188.8 10546.3 10571.3 10627.0 10770.6 10875.9 8244.3 11848.3 12001.2 12083.2 12210.9 10590.2 10770.4 10995.8 11426.0 11460.5 11015.1 11297.9 11347.8 11757.7 11779.0 11020.6 11027.9 11122.8 11467.3 11498.7 9430.8 9599.6 9680.8 9990.3 10005.5 8534.2 8624.0 8919.2 8981.2 9135.6 04:44:22 INFO - PROCESS | 27247 | -------- Summary: end -------- 04:44:22 INFO - PROCESS | 27247 | 04:44:23 INFO - TEST-INFO | 27247: exit 0 04:44:23 INFO - TEST-OK | dromaeo_css | took 1116447ms 04:44:23 INFO - TEST-START | kraken 04:44:23 INFO - operating with platform_type : linux_ 04:44:23 INFO - Initialising browser for kraken test... 04:44:23 INFO - TEST-INFO | started process 27484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4bYruy/profile http://localhost:54273/getInfo.html) 04:44:27 INFO - PROCESS | 27484 | 04:44:27 INFO - PROCESS | 27484 | (process:27550): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:44:28 INFO - PROCESS | 27484 | __metrics Screen width/height:1600/1200 04:44:28 INFO - PROCESS | 27484 | colorDepth:24 04:44:28 INFO - PROCESS | 27484 | Browser inner width/height: 1024/697 04:44:28 INFO - PROCESS | 27484 | __metrics 04:44:29 ERROR - PROCESS | 27484 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 04:44:29 INFO - TEST-INFO | 27484: exit 0 04:44:29 INFO - Browser initialized. 04:44:29 INFO - Running cycle 1/1 for kraken test... 04:44:29 INFO - TEST-INFO | started process 27601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4bYruy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:31 INFO - PROCESS | 27601 | 04:44:31 INFO - PROCESS | 27601 | (process:27661): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:44:41 INFO - PROCESS | 27601 | RSS: Main: 164933632 04:44:41 INFO - PROCESS | 27601 | 04:44:44 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54273/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:45 INFO - PROCESS | 27601 | RSS: Main: 169242624 04:44:45 INFO - PROCESS | 27601 | 04:44:48 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54273/tests/kraken/driver.html?testName=audio-dft) 04:44:49 INFO - PROCESS | 27601 | RSS: Main: 168882176 04:44:49 INFO - PROCESS | 27601 | 04:44:51 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54273/tests/kraken/driver.html?testName=audio-fft) 04:44:52 INFO - PROCESS | 27601 | RSS: Main: 164126720 04:44:52 INFO - PROCESS | 27601 | 04:44:54 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54273/tests/kraken/driver.html?testName=audio-oscillator) 04:44:55 INFO - PROCESS | 27601 | RSS: Main: 164319232 04:44:55 INFO - PROCESS | 27601 | 04:44:57 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:58 INFO - PROCESS | 27601 | RSS: Main: 164581376 04:44:58 INFO - PROCESS | 27601 | 04:45:01 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54273/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:02 INFO - PROCESS | 27601 | RSS: Main: 164818944 04:45:02 INFO - PROCESS | 27601 | 04:45:05 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54273/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:06 INFO - PROCESS | 27601 | RSS: Main: 163901440 04:45:06 INFO - PROCESS | 27601 | 04:45:09 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54273/tests/kraken/driver.html?testName=json-parse-financial) 04:45:10 INFO - PROCESS | 27601 | RSS: Main: 164085760 04:45:10 INFO - PROCESS | 27601 | 04:45:11 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:12 INFO - PROCESS | 27601 | RSS: Main: 164196352 04:45:12 INFO - PROCESS | 27601 | 04:45:14 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:15 INFO - PROCESS | 27601 | RSS: Main: 164618240 04:45:15 INFO - PROCESS | 27601 | 04:45:17 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:18 INFO - PROCESS | 27601 | RSS: Main: 164917248 04:45:18 INFO - PROCESS | 27601 | 04:45:20 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:21 INFO - PROCESS | 27601 | RSS: Main: 164597760 04:45:21 INFO - PROCESS | 27601 | 04:45:24 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:25 INFO - PROCESS | 27601 | RSS: Main: 164737024 04:45:25 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54273/tests/kraken/driver.html?testName=ai-astar) 04:45:27 INFO - PROCESS | 27601 | RSS: Main: 166154240 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | __start_tp_report 04:45:27 INFO - PROCESS | 27601 | _x_x_mozilla_page_load 04:45:27 INFO - PROCESS | 27601 | _x_x_mozilla_page_load_details 04:45:27 INFO - PROCESS | 27601 | |i|pagename|runs| 04:45:27 INFO - PROCESS | 27601 | |0;ai-astar;111;113;106;114;115;114;111;113;114;114 04:45:27 INFO - PROCESS | 27601 | |1;audio-beat-detection;160;128;159;209;131;162;154;136;186;132 04:45:27 INFO - PROCESS | 27601 | |2;audio-dft;163;164;164;171;161;162;161;163;163;163 04:45:27 INFO - PROCESS | 27601 | |3;audio-fft;76;75;75;163;78;75;76;76;173;77 04:45:27 INFO - PROCESS | 27601 | |4;audio-oscillator;92;94;186;92;93;93;141;92;92;153 04:45:27 INFO - PROCESS | 27601 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;117;118 04:45:27 INFO - PROCESS | 27601 | |6;imaging-darkroom;148;146;147;147;146;147;148;148;146;147 04:45:27 INFO - PROCESS | 27601 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;95;100 04:45:27 INFO - PROCESS | 27601 | |8;json-parse-financial;64;66;67;65;68;66;65;71;67;65 04:45:27 INFO - PROCESS | 27601 | |9;json-stringify-tinderbox;64;65;64;64;65;64;63;64;72;64 04:45:27 INFO - PROCESS | 27601 | |10;stanford-crypto-aes;81;83;83;82;82;88;87;83;143;84 04:45:27 INFO - PROCESS | 27601 | |11;stanford-crypto-ccm;136;133;139;127;147;137;146;133;150;130 04:45:27 INFO - PROCESS | 27601 | |12;stanford-crypto-pbkdf2;171;169;169;178;172;165;169;166;172;169 04:45:27 INFO - PROCESS | 27601 | |13;stanford-crypto-sha256-iterative;67;67;70;67;67;66;67;68;67;72 04:45:27 INFO - PROCESS | 27601 | __end_tp_report 04:45:27 INFO - PROCESS | 27601 | __start_cc_report 04:45:27 INFO - PROCESS | 27601 | _x_x_mozilla_cycle_collect,915 04:45:27 INFO - PROCESS | 27601 | __end_cc_report 04:45:27 INFO - PROCESS | 27601 | __startTimestamp1463139927264__endTimestamp 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | ------- Summary: start ------- 04:45:27 INFO - PROCESS | 27601 | Number of tests: 14 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:2.64 (2.3%) stddev-sans-first:2.74 04:45:27 INFO - PROCESS | 27601 | Values: 111.0 113.0 106.0 114.0 115.0 114.0 111.0 113.0 114.0 114.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:159.50 stddev:26.16 (16.4%) stddev-sans-first:27.70 04:45:27 INFO - PROCESS | 27601 | Values: 160.0 128.0 159.0 209.0 131.0 162.0 154.0 136.0 186.0 132.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.84 (1.7%) stddev-sans-first:3.00 04:45:27 INFO - PROCESS | 27601 | Values: 163.0 164.0 164.0 171.0 161.0 162.0 161.0 163.0 163.0 163.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:38.87 (51.1%) stddev-sans-first:40.66 04:45:27 INFO - PROCESS | 27601 | Values: 76.0 75.0 75.0 163.0 78.0 75.0 76.0 76.0 173.0 77.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:92.00 stddev:34.38 (37.4%) stddev-sans-first:35.63 04:45:27 INFO - PROCESS | 27601 | Values: 92.0 94.0 186.0 92.0 93.0 93.0 141.0 92.0 92.0 153.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:45:27 INFO - PROCESS | 27601 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 04:45:27 INFO - PROCESS | 27601 | Values: 148.0 146.0 147.0 147.0 146.0 147.0 148.0 148.0 146.0 147.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 04:45:27 INFO - PROCESS | 27601 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 100.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.50 stddev:2.01 (3.0%) stddev-sans-first:1.94 04:45:27 INFO - PROCESS | 27601 | Values: 64.0 66.0 67.0 65.0 68.0 66.0 65.0 71.0 67.0 65.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:64.00 stddev:2.56 (4.0%) stddev-sans-first:2.69 04:45:27 INFO - PROCESS | 27601 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 63.0 64.0 72.0 64.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:83.00 stddev:18.89 (22.8%) stddev-sans-first:19.78 04:45:27 INFO - PROCESS | 27601 | Values: 81.0 83.0 83.0 82.0 82.0 88.0 87.0 83.0 143.0 84.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:138.00 stddev:7.67 (5.6%) stddev-sans-first:8.11 04:45:27 INFO - PROCESS | 27601 | Values: 136.0 133.0 139.0 127.0 147.0 137.0 146.0 133.0 150.0 130.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.00 stddev:3.62 (2.1%) stddev-sans-first:3.82 04:45:27 INFO - PROCESS | 27601 | Values: 171.0 169.0 169.0 178.0 172.0 165.0 169.0 166.0 172.0 169.0 04:45:27 INFO - PROCESS | 27601 | 04:45:27 INFO - PROCESS | 27601 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:1.81 (2.7%) stddev-sans-first:1.90 04:45:27 INFO - PROCESS | 27601 | Values: 67.0 67.0 70.0 67.0 67.0 66.0 67.0 68.0 67.0 72.0 04:45:27 INFO - PROCESS | 27601 | -------- Summary: end -------- 04:45:27 INFO - PROCESS | 27601 | 04:45:28 INFO - TEST-INFO | 27601: exit 0 04:45:28 INFO - TEST-OK | kraken | took 64979ms 04:45:28 INFO - SUITE-END | took 1181s 04:45:28 INFO - Completed test suite (00:19:41) 04:45:28 INFO - javascript benchmark 04:45:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6398.698878088723, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.574308110702, 2720.1703480438464, 2725.918222453327, 2728.0724553651767, 2740.451909618077, 4816.470188279286, 4821.373221481203, 4828.541288577584, 4905.215165573509, 4970.751462426873, 4806.351142595749, 4884.706917584947, 4901.313816065754, 4902.632302577312, 4920.852374428764, 4453.955460445402, 4486.327050942352, 4576.153411618844, 4586.54134586542, 4598.264277715566, 4527.0, 4617.699849509788, 4647.53524647536, 4647.72113673179, 4660.976695116519, 4406.713563618387, 4484.260097083978, 4514.616257618107, 4519.254323036695, 4598.977005114986, 4431.8448854289945, 4442.933355999663, 4451.732896026248, 4451.866444006685, 4498.0, 4438.7114837535455, 4460.219461594241, 4471.993801394693, 4485.147821913826, 4494.438195225597, 4730.432348118248, 4756.3816703828625, 4801.759912004386, 4808.110499557558, 4809.23052311632, 5199.506046925574, 5231.921521177185, 5255.054090263751, 5264.499872512105, 5301.416844147141, 5115.360579927509, 5304.20436934459, 5307.071262529081, 5307.6019298552765, 5310.097283461782, 4802.255650374198, 4894.437139728905, 4915.16442204826, 4930.827421040318, 4939.629527785431, 5405.486478784509, 5416.7020813855615, 5435.646682965595, 5439.918401223985, 5446.972765136149, 5073.188289873677, 5161.200013997836, 5191.662541934762, 5194.662346947436, 5204.34945631796, 5227.424983251839, 5239.554637855825, 5251.76367063483, 5262.657927234717, 5274.050670879278, 5030.346055012898, 5107.080725469451, 5169.4830516948, 5183.714895680774, 5184.948150518522, 5192.662476938987, 5195.68825870449, 5205.687658740488, 5218.634695571273, 5247.081760691864, 4391.231534481453, 4441.977790111029, 4485.237509623372, 4519.480259770103, 4535.183666939983, 3904.7657140571655, 3918.3338832398563, 3923.7841918694176, 3952.8616498422416, 3963.742356746802, 4500.009997800478, 4552.317152427162, 4575.862724118282, 4595.0, 4643.489216186217, 5207.557357624569, 5317.8936421271355, 5350.38470575881, 5373.704446255493, 5400.945990540123, 4563.657725670521, 4580.587747102777, 4583.931241031387, 4592.311153326961, 4600.217962946307, 4689.788959496831, 4824.95175048245, 4831.8308859190465, 4841.370621819141, 4881.682690625098, 4918.262260660929, 4936.407631084293, 4973.726445045557, 4984.551390374883, 4992.700437973734, 5328.387235467971, 5333.866653333543, 5334.253204551288, 5345.251664766858, 5371.382291036581, 4861.635377346643, 4936.605071594192, 4959.70241785494, 4982.327385802871, 4983.6760610560195, 5152.407473140487, 5195.636305458582, 5219.399769026611, 5222.399424066281, 5275.419703832652, 5303.257543943928, 5303.363596368306, 5319.521243088141, 5333.73331333424, 5373.570114390761, 4963.652544322007, 5023.422306434807, 5040.647154699136, 5137.255098010843, 5155.510226528474, 5007.3240112584335, 5034.16936205522, 5050.772715227897, 5056.317397151338, 5077.7461126944245, 5021.271915572149, 5045.31888195089, 5056.089903817348, 5059.0, 5091.0, 5046.697198168122, 5102.260172275073, 5125.974370128126, 5142.0, 5169.974150129226, 5031.6226283029655, 5040.395152581714, 5053.898922021465, 5099.26060721186, 5099.6685215460875], "value": 4824.2951550458065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.2205761193583, 607.7994261893575, 608.2093278737638, 618.8298217990053, 628.3339659960445, 36464.0, 40661.390079148834, 40974.0, 41082.17835643285, 41382.37926431106, 40970.180596388054, 41358.17283654325, 41554.58445415545, 41576.58423415765, 41656.79171604138, 7829.960850195741, 7968.083670377923, 7997.280244777969, 7999.200079992012, 8006.67973281068, 7661.195574464685, 7662.310392064713, 7682.500637458547, 7732.690692372298, 7742.225777422269, 7728.459007869451, 7798.766037018899, 7799.844003119934, 7801.063872335328, 7814.53112813233, 7665.0, 7697.307242348215, 7698.191689872567, 7712.807179820493, 7735.303822655988, 7835.686572537092, 7849.215078492105, 7879.684812607489, 7903.881441778378, 7906.7627971160955, 30056.699433005826, 37685.81157094224, 37915.62084379148, 37935.24129517394, 37968.240635187416, 3215.6623554526905, 3271.8200498972546, 3326.7005969462866, 3376.4935259710996, 3388.9322213555592, 30401.391972160432, 30836.22909427282, 31153.688463115304, 32331.838340808146, 32456.83771581127, 3569.125564236753, 3591.712662986955, 3632.237230181665, 3664.4136938090046, 3782.224643947984, 260754.0, 268248.0, 268491.0, 269335.6533217341, 269656.0, 34576.48135277973, 35555.11112222215, 35630.0, 62109.37890621036, 63684.36315636784, 36438.80953690306, 36598.0, 36750.26499470049, 36771.63228367682, 36863.4470482943, 14727.631809204642, 14734.115953042852, 14844.109353438827, 14945.77581336259, 14968.401263949538, 11745.11911606633, 11747.88252117485, 11776.411179440993, 11826.0, 11882.94058529719, 8513.702020429255, 8563.95718021406, 8588.785280368042, 8672.609732561923, 8689.0, 3363.6972672459597, 3387.2209391840015, 3415.470602056685, 3420.2817408344526, 3464.6015708193377, 895.552223888056, 913.2374467319729, 924.9963789288697, 930.7905721212672, 1019.8470229465639, 27468.450630987667, 28002.0, 28103.57844632332, 28321.433571328456, 28545.14456560317, 982.6855406269925, 1058.0424715632364, 1069.3423544520065, 1084.4631907205826, 1091.6343025086526, 14407.0, 14506.782398264035, 14834.925825370805, 14898.851011489964, 15279.694406111816, 368950.0, 370541.0, 373679.0, 373689.0, 375165.0, 51084.0, 52452.47547524476, 52500.21249681258, 52558.21162682563, 52572.21141682878, 1235.3144005077088, 1255.8555766087018, 1262.8484581850237, 1277.7252890628374, 1298.8571257161893, 26741.06406275771, 27531.51364764268, 27658.170254892386, 27984.160475185778, 28170.0, 45123.548764511936, 45279.09441811079, 45299.54700452953, 45511.0, 45570.544294557956, 315645.0, 319095.0, 322516.0, 322865.0, 323997.0, 26677.86661066682, 27496.862515687295, 27616.58575121415, 27710.44579108447, 27835.721642783312, 43531.0, 43731.56268437275, 44758.77620611876, 45190.32214516719, 45363.546364535934, 37196.81401592975, 38065.4290185653, 38744.6125538741, 39027.21945561016, 39407.40888886726, 37407.0, 37956.43065353967, 38456.2308753829, 38460.80769596246, 38564.22871542497, 37475.25049499049, 38803.0, 39348.213035739696, 39712.014399279346, 41512.584874150874, 31027.844860776455, 34569.30861382708, 34858.47712284369, 35383.469247960784, 35388.29223415466, 26634.334141646614, 26662.600060998713, 26765.19704408871, 26967.95480677914, 27019.0], "value": 17111.128045929945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.885025642051, 373.458485196465, 374.8313259033434, 383.52634496396945, 386.7234927027175, 16259.187040647965, 17506.29974801008, 18028.107048759888, 18244.726329105073, 18262.17820198091, 17305.307787688478, 17566.912165439157, 17612.88645362555, 17705.82294177061, 17795.37716179934, 4948.999999999991, 5112.795488180468, 5139.383274007125, 5141.228815677641, 5147.613928955325, 3642.5264715586936, 5044.772985215674, 5540.418256083114, 5851.824445266649, 5852.590318677694, 5895.587308888379, 5907.793227237047, 5917.467427931485, 5927.081302398135, 5927.555433342495, 5677.858053548653, 5887.5584331174905, 5903.49820265278, 5909.143174239711, 5920.733566989496, 4510.188166130095, 5163.070647283487, 5165.302684137631, 5178.14560597501, 5212.609054320941, 12145.271283722917, 12232.938835305855, 12344.876551234462, 12383.257004579755, 12400.13199076065, 1769.3895606015903, 1787.356551641408, 1794.1836464408664, 1873.3911478769319, 2012.4163992442175, 8461.788455288606, 8852.291816654717, 9205.033471485465, 9210.263178945668, 9241.122093401116, 1711.3582406597525, 1713.5202143399868, 1727.4040456042644, 1728.3086765293858, 1744.3284335530784, 73737.6313118431, 76383.61808190924, 77455.61272193659, 77645.0, 77901.83147252853, 9511.524423778783, 9702.5148742564, 9788.168005719594, 10008.899911000943, 10155.847662284923, 13173.47306107764, 13250.668733281746, 13294.268815215062, 13346.0, 13397.93301033508, 7469.850602988018, 7512.39900807934, 7515.774526764206, 7594.772156835304, 7640.388768898475, 7157.642117894085, 7270.927290727131, 7307.415406767552, 7397.18630950595, 7416.221296763762, 4122.154958233555, 4139.799458157101, 4143.316352801814, 4176.7076304658385, 4227.852025179165, 1647.4810434713027, 1707.9573010674585, 1807.701729214691, 1838.2095698849623, 1866.887986720801, 768.8846672999094, 883.1874675298612, 902.5081330674667, 917.1195652173988, 953.880764904387, 16366.918165409335, 16882.74675879863, 17492.387766428114, 17713.7342939856, 18486.168122434523, 888.5339190335998, 951.2912879904516, 959.712086374085, 975.8877729061107, 1016.4307987527009, 9610.66362677303, 9868.605255789831, 9870.654527091518, 9894.30739848218, 9907.702768916944, 401425.0, 402357.0, 402876.0, 403318.0, 413157.0, 51526.0, 79870.0, 80131.59934200291, 81494.59252703817, 86069.5696521526, 965.9517024148764, 976.2190247801731, 976.2482888176206, 986.7039888033705, 991.4150651115876, 15613.14127722986, 15729.21353932276, 15746.76379854326, 15769.369225230863, 15898.205089745697, 33767.15582110467, 34921.47617785786, 37237.441438378984, 38599.807000964815, 39065.2186956265, 51518.742406287725, 51934.0, 52470.21294680659, 52495.21257181069, 53425.65743425626, 7684.423668224794, 7858.410619203697, 7923.207679232261, 7925.960370198342, 7953.204679532232, 8522.446041007315, 8642.956785216034, 11547.884521155018, 12275.815862762245, 12400.13199076056, 10426.739331516772, 10460.790784184426, 10536.736581585521, 10542.103921166787, 10569.048785609331, 10156.695299141038, 10793.568257269935, 10813.729656758644, 10848.511816968097, 10974.396408197306, 9558.330916835755, 10376.584936602452, 10495.597685412045, 10716.89283107159, 10878.891211087788, 7800.45396822217, 7810.6485208166905, 8009.519428834288, 8044.798880028046, 8237.50574965504, 10560.683179504627, 10713.625023124465, 10781.083607893417, 10883.782324353628, 11050.447477626247], "value": 8224.647397255514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.2479297954535, 1524.7026829768197, 1709.8375654312845, 1821.772278465192, 1859.851211903048, 6873.621950792704, 7749.961250193748, 7810.0, 8271.50370977741, 8296.91703082969, 7998.32014278787, 8021.879671804928, 8102.7569172924905, 8116.513009219451, 8119.431639785217, 2184.148182208936, 2214.568159208955, 2232.151782322723, 2232.821374290061, 2235.16181431963, 2179.2372669565684, 2195.769444208359, 2214.9114035438565, 2243.371855880356, 2251.887405629712, 2195.1658369819447, 2203.4160947348964, 2205.106931692659, 2210.3037543173928, 2240.6639004149347, 2140.689600007998, 2148.0977989244475, 2149.881756503392, 2150.7204063471804, 2151.376100930728, 2125.883076430796, 2151.376100930728, 2153.2786516516985, 2157.7626461089267, 2195.4511372156962, 8027.839443211103, 8121.959390203011, 8124.959375203145, 8129.512229266263, 8141.959290203511, 4584.816607335702, 4725.243960966263, 4737.810487580493, 4738.526147385269, 4750.61995040396, 2763.847988360639, 2816.8169069010655, 2924.1812292558116, 2944.0873329267997, 2980.821150730963, 912.8251939753532, 922.1424075609681, 923.0999775219175, 960.3229723045237, 969.9369540979814, 10350.0, 10639.095676867475, 10694.839577406345, 10965.725856853564, 10976.780464390748, 3977.3238549446664, 4031.133306339151, 4079.1637714268504, 4087.1008378156757, 4112.198121366365, 8742.650293988168, 8748.0, 8758.956205219061, 8767.298616110824, 8780.385373023955, 4630.490646028934, 4675.836345727883, 4695.084458530554, 4700.271457924027, 4730.053989202173, 3657.7256705747177, 4165.604267594574, 4256.170046840898, 4345.478542574911, 4380.080183161508, 3368.882089126918, 3404.8467818948207, 3513.3851575974104, 3550.467429885486, 3558.5551806024246, 975.7560609847538, 985.6550207427343, 992.4640694025146, 995.571904081252, 1002.7693630465034, 821.9753407397787, 959.9616015359447, 962.5235508423375, 963.2280514183568, 980.7989362180735, 5546.4453554644215, 5570.5265052470995, 5589.329280486368, 5613.522850557667, 5636.2954630671165, 395.3614911917233, 407.3258756757571, 417.1032280596741, 420.3106904676333, 422.30741583802586, 3931.8820435386983, 4123.257813593582, 4284.657227421799, 4369.650427965755, 4392.824287028547, 9451.291153163404, 9749.951250243703, 9807.215422766161, 9817.656382026595, 9830.361026533395, 9597.0, 9648.855267170999, 9711.514424278757, 9717.222622190207, 9736.95131524338, 7210.9278907210255, 7253.963730181421, 7489.28851759082, 7599.278068583476, 7626.771196864103, 5811.302643682785, 5816.73824677882, 5817.069268916953, 5936.940630593812, 5961.791337303173, 8731.781705457415, 8832.425892316978, 9089.727308180765, 9105.27157827359, 9174.816503670023, 9181.495017774087, 9265.675701350421, 9281.350305478552, 9420.057994200799, 9420.576074076545, 6270.2475702915945, 6832.248452670103, 6862.348076932683, 7045.612491313027, 7067.929320706933, 7836.412269079956, 7921.603919804102, 7949.364050875801, 7971.92028079735, 7972.681092756225, 6749.932500675127, 6881.552699074544, 6924.723011079501, 6929.514933954776, 7012.4390048796995, 6884.173899132136, 6907.551009184387, 6913.516053876381, 7072.328128827753, 7075.964620176866, 6436.13112229843, 6710.0, 6724.831879203059, 6738.797836064926, 6789.830254243683, 4925.138100832269, 5047.369078865142, 5061.342025536656, 5144.614153938544, 5156.948430515647, 5048.697078175322, 5062.974685126551, 5083.517065878736, 5132.46109158533, 5160.329157209539], "value": 4163.495709827479, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.9304166999918, 293.28146042196624, 299.24291542397725, 306.1840195877985, 311.7038813127528, 5100.183970564705, 5106.361704786902, 5132.923006154911, 5135.7688903999315, 5183.559397451221, 4940.382452193476, 4999.775010124544, 4999.825006124786, 5028.994201159764, 5032.295478632995, 3755.530558680165, 3831.9233615327676, 3981.542122655903, 3982.1438390745984, 3995.320795464778, 3968.484097067377, 3975.82108805103, 3976.4234186043004, 3993.2013597280516, 4003.3194356959243, 3961.247363001035, 3962.841486340543, 3972.324704800191, 3978.323684973547, 3990.7805070721097, 3861.6331448512346, 3976.224636195943, 3984.920301593952, 4006.659433948118, 4012.3179059559943, 3468.601110872257, 3483.9651603483894, 3498.6151523332414, 3498.632643572439, 3511.4908338290807, 4753.453352864431, 4839.782209800567, 4861.465238823726, 4893.730844803535, 4899.4610592835115, 4424.977875110636, 4571.474280457724, 4586.036932244199, 4617.2381557043045, 4625.167469855424, 5344.812931547377, 5350.571954243651, 5365.222042803811, 5368.731563421813, 5386.272853164812, 3867.323218436762, 3870.0711829161082, 3871.857801948432, 3890.727649064567, 3905.3556163233034, 5328.46715328468, 5571.721413929287, 5632.605717599769, 5642.971785141048, 5659.801906933238, 3951.4665520154986, 3956.624120708528, 3958.722889397772, 3963.6432721054666, 3971.602839716063, 4022.6982976276895, 4033.515978082649, 4042.6956634718517, 4046.393041043867, 4048.67610591152, 4572.497025327211, 4593.311003349524, 4604.654650901196, 4606.539346065434, 4610.40064791575, 5074.188129899198, 5323.1749078892835, 5344.225087362311, 5370.167624018283, 5426.941746359501, 1393.1153717389532, 1401.3133564553295, 1403.5929580421769, 1404.810350602676, 1413.7912085167034, 877.8727084572829, 886.9822603548022, 910.3945875992523, 921.4517362169498, 926.8517037274139, 4525.773711314487, 4625.982283897537, 4636.605888499448, 4644.790984405709, 4658.254679251371, 5484.561235101182, 5488.341399032061, 5507.9449205507435, 5527.811520523107, 5537.698640819404, 4476.2837945928495, 4681.953180468152, 4717.551832575899, 4727.290906364073, 4751.453582838018, 2937.3390987028174, 2938.720821521952, 2947.2779169103705, 2950.6164198654037, 2951.3064429858964, 5100.642954993189, 5146.716930568779, 5173.430922598511, 5194.506521880416, 5213.60897932649, 5453.481919217668, 5502.560899437852, 5594.216809646653, 5616.943830561642, 5626.268585083994, 5155.767990440514, 5198.974005130026, 5216.739163041832, 5225.764840582183, 5227.536289838851, 5444.646098003617, 5499.917501237404, 5508.173773933942, 5516.91724624139, 5531.253280807039, 5321.255024296679, 5329.440408757025, 5442.292501974718, 5451.591130665137, 5453.182022696468, 5190.506901844319, 5198.350206224222, 5202.167653175474, 5236.973815131052, 5247.134222853187, 3937.4684417603257, 3941.2708648900043, 3949.6050394960275, 3954.9604503954592, 3963.128111815396, 5383.380911195262, 5492.802878848493, 5495.422980586981, 5500.367457742411, 5522.889542209053, 5289.175234544076, 5324.6006549508165, 5337.786488540571, 5359.678419294854, 5369.3556773187465, 5074.492550745043, 5298.655587386807, 5382.973085134549, 5387.057264978692, 5396.163594642837, 5173.793048278178, 5218.452062533379, 5258.0798360286035, 5259.500347466985, 5280.155175171954, 5129.794498292824, 5247.1866860636665, 5343.4122246553625, 5345.33183352081, 5347.946520534745, 5192.506711862367, 5243.711595862112, 5252.1596544552685, 5269.681340210295, 5274.7890084396195], "value": 4027.995083836415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.3176087434312, 718.6765955320108, 742.9294217049381, 789.9842003159936, 828.2462958707575, 11682.591109311175, 12431.627051188456, 12456.626301210956, 12465.0, 12483.188592741466, 11983.221090629104, 12027.158098933078, 12031.21797083191, 12037.759244815099, 12054.15620906537, 668.6389349751141, 829.2371018662815, 853.4282031039188, 855.9572021398936, 858.9398742088056, 853.3002937591177, 857.0315543435939, 862.9989212513485, 863.6761214544546, 865.091653763549, 905.7463910105181, 906.0939060939061, 909.5179554835947, 911.3711539038076, 911.8586619074055, 904.4437670832457, 909.236241557092, 910.3309067835136, 911.2618778789202, 912.3886995712888, 662.7382184037278, 667.2093569120559, 667.4860357524678, 668.8729141463107, 669.2838662630987, 11627.59303424376, 11681.182317237797, 11687.357195354252, 11690.0, 11729.472173752201, 12154.513819447211, 12438.315892625902, 12482.875171248354, 12653.114282000264, 12866.806997895039, 9228.6308547658, 9393.0, 9614.663486777928, 9716.854247186298, 9724.076212759777, 3273.9345213095844, 3284.2282063715006, 3297.225152089281, 3315.2374953760527, 3318.900432987014, 44937.55062449366, 45272.773636131606, 45308.3203751944, 45369.773151134366, 46791.0, 9071.228945539571, 9178.86231706525, 9230.630774769068, 9470.621175152917, 9627.807443851223, 18535.35126270574, 18555.628887422175, 18588.814111858977, 18626.813731862778, 18707.532311692044, 6360.554761166766, 6552.705128269239, 6555.573887697285, 6594.934050659528, 6598.241202261705, 3643.6720695137565, 3658.4695219193068, 3658.743887927873, 3660.5790334111384, 3703.4629978652943, 2688.180105067934, 2794.0, 2798.902038428686, 2803.6215110960165, 2818.281338258772, 494.1722614620496, 517.0228268572401, 519.4104691175468, 528.4292963599304, 555.5611067256822, 582.7115577788937, 591.2166379547032, 592.5674257791836, 596.5466245653334, 597.9940200597938, 7730.613469326511, 7765.72819951299, 7838.451308408471, 7844.0, 8033.156518565466, 576.8442520519436, 604.4439116013191, 611.0, 611.3366996808423, 631.2771876201723, 3676.7793932364143, 3692.132348898007, 3726.5341832270965, 3840.251151025523, 3862.517185351831, 58696.11955820666, 59338.0, 59363.0, 59370.10944835831, 60297.0, 52362.73818630882, 52418.0, 53347.0, 53552.0, 54405.0, 46052.7697361511, 46084.53915460803, 46643.766781165876, 46823.76588117037, 47229.29156062662, 7860.803479913048, 7963.124056353912, 7979.680812767424, 8063.758087257392, 8102.0, 30235.69764302329, 30513.542296865122, 30811.0, 31115.377692446476, 31800.84099579487, 36965.63034369622, 37297.0, 40104.59895401126, 40168.196636067696, 40188.7990560057, 10546.26176167661, 10571.2600117991, 10627.0, 10770.623028193975, 10875.945620271848, 8244.340452763645, 11848.28910265387, 12001.1599188056, 12083.214591051554, 12210.938945305217, 10590.205734570092, 10770.353778772986, 10995.835062473909, 11426.02878755315, 11460.541578336773, 11015.118790496581, 11297.887021129683, 11347.773044539228, 11757.706057348634, 11779.0, 11020.559177632806, 11027.944860275647, 11122.777544448903, 11467.31196128235, 11498.712532186762, 9430.789133247144, 9599.616015359308, 9680.806383872143, 9990.250731195045, 10005.54975026111, 8534.231919127309, 8624.0, 8919.241864441596, 8981.236594889508, 9135.588898499716], "value": 6027.37261897175, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 106.0, 114.0, 115.0, 114.0, 111.0, 113.0, 114.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 159.0, 209.0, 131.0, 162.0, 154.0, 136.0, 186.0, 132.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 171.0, 161.0, 162.0, 161.0, 163.0, 163.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 163.0, 78.0, 75.0, 76.0, 76.0, 173.0, 77.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 186.0, 92.0, 93.0, 93.0, 141.0, 92.0, 92.0, 153.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 100.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 67.0, 65.0, 68.0, 66.0, 65.0, 71.0, 67.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 72.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 83.0, 82.0, 82.0, 88.0, 87.0, 83.0, 143.0, 84.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 139.0, 127.0, 147.0, 137.0, 146.0, 133.0, 150.0, 130.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 169.0, 178.0, 172.0, 165.0, 169.0, 166.0, 172.0, 169.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 67.0, 67.0, 66.0, 67.0, 68.0, 67.0, 72.0], "value": 67.8, "unit": "score"}]}]} 04:45:28 INFO - Return code: 0 04:45:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:45:29 ERROR - # TBPL SUCCESS # 04:45:29 INFO - Running post-action listener: _resource_record_post_action 04:45:29 INFO - ##### 04:45:29 INFO - ##### Finished run-tests step (success) 04:45:29 INFO - ##### 04:45:29 INFO - Running post-run listener: _resource_record_post_run 04:45:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530145280; Read time: 12; Write time: 392072 04:45:29 INFO - TinderboxPrint: CPU usage
13.4% 04:45:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:45:29 INFO - TinderboxPrint: I/O write bytes / time
530,145,280 / 392,072 04:45:29 INFO - TinderboxPrint: CPU idle
8,282.2 (86.6%) 04:45:29 INFO - TinderboxPrint: CPU user
1,230.8 (12.9%) 04:45:29 INFO - TinderboxPrint: Swap in / out
0 / 0 04:45:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234762240; Read time: 0; Write time: 207080 04:45:29 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295383040; Read time: 12; Write time: 184992 04:45:29 INFO - Running post-run listener: _upload_blobber_files 04:45:29 INFO - Blob upload gear active. 04:45:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:45:30 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:45:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:30 INFO - (blobuploader) - INFO - Done attempting. 04:45:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:45:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:45:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:34 INFO - (blobuploader) - INFO - Done attempting. 04:45:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:45:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:45:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:35 INFO - (blobuploader) - INFO - Done attempting. 04:45:35 INFO - (blobuploader) - INFO - Iteration through files over. 04:45:35 INFO - Return code: 0 04:45:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:45:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:45:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/749f58b4d64a03c2a051ae9cbe905ddff8ebcd686261776155629e21a6d1f92b23ddaf6b48f4f48026ec8b54e3129aca5fe054308b1f3b9207b9c3ecf105e0cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eaaf05cf2a3ecefc10a54c629bf171b5f6749e1b47dba32a5a276a9ff0d1b95d07d9c9296df0a21f2777e4a6424f98a48d0ed234b4eb6578e44d31968dfc3fc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff683f929fb119a7d5058ff6ec8dfdbba44ac524b8302e13a5db7dc5083a06514c3979bf09810f1d756ce47bfaddcc6d55919fb28419d8c367fb3831ea338204"} 04:45:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:45:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:45:35 INFO - Contents: 04:45:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/749f58b4d64a03c2a051ae9cbe905ddff8ebcd686261776155629e21a6d1f92b23ddaf6b48f4f48026ec8b54e3129aca5fe054308b1f3b9207b9c3ecf105e0cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eaaf05cf2a3ecefc10a54c629bf171b5f6749e1b47dba32a5a276a9ff0d1b95d07d9c9296df0a21f2777e4a6424f98a48d0ed234b4eb6578e44d31968dfc3fc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff683f929fb119a7d5058ff6ec8dfdbba44ac524b8302e13a5db7dc5083a06514c3979bf09810f1d756ce47bfaddcc6d55919fb28419d8c367fb3831ea338204"} 04:45:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:45:35 INFO - Copying logs to upload dir... 04:45:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:45:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.358335 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-13 04:45:34.900908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 04:45:34.904189) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873 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/Firefox-Non-PGO/sha512/749f58b4d64a03c2a051ae9cbe905ddff8ebcd686261776155629e21a6d1f92b23ddaf6b48f4f48026ec8b54e3129aca5fe054308b1f3b9207b9c3ecf105e0cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eaaf05cf2a3ecefc10a54c629bf171b5f6749e1b47dba32a5a276a9ff0d1b95d07d9c9296df0a21f2777e4a6424f98a48d0ed234b4eb6578e44d31968dfc3fc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff683f929fb119a7d5058ff6ec8dfdbba44ac524b8302e13a5db7dc5083a06514c3979bf09810f1d756ce47bfaddcc6d55919fb28419d8c367fb3831ea338204"} build_url:https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/fyj2x_uITkyYZceU9Ejz6w/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/Firefox-Non-PGO/sha512/749f58b4d64a03c2a051ae9cbe905ddff8ebcd686261776155629e21a6d1f92b23ddaf6b48f4f48026ec8b54e3129aca5fe054308b1f3b9207b9c3ecf105e0cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eaaf05cf2a3ecefc10a54c629bf171b5f6749e1b47dba32a5a276a9ff0d1b95d07d9c9296df0a21f2777e4a6424f98a48d0ed234b4eb6578e44d31968dfc3fc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff683f929fb119a7d5058ff6ec8dfdbba44ac524b8302e13a5db7dc5083a06514c3979bf09810f1d756ce47bfaddcc6d55919fb28419d8c367fb3831ea338204"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 04:45:34.929400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:45:34.929736) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463137088.752635-296324873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:45:35.011575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 04:45:35.011941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 04:45:35.012261) ========= ========= Total master_lag: 0.17 =========