builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1463037605.2 results: success (0) buildid: 20160511234012 builduid: eacc19691b5e433c9faf3f81cef51004 revision: c3ff04109a8a6e439be36ae44133b2ba68fc79f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:05.202437) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:05.203081) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:05.203368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:05.229807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:05.230095) ========= 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=7de08804244eb36560b44971000001c3-1463035684.370670-2073163215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 00:20:05-- 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% 224M=0s 2016-05-12 00:20:05 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131271 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:05.374658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:05.374965) ========= 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=7de08804244eb36560b44971000001c3-1463035684.370670-2073163215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019665 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:05.459009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 00:20:05.459331) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c3ff04109a8a6e439be36ae44133b2ba68fc79f6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c3ff04109a8a6e439be36ae44133b2ba68fc79f6 --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=7de08804244eb36560b44971000001c3-1463035684.370670-2073163215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 00:20:05,810 truncating revision to first 12 chars 2016-05-12 00:20:05,811 Setting DEBUG logging. 2016-05-12 00:20:05,811 attempt 1/10 2016-05-12 00:20:05,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c3ff04109a8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 00:20:06,650 unpacking tar archive at: fx-team-c3ff04109a8a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.153535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 00:20:06.625531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:06.625833) ========= script_repo_revision: c3ff04109a8a6e439be36ae44133b2ba68fc79f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:06.626224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:06.626501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 00:20:06.636457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-12 00:20:06.636747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=7de08804244eb36560b44971000001c3-1463035684.370670-2073163215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:20:07 INFO - MultiFileLogger online at 20160512 00:20:07 in /builds/slave/test 00:20:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:20:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:20:07 INFO - {'append_to_log': False, 00:20:07 INFO - 'base_work_dir': '/builds/slave/test', 00:20:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:20:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:20:07 INFO - 'branch': 'Fx-Team-Non-PGO', 00:20:07 INFO - 'buildbot_json_path': 'buildprops.json', 00:20:07 INFO - 'config_files': ('talos/linux_config.py',), 00:20:07 INFO - 'default_actions': ('clobber', 00:20:07 INFO - 'read-buildbot-config', 00:20:07 INFO - 'download-and-extract', 00:20:07 INFO - 'populate-webroot', 00:20:07 INFO - 'create-virtualenv', 00:20:07 INFO - 'install', 00:20:07 INFO - 'run-tests'), 00:20:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:20:07 INFO - 'download_minidump_stackwalk': True, 00:20:07 INFO - 'download_symbols': 'ondemand', 00:20:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:20:07 INFO - 'tooltool.py': '/tools/tooltool.py', 00:20:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:20:07 INFO - '/tools/misc-python/virtualenv.py')}, 00:20:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:20:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:20:07 INFO - 'installer_path': 'installer.exe', 00:20:07 INFO - 'log_level': 'info', 00:20:07 INFO - 'log_name': 'talos', 00:20:07 INFO - 'log_to_console': True, 00:20:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:20:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:20:07 INFO - 'opt_config_files': (), 00:20:07 INFO - 'pip_index': False, 00:20:07 INFO - 'sps_profile': False, 00:20:07 INFO - 'sps_profile_interval': 0, 00:20:07 INFO - 'suite': 'dromaeojs-e10s', 00:20:07 INFO - 'system_bits': '32', 00:20:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:20:07 INFO - 'title': 'talos-linux64-ix-003', 00:20:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:20:07 INFO - 'use_talos_json': True, 00:20:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:20:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:20:07 INFO - 'work_dir': 'build'} 00:20:07 INFO - ##### 00:20:07 INFO - ##### Running clobber step. 00:20:07 INFO - ##### 00:20:07 INFO - Running pre-action listener: _resource_record_pre_action 00:20:07 INFO - Running main action method: clobber 00:20:07 INFO - rmtree: /builds/slave/test/build 00:20:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:20:07 INFO - Running post-action listener: _resource_record_post_action 00:20:07 INFO - ##### 00:20:07 INFO - ##### Finished clobber step (success) 00:20:07 INFO - ##### 00:20:07 INFO - ##### 00:20:07 INFO - ##### Running read-buildbot-config step. 00:20:07 INFO - ##### 00:20:07 INFO - Running pre-action listener: _resource_record_pre_action 00:20:07 INFO - Running main action method: read_buildbot_config 00:20:07 INFO - Using buildbot properties: 00:20:07 INFO - { 00:20:07 INFO - "project": "", 00:20:07 INFO - "product": "firefox", 00:20:07 INFO - "script_repo_revision": "production", 00:20:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:20:07 INFO - "repository": "", 00:20:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 00:20:07 INFO - "buildid": "20160511234012", 00:20:07 INFO - "pgo_build": "False", 00:20:07 INFO - "basedir": "/builds/slave/test", 00:20:07 INFO - "buildnumber": 1264, 00:20:07 INFO - "slavename": "talos-linux64-ix-003", 00:20:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:20:07 INFO - "platform": "ubuntu64_hw", 00:20:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:20:07 INFO - "branch": "fx-team", 00:20:07 INFO - "repo_path": "integration/fx-team", 00:20:07 INFO - "revision": "c3ff04109a8a6e439be36ae44133b2ba68fc79f6", 00:20:07 INFO - "stage_platform": "linux64", 00:20:07 INFO - "builduid": "eacc19691b5e433c9faf3f81cef51004", 00:20:07 INFO - "slavebuilddir": "test" 00:20:07 INFO - } 00:20:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 00:20:07 INFO - Running post-action listener: _resource_record_post_action 00:20:07 INFO - ##### 00:20:07 INFO - ##### Finished read-buildbot-config step (success) 00:20:07 INFO - ##### 00:20:07 INFO - ##### 00:20:07 INFO - ##### Running download-and-extract step. 00:20:07 INFO - ##### 00:20:07 INFO - Running pre-action listener: _resource_record_pre_action 00:20:07 INFO - Running main action method: download_and_extract 00:20:07 INFO - mkdir: /builds/slave/test/build/tests 00:20: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')]} 00:20:07 INFO - https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:20:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:20:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:20:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:10 INFO - Downloaded 1361 bytes. 00:20:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:20:10 INFO - Using the following test package requirements: 00:20:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:20:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:20:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:20:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:20:10 INFO - u'jsshell-linux-x86_64.zip'], 00:20:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:20:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:20:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:20:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:20:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:20:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:20:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:20:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:20: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')]} 00:20:10 INFO - https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:20:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:20:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:20:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:11 INFO - Downloaded 22329056 bytes. 00:20:11 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'] 00:20:11 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 00:20:12 INFO - Return code: 0 00:20:12 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 00:20:12 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')]} 00:20:12 INFO - https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:20:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:20:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:20:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:13 INFO - Downloaded 22329056 bytes. 00:20:13 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'] 00:20:13 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 00:20:14 INFO - Return code: 0 00:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:14 INFO - https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:20:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:20:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:20:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:15 INFO - Downloaded 10840152 bytes. 00:20:15 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'] 00:20:15 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 00:20:15 INFO - Return code: 0 00:20: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')]} 00:20:16 INFO - https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:20:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:20:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:20:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7F3XS5TSnWXSGu8-kITXQ/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 00:20:18 INFO - Downloaded 54680069 bytes. 00:20:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:20:18 INFO - mkdir: /builds/slave/test/properties 00:20:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:20:18 INFO - Writing to file /builds/slave/test/properties/build_url 00:20:18 INFO - Contents: 00:20:18 INFO - build_url:https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:20:19 INFO - Running post-action listener: _resource_record_post_action 00:20:19 INFO - Running post-action listener: set_extra_try_arguments 00:20:19 INFO - ##### 00:20:19 INFO - ##### Finished download-and-extract step (success) 00:20:19 INFO - ##### 00:20:19 INFO - ##### 00:20:19 INFO - ##### Running populate-webroot step. 00:20:19 INFO - ##### 00:20:19 INFO - Running pre-action listener: _resource_record_pre_action 00:20:19 INFO - Running main action method: populate_webroot 00:20:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:20:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:20:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:20:19 INFO - '--tppagecycles', 00:20:19 INFO - '7'], 00:20:19 INFO - 'tests': ['tsvgm']}}, 00:20:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:20:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:20:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:20:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:20:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:19 INFO - 'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:20:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:20:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:19 INFO - 'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['damp', 'tps']}, 00:20:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:19 INFO - 'tests': ['damp', 'tps']}, 00:20:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['dromaeo_dom']}, 00:20:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:20:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['a11yr', 00:20:19 INFO - 'ts_paint', 00:20:19 INFO - 'tpaint', 00:20:19 INFO - 'sessionrestore', 00:20:19 INFO - 'sessionrestore_no_auto_restore', 00:20:19 INFO - 'tabpaint']}, 00:20:19 INFO - 'other-e10s': {'tests': ['a11yr', 00:20:19 INFO - 'ts_paint', 00:20:19 INFO - 'tpaint', 00:20:19 INFO - 'sessionrestore', 00:20:19 INFO - 'sessionrestore_no_auto_restore', 00:20:19 INFO - 'tabpaint']}, 00:20:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:20:19 INFO - 'ts_paint', 00:20:19 INFO - 'tpaint', 00:20:19 INFO - 'sessionrestore', 00:20:19 INFO - 'sessionrestore_no_auto_restore', 00:20:19 INFO - 'tabpaint']}, 00:20:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:20:19 INFO - 'ts_paint', 00:20:19 INFO - 'tpaint', 00:20:19 INFO - 'sessionrestore', 00:20:19 INFO - 'sessionrestore_no_auto_restore', 00:20:19 INFO - 'tabpaint']}, 00:20:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['a11yr', 00:20:19 INFO - 'ts_paint', 00:20:19 INFO - 'tpaint', 00:20:19 INFO - 'sessionrestore', 00:20:19 INFO - 'sessionrestore_no_auto_restore', 00:20:19 INFO - 'tabpaint']}, 00:20:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['a11yr', 00:20:19 INFO - 'ts_paint', 00:20:19 INFO - 'tpaint', 00:20:19 INFO - 'sessionrestore', 00:20:19 INFO - 'sessionrestore_no_auto_restore', 00:20:19 INFO - 'tabpaint']}, 00:20:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['tsvgx', 00:20:19 INFO - 'tsvgr_opacity', 00:20:19 INFO - 'tart', 00:20:19 INFO - 'tscrollx', 00:20:19 INFO - 'cart']}, 00:20:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:20:19 INFO - 'tsvgr_opacity', 00:20:19 INFO - 'tart', 00:20:19 INFO - 'tscrollx', 00:20:19 INFO - 'cart']}, 00:20:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:19 INFO - 'talos_options': ['--disable-e10s'], 00:20:19 INFO - 'tests': ['tp5o']}, 00:20:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:19 INFO - 'tests': ['tp5o']}, 00:20:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:19 INFO - 'talos_options': ['--disable-e10s', 00:20:19 INFO - '--xperf_path', 00:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:20:19 INFO - 'tests': ['tp5n']}, 00:20:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:19 INFO - 'talos_options': ['--xperf_path', 00:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:20:19 INFO - 'tests': ['tp5n']}}, 00:20:19 INFO - 'talos.zip': {'path': '', 00:20:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:20:19 INFO - Running post-action listener: _resource_record_post_action 00:20:19 INFO - ##### 00:20:19 INFO - ##### Finished populate-webroot step (success) 00:20:19 INFO - ##### 00:20:19 INFO - ##### 00:20:19 INFO - ##### Running create-virtualenv step. 00:20:19 INFO - ##### 00:20:19 INFO - Running pre-action listener: _resource_record_pre_action 00:20:19 INFO - Running main action method: create_virtualenv 00:20:19 INFO - Creating virtualenv /builds/slave/test/build/venv 00:20:19 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 00:20:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:20:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:20:19 INFO - Using real prefix '/usr' 00:20:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:20:19 INFO - Installing distribute.............................................................................................................................................................................................done. 00:20:21 INFO - Installing pip.................done. 00:20:21 INFO - Return code: 0 00:20:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:20:21 INFO - Using env: {'DISPLAY': ':0', 00:20:21 INFO - 'HOME': '/home/cltbld', 00:20:21 INFO - 'LANG': 'en_US.UTF-8', 00:20:21 INFO - 'LANGUAGE': 'en_US:en', 00:20:21 INFO - 'LOGNAME': 'cltbld', 00:20:21 INFO - 'MAIL': '/var/mail/cltbld', 00:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:21 INFO - 'MOZ_NO_REMOTE': '1', 00:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:21 INFO - 'NO_EM_RESTART': '1', 00:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:21 INFO - 'PWD': '/builds/slave/test', 00:20:21 INFO - 'SHELL': '/bin/bash', 00:20:21 INFO - 'SHLVL': '1', 00:20:21 INFO - 'TERM': 'linux', 00:20:21 INFO - 'TMOUT': '86400', 00:20:21 INFO - 'USER': 'cltbld', 00:20:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:21 INFO - '_': '/tools/buildbot/bin/python'} 00:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:21 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 00:20:21 INFO - Cleaning up... 00:20:21 INFO - Return code: 0 00:20:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:20:21 INFO - Using env: {'DISPLAY': ':0', 00:20:21 INFO - 'HOME': '/home/cltbld', 00:20:21 INFO - 'LANG': 'en_US.UTF-8', 00:20:21 INFO - 'LANGUAGE': 'en_US:en', 00:20:21 INFO - 'LOGNAME': 'cltbld', 00:20:21 INFO - 'MAIL': '/var/mail/cltbld', 00:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:21 INFO - 'MOZ_NO_REMOTE': '1', 00:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:21 INFO - 'NO_EM_RESTART': '1', 00:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:21 INFO - 'PWD': '/builds/slave/test', 00:20:21 INFO - 'SHELL': '/bin/bash', 00:20:21 INFO - 'SHLVL': '1', 00:20:21 INFO - 'TERM': 'linux', 00:20:21 INFO - 'TMOUT': '86400', 00:20:21 INFO - 'USER': 'cltbld', 00:20:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:21 INFO - '_': '/tools/buildbot/bin/python'} 00:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:22 INFO - Downloading/unpacking psutil>=0.7.1 00:20:22 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 00:20:22 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 00:20:22 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 00:20:22 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 00:20:22 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 00:20:22 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 00:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:20:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:20:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:20:24 INFO - Installing collected packages: psutil 00:20:24 INFO - Running setup.py install for psutil 00:20:24 INFO - building 'psutil._psutil_linux' extension 00:20:24 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 00:20:24 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 00:20:24 INFO - building 'psutil._psutil_posix' extension 00:20:24 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 00:20:24 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 00:20:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:20:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:20:24 INFO - Successfully installed psutil 00:20:24 INFO - Cleaning up... 00:20:24 INFO - Return code: 0 00:20:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:20: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')]} 00:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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')]} 00:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:20: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 mozsystemmonitor==0.0.0 00:20:24 INFO - Using env: {'DISPLAY': ':0', 00:20:24 INFO - 'HOME': '/home/cltbld', 00:20:24 INFO - 'LANG': 'en_US.UTF-8', 00:20:24 INFO - 'LANGUAGE': 'en_US:en', 00:20:24 INFO - 'LOGNAME': 'cltbld', 00:20:24 INFO - 'MAIL': '/var/mail/cltbld', 00:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:24 INFO - 'MOZ_NO_REMOTE': '1', 00:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:24 INFO - 'NO_EM_RESTART': '1', 00:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:24 INFO - 'PWD': '/builds/slave/test', 00:20:24 INFO - 'SHELL': '/bin/bash', 00:20:24 INFO - 'SHLVL': '1', 00:20:24 INFO - 'TERM': 'linux', 00:20:24 INFO - 'TMOUT': '86400', 00:20:24 INFO - 'USER': 'cltbld', 00:20:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:24 INFO - '_': '/tools/buildbot/bin/python'} 00:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:20: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 00:20: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 00:20: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 00:20: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 00:20: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 00:20: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 00:20:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:20:26 INFO - Installing collected packages: mozsystemmonitor 00:20:26 INFO - Running setup.py install for mozsystemmonitor 00:20:26 INFO - Successfully installed mozsystemmonitor 00:20:26 INFO - Cleaning up... 00:20:26 INFO - Return code: 0 00:20:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:20: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')]} 00:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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')]} 00:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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', '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 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:20: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 blobuploader==1.2.4 00:20:26 INFO - Using env: {'DISPLAY': ':0', 00:20:26 INFO - 'HOME': '/home/cltbld', 00:20:26 INFO - 'LANG': 'en_US.UTF-8', 00:20:26 INFO - 'LANGUAGE': 'en_US:en', 00:20:26 INFO - 'LOGNAME': 'cltbld', 00:20:26 INFO - 'MAIL': '/var/mail/cltbld', 00:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:26 INFO - 'MOZ_NO_REMOTE': '1', 00:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:26 INFO - 'NO_EM_RESTART': '1', 00:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:26 INFO - 'PWD': '/builds/slave/test', 00:20:26 INFO - 'SHELL': '/bin/bash', 00:20:26 INFO - 'SHLVL': '1', 00:20:26 INFO - 'TERM': 'linux', 00:20:26 INFO - 'TMOUT': '86400', 00:20:26 INFO - 'USER': 'cltbld', 00:20:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:26 INFO - '_': '/tools/buildbot/bin/python'} 00:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:27 INFO - Downloading/unpacking blobuploader==1.2.4 00:20:27 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 00:20:27 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 00:20:27 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 00:20:27 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 00:20:27 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 00:20:27 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 00:20:29 INFO - Downloading blobuploader-1.2.4.tar.gz 00:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:20:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:20: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 00:20: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 00:20: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 00:20: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 00:20: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 00:20: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 00:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:20:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:20: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 00:20: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 00:20: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 00:20: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 00:20: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 00:20: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 00:20:29 INFO - Downloading docopt-0.6.1.tar.gz 00:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:20:29 INFO - Installing collected packages: blobuploader, requests, docopt 00:20:29 INFO - Running setup.py install for blobuploader 00:20:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:20:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:20:29 INFO - Running setup.py install for requests 00:20:30 INFO - Running setup.py install for docopt 00:20:30 INFO - Successfully installed blobuploader requests docopt 00:20:30 INFO - Cleaning up... 00:20:30 INFO - Return code: 0 00:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:30 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 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20:30 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 00:20:30 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 00:20:30 INFO - Using env: {'DISPLAY': ':0', 00:20:30 INFO - 'HOME': '/home/cltbld', 00:20:30 INFO - 'LANG': 'en_US.UTF-8', 00:20:30 INFO - 'LANGUAGE': 'en_US:en', 00:20:30 INFO - 'LOGNAME': 'cltbld', 00:20:30 INFO - 'MAIL': '/var/mail/cltbld', 00:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:30 INFO - 'MOZ_NO_REMOTE': '1', 00:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:30 INFO - 'NO_EM_RESTART': '1', 00:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:30 INFO - 'PWD': '/builds/slave/test', 00:20:30 INFO - 'SHELL': '/bin/bash', 00:20:30 INFO - 'SHLVL': '1', 00:20:30 INFO - 'TERM': 'linux', 00:20:30 INFO - 'TMOUT': '86400', 00:20:30 INFO - 'USER': 'cltbld', 00:20:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:30 INFO - '_': '/tools/buildbot/bin/python'} 00:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:20:30 INFO - Running setup.py (path:/tmp/pip-udXNMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:20:30 INFO - Running setup.py (path:/tmp/pip-hKUcb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:20:30 INFO - Running setup.py (path:/tmp/pip-ESG562-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:20:30 INFO - Running setup.py (path:/tmp/pip-YgtV2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:20:30 INFO - Running setup.py (path:/tmp/pip-7qjHfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:20:31 INFO - Running setup.py (path:/tmp/pip-OgJYCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:20:31 INFO - Running setup.py (path:/tmp/pip-ySt7gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:20:31 INFO - Running setup.py (path:/tmp/pip-g0OATZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:20:31 INFO - Running setup.py (path:/tmp/pip-XlWmNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:20:31 INFO - Running setup.py (path:/tmp/pip-dZroMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:20:31 INFO - Running setup.py (path:/tmp/pip-OHM4Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:20:31 INFO - Running setup.py (path:/tmp/pip-26kuXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:20:31 INFO - Running setup.py (path:/tmp/pip-M35urn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:20:31 INFO - Running setup.py (path:/tmp/pip-4r4wRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:31 INFO - Running setup.py (path:/tmp/pip-Ubcr3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:20:31 INFO - Running setup.py (path:/tmp/pip-lmYpSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:20:31 INFO - Running setup.py (path:/tmp/pip-0Bk0Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:20:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:20:31 INFO - Running setup.py install for manifestparser 00:20:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:20:31 INFO - Running setup.py install for mozcrash 00:20:32 INFO - Running setup.py install for mozdebug 00:20:32 INFO - Running setup.py install for mozdevice 00:20:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Running setup.py install for mozfile 00:20:32 INFO - Running setup.py install for mozhttpd 00:20:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Running setup.py install for mozinfo 00:20:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Running setup.py install for mozInstall 00:20:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Running setup.py install for mozleak 00:20:32 INFO - Running setup.py install for mozlog 00:20:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:20:32 INFO - Running setup.py install for moznetwork 00:20:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Running setup.py install for mozprocess 00:20:33 INFO - Running setup.py install for mozprofile 00:20:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Running setup.py install for mozrunner 00:20:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Running setup.py install for mozscreenshot 00:20:33 INFO - Running setup.py install for moztest 00:20:33 INFO - Running setup.py install for mozversion 00:20:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:20:33 INFO - Cleaning up... 00:20:33 INFO - Return code: 0 00:20:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:33 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 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20:33 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 00:20:33 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 00:20:33 INFO - Using env: {'DISPLAY': ':0', 00:20:33 INFO - 'HOME': '/home/cltbld', 00:20:33 INFO - 'LANG': 'en_US.UTF-8', 00:20:33 INFO - 'LANGUAGE': 'en_US:en', 00:20:33 INFO - 'LOGNAME': 'cltbld', 00:20:33 INFO - 'MAIL': '/var/mail/cltbld', 00:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:33 INFO - 'MOZ_NO_REMOTE': '1', 00:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:33 INFO - 'NO_EM_RESTART': '1', 00:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:33 INFO - 'PWD': '/builds/slave/test', 00:20:33 INFO - 'SHELL': '/bin/bash', 00:20:33 INFO - 'SHLVL': '1', 00:20:33 INFO - 'TERM': 'linux', 00:20:33 INFO - 'TMOUT': '86400', 00:20:33 INFO - 'USER': 'cltbld', 00:20:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:33 INFO - '_': '/tools/buildbot/bin/python'} 00:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:20:33 INFO - Running setup.py (path:/tmp/pip-eYsKpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:20:33 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)) 00:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:20:33 INFO - Running setup.py (path:/tmp/pip-EPdAh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:20:34 INFO - Running setup.py (path:/tmp/pip-TXuel4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:20:34 INFO - Running setup.py (path:/tmp/pip-McP20O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:20:34 INFO - Running setup.py (path:/tmp/pip-GtJax0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:20:34 INFO - Running setup.py (path:/tmp/pip-jAw2hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:20:34 INFO - Running setup.py (path:/tmp/pip-kUxtsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:20:34 INFO - Running setup.py (path:/tmp/pip-i_g76x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:20:34 INFO - Running setup.py (path:/tmp/pip-5U2MTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:20:34 INFO - Running setup.py (path:/tmp/pip-_gnAkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:20:34 INFO - Running setup.py (path:/tmp/pip-qnlQ9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:20:34 INFO - Running setup.py (path:/tmp/pip-tMsPZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:20:34 INFO - Running setup.py (path:/tmp/pip-r5BWQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:20:34 INFO - Running setup.py (path:/tmp/pip-bq8A4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:34 INFO - Running setup.py (path:/tmp/pip-61OlL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:34 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)) 00:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:20:34 INFO - Running setup.py (path:/tmp/pip-VvRAy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:20:35 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)) 00:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:20:35 INFO - Running setup.py (path:/tmp/pip-NtNWV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:20:35 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)) 00:20:35 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)) 00:20:35 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)) 00:20:35 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)) 00:20:35 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)) 00:20:35 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)) 00:20:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:20:35 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 00:20:35 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 00:20:35 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 00:20:35 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 00:20:35 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 00:20:35 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 00:20:36 INFO - Downloading blessings-1.6.tar.gz 00:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:20:37 INFO - Installing collected packages: blessings 00:20:37 INFO - Running setup.py install for blessings 00:20:37 INFO - Successfully installed blessings 00:20:37 INFO - Cleaning up... 00:20:37 INFO - Return code: 0 00:20:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:20:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:20:37 INFO - Reading from file tmpfile_stdout 00:20:37 INFO - Current package versions: 00:20:37 INFO - argparse == 1.2.1 00:20:37 INFO - blessings == 1.6 00:20:37 INFO - blobuploader == 1.2.4 00:20:37 INFO - docopt == 0.6.1 00:20:37 INFO - manifestparser == 1.1 00:20:37 INFO - mozInstall == 1.12 00:20:37 INFO - mozcrash == 0.17 00:20:37 INFO - mozdebug == 0.1 00:20:37 INFO - mozdevice == 0.48 00:20:37 INFO - mozfile == 1.2 00:20:37 INFO - mozhttpd == 0.7 00:20:37 INFO - mozinfo == 0.9 00:20:37 INFO - mozleak == 0.1 00:20:37 INFO - mozlog == 3.1 00:20:37 INFO - moznetwork == 0.27 00:20:37 INFO - mozprocess == 0.22 00:20:37 INFO - mozprofile == 0.28 00:20:37 INFO - mozrunner == 6.11 00:20:37 INFO - mozscreenshot == 0.1 00:20:37 INFO - mozsystemmonitor == 0.0 00:20:37 INFO - moztest == 0.7 00:20:37 INFO - mozversion == 1.4 00:20:37 INFO - psutil == 3.1.1 00:20:37 INFO - requests == 1.2.3 00:20:37 INFO - wsgiref == 0.1.2 00:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20:37 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')]} 00:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:37 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')]} 00:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:37 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 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20:37 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 00:20:37 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 00:20:37 INFO - Using env: {'DISPLAY': ':0', 00:20:37 INFO - 'HOME': '/home/cltbld', 00:20:37 INFO - 'LANG': 'en_US.UTF-8', 00:20:37 INFO - 'LANGUAGE': 'en_US:en', 00:20:37 INFO - 'LOGNAME': 'cltbld', 00:20:37 INFO - 'MAIL': '/var/mail/cltbld', 00:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:37 INFO - 'MOZ_NO_REMOTE': '1', 00:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:37 INFO - 'NO_EM_RESTART': '1', 00:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:37 INFO - 'PWD': '/builds/slave/test', 00:20:37 INFO - 'SHELL': '/bin/bash', 00:20:37 INFO - 'SHLVL': '1', 00:20:37 INFO - 'TERM': 'linux', 00:20:37 INFO - 'TMOUT': '86400', 00:20:37 INFO - 'USER': 'cltbld', 00:20:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:37 INFO - '_': '/tools/buildbot/bin/python'} 00:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 INFO - Cleaning up... 00:20:37 INFO - Return code: 0 00:20:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:20:37 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')]} 00:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:37 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')]} 00:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:37 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 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20:37 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 00:20:37 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 00:20:37 INFO - Using env: {'DISPLAY': ':0', 00:20:37 INFO - 'HOME': '/home/cltbld', 00:20:37 INFO - 'LANG': 'en_US.UTF-8', 00:20:37 INFO - 'LANGUAGE': 'en_US:en', 00:20:37 INFO - 'LOGNAME': 'cltbld', 00:20:37 INFO - 'MAIL': '/var/mail/cltbld', 00:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:37 INFO - 'MOZ_NO_REMOTE': '1', 00:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:37 INFO - 'NO_EM_RESTART': '1', 00:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:37 INFO - 'PWD': '/builds/slave/test', 00:20:37 INFO - 'SHELL': '/bin/bash', 00:20:37 INFO - 'SHLVL': '1', 00:20:37 INFO - 'TERM': 'linux', 00:20:37 INFO - 'TMOUT': '86400', 00:20:37 INFO - 'USER': 'cltbld', 00:20:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:37 INFO - '_': '/tools/buildbot/bin/python'} 00:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:37 INFO - Downloading/unpacking jsonschema 00:20:37 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 00:20:37 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 00:20:37 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 00:20:37 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 00:20:37 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 00:20:37 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 00:20:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:20:39 INFO - Downloading/unpacking functools32 (from jsonschema) 00:20:39 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 00:20:39 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 00:20:39 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 00:20:39 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 00:20:39 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 00:20:39 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 00:20:39 INFO - Downloading functools32-3.2.3-2.tar.gz 00:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:20:40 INFO - warning: no files found matching '*.txt' 00:20:40 INFO - no previously-included directories found matching 'build' 00:20:40 INFO - no previously-included directories found matching 'dist' 00:20:40 INFO - no previously-included directories found matching '.git*' 00:20:40 INFO - Installing collected packages: jsonschema, functools32 00:20:40 INFO - Running setup.py install for functools32 00:20:40 INFO - warning: no files found matching '*.txt' 00:20:40 INFO - no previously-included directories found matching 'build' 00:20:40 INFO - no previously-included directories found matching 'dist' 00:20:40 INFO - no previously-included directories found matching '.git*' 00:20:40 INFO - Successfully installed jsonschema functools32 00:20:40 INFO - Cleaning up... 00:20:40 INFO - Return code: 0 00:20:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:20:40 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')]} 00:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:40 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')]} 00:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:40 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 0x7f2bda1e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, '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': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', '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 00:20:40 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 00:20:40 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 00:20:40 INFO - Using env: {'DISPLAY': ':0', 00:20:40 INFO - 'HOME': '/home/cltbld', 00:20:40 INFO - 'LANG': 'en_US.UTF-8', 00:20:40 INFO - 'LANGUAGE': 'en_US:en', 00:20:40 INFO - 'LOGNAME': 'cltbld', 00:20:40 INFO - 'MAIL': '/var/mail/cltbld', 00:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:40 INFO - 'MOZ_NO_REMOTE': '1', 00:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:40 INFO - 'NO_EM_RESTART': '1', 00:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:40 INFO - 'PWD': '/builds/slave/test', 00:20:40 INFO - 'SHELL': '/bin/bash', 00:20:40 INFO - 'SHLVL': '1', 00:20:40 INFO - 'TERM': 'linux', 00:20:40 INFO - 'TMOUT': '86400', 00:20:40 INFO - 'USER': 'cltbld', 00:20:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:40 INFO - '_': '/tools/buildbot/bin/python'} 00:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:40 INFO - Downloading/unpacking flake8 00:20:40 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 00:20:40 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 00:20:40 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 00:20:40 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 00:20:40 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 00:20:40 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 00:20:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:20:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:20:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 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 00:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:20:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:20:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:20:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:20:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:20:43 INFO - no previously-included directories found matching 'docs/_build' 00:20:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:20:43 INFO - Running setup.py install for pep8 00:20:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:20:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:20:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:20:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:20:43 INFO - no previously-included directories found matching 'docs/_build' 00:20:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:20:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:20:43 INFO - Cleaning up... 00:20:43 INFO - Return code: 0 00:20:43 INFO - Running post-action listener: _resource_record_post_action 00:20:43 INFO - Running post-action listener: _start_resource_monitoring 00:20:43 INFO - Starting resource monitoring. 00:20:43 INFO - ##### 00:20:43 INFO - ##### Finished create-virtualenv step (success) 00:20:43 INFO - ##### 00:20:43 INFO - ##### 00:20:43 INFO - ##### Running install step. 00:20:43 INFO - ##### 00:20:43 INFO - Running pre-action listener: _resource_record_pre_action 00:20:43 INFO - Running main action method: install 00:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:20:43 INFO - Reading from file tmpfile_stdout 00:20:43 INFO - Detecting whether we're running mozinstall >=1.0... 00:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:20:43 INFO - Reading from file tmpfile_stdout 00:20:43 INFO - Output received: 00:20:43 INFO - Usage: mozinstall [options] installer 00:20:43 INFO - Options: 00:20:43 INFO - -h, --help show this help message and exit 00:20:43 INFO - -d DEST, --destination=DEST 00:20:43 INFO - Directory to install application into. [default: 00:20:43 INFO - "/builds/slave/test"] 00:20:43 INFO - --app=APP Application being installed. [default: firefox] 00:20:43 INFO - mkdir: /builds/slave/test/build/application 00:20:43 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'] 00:20:43 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 00:20:59 INFO - Reading from file tmpfile_stdout 00:20:59 INFO - Output received: 00:20:59 INFO - /builds/slave/test/build/application/firefox/firefox 00:20:59 INFO - Running post-action listener: _resource_record_post_action 00:20:59 INFO - ##### 00:20:59 INFO - ##### Finished install step (success) 00:20:59 INFO - ##### 00:20:59 INFO - ##### 00:20:59 INFO - ##### Running run-tests step. 00:20:59 INFO - ##### 00:20:59 INFO - Running pre-action listener: _resource_record_pre_action 00:20:59 INFO - Running main action method: run_tests 00:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:20:59 INFO - Python 2.7.3 00:20:59 INFO - Return code: 0 00:20:59 INFO - grabbing minidump binary from tooltool 00:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:20:59 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 0x170e9c0>, '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 0x170f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:20:59 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 00:20:59 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 00:20:59 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 00:20:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:20:59 INFO - Return code: 0 00:20:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:20:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:20:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:20:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:20:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:21:00 INFO - Return code: 0 00:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 00:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 00:21:00 INFO - Using env: {'DISPLAY': ':0', 00:21:00 INFO - 'HOME': '/home/cltbld', 00:21:00 INFO - 'LANG': 'en_US.UTF-8', 00:21:00 INFO - 'LANGUAGE': 'en_US:en', 00:21:00 INFO - 'LOGNAME': 'cltbld', 00:21:00 INFO - 'MAIL': '/var/mail/cltbld', 00:21:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:21:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:00 INFO - 'MOZ_NO_REMOTE': '1', 00:21:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:00 INFO - 'NO_EM_RESTART': '1', 00:21:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:00 INFO - 'PWD': '/builds/slave/test', 00:21:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:21:00 INFO - 'SHELL': '/bin/bash', 00:21:00 INFO - 'SHLVL': '1', 00:21:00 INFO - 'TERM': 'linux', 00:21:00 INFO - 'TMOUT': '86400', 00:21:00 INFO - 'USER': 'cltbld', 00:21:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463035684.370670-2073163215', 00:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:00 INFO - '_': '/tools/buildbot/bin/python'} 00:21:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 00:21:00 INFO - mozversion application_buildid: 20160511234012 00:21:00 INFO - mozversion application_changeset: c3ff04109a8a6e439be36ae44133b2ba68fc79f6 00:21:00 INFO - mozversion application_display_name: Nightly 00:21:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:21:00 INFO - mozversion application_name: Firefox 00:21:00 INFO - mozversion application_remotingname: firefox 00:21:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:21:00 INFO - mozversion application_vendor: Mozilla 00:21:00 INFO - mozversion application_version: 49.0a1 00:21:00 INFO - mozversion platform_buildid: 20160511234012 00:21:00 INFO - mozversion platform_changeset: c3ff04109a8a6e439be36ae44133b2ba68fc79f6 00:21:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:21:00 INFO - mozversion platform_version: 49.0a1 00:21:00 INFO - using testdate: 1463037660 00:21:00 INFO - actual date: 1463037660 00:21:00 INFO - starting webserver on 'localhost:52742' 00:21:00 INFO - SUITE-START | Running 2 tests 00:21:00 INFO - TEST-START | dromaeo_css 00:21:00 INFO - operating with platform_type : linux_ 00:21:00 INFO - Initialising browser for dromaeo_css test... 00:21:00 INFO - TEST-INFO | started process 20899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphHFD0h/profile http://localhost:52742/getInfo.html) 00:21:04 INFO - PROCESS | 20899 | 00:21:04 INFO - PROCESS | 20899 | (process:20968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:21:05 INFO - PROCESS | 20899 | __metrics Screen width/height:1600/1200 00:21:05 INFO - PROCESS | 20899 | colorDepth:24 00:21:05 INFO - PROCESS | 20899 | Browser inner width/height: 1024/697 00:21:05 INFO - PROCESS | 20899 | __metrics 00:21:06 ERROR - PROCESS | 20899 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 00:21:07 INFO - TEST-INFO | 20899: exit 0 00:21:07 INFO - Browser initialized. 00:21:07 INFO - Running cycle 1/1 for dromaeo_css test... 00:21:07 INFO - TEST-INFO | started process 21019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphHFD0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:21:09 INFO - PROCESS | 21019 | 00:21:09 INFO - PROCESS | 21019 | (process:21078): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:21:19 INFO - PROCESS | 21019 | RSS: Main: 163913728 00:21:19 INFO - PROCESS | 21019 | 00:22:08 INFO - PROCESS | 21019 | 1463037728884 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] 00:24:20 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:52742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52742/tests/dromaeo/cssquery-ext.html) 00:24:21 INFO - PROCESS | 21019 | RSS: Main: 164020224 00:24:21 INFO - PROCESS | 21019 | 00:27:23 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:52742/tests/dromaeo/cssquery-ext.html (next: http://localhost:52742/tests/dromaeo/cssquery-jquery.html) 00:27:24 INFO - PROCESS | 21019 | RSS: Main: 165441536 00:27:24 INFO - PROCESS | 21019 | 00:30:26 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:52742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52742/tests/dromaeo/cssquery-mootools.html) 00:30:26 INFO - PROCESS | 21019 | RSS: Main: 164208640 00:30:26 INFO - PROCESS | 21019 | 00:33:28 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:52742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52742/tests/dromaeo/cssquery-prototype.html) 00:33:29 INFO - PROCESS | 21019 | RSS: Main: 165380096 00:33:29 INFO - PROCESS | 21019 | 00:36:32 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:52742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52742/tests/dromaeo/cssquery-yui.html) 00:36:32 INFO - PROCESS | 21019 | RSS: Main: 164233216 00:36:32 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | Cycle 1(1): loaded http://localhost:52742/tests/dromaeo/cssquery-yui.html (next: http://localhost:52742/tests/dromaeo/cssquery-dojo.html) 00:39:35 INFO - PROCESS | 21019 | RSS: Main: 165920768 00:39:35 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | __start_tp_report 00:39:35 INFO - PROCESS | 21019 | _x_x_mozilla_page_load 00:39:35 INFO - PROCESS | 21019 | _x_x_mozilla_page_load_details 00:39:35 INFO - PROCESS | 21019 | |i|pagename|runs| 00:39:35 INFO - PROCESS | 21019 | |0;dojo.html;2671.2520494261607;2710.593410988352;2729.522333591621;2730.3583657840404;2737.3567211705245;4697.741624210663;4763.928541071887;4811.326414302001;4918.36061312029;4985.651004429691;4694.920168361279;4772.689775164612;4792.472827988919;4877.439094504133;4914.11545921734;4390.078083602447;4473.82104715811;4516.683832131752;4532.7280363178315;4551.68138230324;648.8199177173517;4355.150745604608;4393.253146965024;4455.509893911667;4544.750038747868;4432.22436073689;4439.75581343026;4464.754438505881;4473.194824931511;4509.436320459942;4547.022390186093;4549.13566422382;4549.27211646135;4555.476120246148;4594.058218065288;4406.449193850769;4416.955830441687;4505.707129036635;4520.050789334244;4524.728516289033;4735.644826638016;4819.4939531349055;4826.589739872115;4827.951720482785;4878;5268.5521730652945;5297.549708274802;5303.23103150045;5308.628396012281;5358.839234822923;5149.382074151088;5163.845084647429;5169.922451163236;5239.187925871496;5283.022640811424;4936.136176169156;4959.504049595083;4963.156263435225;4967.925481117786;5010.949890501085;5415.702136382537;5421.83734487966;5424.566034717213;5436.565074794007;5475.014497390508;5053.898922021539;5091.956148989449;5108.080545501845;5128.666636668605;5217.034848552954;5212.713300768494;5252.29094072303;5260.579153667697;5263.894722105537;5267.894642107136;5197.97401013;5201.193814958688;5215.921761173586;5224.373075230997;5245.7114858683135;5032.370953630796;5090.312807770978;5121.8463446096675;5138.743062846917;5140.434552199255;4449.57729015743;4459.821607135743;4467.709598876063;4474.105178964221;4505.481869584974;3803.8098095095133;3907.4138879167785;3911.6283953024417;3922.9607703923166;3960.207958408272;4298.376735373354;4371.978140109279;4387.780610969438;4391.736495810262;4408.713433626804;5051.06555287273;5114.462981386975;5134;5135.6918584885025;5182.989317083133;4380.189664912002;4386.8025938832825;4390.253656878338;4401.449818772653;4430.667699922518;4557.043020965568;4611.608013318838;4615.469221039556;4622.9768851156205;4631.467381251199;4802.7838747255755;4838.709677419366;4857.732824694675;4858.58702010333;4888.5355891189565;5124.666896651705;5134.101532231919;5183.222516622537;5185.507376799198;5187.273781670645;4910.582600479;4934.259861020732;4943.30793688891;4951.331570238116;4998.875028124326;5157.226416037624;5158.561522270649;5165.767540460613;5176.145935920682;5219.2953951216095;5056.191009438619;5170.819021334235;5187.688738675692;5232.3459567554055;5240.816571419982;5093.4651861554;5106.846794596168;5114.053900028507;5121.948780512147;5142.434332223377;5078.162103252922;5083.2883396323805;5087.771050302671;5118.590512759045;5123.28274041627;4812.687175333592;4876.536729010738;4879.585235254901;4908.656394052525;5022.422421421437;4993.750312484434;5027.195648696191;5048.217526283432;5050.3182070420025;5068.062408454301;4918.1393256180745;4923.803047878188;4929.852104436729;4931.580815630568;4995.300657907968 00:39:35 INFO - PROCESS | 21019 | |1;ext.html;576.6482445708117;604.9969750151249;607.8541150123972;619.3589634728057;622.1103821535206;28707.138785836407;41507.377389339184;42274.57725422745;42375.78812105943;42447.57552424475;41624.791876040654;41881.16237675244;42028;42206.36690449638;42339;7942.4837385570045;8000.159983201767;8064.112947575762;8078.151794061627;8095.311898488636;7853.489523181003;7982.680692772282;7998.520088794662;8002.159773223815;8019.839603207962;8028.718994835182;8044.637991290377;8061.758147255592;8074.515529068245;8077.7576672699915;7962.92500512435;7974.0431148262;8000.479968802009;8002.0797608274925;8012.158723334053;7919.604019798987;7952.244536768998;7960.562169080698;7972.441929064968;7986.321162701177;39419.80290098531;39676.20647587061;39765;39801.40297895505;39808;3233.854476548561;3321.335732853439;3720.609336019706;3926.705497087701;3992.0818211811156;30265.394692106256;30554.694453055406;30744.2313942151;31055.689443105504;32018.519722204186;3154.5268209768487;3161.2254997525524;3187.3147273336112;3193.952090718641;3333.633300336961;237195;240273;240359;241362;241964;30717.846410767805;55937;56169.15746263809;56537.71731141318;56638;36183.20076391941;36261.81869090637;36295.27409451796;36481.087972800364;36509.08727281786;14735.115893046452;14884.70230595382;14934.551963441114;14993.775093373608;14994.925025374803;12322.630321090382;12324.630261092003;12484.375781210903;12485.875141248653;12496.25022498653;8369.246767790928;8416.326693864476;8452.070272270046;8469.153084691605;8506.36202284831;3246.204679853404;3253.674632536775;3255.869765209365;3258.5438038674606;3294.950575741366;906.8503696890072;962.6486332488731;996.8056229035413;1038.7039693687263;1077.0414331245197;29630;29684.257893552403;30193;30376.392472150874;30407.391852162833;986.0829428631298;1010.4897027001464;1086.315621158665;1093.136422226448;1159.310210424796;15172;15901.52295431139;16567.751483727752;16580.58548536296;17259.56851078708;369989;416012;422539;425613;643103;53092.46907530875;53673.1949020765;53937;54065.72967135139;54374.45625543773;1291.1865524719553;1304.7390521895848;1306.242379419953;1319.5711393797055;1327.2036777933356;28598.57102143428;29434;29863.357515336866;30205.69794302029;30575.2356191097;45703.542964569926;46029.53970460386;46397.30404043874;46427.30359044685;46468.30297545607;321121;321290;322006;322889;323196;27053.1884043479;27628.58557121685;27732.168034958984;27744.306392340353;27918.3020424491;43839.34240986324;44519;44703.10593788041;45298.32052519281;45376.77311613421;37017.44473832948;37700.62299376971;38133.61866381301;38527;39152.41271380874;37510.62489375071;37724.24551509009;38044.42933356057;38355.616443835206;38475.615243847205;37201.4419783698;38155.80922095483;38994;39178.4123238146;42383.24508906911;30761.538576921812;33042.504362435066;33281.16797079996;33471;33540.66459335375;25647.23058308254;25797.613035804854;25825.6126158104;26091.217263482125;26260.868695656398 00:39:35 INFO - PROCESS | 21019 | |2;jquery.html;389.77393111995036;390.8299889548045;390.9237698648763;398.6651212981095;406.6238729175512;16033.67932641348;16834.494965151065;17065.48803535893;17369.478915632535;17370.305187792474;13455.125416847923;16321.10233937133;16466.506004819843;16999.810013299073;17116.058616776103;4972.32873562069;5128.666636668623;5134.922976155361;5159.819406320761;5178.171492561191;5053.9241911371355;5055.570276526481;5081.441041485434;5110.080185566597;5113.258577506259;5094.898102037957;5145.511176438233;5172.948270517284;5174.2238664200295;5183.455737147583;4976.104301225778;5108.795648174068;5152.381714194302;5154.149565321736;5189.636725429222;4624.306354046887;4652.023075154221;4653.88365290867;4671.743054132022;4675.672702910798;20068.197272109097;20330.288439904532;20423.2851850186;21004.894975525178;21059.473513162142;1779.9021053842034;2023.9392818215476;2025.2202901882733;2120.9151633934625;2293.6100862853355;9269.629214831399;9581;9690.41857488546;9761.951190244003;9781.853272200922;1768.823117688221;1773.9645207095787;1781.8129096444945;1866.1975350599237;1893.0534732633682;61933.07100393543;65867.67066164638;67806;68847.65576172137;70118;9918.553665084944;10155.136813370946;10307.536160872778;10485.633002844865;10540.472976351151;14653.780193297109;14691.338889749986;14710.264486775619;14804.629884252765;14835.258237088103;6571.769988050395;7103.751368702071;7425.628718564159;7587;7792.259735325135;6751.932480675228;6837.931620683829;7292.671829767673;7297.087864016998;7459.552426854406;4424.026714122888;4455.2648812946145;4458.197524445631;4504.707194032378;4580.473245576802;1809.6652119357962;1848;1867.915943782533;1879.2952642758964;1900.1259420666647;870.9303255739526;889.1686273334324;898.2842770308679;917.5870858113875;937.4281688170211;16316.836831631532;17471.126443677764;18001.909990449964;18455.16951737175;18698.923498057844;877.0790669796688;899.4423457456419;923.1968187676764;966.0918736387773;975.8828940527183;9789.51052447389;9820.950895245478;9894.950525247328;9901.702948911545;9999.600015999278;302062;305295;416393;431472;435048;82653.58673206596;85108.57445712856;87431;88669;89066.10933890578;943.9386439881386;971.5919313888184;980.4411485453365;985.7486340983004;988.8467287570438;15781;15811.288492017657;15816.97189682667;16035.518934431986;16132;35553.82223088868;35624.82187589149;35945.82027089952;36249.637503624625;36601.45097823482;48609;50952;51416;52641.7367913158;52864.94270114653;7684.193159718373;7970.601469926364;8005.59972001386;8010.8397832041865;8103.554304513073;8945.23965462943;11365.147613928822;11962.222455540363;11972.042236621224;12169.148159628741;10363.689089327332;10502.474876256309;10579.8942010582;10664.573417063231;10664.57341706354;10158.034986676254;10279.743006424898;10304.381737095799;10342.5345859438;10438.739031523968;10355.689329320132;10410.947945260225;10465.895341046493;10703.678889633324;10788.298760580537;7522.511036782592;7852.921470785219;8004.199580042182;8125.593720314079;8176.100628930694;9771.657991970531;10350.792984140426;10520.316179448617;10900.890991089987;11225.382603956861 00:39:35 INFO - PROCESS | 21019 | |3;mootools.html;1486.4871619291343;1503.0305452982827;1701.5235733994477;1834.486343823729;1841.6739947237984;6826.146731658543;7609.581473018989;7622.504537205078;8120.837583248332;8135.91864081359;7731.420143489247;7854.175311592287;8013.519188848673;8030.95984520078;8061.717839875606;2216.745074316454;2251.324602619216;2256.9322920312416;2259.5142044460435;2269.024319542596;2207.9779202207933;2212.7787221277904;2269.4553307206315;2270.2281224383705;2285.02886273334;2249.718785151856;2263.1286954522543;2265.5808675395024;2267.501149747053;2289.7366802817637;2135.316698656423;2147.8389120815923;2148.0655914677163;2150.118451434912;2157.4282815054025;2136.9465763355884;2142.271627646592;2143.4641339665086;2155.7844215578475;2159.136345461812;7945.205479452066;7999.640016199285;8010.038795344596;8013.0384353877325;8015.318697910685;4867.3915760529935;4967.528084831935;4971.45314015458;4979.278004689336;4997.775100120503;2887.148291254064;3087.289923317627;3096.0711786464194;3098.380323935222;3098.8915387961315;928.373347990104;932.1983094538691;961.927855410847;968.1867231525553;990.4651488196365;10884.510197041152;11138.27601205919;11196.944015279953;11224.382658953755;11283.66149015531;4495.617872480811;4577.954220457819;4582.106489234568;4629.745364005012;4661.766911654404;9604.135627793532;9621.27840411972;9625.951870240604;9631.855522167172;9632.95183524078;4995.500449954975;5018.071656743514;5019.372578427697;5022.422421421583;5026.79892804291;3802.239552089593;4246.808893599796;4361.1495758327455;4372.060007098489;4551.271796512542;3802.7147963902817;3861.652451279342;3933.272344616255;3957.703172262092;4135.58644135584;1264.8861602455822;1303.7848754955517;1304.5108084468325;1307.8888294494884;1316.7037416581193;715.7244460882494;824.4270232188692;885.968991085309;905.0813424374265;908.5411867007251;5492.642978206404;5745.396733342939;5782.739776709974;5784.016717158009;5975.880482390327;952.2429668413628;990.3315262198131;1031.3966329697212;1031.5403703759246;1044.6657069737762;3724.3296206682517;3842.4620553122586;3846.615338466131;3854.4989151410136;3858.9421158682644;9702.611895524242;10037.849432258521;10066.396016239049;10177.592896284214;10206.540705668114;9962.103410693073;10035.949820250851;10061.597536098474;10128.797424051478;10135.341202821794;6867.622280774605;7199.704053270357;7268.890966635505;7423.62881855905;7663.19536448676;5586.424837873844;5703.372629010889;5712.171735098304;5910.172575839472;5922.644641321534;8731.956340218258;8805.867911981453;9351;9460.148586627236;9492.667756628485;9004.234640055669;9264.768380790534;9328.766780830261;9373.859392108987;9481.905180948102;5995.400459953969;6640.402363787282;6796.864062718817;6875.5530890491955;6896.27589103137;7735.265149810759;7838.216178382344;7841.372690184658;7880.05439347282;7892.763217103496;6738.393544581011;7050.647467626701;7078.256783037913;7117.572945623279;7139.357457828821;6948.583085014915;6975.860482790417;6984.476164287597;7105.076340075964;7136.607486588287;6400.839979000562;6413.454856337264;6427.196600424947;6482.773102941374;6558.213014438298;4931.432885218246;4996.850094497171;5010.198368261061;5041.873953151201;5045.646804723634;4741.288806679026;4886.804527818847;4911.877203069952;4914.877128071684;4917.459079501181 00:39:35 INFO - PROCESS | 21019 | |4;prototype.html;283.7262042129346;297.8213072156705;299.95166891713467;313.6126883299126;316.5062502496106;4846.515348465152;4890.8506500972335;5098.26075219093;5107.310513080733;5144.485551444858;4989.900201995958;4991;5017.122003649356;5018.146915024446;5021.899562008758;3936.547297060846;3945.151792364641;3950.1112249743865;3966.424868394074;3984.681225501967;3899.493065901429;3971.384435412516;3990.7805070721097;3993.640572348488;4001.539822920358;3921.2353591049755;3923.1761330120707;3949.1706741584157;3949.940750888739;3950.1112249743865;3919.412088186752;3923.0388554804113;3984.163325701606;4000.139969906455;4028.6575641070544;3539.256756081226;3541.2917416516543;3567.571891373052;3572.928541429183;3580.785152890835;4532.4787649420405;4749.952500474986;4795.184818580849;4860.708357498526;4878;4378.190034843564;4384.539623339535;4399.142167277382;4409.691321607489;4411.250087485135;5227.47725227478;5245.344331958505;5249.42256351801;5260.316158899319;5262.842114736564;3470.548828652259;3682;3691.7231207659265;3708.2398108387715;3711.777293362407;5438.510534051954;5440.755166017539;5440.863978400532;5444.183372494118;5467.261919640838;3748.1379282765115;3784.905377365588;3787;3787.9431808522895;3814.561325447609;3839.5584507781964;3840.519935008124;3852.3643598805884;3852.3836186210633;3855.5566109897723;4153.210889930903;4342.609165175149;4353.6081752641785;4382.649388048949;4388.824447022083;5190.455002224788;5218.791248350023;5229.50319719626;5232.816851410183;5238.842834714965;1244.539520377448;1297.4161627267579;1330.5742162508097;1331.760283149023;1334.8531661517225;830.2735106781566;836.7991681996277;837.4347315561971;849.7763220961796;864.3733293362262;4059.7564146151326;4070.738071197938;4082.1631565528996;4088;4100.34394496879;4703.811847526061;4711.3639658646325;4729.408823897013;4755.311864288197;4821.349117869043;4075.9592404076175;4091.365838295069;4103.733257338264;4110.445089912883;4140.60664236897;2549.7251374312846;2687.2475706802124;2899.826010439338;2909.912702618925;2919.664238612544;4964.60283177345;5042.294078828967;5116.590672746246;5132.923006154911;5133.614978876524;5355.250264962909;5556.361018482926;5568.192612071308;5571.164325351148;5575.972120139373;5044.344235249394;5121.359830021247;5127.717975511308;5136.356365962931;5138.537531622097;5362.570994320367;5374.892502150014;5401.621886468067;5412.566994640498;5419.83740487786;5056.367954005749;5235.188545775411;5276.419593844751;5322.962022405593;5342.545883599938;5060.3927528696795;5083.822066227664;5096.51583099605;5110.616703747308;5121.692698438105;3761.6802571781705;3771.396576547849;3789.9621003789607;3798.468214449924;3799.829007694605;5238.5023422774775;5360.65155764874;5396.271503347155;5418.512333889968;5423.29497165366;5226.947730522798;5259.60552958522;5279.155335146358;5280.867978300574;5295.920561191509;5206.479352064764;5214.478552144755;5223.869403264949;5250.369955605352;5281.815136470205;4937.654364194472;5010.398752149766;5051.30781188306;5103.928175083274;5144.356955380577;5226.2421948816445;5249.160134378481;5271.156614941591;5274.498922602346;5276.762545685377;5088.135017047037;5112.642115052059;5121.897562048813;5122.820701275437;5134.178531434953 00:39:35 INFO - PROCESS | 21019 | |5;yui.html;767.1254769562697;769.530586342331;773.3001633521664;793.9841203175934;831.7421599304213;13191.604251872448;13372.462166850828;13426;13479;13481.528146514875;14501.854981450182;14502.854971450282;14513.20177390243;14534.709305813878;14538.418463261483;683.781190019194;869.1438932651333;873.9737807865743;874.0472884555833;875.9737207883774;864.8054187807725;887.6050157679836;888.35594194209;888.9155530224618;892.0677891603258;916.4959272400187;918.8483900156466;924.5377311344328;927.4759760735196;928.8095940332249;915.8763566918448;916.3906002508324;917.9816403671956;919.1773362840287;920.0385597051097;673.3569441183657;675.9898601520981;677.4478799778165;679.2019377231783;679.341039191983;12295.200811947196;12441.191322564004;12452.564160254347;12500.49998000079;12518.687032824162;12174.695632609168;12714.110012299143;12733.172343797716;12799.552015679406;12908.440479576173;9547.856782148274;9763.90236097644;9783.36408133469;9868.45723485208;10120.544575494047;3258.934821303584;3316.6185888622636;3317.1209629448217;3317.170707323169;3331.816750078745;46737.29894051592;47059.529404705856;47418.76290618559;47772.28341574879;47821.76089119532;10053.346532475365;10056.446895420822;10194.592216311265;10203.795924081476;10361.585536578603;16822.495325140266;16887.91556042212;16891.324347026228;17409.04250266222;17492.38776642837;7020.543664661883;7124.394426473704;7153.928460715326;7321.78034658961;7382.889256661047;3814.9809250953567;3959;4010.5588385277597;4011.8796436106963;4019.7588144710826;2919.459899918522;3024.4404785114384;3034.787564870482;3043.9847800760854;3048.8475576221545;537.6424677589359;539.051269765216;548.358420647843;550.8540236837241;558.7541481748099;599.3856297295307;616.9691515424211;626.2266101364811;626.9937300627026;628.5129025005566;7309.89035164473;7358.926410735931;7535.1334596521;7580.696772129163;7848;563.132775525694;570.8715539003691;592.5052581094748;618.3538202578317;618.8267285160163;3407.1993081625797;3686.612905644922;3694.3350196964802;3695.8521659133335;3830.636089571542;45660.77169614197;45952;51327;52152.739236303576;52902.73548632232;45590.31614525785;46320;46452;46993.53006469891;47074;43663.345049824275;43863.78068109703;43907;44030;44613.33080003803;8054.758357249292;8064.324474194917;8097.676092956216;8286.295664868554;8464.068952415106;29227.85386073056;29301.85349073241;30041.5493767598;30079.398412032075;30211.546826797177;35288.64711352854;37180.81409593043;37263.25473490461;37630.247395052495;38387.80806095952;10813.243072984815;11069.889301106887;11103.944480277547;11114.333140011626;11163.218574699693;11941.76116477683;12201.389930503618;12206.87793122093;12334.136610437543;12721.872781272068;10616.469176541297;10616.52225649863;10752.623658171926;11108.777824443627;11137.610183643857;10347.844782328422;10647.148228141885;10656.307340022873;10896.836547451636;10925.344479331265;10562.89437105619;10726.088282496075;10863.348199108079;11139.443027848412;11213.887861121284;9034.728958131267;9722.173615242784;9724.854127187957;10025.749356266151;10097;9086.909130908607;9185.724428267162;9185.954070229605;9322;9359.679690074197 00:39:35 INFO - PROCESS | 21019 | __end_tp_report 00:39:35 INFO - PROCESS | 21019 | __start_cc_report 00:39:35 INFO - PROCESS | 21019 | _x_x_mozilla_cycle_collect,372 00:39:35 INFO - PROCESS | 21019 | __end_cc_report 00:39:35 INFO - PROCESS | 21019 | __startTimestamp1463038775824__endTimestamp 00:39:35 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | ------- Summary: start ------- 00:39:35 INFO - PROCESS | 21019 | Number of tests: 6 00:39:35 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | [#0] dojo.html Cycles:165 Average:4779.72 Median:4934.26 stddev:601.21 (12.2%) stddev-sans-first:579.86 00:39:35 INFO - PROCESS | 21019 | Values: 2671.3 2710.6 2729.5 2730.4 2737.4 4697.7 4763.9 4811.3 4918.4 4985.7 4694.9 4772.7 4792.5 4877.4 4914.1 4390.1 4473.8 4516.7 4532.7 4551.7 648.8 4355.2 4393.3 4455.5 4544.8 4432.2 4439.8 4464.8 4473.2 4509.4 4547.0 4549.1 4549.3 4555.5 4594.1 4406.4 4417.0 4505.7 4520.1 4524.7 4735.6 4819.5 4826.6 4828.0 4878.0 5268.6 5297.5 5303.2 5308.6 5358.8 5149.4 5163.8 5169.9 5239.2 5283.0 4936.1 4959.5 4963.2 4967.9 5010.9 5415.7 5421.8 5424.6 5436.6 5475.0 5053.9 5092.0 5108.1 5128.7 5217.0 5212.7 5252.3 5260.6 5263.9 5267.9 5198.0 5201.2 5215.9 5224.4 5245.7 5032.4 5090.3 5121.8 5138.7 5140.4 4449.6 4459.8 4467.7 4474.1 4505.5 3803.8 3907.4 3911.6 3923.0 3960.2 4298.4 4372.0 4387.8 4391.7 4408.7 5051.1 5114.5 5134.0 5135.7 5183.0 4380.2 4386.8 4390.3 4401.4 4430.7 4557.0 4611.6 4615.5 4623.0 4631.5 4802.8 4838.7 4857.7 4858.6 4888.5 5124.7 5134.1 5183.2 5185.5 5187.3 4910.6 4934.3 4943.3 4951.3 4998.9 5157.2 5158.6 5165.8 5176.1 5219.3 5056.2 5170.8 5187.7 5232.3 5240.8 5093.5 5106.8 5114.1 5121.9 5142.4 5078.2 5083.3 5087.8 5118.6 5123.3 4812.7 4876.5 4879.6 4908.7 5022.4 4993.8 5027.2 5048.2 5050.3 5068.1 4918.1 4923.8 4929.9 4931.6 4995.3 00:39:35 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | [#1] ext.html Cycles:180 Average:49162.31 Median:37712.43 stddev:94229.59 (249.9%) stddev-sans-first:94423.32 00:39:35 INFO - PROCESS | 21019 | Values: 576.6 605.0 607.9 619.4 622.1 28707.1 41507.4 42274.6 42375.8 42447.6 41624.8 41881.2 42028.0 42206.4 42339.0 7942.5 8000.2 8064.1 8078.2 8095.3 7853.5 7982.7 7998.5 8002.2 8019.8 8028.7 8044.6 8061.8 8074.5 8077.8 7962.9 7974.0 8000.5 8002.1 8012.2 7919.6 7952.2 7960.6 7972.4 7986.3 39419.8 39676.2 39765.0 39801.4 39808.0 3233.9 3321.3 3720.6 3926.7 3992.1 30265.4 30554.7 30744.2 31055.7 32018.5 3154.5 3161.2 3187.3 3194.0 3333.6 237195.0 240273.0 240359.0 241362.0 241964.0 30717.8 55937.0 56169.2 56537.7 56638.0 36183.2 36261.8 36295.3 36481.1 36509.1 14735.1 14884.7 14934.6 14993.8 14994.9 12322.6 12324.6 12484.4 12485.9 12496.3 8369.2 8416.3 8452.1 8469.2 8506.4 3246.2 3253.7 3255.9 3258.5 3295.0 906.9 962.6 996.8 1038.7 1077.0 29630.0 29684.3 30193.0 30376.4 30407.4 986.1 1010.5 1086.3 1093.1 1159.3 15172.0 15901.5 16567.8 16580.6 17259.6 369989.0 416012.0 422539.0 425613.0 643103.0 53092.5 53673.2 53937.0 54065.7 54374.5 1291.2 1304.7 1306.2 1319.6 1327.2 28598.6 29434.0 29863.4 30205.7 30575.2 45703.5 46029.5 46397.3 46427.3 46468.3 321121.0 321290.0 322006.0 322889.0 323196.0 27053.2 27628.6 27732.2 27744.3 27918.3 43839.3 44519.0 44703.1 45298.3 45376.8 37017.4 37700.6 38133.6 38527.0 39152.4 37510.6 37724.2 38044.4 38355.6 38475.6 37201.4 38155.8 38994.0 39178.4 42383.2 30761.5 33042.5 33281.2 33471.0 33540.7 25647.2 25797.6 25825.6 26091.2 26260.9 00:39:35 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | [#2] jquery.html Cycles:180 Average:24242.89 Median:4542.59 stddev:63516.06 (1398.2%) stddev-sans-first:63668.99 00:39:35 INFO - PROCESS | 21019 | Values: 389.8 390.8 390.9 398.7 406.6 16033.7 16834.5 17065.5 17369.5 17370.3 13455.1 16321.1 16466.5 16999.8 17116.1 4972.3 5128.7 5134.9 5159.8 5178.2 5053.9 5055.6 5081.4 5110.1 5113.3 5094.9 5145.5 5172.9 5174.2 5183.5 4976.1 5108.8 5152.4 5154.1 5189.6 4624.3 4652.0 4653.9 4671.7 4675.7 20068.2 20330.3 20423.3 21004.9 21059.5 1779.9 2023.9 2025.2 2120.9 2293.6 9269.6 9581.0 9690.4 9762.0 9781.9 1768.8 1774.0 1781.8 1866.2 1893.1 61933.1 65867.7 67806.0 68847.7 70118.0 9918.6 10155.1 10307.5 10485.6 10540.5 14653.8 14691.3 14710.3 14804.6 14835.3 6571.8 7103.8 7425.6 7587.0 7792.3 6751.9 6837.9 7292.7 7297.1 7459.6 4424.0 4455.3 4458.2 4504.7 4580.5 1809.7 1848.0 1867.9 1879.3 1900.1 870.9 889.2 898.3 917.6 937.4 16316.8 17471.1 18001.9 18455.2 18698.9 877.1 899.4 923.2 966.1 975.9 9789.5 9821.0 9895.0 9901.7 9999.6 302062.0 305295.0 416393.0 431472.0 435048.0 82653.6 85108.6 87431.0 88669.0 89066.1 943.9 971.6 980.4 985.7 988.8 15781.0 15811.3 15817.0 16035.5 16132.0 35553.8 35624.8 35945.8 36249.6 36601.5 48609.0 50952.0 51416.0 52641.7 52864.9 7684.2 7970.6 8005.6 8010.8 8103.6 8945.2 11365.1 11962.2 11972.0 12169.1 10363.7 10502.5 10579.9 10664.6 10664.6 10158.0 10279.7 10304.4 10342.5 10438.7 10355.7 10410.9 10465.9 10703.7 10788.3 7522.5 7852.9 8004.2 8125.6 8176.1 9771.7 10350.8 10520.3 10900.9 11225.4 00:39:35 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | [#3] mootools.html Cycles:180 Average:5363.94 Median:5018.72 stddev:2963.20 (59.0%) stddev-sans-first:2957.18 00:39:35 INFO - PROCESS | 21019 | Values: 1486.5 1503.0 1701.5 1834.5 1841.7 6826.1 7609.6 7622.5 8120.8 8135.9 7731.4 7854.2 8013.5 8031.0 8061.7 2216.7 2251.3 2256.9 2259.5 2269.0 2208.0 2212.8 2269.5 2270.2 2285.0 2249.7 2263.1 2265.6 2267.5 2289.7 2135.3 2147.8 2148.1 2150.1 2157.4 2136.9 2142.3 2143.5 2155.8 2159.1 7945.2 7999.6 8010.0 8013.0 8015.3 4867.4 4967.5 4971.5 4979.3 4997.8 2887.1 3087.3 3096.1 3098.4 3098.9 928.4 932.2 961.9 968.2 990.5 10884.5 11138.3 11196.9 11224.4 11283.7 4495.6 4578.0 4582.1 4629.7 4661.8 9604.1 9621.3 9626.0 9631.9 9633.0 4995.5 5018.1 5019.4 5022.4 5026.8 3802.2 4246.8 4361.1 4372.1 4551.3 3802.7 3861.7 3933.3 3957.7 4135.6 1264.9 1303.8 1304.5 1307.9 1316.7 715.7 824.4 886.0 905.1 908.5 5492.6 5745.4 5782.7 5784.0 5975.9 952.2 990.3 1031.4 1031.5 1044.7 3724.3 3842.5 3846.6 3854.5 3858.9 9702.6 10037.8 10066.4 10177.6 10206.5 9962.1 10035.9 10061.6 10128.8 10135.3 6867.6 7199.7 7268.9 7423.6 7663.2 5586.4 5703.4 5712.2 5910.2 5922.6 8732.0 8805.9 9351.0 9460.1 9492.7 9004.2 9264.8 9328.8 9373.9 9481.9 5995.4 6640.4 6796.9 6875.6 6896.3 7735.3 7838.2 7841.4 7880.1 7892.8 6738.4 7050.6 7078.3 7117.6 7139.4 6948.6 6975.9 6984.5 7105.1 7136.6 6400.8 6413.5 6427.2 6482.8 6558.2 4931.4 4996.9 5010.2 5041.9 5045.6 4741.3 4886.8 4911.9 4914.9 4917.5 00:39:35 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | [#4] prototype.html Cycles:180 Average:4300.54 Median:4884.43 stddev:1257.55 (25.7%) stddev-sans-first:1224.40 00:39:35 INFO - PROCESS | 21019 | Values: 283.7 297.8 300.0 313.6 316.5 4846.5 4890.9 5098.3 5107.3 5144.5 4989.9 4991.0 5017.1 5018.1 5021.9 3936.5 3945.2 3950.1 3966.4 3984.7 3899.5 3971.4 3990.8 3993.6 4001.5 3921.2 3923.2 3949.2 3949.9 3950.1 3919.4 3923.0 3984.2 4000.1 4028.7 3539.3 3541.3 3567.6 3572.9 3580.8 4532.5 4750.0 4795.2 4860.7 4878.0 4378.2 4384.5 4399.1 4409.7 4411.3 5227.5 5245.3 5249.4 5260.3 5262.8 3470.5 3682.0 3691.7 3708.2 3711.8 5438.5 5440.8 5440.9 5444.2 5467.3 3748.1 3784.9 3787.0 3787.9 3814.6 3839.6 3840.5 3852.4 3852.4 3855.6 4153.2 4342.6 4353.6 4382.6 4388.8 5190.5 5218.8 5229.5 5232.8 5238.8 1244.5 1297.4 1330.6 1331.8 1334.9 830.3 836.8 837.4 849.8 864.4 4059.8 4070.7 4082.2 4088.0 4100.3 4703.8 4711.4 4729.4 4755.3 4821.3 4076.0 4091.4 4103.7 4110.4 4140.6 2549.7 2687.2 2899.8 2909.9 2919.7 4964.6 5042.3 5116.6 5132.9 5133.6 5355.3 5556.4 5568.2 5571.2 5576.0 5044.3 5121.4 5127.7 5136.4 5138.5 5362.6 5374.9 5401.6 5412.6 5419.8 5056.4 5235.2 5276.4 5323.0 5342.5 5060.4 5083.8 5096.5 5110.6 5121.7 3761.7 3771.4 3790.0 3798.5 3799.8 5238.5 5360.7 5396.3 5418.5 5423.3 5226.9 5259.6 5279.2 5280.9 5295.9 5206.5 5214.5 5223.9 5250.4 5281.8 4937.7 5010.4 5051.3 5103.9 5144.4 5226.2 5249.2 5271.2 5274.5 5276.8 5088.1 5112.6 5121.9 5122.8 5134.2 00:39:35 INFO - PROCESS | 21019 | 00:39:35 INFO - PROCESS | 21019 | [#5] yui.html Cycles:180 Average:12857.54 Median:43968.50 stddev:14338.49 (32.6%) stddev-sans-first:14349.96 00:39:35 INFO - PROCESS | 21019 | Values: 767.1 769.5 773.3 794.0 831.7 13191.6 13372.5 13426.0 13479.0 13481.5 14501.9 14502.9 14513.2 14534.7 14538.4 683.8 869.1 874.0 874.0 876.0 864.8 887.6 888.4 888.9 892.1 916.5 918.8 924.5 927.5 928.8 915.9 916.4 918.0 919.2 920.0 673.4 676.0 677.4 679.2 679.3 12295.2 12441.2 12452.6 12500.5 12518.7 12174.7 12714.1 12733.2 12799.6 12908.4 9547.9 9763.9 9783.4 9868.5 10120.5 3258.9 3316.6 3317.1 3317.2 3331.8 46737.3 47059.5 47418.8 47772.3 47821.8 10053.3 10056.4 10194.6 10203.8 10361.6 16822.5 16887.9 16891.3 17409.0 17492.4 7020.5 7124.4 7153.9 7321.8 7382.9 3815.0 3959.0 4010.6 4011.9 4019.8 2919.5 3024.4 3034.8 3044.0 3048.8 537.6 539.1 548.4 550.9 558.8 599.4 617.0 626.2 627.0 628.5 7309.9 7358.9 7535.1 7580.7 7848.0 563.1 570.9 592.5 618.4 618.8 3407.2 3686.6 3694.3 3695.9 3830.6 45660.8 45952.0 51327.0 52152.7 52902.7 45590.3 46320.0 46452.0 46993.5 47074.0 43663.3 43863.8 43907.0 44030.0 44613.3 8054.8 8064.3 8097.7 8286.3 8464.1 29227.9 29301.9 30041.5 30079.4 30211.5 35288.6 37180.8 37263.3 37630.2 38387.8 10813.2 11069.9 11103.9 11114.3 11163.2 11941.8 12201.4 12206.9 12334.1 12721.9 10616.5 10616.5 10752.6 11108.8 11137.6 10347.8 10647.1 10656.3 10896.8 10925.3 10562.9 10726.1 10863.3 11139.4 11213.9 9034.7 9722.2 9724.9 10025.7 10097.0 9086.9 9185.7 9186.0 9322.0 9359.7 00:39:35 INFO - PROCESS | 21019 | -------- Summary: end -------- 00:39:35 INFO - PROCESS | 21019 | 00:39:36 INFO - TEST-INFO | 21019: exit 0 00:39:36 INFO - TEST-OK | dromaeo_css | took 1115962ms 00:39:36 INFO - TEST-START | kraken 00:39:36 INFO - operating with platform_type : linux_ 00:39:36 INFO - Initialising browser for kraken test... 00:39:36 INFO - TEST-INFO | started process 21256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXDB47/profile http://localhost:52742/getInfo.html) 00:39:40 INFO - PROCESS | 21256 | 00:39:40 INFO - PROCESS | 21256 | (process:21322): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:39:41 INFO - PROCESS | 21256 | __metrics Screen width/height:1600/1200 00:39:41 INFO - PROCESS | 21256 | colorDepth:24 00:39:41 INFO - PROCESS | 21256 | Browser inner width/height: 1024/697 00:39:41 INFO - PROCESS | 21256 | __metrics 00:39:42 ERROR - PROCESS | 21256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 00:39:43 INFO - TEST-INFO | 21256: exit 0 00:39:43 INFO - Browser initialized. 00:39:43 INFO - Running cycle 1/1 for kraken test... 00:39:43 INFO - TEST-INFO | started process 21374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXDB47/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:39:45 INFO - PROCESS | 21374 | 00:39:45 INFO - PROCESS | 21374 | (process:21436): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:39:55 INFO - PROCESS | 21374 | RSS: Main: 164065280 00:39:55 INFO - PROCESS | 21374 | 00:39:57 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52742/tests/kraken/driver.html?testName=audio-beat-detection) 00:39:58 INFO - PROCESS | 21374 | RSS: Main: 167567360 00:39:58 INFO - PROCESS | 21374 | 00:40:01 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52742/tests/kraken/driver.html?testName=audio-dft) 00:40:02 INFO - PROCESS | 21374 | RSS: Main: 167538688 00:40:02 INFO - PROCESS | 21374 | 00:40:05 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52742/tests/kraken/driver.html?testName=audio-fft) 00:40:06 INFO - PROCESS | 21374 | RSS: Main: 163713024 00:40:06 INFO - PROCESS | 21374 | 00:40:08 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52742/tests/kraken/driver.html?testName=audio-oscillator) 00:40:08 INFO - PROCESS | 21374 | RSS: Main: 163831808 00:40:08 INFO - PROCESS | 21374 | 00:40:11 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:40:11 INFO - PROCESS | 21374 | RSS: Main: 164417536 00:40:11 INFO - PROCESS | 21374 | 00:40:15 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52742/tests/kraken/driver.html?testName=imaging-darkroom) 00:40:15 INFO - PROCESS | 21374 | RSS: Main: 164220928 00:40:15 INFO - PROCESS | 21374 | 00:40:19 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52742/tests/kraken/driver.html?testName=imaging-desaturate) 00:40:19 INFO - PROCESS | 21374 | RSS: Main: 162512896 00:40:19 INFO - PROCESS | 21374 | 00:40:22 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52742/tests/kraken/driver.html?testName=json-parse-financial) 00:40:23 INFO - PROCESS | 21374 | RSS: Main: 163405824 00:40:23 INFO - PROCESS | 21374 | 00:40:25 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:40:26 INFO - PROCESS | 21374 | RSS: Main: 163737600 00:40:26 INFO - PROCESS | 21374 | 00:40:27 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52742/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:40:28 INFO - PROCESS | 21374 | RSS: Main: 163811328 00:40:28 INFO - PROCESS | 21374 | 00:40:30 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:40:31 INFO - PROCESS | 21374 | RSS: Main: 164241408 00:40:31 INFO - PROCESS | 21374 | 00:40:34 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:40:35 INFO - PROCESS | 21374 | RSS: Main: 164311040 00:40:35 INFO - PROCESS | 21374 | 00:40:38 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:40:38 INFO - PROCESS | 21374 | RSS: Main: 164261888 00:40:38 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:52742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52742/tests/kraken/driver.html?testName=ai-astar) 00:40:40 INFO - PROCESS | 21374 | RSS: Main: 166502400 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | __start_tp_report 00:40:40 INFO - PROCESS | 21374 | _x_x_mozilla_page_load 00:40:40 INFO - PROCESS | 21374 | _x_x_mozilla_page_load_details 00:40:40 INFO - PROCESS | 21374 | |i|pagename|runs| 00:40:40 INFO - PROCESS | 21374 | |0;ai-astar;112;117;108;114;115;122;112;113;116;114 00:40:40 INFO - PROCESS | 21374 | |1;audio-beat-detection;156;145;158;220;132;155;160;137;193;134 00:40:40 INFO - PROCESS | 21374 | |2;audio-dft;163;165;178;162;161;161;162;163;169;163 00:40:40 INFO - PROCESS | 21374 | |3;audio-fft;76;75;76;166;77;75;76;77;169;76 00:40:40 INFO - PROCESS | 21374 | |4;audio-oscillator;94;93;171;93;94;92;135;95;93;141 00:40:40 INFO - PROCESS | 21374 | |5;imaging-gaussian-blur;118;117;119;121;120;120;119;122;121;121 00:40:40 INFO - PROCESS | 21374 | |6;imaging-darkroom;149;146;147;147;147;147;148;148;147;147 00:40:40 INFO - PROCESS | 21374 | |7;imaging-desaturate;95;95;95;96;96;96;97;96;95;96 00:40:40 INFO - PROCESS | 21374 | |8;json-parse-financial;66;67;67;65;66;67;67;67;67;67 00:40:40 INFO - PROCESS | 21374 | |9;json-stringify-tinderbox;64;64;63;64;64;63;64;64;67;65 00:40:40 INFO - PROCESS | 21374 | |10;stanford-crypto-aes;82;83;89;82;84;84;83;84;148;88 00:40:40 INFO - PROCESS | 21374 | |11;stanford-crypto-ccm;144;144;138;140;138;132;135;141;165;144 00:40:40 INFO - PROCESS | 21374 | |12;stanford-crypto-pbkdf2;177;174;176;176;174;177;178;174;174;170 00:40:40 INFO - PROCESS | 21374 | |13;stanford-crypto-sha256-iterative;67;67;68;69;66;68;71;67;66;68 00:40:40 INFO - PROCESS | 21374 | __end_tp_report 00:40:40 INFO - PROCESS | 21374 | __start_cc_report 00:40:40 INFO - PROCESS | 21374 | _x_x_mozilla_cycle_collect,935 00:40:40 INFO - PROCESS | 21374 | __end_cc_report 00:40:40 INFO - PROCESS | 21374 | __startTimestamp1463038840758__endTimestamp 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | ------- Summary: start ------- 00:40:40 INFO - PROCESS | 21374 | Number of tests: 14 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.50 stddev:3.68 (3.2%) stddev-sans-first:3.81 00:40:40 INFO - PROCESS | 21374 | Values: 112.0 117.0 108.0 114.0 115.0 122.0 112.0 113.0 116.0 114.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#1] audio-beat-detection Cycles:10 Average:159.00 Median:157.00 stddev:27.76 (17.7%) stddev-sans-first:29.43 00:40:40 INFO - PROCESS | 21374 | Values: 156.0 145.0 158.0 220.0 132.0 155.0 160.0 137.0 193.0 134.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.00 stddev:5.23 (3.2%) stddev-sans-first:5.51 00:40:40 INFO - PROCESS | 21374 | Values: 163.0 165.0 178.0 162.0 161.0 161.0 162.0 163.0 169.0 163.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:38.59 (50.8%) stddev-sans-first:40.36 00:40:40 INFO - PROCESS | 21374 | Values: 76.0 75.0 76.0 166.0 77.0 75.0 76.0 77.0 169.0 76.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:28.35 (30.5%) stddev-sans-first:29.47 00:40:40 INFO - PROCESS | 21374 | Values: 94.0 93.0 171.0 93.0 94.0 92.0 135.0 95.0 93.0 141.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#5] imaging-gaussian-blur Cycles:10 Average:119.80 Median:120.50 stddev:1.55 (1.3%) stddev-sans-first:1.50 00:40:40 INFO - PROCESS | 21374 | Values: 118.0 117.0 119.0 121.0 120.0 120.0 119.0 122.0 121.0 121.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 00:40:40 INFO - PROCESS | 21374 | Values: 149.0 146.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 00:40:40 INFO - PROCESS | 21374 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 97.0 96.0 95.0 96.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 00:40:40 INFO - PROCESS | 21374 | Values: 66.0 67.0 67.0 65.0 66.0 67.0 67.0 67.0 67.0 67.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 00:40:40 INFO - PROCESS | 21374 | Values: 64.0 64.0 63.0 64.0 64.0 63.0 64.0 64.0 67.0 65.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:84.00 stddev:20.27 (24.1%) stddev-sans-first:21.25 00:40:40 INFO - PROCESS | 21374 | Values: 82.0 83.0 89.0 82.0 84.0 84.0 83.0 84.0 148.0 88.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:142.50 stddev:8.99 (6.3%) stddev-sans-first:9.51 00:40:40 INFO - PROCESS | 21374 | Values: 144.0 144.0 138.0 140.0 138.0 132.0 135.0 141.0 165.0 144.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.00 stddev:2.31 (1.3%) stddev-sans-first:2.33 00:40:40 INFO - PROCESS | 21374 | Values: 177.0 174.0 176.0 176.0 174.0 177.0 178.0 174.0 174.0 170.0 00:40:40 INFO - PROCESS | 21374 | 00:40:40 INFO - PROCESS | 21374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.56 00:40:40 INFO - PROCESS | 21374 | Values: 67.0 67.0 68.0 69.0 66.0 68.0 71.0 67.0 66.0 68.0 00:40:40 INFO - PROCESS | 21374 | -------- Summary: end -------- 00:40:40 INFO - PROCESS | 21374 | 00:40:41 INFO - TEST-INFO | 21374: exit 0 00:40:41 INFO - TEST-OK | kraken | took 65337ms 00:40:41 INFO - SUITE-END | took 1181s 00:40:41 INFO - Completed test suite (00:19:41) 00:40:41 INFO - javascript benchmark 00:40:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2671.2520494261607, 2710.593410988352, 2729.522333591621, 2730.3583657840404, 2737.3567211705245, 4697.741624210663, 4763.928541071887, 4811.326414302001, 4918.36061312029, 4985.651004429691, 4694.920168361279, 4772.689775164612, 4792.472827988919, 4877.439094504133, 4914.11545921734, 4390.078083602447, 4473.82104715811, 4516.683832131752, 4532.7280363178315, 4551.68138230324, 648.8199177173517, 4355.150745604608, 4393.253146965024, 4455.509893911667, 4544.750038747868, 4432.22436073689, 4439.75581343026, 4464.754438505881, 4473.194824931511, 4509.436320459942, 4547.022390186093, 4549.13566422382, 4549.27211646135, 4555.476120246148, 4594.058218065288, 4406.449193850769, 4416.955830441687, 4505.707129036635, 4520.050789334244, 4524.728516289033, 4735.644826638016, 4819.4939531349055, 4826.589739872115, 4827.951720482785, 4878.0, 5268.5521730652945, 5297.549708274802, 5303.23103150045, 5308.628396012281, 5358.839234822923, 5149.382074151088, 5163.845084647429, 5169.922451163236, 5239.187925871496, 5283.022640811424, 4936.136176169156, 4959.504049595083, 4963.156263435225, 4967.925481117786, 5010.949890501085, 5415.702136382537, 5421.83734487966, 5424.566034717213, 5436.565074794007, 5475.014497390508, 5053.898922021539, 5091.956148989449, 5108.080545501845, 5128.666636668605, 5217.034848552954, 5212.713300768494, 5252.29094072303, 5260.579153667697, 5263.894722105537, 5267.894642107136, 5197.97401013, 5201.193814958688, 5215.921761173586, 5224.373075230997, 5245.7114858683135, 5032.370953630796, 5090.312807770978, 5121.8463446096675, 5138.743062846917, 5140.434552199255, 4449.57729015743, 4459.821607135743, 4467.709598876063, 4474.105178964221, 4505.481869584974, 3803.8098095095133, 3907.4138879167785, 3911.6283953024417, 3922.9607703923166, 3960.207958408272, 4298.376735373354, 4371.978140109279, 4387.780610969438, 4391.736495810262, 4408.713433626804, 5051.06555287273, 5114.462981386975, 5134.0, 5135.6918584885025, 5182.989317083133, 4380.189664912002, 4386.8025938832825, 4390.253656878338, 4401.449818772653, 4430.667699922518, 4557.043020965568, 4611.608013318838, 4615.469221039556, 4622.9768851156205, 4631.467381251199, 4802.7838747255755, 4838.709677419366, 4857.732824694675, 4858.58702010333, 4888.5355891189565, 5124.666896651705, 5134.101532231919, 5183.222516622537, 5185.507376799198, 5187.273781670645, 4910.582600479, 4934.259861020732, 4943.30793688891, 4951.331570238116, 4998.875028124326, 5157.226416037624, 5158.561522270649, 5165.767540460613, 5176.145935920682, 5219.2953951216095, 5056.191009438619, 5170.819021334235, 5187.688738675692, 5232.3459567554055, 5240.816571419982, 5093.4651861554, 5106.846794596168, 5114.053900028507, 5121.948780512147, 5142.434332223377, 5078.162103252922, 5083.2883396323805, 5087.771050302671, 5118.590512759045, 5123.28274041627, 4812.687175333592, 4876.536729010738, 4879.585235254901, 4908.656394052525, 5022.422421421437, 4993.750312484434, 5027.195648696191, 5048.217526283432, 5050.3182070420025, 5068.062408454301, 4918.1393256180745, 4923.803047878188, 4929.852104436729, 4931.580815630568, 4995.300657907968], "value": 4743.198903877737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.6482445708117, 604.9969750151249, 607.8541150123972, 619.3589634728057, 622.1103821535206, 28707.138785836407, 41507.377389339184, 42274.57725422745, 42375.78812105943, 42447.57552424475, 41624.791876040654, 41881.16237675244, 42028.0, 42206.36690449638, 42339.0, 7942.4837385570045, 8000.159983201767, 8064.112947575762, 8078.151794061627, 8095.311898488636, 7853.489523181003, 7982.680692772282, 7998.520088794662, 8002.159773223815, 8019.839603207962, 8028.718994835182, 8044.637991290377, 8061.758147255592, 8074.515529068245, 8077.7576672699915, 7962.92500512435, 7974.0431148262, 8000.479968802009, 8002.0797608274925, 8012.158723334053, 7919.604019798987, 7952.244536768998, 7960.562169080698, 7972.441929064968, 7986.321162701177, 39419.80290098531, 39676.20647587061, 39765.0, 39801.40297895505, 39808.0, 3233.854476548561, 3321.335732853439, 3720.609336019706, 3926.705497087701, 3992.0818211811156, 30265.394692106256, 30554.694453055406, 30744.2313942151, 31055.689443105504, 32018.519722204186, 3154.5268209768487, 3161.2254997525524, 3187.3147273336112, 3193.952090718641, 3333.633300336961, 237195.0, 240273.0, 240359.0, 241362.0, 241964.0, 30717.846410767805, 55937.0, 56169.15746263809, 56537.71731141318, 56638.0, 36183.20076391941, 36261.81869090637, 36295.27409451796, 36481.087972800364, 36509.08727281786, 14735.115893046452, 14884.70230595382, 14934.551963441114, 14993.775093373608, 14994.925025374803, 12322.630321090382, 12324.630261092003, 12484.375781210903, 12485.875141248653, 12496.25022498653, 8369.246767790928, 8416.326693864476, 8452.070272270046, 8469.153084691605, 8506.36202284831, 3246.204679853404, 3253.674632536775, 3255.869765209365, 3258.5438038674606, 3294.950575741366, 906.8503696890072, 962.6486332488731, 996.8056229035413, 1038.7039693687263, 1077.0414331245197, 29630.0, 29684.257893552403, 30193.0, 30376.392472150874, 30407.391852162833, 986.0829428631298, 1010.4897027001464, 1086.315621158665, 1093.136422226448, 1159.310210424796, 15172.0, 15901.52295431139, 16567.751483727752, 16580.58548536296, 17259.56851078708, 369989.0, 416012.0, 422539.0, 425613.0, 643103.0, 53092.46907530875, 53673.1949020765, 53937.0, 54065.72967135139, 54374.45625543773, 1291.1865524719553, 1304.7390521895848, 1306.242379419953, 1319.5711393797055, 1327.2036777933356, 28598.57102143428, 29434.0, 29863.357515336866, 30205.69794302029, 30575.2356191097, 45703.542964569926, 46029.53970460386, 46397.30404043874, 46427.30359044685, 46468.30297545607, 321121.0, 321290.0, 322006.0, 322889.0, 323196.0, 27053.1884043479, 27628.58557121685, 27732.168034958984, 27744.306392340353, 27918.3020424491, 43839.34240986324, 44519.0, 44703.10593788041, 45298.32052519281, 45376.77311613421, 37017.44473832948, 37700.62299376971, 38133.61866381301, 38527.0, 39152.41271380874, 37510.62489375071, 37724.24551509009, 38044.42933356057, 38355.616443835206, 38475.615243847205, 37201.4419783698, 38155.80922095483, 38994.0, 39178.4123238146, 42383.24508906911, 30761.538576921812, 33042.504362435066, 33281.16797079996, 33471.0, 33540.66459335375, 25647.23058308254, 25797.613035804854, 25825.6126158104, 26091.217263482125, 26260.868695656398], "value": 17421.9896009592, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.77393111995036, 390.8299889548045, 390.9237698648763, 398.6651212981095, 406.6238729175512, 16033.67932641348, 16834.494965151065, 17065.48803535893, 17369.478915632535, 17370.305187792474, 13455.125416847923, 16321.10233937133, 16466.506004819843, 16999.810013299073, 17116.058616776103, 4972.32873562069, 5128.666636668623, 5134.922976155361, 5159.819406320761, 5178.171492561191, 5053.9241911371355, 5055.570276526481, 5081.441041485434, 5110.080185566597, 5113.258577506259, 5094.898102037957, 5145.511176438233, 5172.948270517284, 5174.2238664200295, 5183.455737147583, 4976.104301225778, 5108.795648174068, 5152.381714194302, 5154.149565321736, 5189.636725429222, 4624.306354046887, 4652.023075154221, 4653.88365290867, 4671.743054132022, 4675.672702910798, 20068.197272109097, 20330.288439904532, 20423.2851850186, 21004.894975525178, 21059.473513162142, 1779.9021053842034, 2023.9392818215476, 2025.2202901882733, 2120.9151633934625, 2293.6100862853355, 9269.629214831399, 9581.0, 9690.41857488546, 9761.951190244003, 9781.853272200922, 1768.823117688221, 1773.9645207095787, 1781.8129096444945, 1866.1975350599237, 1893.0534732633682, 61933.07100393543, 65867.67066164638, 67806.0, 68847.65576172137, 70118.0, 9918.553665084944, 10155.136813370946, 10307.536160872778, 10485.633002844865, 10540.472976351151, 14653.780193297109, 14691.338889749986, 14710.264486775619, 14804.629884252765, 14835.258237088103, 6571.769988050395, 7103.751368702071, 7425.628718564159, 7587.0, 7792.259735325135, 6751.932480675228, 6837.931620683829, 7292.671829767673, 7297.087864016998, 7459.552426854406, 4424.026714122888, 4455.2648812946145, 4458.197524445631, 4504.707194032378, 4580.473245576802, 1809.6652119357962, 1848.0, 1867.915943782533, 1879.2952642758964, 1900.1259420666647, 870.9303255739526, 889.1686273334324, 898.2842770308679, 917.5870858113875, 937.4281688170211, 16316.836831631532, 17471.126443677764, 18001.909990449964, 18455.16951737175, 18698.923498057844, 877.0790669796688, 899.4423457456419, 923.1968187676764, 966.0918736387773, 975.8828940527183, 9789.51052447389, 9820.950895245478, 9894.950525247328, 9901.702948911545, 9999.600015999278, 302062.0, 305295.0, 416393.0, 431472.0, 435048.0, 82653.58673206596, 85108.57445712856, 87431.0, 88669.0, 89066.10933890578, 943.9386439881386, 971.5919313888184, 980.4411485453365, 985.7486340983004, 988.8467287570438, 15781.0, 15811.288492017657, 15816.97189682667, 16035.518934431986, 16132.0, 35553.82223088868, 35624.82187589149, 35945.82027089952, 36249.637503624625, 36601.45097823482, 48609.0, 50952.0, 51416.0, 52641.7367913158, 52864.94270114653, 7684.193159718373, 7970.601469926364, 8005.59972001386, 8010.8397832041865, 8103.554304513073, 8945.23965462943, 11365.147613928822, 11962.222455540363, 11972.042236621224, 12169.148159628741, 10363.689089327332, 10502.474876256309, 10579.8942010582, 10664.573417063231, 10664.57341706354, 10158.034986676254, 10279.743006424898, 10304.381737095799, 10342.5345859438, 10438.739031523968, 10355.689329320132, 10410.947945260225, 10465.895341046493, 10703.678889633324, 10788.298760580537, 7522.511036782592, 7852.921470785219, 8004.199580042182, 8125.593720314079, 8176.100628930694, 9771.657991970531, 10350.792984140426, 10520.316179448617, 10900.890991089987, 11225.382603956861], "value": 8320.175648294708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.4871619291343, 1503.0305452982827, 1701.5235733994477, 1834.486343823729, 1841.6739947237984, 6826.146731658543, 7609.581473018989, 7622.504537205078, 8120.837583248332, 8135.91864081359, 7731.420143489247, 7854.175311592287, 8013.519188848673, 8030.95984520078, 8061.717839875606, 2216.745074316454, 2251.324602619216, 2256.9322920312416, 2259.5142044460435, 2269.024319542596, 2207.9779202207933, 2212.7787221277904, 2269.4553307206315, 2270.2281224383705, 2285.02886273334, 2249.718785151856, 2263.1286954522543, 2265.5808675395024, 2267.501149747053, 2289.7366802817637, 2135.316698656423, 2147.8389120815923, 2148.0655914677163, 2150.118451434912, 2157.4282815054025, 2136.9465763355884, 2142.271627646592, 2143.4641339665086, 2155.7844215578475, 2159.136345461812, 7945.205479452066, 7999.640016199285, 8010.038795344596, 8013.0384353877325, 8015.318697910685, 4867.3915760529935, 4967.528084831935, 4971.45314015458, 4979.278004689336, 4997.775100120503, 2887.148291254064, 3087.289923317627, 3096.0711786464194, 3098.380323935222, 3098.8915387961315, 928.373347990104, 932.1983094538691, 961.927855410847, 968.1867231525553, 990.4651488196365, 10884.510197041152, 11138.27601205919, 11196.944015279953, 11224.382658953755, 11283.66149015531, 4495.617872480811, 4577.954220457819, 4582.106489234568, 4629.745364005012, 4661.766911654404, 9604.135627793532, 9621.27840411972, 9625.951870240604, 9631.855522167172, 9632.95183524078, 4995.500449954975, 5018.071656743514, 5019.372578427697, 5022.422421421583, 5026.79892804291, 3802.239552089593, 4246.808893599796, 4361.1495758327455, 4372.060007098489, 4551.271796512542, 3802.7147963902817, 3861.652451279342, 3933.272344616255, 3957.703172262092, 4135.58644135584, 1264.8861602455822, 1303.7848754955517, 1304.5108084468325, 1307.8888294494884, 1316.7037416581193, 715.7244460882494, 824.4270232188692, 885.968991085309, 905.0813424374265, 908.5411867007251, 5492.642978206404, 5745.396733342939, 5782.739776709974, 5784.016717158009, 5975.880482390327, 952.2429668413628, 990.3315262198131, 1031.3966329697212, 1031.5403703759246, 1044.6657069737762, 3724.3296206682517, 3842.4620553122586, 3846.615338466131, 3854.4989151410136, 3858.9421158682644, 9702.611895524242, 10037.849432258521, 10066.396016239049, 10177.592896284214, 10206.540705668114, 9962.103410693073, 10035.949820250851, 10061.597536098474, 10128.797424051478, 10135.341202821794, 6867.622280774605, 7199.704053270357, 7268.890966635505, 7423.62881855905, 7663.19536448676, 5586.424837873844, 5703.372629010889, 5712.171735098304, 5910.172575839472, 5922.644641321534, 8731.956340218258, 8805.867911981453, 9351.0, 9460.148586627236, 9492.667756628485, 9004.234640055669, 9264.768380790534, 9328.766780830261, 9373.859392108987, 9481.905180948102, 5995.400459953969, 6640.402363787282, 6796.864062718817, 6875.5530890491955, 6896.27589103137, 7735.265149810759, 7838.216178382344, 7841.372690184658, 7880.05439347282, 7892.763217103496, 6738.393544581011, 7050.647467626701, 7078.256783037913, 7117.572945623279, 7139.357457828821, 6948.583085014915, 6975.860482790417, 6984.476164287597, 7105.076340075964, 7136.607486588287, 6400.839979000562, 6413.454856337264, 6427.196600424947, 6482.773102941374, 6558.213014438298, 4931.432885218246, 4996.850094497171, 5010.198368261061, 5041.873953151201, 5045.646804723634, 4741.288806679026, 4886.804527818847, 4911.877203069952, 4914.877128071684, 4917.459079501181], "value": 4345.364660501132, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.7262042129346, 297.8213072156705, 299.95166891713467, 313.6126883299126, 316.5062502496106, 4846.515348465152, 4890.8506500972335, 5098.26075219093, 5107.310513080733, 5144.485551444858, 4989.900201995958, 4991.0, 5017.122003649356, 5018.146915024446, 5021.899562008758, 3936.547297060846, 3945.151792364641, 3950.1112249743865, 3966.424868394074, 3984.681225501967, 3899.493065901429, 3971.384435412516, 3990.7805070721097, 3993.640572348488, 4001.539822920358, 3921.2353591049755, 3923.1761330120707, 3949.1706741584157, 3949.940750888739, 3950.1112249743865, 3919.412088186752, 3923.0388554804113, 3984.163325701606, 4000.139969906455, 4028.6575641070544, 3539.256756081226, 3541.2917416516543, 3567.571891373052, 3572.928541429183, 3580.785152890835, 4532.4787649420405, 4749.952500474986, 4795.184818580849, 4860.708357498526, 4878.0, 4378.190034843564, 4384.539623339535, 4399.142167277382, 4409.691321607489, 4411.250087485135, 5227.47725227478, 5245.344331958505, 5249.42256351801, 5260.316158899319, 5262.842114736564, 3470.548828652259, 3682.0, 3691.7231207659265, 3708.2398108387715, 3711.777293362407, 5438.510534051954, 5440.755166017539, 5440.863978400532, 5444.183372494118, 5467.261919640838, 3748.1379282765115, 3784.905377365588, 3787.0, 3787.9431808522895, 3814.561325447609, 3839.5584507781964, 3840.519935008124, 3852.3643598805884, 3852.3836186210633, 3855.5566109897723, 4153.210889930903, 4342.609165175149, 4353.6081752641785, 4382.649388048949, 4388.824447022083, 5190.455002224788, 5218.791248350023, 5229.50319719626, 5232.816851410183, 5238.842834714965, 1244.539520377448, 1297.4161627267579, 1330.5742162508097, 1331.760283149023, 1334.8531661517225, 830.2735106781566, 836.7991681996277, 837.4347315561971, 849.7763220961796, 864.3733293362262, 4059.7564146151326, 4070.738071197938, 4082.1631565528996, 4088.0, 4100.34394496879, 4703.811847526061, 4711.3639658646325, 4729.408823897013, 4755.311864288197, 4821.349117869043, 4075.9592404076175, 4091.365838295069, 4103.733257338264, 4110.445089912883, 4140.60664236897, 2549.7251374312846, 2687.2475706802124, 2899.826010439338, 2909.912702618925, 2919.664238612544, 4964.60283177345, 5042.294078828967, 5116.590672746246, 5132.923006154911, 5133.614978876524, 5355.250264962909, 5556.361018482926, 5568.192612071308, 5571.164325351148, 5575.972120139373, 5044.344235249394, 5121.359830021247, 5127.717975511308, 5136.356365962931, 5138.537531622097, 5362.570994320367, 5374.892502150014, 5401.621886468067, 5412.566994640498, 5419.83740487786, 5056.367954005749, 5235.188545775411, 5276.419593844751, 5322.962022405593, 5342.545883599938, 5060.3927528696795, 5083.822066227664, 5096.51583099605, 5110.616703747308, 5121.692698438105, 3761.6802571781705, 3771.396576547849, 3789.9621003789607, 3798.468214449924, 3799.829007694605, 5238.5023422774775, 5360.65155764874, 5396.271503347155, 5418.512333889968, 5423.29497165366, 5226.947730522798, 5259.60552958522, 5279.155335146358, 5280.867978300574, 5295.920561191509, 5206.479352064764, 5214.478552144755, 5223.869403264949, 5250.369955605352, 5281.815136470205, 4937.654364194472, 5010.398752149766, 5051.30781188306, 5103.928175083274, 5144.356955380577, 5226.2421948816445, 5249.160134378481, 5271.156614941591, 5274.498922602346, 5276.762545685377, 5088.135017047037, 5112.642115052059, 5121.897562048813, 5122.820701275437, 5134.178531434953], "value": 3897.2019799237773, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.1254769562697, 769.530586342331, 773.3001633521664, 793.9841203175934, 831.7421599304213, 13191.604251872448, 13372.462166850828, 13426.0, 13479.0, 13481.528146514875, 14501.854981450182, 14502.854971450282, 14513.20177390243, 14534.709305813878, 14538.418463261483, 683.781190019194, 869.1438932651333, 873.9737807865743, 874.0472884555833, 875.9737207883774, 864.8054187807725, 887.6050157679836, 888.35594194209, 888.9155530224618, 892.0677891603258, 916.4959272400187, 918.8483900156466, 924.5377311344328, 927.4759760735196, 928.8095940332249, 915.8763566918448, 916.3906002508324, 917.9816403671956, 919.1773362840287, 920.0385597051097, 673.3569441183657, 675.9898601520981, 677.4478799778165, 679.2019377231783, 679.341039191983, 12295.200811947196, 12441.191322564004, 12452.564160254347, 12500.49998000079, 12518.687032824162, 12174.695632609168, 12714.110012299143, 12733.172343797716, 12799.552015679406, 12908.440479576173, 9547.856782148274, 9763.90236097644, 9783.36408133469, 9868.45723485208, 10120.544575494047, 3258.934821303584, 3316.6185888622636, 3317.1209629448217, 3317.170707323169, 3331.816750078745, 46737.29894051592, 47059.529404705856, 47418.76290618559, 47772.28341574879, 47821.76089119532, 10053.346532475365, 10056.446895420822, 10194.592216311265, 10203.795924081476, 10361.585536578603, 16822.495325140266, 16887.91556042212, 16891.324347026228, 17409.04250266222, 17492.38776642837, 7020.543664661883, 7124.394426473704, 7153.928460715326, 7321.78034658961, 7382.889256661047, 3814.9809250953567, 3959.0, 4010.5588385277597, 4011.8796436106963, 4019.7588144710826, 2919.459899918522, 3024.4404785114384, 3034.787564870482, 3043.9847800760854, 3048.8475576221545, 537.6424677589359, 539.051269765216, 548.358420647843, 550.8540236837241, 558.7541481748099, 599.3856297295307, 616.9691515424211, 626.2266101364811, 626.9937300627026, 628.5129025005566, 7309.89035164473, 7358.926410735931, 7535.1334596521, 7580.696772129163, 7848.0, 563.132775525694, 570.8715539003691, 592.5052581094748, 618.3538202578317, 618.8267285160163, 3407.1993081625797, 3686.612905644922, 3694.3350196964802, 3695.8521659133335, 3830.636089571542, 45660.77169614197, 45952.0, 51327.0, 52152.739236303576, 52902.73548632232, 45590.31614525785, 46320.0, 46452.0, 46993.53006469891, 47074.0, 43663.345049824275, 43863.78068109703, 43907.0, 44030.0, 44613.33080003803, 8054.758357249292, 8064.324474194917, 8097.676092956216, 8286.295664868554, 8464.068952415106, 29227.85386073056, 29301.85349073241, 30041.5493767598, 30079.398412032075, 30211.546826797177, 35288.64711352854, 37180.81409593043, 37263.25473490461, 37630.247395052495, 38387.80806095952, 10813.243072984815, 11069.889301106887, 11103.944480277547, 11114.333140011626, 11163.218574699693, 11941.76116477683, 12201.389930503618, 12206.87793122093, 12334.136610437543, 12721.872781272068, 10616.469176541297, 10616.52225649863, 10752.623658171926, 11108.777824443627, 11137.610183643857, 10347.844782328422, 10647.148228141885, 10656.307340022873, 10896.836547451636, 10925.344479331265, 10562.89437105619, 10726.088282496075, 10863.348199108079, 11139.443027848412, 11213.887861121284, 9034.728958131267, 9722.173615242784, 9724.854127187957, 10025.749356266151, 10097.0, 9086.909130908607, 9185.724428267162, 9185.954070229605, 9322.0, 9359.679690074197], "value": 6099.329470012364, "unit": "score"}], "name": "dromaeo_css", "value": 6435.291043059406, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 108.0, 114.0, 115.0, 122.0, 112.0, 113.0, 116.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 145.0, 158.0, 220.0, 132.0, 155.0, 160.0, 137.0, 193.0, 134.0], "value": 159.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 178.0, 162.0, 161.0, 161.0, 162.0, 163.0, 169.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 166.0, 77.0, 75.0, 76.0, 77.0, 169.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 171.0, 93.0, 94.0, 92.0, 135.0, 95.0, 93.0, 141.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 121.0, 120.0, 120.0, 119.0, 122.0, 121.0, 121.0], "value": 119.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 67.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 89.0, 82.0, 84.0, 84.0, 83.0, 84.0, 148.0, 88.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 138.0, 140.0, 138.0, 132.0, 135.0, 141.0, 165.0, 144.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 176.0, 176.0, 174.0, 177.0, 178.0, 174.0, 174.0, 170.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 66.0, 68.0, 71.0, 67.0, 66.0, 68.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1611.5, "alertThreshold": 2.0}]} 00:40:42 INFO - Return code: 0 00:40:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:40:42 ERROR - # TBPL SUCCESS # 00:40:42 INFO - Running post-action listener: _resource_record_post_action 00:40:42 INFO - ##### 00:40:42 INFO - ##### Finished run-tests step (success) 00:40:42 INFO - ##### 00:40:42 INFO - Running post-run listener: _resource_record_post_run 00:40:43 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535740416; Read time: 20; Write time: 421304 00:40:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241700864; Read time: 0; Write time: 235492 00:40:43 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294039552; Read time: 20; Write time: 185812 00:40:43 INFO - Running post-run listener: _upload_blobber_files 00:40:43 INFO - Blob upload gear active. 00:40:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:40:43 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 00:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:40:43 INFO - (blobuploader) - INFO - Open directory for files ... 00:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:40:44 INFO - (blobuploader) - INFO - Done attempting. 00:40:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:40:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:40:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:40:45 INFO - (blobuploader) - INFO - Done attempting. 00:40:45 INFO - (blobuploader) - INFO - Iteration through files over. 00:40:45 INFO - Return code: 0 00:40:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:40:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:40:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d75185b20522d568eafa195655209904804c6ac11c8b035930d3215732e021ca958186d5d00d598cf452136584ef93159ab296530562cdcb9a39664e3776294", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/331e190614e6de20a5bef187ef36829fb05cfe34d5e38ff3665ac911317d851f67258032b5b3d98b586fb7f7f5340ae698bd6332ba5e2f593e62f3a0dd91b86f"} 00:40:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:40:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:40:45 INFO - Contents: 00:40:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d75185b20522d568eafa195655209904804c6ac11c8b035930d3215732e021ca958186d5d00d598cf452136584ef93159ab296530562cdcb9a39664e3776294", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/331e190614e6de20a5bef187ef36829fb05cfe34d5e38ff3665ac911317d851f67258032b5b3d98b586fb7f7f5340ae698bd6332ba5e2f593e62f3a0dd91b86f"} 00:40:45 INFO - Running post-run listener: copy_logs_to_upload_dir 00:40:45 INFO - Copying logs to upload dir... 00:40:45 INFO - mkdir: /builds/slave/test/build/upload/logs 00:40:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.572146 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-12 00:40:45.227238) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 00:40:45.230940) ========= 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=7de08804244eb36560b44971000001c3-1463035684.370670-2073163215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d75185b20522d568eafa195655209904804c6ac11c8b035930d3215732e021ca958186d5d00d598cf452136584ef93159ab296530562cdcb9a39664e3776294", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/331e190614e6de20a5bef187ef36829fb05cfe34d5e38ff3665ac911317d851f67258032b5b3d98b586fb7f7f5340ae698bd6332ba5e2f593e62f3a0dd91b86f"} build_url:https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/M7F3XS5TSnWXSGu8-kITXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d75185b20522d568eafa195655209904804c6ac11c8b035930d3215732e021ca958186d5d00d598cf452136584ef93159ab296530562cdcb9a39664e3776294", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/331e190614e6de20a5bef187ef36829fb05cfe34d5e38ff3665ac911317d851f67258032b5b3d98b586fb7f7f5340ae698bd6332ba5e2f593e62f3a0dd91b86f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 00:40:45.258092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:40:45.258571) ========= 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=7de08804244eb36560b44971000001c3-1463035684.370670-2073163215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:40:45.340589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 00:40:45.340916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 00:40:45.341211) ========= ========= Total master_lag: 0.20 =========