builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1460672085.84 results: success (0) buildid: 20160414144949 builduid: 14c80def27a14174b4e5ddac95dfed06 revision: 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:45.843374) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:45.844095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:45.844612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:45.859742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:45.860051) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 15:14:45-- 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% 89.3M=0s 2016-04-14 15:14:45 (89.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074888 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:45.951096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:45.951457) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014953 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:46.002222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:46.002705) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b --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 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b --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=9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 15:14:46,046 truncating revision to first 12 chars 2016-04-14 15:14:46,046 Setting DEBUG logging. 2016-04-14 15:14:46,046 attempt 1/10 2016-04-14 15:14:46,046 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/159d0cb3c2c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 15:14:46,571 unpacking tar archive at: fx-team-159d0cb3c2c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.826546 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:46.846417) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:46.847102) ========= script_repo_revision: 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:46.848065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:46.848748) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 15:14:46.859991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-14 15:14:46.860334) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:14:46 INFO - MultiFileLogger online at 20160414 15:14:46 in /builds/slave/test 15:14:46 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 15:14:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:46 INFO - {'append_to_log': False, 15:14:46 INFO - 'base_work_dir': '/builds/slave/test', 15:14:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:14:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:46 INFO - 'branch': 'Fx-Team-Non-PGO', 15:14:46 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:46 INFO - 'config_files': ('talos/linux_config.py',), 15:14:46 INFO - 'default_actions': ('clobber', 15:14:46 INFO - 'read-buildbot-config', 15:14:46 INFO - 'download-and-extract', 15:14:46 INFO - 'populate-webroot', 15:14:46 INFO - 'create-virtualenv', 15:14:46 INFO - 'install', 15:14:46 INFO - 'run-tests'), 15:14:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:46 INFO - 'download_minidump_stackwalk': True, 15:14:46 INFO - 'download_symbols': 'ondemand', 15:14:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:46 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:46 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:46 INFO - 'installer_path': 'installer.exe', 15:14:46 INFO - 'log_level': 'info', 15:14:46 INFO - 'log_name': 'talos', 15:14:46 INFO - 'log_to_console': True, 15:14:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:14:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:14:46 INFO - 'opt_config_files': (), 15:14:46 INFO - 'pip_index': False, 15:14:46 INFO - 'sps_profile': False, 15:14:46 INFO - 'sps_profile_interval': 0, 15:14:46 INFO - 'suite': 'dromaeojs-e10s', 15:14:46 INFO - 'system_bits': '32', 15:14:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:46 INFO - 'title': 'talos-linux64-ix-022', 15:14:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:46 INFO - 'use_talos_json': True, 15:14:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:14:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:46 INFO - 'work_dir': 'build'} 15:14:46 INFO - ##### 15:14:46 INFO - ##### Running clobber step. 15:14:46 INFO - ##### 15:14:46 INFO - Running pre-action listener: _resource_record_pre_action 15:14:46 INFO - Running main action method: clobber 15:14:46 INFO - rmtree: /builds/slave/test/build 15:14:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:47 INFO - Running post-action listener: _resource_record_post_action 15:14:47 INFO - ##### 15:14:47 INFO - ##### Running read-buildbot-config step. 15:14:47 INFO - ##### 15:14:47 INFO - Running pre-action listener: _resource_record_pre_action 15:14:47 INFO - Running main action method: read_buildbot_config 15:14:47 INFO - Using buildbot properties: 15:14:47 INFO - { 15:14:47 INFO - "project": "", 15:14:47 INFO - "product": "firefox", 15:14:47 INFO - "script_repo_revision": "production", 15:14:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:14:47 INFO - "repository": "", 15:14:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:14:47 INFO - "buildid": "20160414144949", 15:14:47 INFO - "pgo_build": "False", 15:14:47 INFO - "basedir": "/builds/slave/test", 15:14:47 INFO - "buildnumber": 1146, 15:14:47 INFO - "slavename": "talos-linux64-ix-022", 15:14:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:14:47 INFO - "platform": "ubuntu64_hw", 15:14:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:14:47 INFO - "branch": "fx-team", 15:14:47 INFO - "repo_path": "integration/fx-team", 15:14:47 INFO - "revision": "159d0cb3c2c360ec38ff965a50a67fc2b5ab736b", 15:14:47 INFO - "stage_platform": "linux64", 15:14:47 INFO - "builduid": "14c80def27a14174b4e5ddac95dfed06", 15:14:47 INFO - "slavebuilddir": "test" 15:14:47 INFO - } 15:14:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:14:47 INFO - Running post-action listener: _resource_record_post_action 15:14:47 INFO - ##### 15:14:47 INFO - ##### Running download-and-extract step. 15:14:47 INFO - ##### 15:14:47 INFO - Running pre-action listener: _resource_record_pre_action 15:14:47 INFO - Running main action method: download_and_extract 15:14:47 INFO - mkdir: /builds/slave/test/build/tests 15:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:47 INFO - https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:14:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:14:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:14:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:14:48 INFO - Downloaded 1361 bytes. 15:14:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:14:48 INFO - Using the following test package requirements: 15:14:48 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:14:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:14:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:14:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:48 INFO - u'jsshell-linux-x86_64.zip'], 15:14:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:14:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:14:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:14:48 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:14:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:14:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:14:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:14:48 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')]} 15:14:48 INFO - https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:14:49 INFO - Downloaded 22203341 bytes. 15:14:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:14:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:14:50 INFO - Return code: 0 15:14:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:14:50 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')]} 15:14:50 INFO - https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:14:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:14:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:14:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:14:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:14:51 INFO - Downloaded 22203341 bytes. 15:14:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:14:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:14:53 INFO - Return code: 0 15:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:53 INFO - https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:14:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:14:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:14:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:14:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:14:54 INFO - Downloaded 10841076 bytes. 15:14:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:14:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:14:54 INFO - Return code: 0 15:14:54 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')]} 15:14:54 INFO - https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:14:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:14:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:14:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:14:55 INFO - Downloaded 54451003 bytes. 15:14:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:14:55 INFO - mkdir: /builds/slave/test/properties 15:14:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:14:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:14:55 INFO - Contents: 15:14:55 INFO - build_url:https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:14:56 INFO - Running post-action listener: _resource_record_post_action 15:14:56 INFO - Running post-action listener: set_extra_try_arguments 15:14:56 INFO - ##### 15:14:56 INFO - ##### Running populate-webroot step. 15:14:56 INFO - ##### 15:14:56 INFO - Running pre-action listener: _resource_record_pre_action 15:14:56 INFO - Running main action method: populate_webroot 15:14:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:14:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:14:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:14:56 INFO - '--tppagecycles', 15:14:56 INFO - '7'], 15:14:56 INFO - 'tests': ['tsvgm']}}, 15:14:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:14:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:14:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:14:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:14:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:56 INFO - 'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:56 INFO - 'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['damp', 'tps']}, 15:14:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:56 INFO - 'tests': ['damp', 'tps']}, 15:14:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['dromaeo_dom']}, 15:14:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:14:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['a11yr', 15:14:56 INFO - 'ts_paint', 15:14:56 INFO - 'tpaint', 15:14:56 INFO - 'sessionrestore', 15:14:56 INFO - 'sessionrestore_no_auto_restore', 15:14:56 INFO - 'tabpaint']}, 15:14:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:14:56 INFO - 'ts_paint', 15:14:56 INFO - 'tpaint', 15:14:56 INFO - 'sessionrestore', 15:14:56 INFO - 'sessionrestore_no_auto_restore', 15:14:56 INFO - 'tabpaint']}, 15:14:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:14:56 INFO - 'ts_paint', 15:14:56 INFO - 'tpaint', 15:14:56 INFO - 'sessionrestore', 15:14:56 INFO - 'sessionrestore_no_auto_restore', 15:14:56 INFO - 'tabpaint']}, 15:14:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:14:56 INFO - 'ts_paint', 15:14:56 INFO - 'tpaint', 15:14:56 INFO - 'sessionrestore', 15:14:56 INFO - 'sessionrestore_no_auto_restore', 15:14:56 INFO - 'tabpaint']}, 15:14:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['a11yr', 15:14:56 INFO - 'ts_paint', 15:14:56 INFO - 'tpaint', 15:14:56 INFO - 'sessionrestore', 15:14:56 INFO - 'sessionrestore_no_auto_restore', 15:14:56 INFO - 'tabpaint']}, 15:14:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['a11yr', 15:14:56 INFO - 'ts_paint', 15:14:56 INFO - 'tpaint', 15:14:56 INFO - 'sessionrestore', 15:14:56 INFO - 'sessionrestore_no_auto_restore', 15:14:56 INFO - 'tabpaint']}, 15:14:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['tsvgx', 15:14:56 INFO - 'tsvgr_opacity', 15:14:56 INFO - 'tart', 15:14:56 INFO - 'tscrollx', 15:14:56 INFO - 'cart']}, 15:14:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:14:56 INFO - 'tsvgr_opacity', 15:14:56 INFO - 'tart', 15:14:56 INFO - 'tscrollx', 15:14:56 INFO - 'cart']}, 15:14:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:56 INFO - 'talos_options': ['--disable-e10s'], 15:14:56 INFO - 'tests': ['tp5o']}, 15:14:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:56 INFO - 'tests': ['tp5o']}, 15:14:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:56 INFO - 'talos_options': ['--disable-e10s', 15:14:56 INFO - '--xperf_path', 15:14:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:56 INFO - 'tests': ['tp5n']}, 15:14:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:56 INFO - 'talos_options': ['--xperf_path', 15:14:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:56 INFO - 'tests': ['tp5n']}}, 15:14:56 INFO - 'talos.zip': {'path': '', 15:14:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:14:56 INFO - Running post-action listener: _resource_record_post_action 15:14:56 INFO - ##### 15:14:56 INFO - ##### Running create-virtualenv step. 15:14:56 INFO - ##### 15:14:56 INFO - Running pre-action listener: _resource_record_pre_action 15:14:56 INFO - Running main action method: create_virtualenv 15:14:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:14:56 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 15:14:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:14:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:14:56 INFO - Using real prefix '/usr' 15:14:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:14:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:14:59 INFO - Installing pip.................done. 15:14:59 INFO - Return code: 0 15:14:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:59 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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:14:59 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 15:14:59 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 15:14:59 INFO - Using env: {'DISPLAY': ':0', 15:14:59 INFO - 'HOME': '/home/cltbld', 15:14:59 INFO - 'LANG': 'en_US.UTF-8', 15:14:59 INFO - 'LANGUAGE': 'en_US:en', 15:14:59 INFO - 'LOGNAME': 'cltbld', 15:14:59 INFO - 'MAIL': '/var/mail/cltbld', 15:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:59 INFO - 'MOZ_NO_REMOTE': '1', 15:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:59 INFO - 'NO_EM_RESTART': '1', 15:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:59 INFO - 'PWD': '/builds/slave/test', 15:14:59 INFO - 'SHELL': '/bin/bash', 15:14:59 INFO - 'SHLVL': '1', 15:14:59 INFO - 'TERM': 'linux', 15:14:59 INFO - 'TMOUT': '86400', 15:14:59 INFO - 'USER': 'cltbld', 15:14:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:59 INFO - '_': '/tools/buildbot/bin/python'} 15:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:59 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 15:14:59 INFO - Cleaning up... 15:14:59 INFO - Return code: 0 15:14:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:59 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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:14:59 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 15:14:59 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 15:14:59 INFO - Using env: {'DISPLAY': ':0', 15:14:59 INFO - 'HOME': '/home/cltbld', 15:14:59 INFO - 'LANG': 'en_US.UTF-8', 15:14:59 INFO - 'LANGUAGE': 'en_US:en', 15:14:59 INFO - 'LOGNAME': 'cltbld', 15:14:59 INFO - 'MAIL': '/var/mail/cltbld', 15:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:59 INFO - 'MOZ_NO_REMOTE': '1', 15:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:59 INFO - 'NO_EM_RESTART': '1', 15:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:59 INFO - 'PWD': '/builds/slave/test', 15:14:59 INFO - 'SHELL': '/bin/bash', 15:14:59 INFO - 'SHLVL': '1', 15:14:59 INFO - 'TERM': 'linux', 15:14:59 INFO - 'TMOUT': '86400', 15:14:59 INFO - 'USER': 'cltbld', 15:14:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:59 INFO - '_': '/tools/buildbot/bin/python'} 15:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:59 INFO - Downloading/unpacking psutil>=0.7.1 15:14:59 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 15:14:59 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 15:14:59 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 15:14:59 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 15:14:59 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 15:14:59 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 15:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:15:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:01 INFO - Installing collected packages: psutil 15:15:01 INFO - Running setup.py install for psutil 15:15:01 INFO - building 'psutil._psutil_linux' extension 15:15:01 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 15:15:01 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 15:15:01 INFO - building 'psutil._psutil_posix' extension 15:15:01 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 15:15:01 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 15:15:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:02 INFO - Successfully installed psutil 15:15:02 INFO - Cleaning up... 15:15:02 INFO - Return code: 0 15:15:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:15:02 INFO - Using env: {'DISPLAY': ':0', 15:15:02 INFO - 'HOME': '/home/cltbld', 15:15:02 INFO - 'LANG': 'en_US.UTF-8', 15:15:02 INFO - 'LANGUAGE': 'en_US:en', 15:15:02 INFO - 'LOGNAME': 'cltbld', 15:15:02 INFO - 'MAIL': '/var/mail/cltbld', 15:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:02 INFO - 'MOZ_NO_REMOTE': '1', 15:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:02 INFO - 'NO_EM_RESTART': '1', 15:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:02 INFO - 'PWD': '/builds/slave/test', 15:15:02 INFO - 'SHELL': '/bin/bash', 15:15:02 INFO - 'SHLVL': '1', 15:15:02 INFO - 'TERM': 'linux', 15:15:02 INFO - 'TMOUT': '86400', 15:15:02 INFO - 'USER': 'cltbld', 15:15:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:02 INFO - '_': '/tools/buildbot/bin/python'} 15:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:15:04 INFO - Installing collected packages: mozsystemmonitor 15:15:04 INFO - Running setup.py install for mozsystemmonitor 15:15:04 INFO - Successfully installed mozsystemmonitor 15:15:04 INFO - Cleaning up... 15:15:04 INFO - Return code: 0 15:15:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:04 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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:15:04 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 15:15:04 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 15:15:04 INFO - Using env: {'DISPLAY': ':0', 15:15:04 INFO - 'HOME': '/home/cltbld', 15:15:04 INFO - 'LANG': 'en_US.UTF-8', 15:15:04 INFO - 'LANGUAGE': 'en_US:en', 15:15:04 INFO - 'LOGNAME': 'cltbld', 15:15:04 INFO - 'MAIL': '/var/mail/cltbld', 15:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:04 INFO - 'MOZ_NO_REMOTE': '1', 15:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:04 INFO - 'NO_EM_RESTART': '1', 15:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:04 INFO - 'PWD': '/builds/slave/test', 15:15:04 INFO - 'SHELL': '/bin/bash', 15:15:04 INFO - 'SHLVL': '1', 15:15:04 INFO - 'TERM': 'linux', 15:15:04 INFO - 'TMOUT': '86400', 15:15:04 INFO - 'USER': 'cltbld', 15:15:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:04 INFO - '_': '/tools/buildbot/bin/python'} 15:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:15:04 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 15:15:04 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 15:15:04 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 15:15:04 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 15:15:04 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 15:15:04 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 15:15:06 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:06 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 15:15:06 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 15:15:06 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 15:15:06 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 15:15:06 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 15:15:06 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 15:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:07 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 15:15:07 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 15:15:07 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 15:15:07 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 15:15:07 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 15:15:07 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 15:15:07 INFO - Downloading docopt-0.6.1.tar.gz 15:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:07 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:07 INFO - Running setup.py install for blobuploader 15:15:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:07 INFO - Running setup.py install for requests 15:15:07 INFO - Running setup.py install for docopt 15:15:08 INFO - Successfully installed blobuploader requests docopt 15:15:08 INFO - Cleaning up... 15:15:08 INFO - Return code: 0 15:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:08 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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:15:08 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 15:15:08 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 15:15:08 INFO - Using env: {'DISPLAY': ':0', 15:15:08 INFO - 'HOME': '/home/cltbld', 15:15:08 INFO - 'LANG': 'en_US.UTF-8', 15:15:08 INFO - 'LANGUAGE': 'en_US:en', 15:15:08 INFO - 'LOGNAME': 'cltbld', 15:15:08 INFO - 'MAIL': '/var/mail/cltbld', 15:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:08 INFO - 'MOZ_NO_REMOTE': '1', 15:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:08 INFO - 'NO_EM_RESTART': '1', 15:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:08 INFO - 'PWD': '/builds/slave/test', 15:15:08 INFO - 'SHELL': '/bin/bash', 15:15:08 INFO - 'SHLVL': '1', 15:15:08 INFO - 'TERM': 'linux', 15:15:08 INFO - 'TMOUT': '86400', 15:15:08 INFO - 'USER': 'cltbld', 15:15:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:08 INFO - '_': '/tools/buildbot/bin/python'} 15:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:08 INFO - Running setup.py (path:/tmp/pip-UQx998-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:08 INFO - Running setup.py (path:/tmp/pip-2rYr5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:08 INFO - Running setup.py (path:/tmp/pip-lSl4SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:08 INFO - Running setup.py (path:/tmp/pip-jf3tdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:08 INFO - Running setup.py (path:/tmp/pip-jlMsiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:08 INFO - Running setup.py (path:/tmp/pip-be9q1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:08 INFO - Running setup.py (path:/tmp/pip-OHxTwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:08 INFO - Running setup.py (path:/tmp/pip-ixrMpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:08 INFO - Running setup.py (path:/tmp/pip-hs9z7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:08 INFO - Running setup.py (path:/tmp/pip-efIp9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:08 INFO - Running setup.py (path:/tmp/pip-7i1bT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:09 INFO - Running setup.py (path:/tmp/pip-dsp1Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:09 INFO - Running setup.py (path:/tmp/pip-oDBA51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:09 INFO - Running setup.py (path:/tmp/pip-LuNZzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:09 INFO - Running setup.py (path:/tmp/pip-0MkLs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:09 INFO - Running setup.py (path:/tmp/pip-H08bzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:09 INFO - Running setup.py (path:/tmp/pip-uIHF0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:09 INFO - Running setup.py install for manifestparser 15:15:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:15:09 INFO - Running setup.py install for mozcrash 15:15:09 INFO - Running setup.py install for mozdebug 15:15:09 INFO - Running setup.py install for mozdevice 15:15:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:15:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:15:09 INFO - Running setup.py install for mozfile 15:15:09 INFO - Running setup.py install for mozhttpd 15:15:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for mozinfo 15:15:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for mozInstall 15:15:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for mozleak 15:15:10 INFO - Running setup.py install for mozlog 15:15:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for moznetwork 15:15:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for mozprocess 15:15:10 INFO - Running setup.py install for mozprofile 15:15:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for mozrunner 15:15:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for mozscreenshot 15:15:11 INFO - Running setup.py install for moztest 15:15:11 INFO - Running setup.py install for mozversion 15:15:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:15:11 INFO - Cleaning up... 15:15:11 INFO - Return code: 0 15:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:11 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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:15:11 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 15:15:11 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 15:15:11 INFO - Using env: {'DISPLAY': ':0', 15:15:11 INFO - 'HOME': '/home/cltbld', 15:15:11 INFO - 'LANG': 'en_US.UTF-8', 15:15:11 INFO - 'LANGUAGE': 'en_US:en', 15:15:11 INFO - 'LOGNAME': 'cltbld', 15:15:11 INFO - 'MAIL': '/var/mail/cltbld', 15:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:11 INFO - 'MOZ_NO_REMOTE': '1', 15:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:11 INFO - 'NO_EM_RESTART': '1', 15:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:11 INFO - 'PWD': '/builds/slave/test', 15:15:11 INFO - 'SHELL': '/bin/bash', 15:15:11 INFO - 'SHLVL': '1', 15:15:11 INFO - 'TERM': 'linux', 15:15:11 INFO - 'TMOUT': '86400', 15:15:11 INFO - 'USER': 'cltbld', 15:15:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:11 INFO - '_': '/tools/buildbot/bin/python'} 15:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:11 INFO - Running setup.py (path:/tmp/pip-0ACj5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:11 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)) 15:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:11 INFO - Running setup.py (path:/tmp/pip-MvnpXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:11 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)) 15:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:11 INFO - Running setup.py (path:/tmp/pip-r0fPWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:11 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)) 15:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:11 INFO - Running setup.py (path:/tmp/pip-1U5neo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:11 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)) 15:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:11 INFO - Running setup.py (path:/tmp/pip-nseguf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:11 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)) 15:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:11 INFO - Running setup.py (path:/tmp/pip-kbqA4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:11 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)) 15:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:11 INFO - Running setup.py (path:/tmp/pip-CGHaar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:12 INFO - Running setup.py (path:/tmp/pip-Qc8hNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:12 INFO - Running setup.py (path:/tmp/pip-D9l91U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:12 INFO - Running setup.py (path:/tmp/pip-CG22sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:12 INFO - Running setup.py (path:/tmp/pip-TPTXnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:12 INFO - Running setup.py (path:/tmp/pip-2FdvXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:12 INFO - Running setup.py (path:/tmp/pip-EHZ5KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:12 INFO - Running setup.py (path:/tmp/pip-Sp73zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:12 INFO - Running setup.py (path:/tmp/pip-ALrfxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:12 INFO - Running setup.py (path:/tmp/pip-zPXXyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:12 INFO - Running setup.py (path:/tmp/pip-IOh7SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:12 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)) 15:15:12 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)) 15:15:12 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)) 15:15:12 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)) 15:15:12 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)) 15:15:12 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)) 15:15:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:14 INFO - Downloading blessings-1.6.tar.gz 15:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:15:14 INFO - Installing collected packages: blessings 15:15:14 INFO - Running setup.py install for blessings 15:15:14 INFO - Successfully installed blessings 15:15:14 INFO - Cleaning up... 15:15:14 INFO - Return code: 0 15:15:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:15 INFO - Reading from file tmpfile_stdout 15:15:15 INFO - Current package versions: 15:15:15 INFO - argparse == 1.2.1 15:15:15 INFO - blessings == 1.6 15:15:15 INFO - blobuploader == 1.2.4 15:15:15 INFO - docopt == 0.6.1 15:15:15 INFO - manifestparser == 1.1 15:15:15 INFO - mozInstall == 1.12 15:15:15 INFO - mozcrash == 0.17 15:15:15 INFO - mozdebug == 0.1 15:15:15 INFO - mozdevice == 0.48 15:15:15 INFO - mozfile == 1.2 15:15:15 INFO - mozhttpd == 0.7 15:15:15 INFO - mozinfo == 0.9 15:15:15 INFO - mozleak == 0.1 15:15:15 INFO - mozlog == 3.1 15:15:15 INFO - moznetwork == 0.27 15:15:15 INFO - mozprocess == 0.22 15:15:15 INFO - mozprofile == 0.28 15:15:15 INFO - mozrunner == 6.11 15:15:15 INFO - mozscreenshot == 0.1 15:15:15 INFO - mozsystemmonitor == 0.0 15:15:15 INFO - moztest == 0.7 15:15:15 INFO - mozversion == 1.4 15:15:15 INFO - psutil == 3.1.1 15:15:15 INFO - requests == 1.2.3 15:15:15 INFO - wsgiref == 0.1.2 15:15:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:15 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')]} 15:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:15 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')]} 15:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:15 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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:15:15 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 15:15:15 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 15:15:15 INFO - Using env: {'DISPLAY': ':0', 15:15:15 INFO - 'HOME': '/home/cltbld', 15:15:15 INFO - 'LANG': 'en_US.UTF-8', 15:15:15 INFO - 'LANGUAGE': 'en_US:en', 15:15:15 INFO - 'LOGNAME': 'cltbld', 15:15:15 INFO - 'MAIL': '/var/mail/cltbld', 15:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:15 INFO - 'MOZ_NO_REMOTE': '1', 15:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:15 INFO - 'NO_EM_RESTART': '1', 15:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:15 INFO - 'PWD': '/builds/slave/test', 15:15:15 INFO - 'SHELL': '/bin/bash', 15:15:15 INFO - 'SHLVL': '1', 15:15:15 INFO - 'TERM': 'linux', 15:15:15 INFO - 'TMOUT': '86400', 15:15:15 INFO - 'USER': 'cltbld', 15:15:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:15 INFO - '_': '/tools/buildbot/bin/python'} 15:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 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)) 15:15:15 INFO - Cleaning up... 15:15:15 INFO - Return code: 0 15:15:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:15:15 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')]} 15:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:15 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')]} 15:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:15 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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:15:15 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 15:15:15 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 15:15:15 INFO - Using env: {'DISPLAY': ':0', 15:15:15 INFO - 'HOME': '/home/cltbld', 15:15:15 INFO - 'LANG': 'en_US.UTF-8', 15:15:15 INFO - 'LANGUAGE': 'en_US:en', 15:15:15 INFO - 'LOGNAME': 'cltbld', 15:15:15 INFO - 'MAIL': '/var/mail/cltbld', 15:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:15 INFO - 'MOZ_NO_REMOTE': '1', 15:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:15 INFO - 'NO_EM_RESTART': '1', 15:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:15 INFO - 'PWD': '/builds/slave/test', 15:15:15 INFO - 'SHELL': '/bin/bash', 15:15:15 INFO - 'SHLVL': '1', 15:15:15 INFO - 'TERM': 'linux', 15:15:15 INFO - 'TMOUT': '86400', 15:15:15 INFO - 'USER': 'cltbld', 15:15:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:15 INFO - '_': '/tools/buildbot/bin/python'} 15:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:15 INFO - Downloading/unpacking jsonschema 15:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:15:17 INFO - Downloading/unpacking functools32 (from jsonschema) 15:15:17 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 15:15:17 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 15:15:17 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 15:15:17 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 15:15:17 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 15:15:17 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 15:15:17 INFO - Downloading functools32-3.2.3-2.tar.gz 15:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:15:17 INFO - warning: no files found matching '*.txt' 15:15:17 INFO - no previously-included directories found matching 'build' 15:15:17 INFO - no previously-included directories found matching 'dist' 15:15:17 INFO - no previously-included directories found matching '.git*' 15:15:17 INFO - Installing collected packages: jsonschema, functools32 15:15:17 INFO - Running setup.py install for functools32 15:15:17 INFO - warning: no files found matching '*.txt' 15:15:17 INFO - no previously-included directories found matching 'build' 15:15:17 INFO - no previously-included directories found matching 'dist' 15:15:17 INFO - no previously-included directories found matching '.git*' 15:15:17 INFO - Successfully installed jsonschema functools32 15:15:17 INFO - Cleaning up... 15:15:17 INFO - Return code: 0 15:15:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:15:17 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')]} 15:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:17 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')]} 15:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:17 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 0x7f8a7bcecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', '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 15:15:17 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 15:15:17 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 15:15:17 INFO - Using env: {'DISPLAY': ':0', 15:15:17 INFO - 'HOME': '/home/cltbld', 15:15:17 INFO - 'LANG': 'en_US.UTF-8', 15:15:17 INFO - 'LANGUAGE': 'en_US:en', 15:15:17 INFO - 'LOGNAME': 'cltbld', 15:15:17 INFO - 'MAIL': '/var/mail/cltbld', 15:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:17 INFO - 'MOZ_NO_REMOTE': '1', 15:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:17 INFO - 'NO_EM_RESTART': '1', 15:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:17 INFO - 'PWD': '/builds/slave/test', 15:15:17 INFO - 'SHELL': '/bin/bash', 15:15:17 INFO - 'SHLVL': '1', 15:15:17 INFO - 'TERM': 'linux', 15:15:17 INFO - 'TMOUT': '86400', 15:15:17 INFO - 'USER': 'cltbld', 15:15:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:17 INFO - '_': '/tools/buildbot/bin/python'} 15:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:18 INFO - Downloading/unpacking flake8 15:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:15:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:15:19 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 15:15:19 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 15:15:19 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 15:15:19 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 15:15:19 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 15:15:19 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 15:15:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:15:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:15:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:15:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:15:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:15:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:15:20 INFO - no previously-included directories found matching 'docs/_build' 15:15:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:15:20 INFO - Running setup.py install for pep8 15:15:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:15:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:15:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:15:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:15:20 INFO - no previously-included directories found matching 'docs/_build' 15:15:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:15:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:15:20 INFO - Cleaning up... 15:15:20 INFO - Return code: 0 15:15:20 INFO - Running post-action listener: _resource_record_post_action 15:15:20 INFO - Running post-action listener: _start_resource_monitoring 15:15:20 INFO - Starting resource monitoring. 15:15:20 INFO - ##### 15:15:20 INFO - ##### Running install step. 15:15:20 INFO - ##### 15:15:20 INFO - Running pre-action listener: _resource_record_pre_action 15:15:20 INFO - Running main action method: install 15:15:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:21 INFO - Reading from file tmpfile_stdout 15:15:21 INFO - Detecting whether we're running mozinstall >=1.0... 15:15:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:15:21 INFO - Reading from file tmpfile_stdout 15:15:21 INFO - Output received: 15:15:21 INFO - Usage: mozinstall [options] installer 15:15:21 INFO - Options: 15:15:21 INFO - -h, --help show this help message and exit 15:15:21 INFO - -d DEST, --destination=DEST 15:15:21 INFO - Directory to install application into. [default: 15:15:21 INFO - "/builds/slave/test"] 15:15:21 INFO - --app=APP Application being installed. [default: firefox] 15:15:21 INFO - mkdir: /builds/slave/test/build/application 15:15:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:15:36 INFO - Reading from file tmpfile_stdout 15:15:36 INFO - Output received: 15:15:36 INFO - /builds/slave/test/build/application/firefox/firefox 15:15:36 INFO - Running post-action listener: _resource_record_post_action 15:15:36 INFO - ##### 15:15:36 INFO - ##### Running run-tests step. 15:15:36 INFO - ##### 15:15:36 INFO - Running pre-action listener: _resource_record_pre_action 15:15:36 INFO - Running main action method: run_tests 15:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:15:36 INFO - Python 2.7.3 15:15:36 INFO - Return code: 0 15:15:36 INFO - grabbing minidump binary from tooltool 15:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:36 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeca640>, '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 0xecb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:15:36 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 15:15:36 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 15:15:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:15:36 INFO - Return code: 0 15:15:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:15:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:15:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:15:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:15:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:15:37 INFO - Return code: 0 15:15:37 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/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 15:15:37 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/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 15:15:37 INFO - Using env: {'DISPLAY': ':0', 15:15:37 INFO - 'HOME': '/home/cltbld', 15:15:37 INFO - 'LANG': 'en_US.UTF-8', 15:15:37 INFO - 'LANGUAGE': 'en_US:en', 15:15:37 INFO - 'LOGNAME': 'cltbld', 15:15:37 INFO - 'MAIL': '/var/mail/cltbld', 15:15:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:15:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:37 INFO - 'MOZ_NO_REMOTE': '1', 15:15:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:37 INFO - 'NO_EM_RESTART': '1', 15:15:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:37 INFO - 'PWD': '/builds/slave/test', 15:15:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:15:37 INFO - 'SHELL': '/bin/bash', 15:15:37 INFO - 'SHLVL': '1', 15:15:37 INFO - 'TERM': 'linux', 15:15:37 INFO - 'TMOUT': '86400', 15:15:37 INFO - 'USER': 'cltbld', 15:15:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176', 15:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:37 INFO - '_': '/tools/buildbot/bin/python'} 15:15:37 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/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 15:15:38 INFO - mozversion application_buildid: 20160414144949 15:15:38 INFO - mozversion application_changeset: 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b 15:15:38 INFO - mozversion application_display_name: Nightly 15:15:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:15:38 INFO - mozversion application_name: Firefox 15:15:38 INFO - mozversion application_remotingname: firefox 15:15:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:15:38 INFO - mozversion application_vendor: Mozilla 15:15:38 INFO - mozversion application_version: 48.0a1 15:15:38 INFO - mozversion platform_buildid: 20160414144949 15:15:38 INFO - mozversion platform_changeset: 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b 15:15:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:15:38 INFO - mozversion platform_version: 48.0a1 15:15:38 INFO - using testdate: 1460672138 15:15:38 INFO - actual date: 1460672138 15:15:38 INFO - starting webserver on 'localhost:54273' 15:15:38 INFO - SUITE-START | Running 2 tests 15:15:38 INFO - TEST-START | dromaeo_css 15:15:38 INFO - operating with platform_type : linux_ 15:15:38 INFO - Initialising browser for dromaeo_css test... 15:15:38 INFO - TEST-INFO | started process 3886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNRoWRs/profile http://localhost:54273/getInfo.html) 15:15:42 INFO - PROCESS | 3886 | 15:15:42 INFO - PROCESS | 3886 | (process:3956): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:15:42 INFO - PROCESS | 3886 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:15:43 INFO - PROCESS | 3886 | __metrics Screen width/height:1600/1200 15:15:43 INFO - PROCESS | 3886 | colorDepth:24 15:15:43 INFO - PROCESS | 3886 | Browser inner width/height: 1024/697 15:15:43 INFO - PROCESS | 3886 | __metrics 15:15:43 ERROR - PROCESS | 3886 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:15:44 INFO - TEST-INFO | 3886: exit 0 15:15:44 INFO - Browser initialized. 15:15:44 INFO - Running cycle 1/1 for dromaeo_css test... 15:15:44 INFO - TEST-INFO | started process 4007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNRoWRs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:46 INFO - PROCESS | 4007 | 15:15:46 INFO - PROCESS | 4007 | (process:4066): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:15:56 INFO - PROCESS | 4007 | RSS: Main: 164315136 15:15:56 INFO - PROCESS | 4007 | 15:16:46 INFO - PROCESS | 4007 | 1460672206276 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] 15:18:58 INFO - PROCESS | 4007 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54273/tests/dromaeo/cssquery-ext.html) 15:18:59 INFO - PROCESS | 4007 | RSS: Main: 168460288 15:18:59 INFO - PROCESS | 4007 | 15:22:01 INFO - PROCESS | 4007 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-ext.html (next: http://localhost:54273/tests/dromaeo/cssquery-jquery.html) 15:22:02 INFO - PROCESS | 4007 | RSS: Main: 167424000 15:22:02 INFO - PROCESS | 4007 | 15:25:04 INFO - PROCESS | 4007 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54273/tests/dromaeo/cssquery-mootools.html) 15:25:04 INFO - PROCESS | 4007 | RSS: Main: 166600704 15:25:04 INFO - PROCESS | 4007 | 15:28:06 INFO - PROCESS | 4007 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54273/tests/dromaeo/cssquery-prototype.html) 15:28:07 INFO - PROCESS | 4007 | RSS: Main: 164397056 15:28:07 INFO - PROCESS | 4007 | 15:31:09 INFO - PROCESS | 4007 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54273/tests/dromaeo/cssquery-yui.html) 15:31:10 INFO - PROCESS | 4007 | RSS: Main: 165203968 15:31:10 INFO - PROCESS | 4007 | 15:34:12 INFO - PROCESS | 4007 | Cycle 1(1): loaded http://localhost:54273/tests/dromaeo/cssquery-yui.html (next: http://localhost:54273/tests/dromaeo/cssquery-dojo.html) 15:34:13 INFO - PROCESS | 4007 | RSS: Main: 167780352 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - PROCESS | 4007 | __start_tp_report 15:34:13 INFO - PROCESS | 4007 | _x_x_mozilla_page_load 15:34:13 INFO - PROCESS | 4007 | _x_x_mozilla_page_load_details 15:34:13 INFO - PROCESS | 4007 | |i|pagename|runs| 15:34:13 INFO - PROCESS | 4007 | |0;dojo.html;2636.2486691292984;2713.728627137286;2754.449110177965;2761.7514423701878;2774.112284069096;4738.194506933821;4782.976085119578;4803.087413391453;4812.4225092988845;4850.490698476662;4692.882677933045;4835.830745923893;4845.1763200255955;4855.902881942359;4902.43621983472;4333.479982402117;4356.172327257811;4430.313301438282;4435.112977404516;4456.086502267028;4333.848315308965;4530.886727831814;4537.137943790685;4573.176828170928;4577.29051996941;4315.741055536678;4393.319035549495;4396.780160991938;4440.977795111036;4503.48209955856;4320.092780516095;4353.542877997828;4410.62509686677;4419.668524860616;4449.199144154051;4387.122575484884;4425.800838962255;4433.179861725559;4439.2675208590545;4460.085682435093;4616.492185859553;4681.274402467623;4701.294805779126;4703;4704.317873908299;5217.060929032773;5224.947750522484;5240.371155461331;5251.52736253739;5282.788688452496;5147.099257629937;5241.213817927303;5242.606804489678;5266.104762190437;5312.814051508218;4591.7244965301525;4783.521647835189;4790.473047964721;4834.226523756182;4850.320955066293;5281.234221037928;5313.203019547099;5356.625036247426;5359.035373632783;5374.167004114369;5083.949160508348;5087.567556757643;5102;5107.33604631403;5147.6911385317;4969.776360063805;5091.1090559152;5163.122269214243;5164.147915593885;5202.713850738246;4924.433690125681;4999.500049995044;5023.673461225008;5028.698278103326;5032.6980381177245;5017.9247311290355;5022.447530771612;5034.194528875362;5034.521720436553;5036.169032109661;4287.3140297552245;4299.903524601269;4326.913461730811;4331.328644060176;4373.868783936487;3770.2647983643474;3796.088938654703;3820.6943444524372;3827.158025234444;3847.076701591598;4403.3174857897075;4460.955390446119;4483.887902802456;4494.415725955605;4542.591166795004;5037.722925239147;5084.3898732152375;5110.948890511122;5123.129068058439;5133.23001549763;4458.576435238647;4471.955280447219;4478.596926276586;4484.730916145042;4484.9103017940115;4504.166729155117;4582.24392975162;4585;4589.151007063704;4630.745309008037;4727.2909063640045;4779.30700048498;4788.856334309976;4805.927911081407;4836.927446088382;5127.2052831811125;5142.408623008402;5154.871128221825;5158.148905430562;5181.455947125648;4653;4842.225243960949;4861.586765125004;4873.975630121827;4904.6566740327835;5021.071101846024;5047.369078865142;5047.570956468594;5065.214891691794;5099.6685215460875;5111.05445492585;5111.361079865017;5112.079825631422;5125.564327032095;5127.717975511383;4752.9287060694805;4880.1215781159735;4902.093112774148;4939.777710002986;4967.950320496749;4976.950230497649;5043.067032598981;5048.167052436307;5063.392392912874;5080.26336181259;4876.073546026244;4909.729964851967;4928.457869634409;4928.926066109083;4929.482404347492;4945.77744001528;5030.773615187252;5040.521150490697;5041.344625198701;5088.6946783193125;4917.041176970456;4964.975175124101;4979.029089327546;4989.775460104232;4992.475790042138 15:34:13 INFO - PROCESS | 4007 | |1;ext.html;560.9663420194788;596.5078809981765;607.8632307730761;614.1187396086615;635.75523423482;35253.2949341013;36255.4561681575;36508;36596.634033659655;36770.080747981345;37187.4421883672;37735.62264377355;37750.43374349387;37986.62013379866;38044.42933355995;7779.727709530168;7940.880886786703;7952.562609056499;7965.044194696645;7979.122296547375;7818.45270831042;7909.762707118795;7930.762077137695;7957.124716281204;7961.1242763295995;7895.802604934894;7946.920530794705;7961.124276329628;7978.561179135145;7982.082060563022;7841.0982736985125;7879.054513458393;7920.52476851385;7945.086315073754;7966.283034526862;7825.804354891174;7888.329491993188;7922.36621070313;7928.920710792876;7942.722004729807;33815.83092084524;33964.66035339639;33982.83008584941;34149;34226.657733422595;2979.567962645426;3102.705243001911;3110.5645209670665;3119.111053349807;3128.264857758425;26541.867290663617;26741.866290668615;26947.595786063226;26951.32621684454;27091.593626095626;3330.600327960636;3341.8830340937952;3429.742769292288;3476.5480487536456;3504.3692135415613;227780;228234;229523;230218.84890575608;230751;33221.50167747486;52069.739651301505;52779.20831187535;52810.47189528133;52854.73572632112;31675.41622918845;31681.841590791897;31814.04557863268;31880;31917;13238.53665121716;13429.597112086652;13438.462461501626;13516.12145210578;13556.661083472993;10327.173826093895;10366.585336586451;10368.326058806153;10375.221858360654;10404.739881502872;7941.126476087626;8134.837303253902;8191.443625711215;8195.303399211134;8234.300084492765;3242.4974129010043;3248.642649308574;3256.967430325714;3291.654376290503;3315.7015868571943;925.2644147902433;1007.5717819926502;1021.2544842265188;1040.5369610523244;1062.8671416072991;27474;27971.58042629362;28082.85958570235;28184.577231341547;28562;1007.219404961161;1023.2530252915413;1026.6355443817486;1037.4345981440133;1048.4757621189406;14783.778243326144;14968.401263949538;15029.398824047134;15376.154311512973;15448.382064717285;315933;319632;325052;325549;326310;48070.75964620154;48208.517914820404;48285.75857120692;48374.27438588354;48505;1212.2423485321674;1248.3633346992917;1256.378092844048;1285.9228446293253;1292.2440372382073;26096.478070438865;27672.861635691694;27681.169564913085;27761.58357624597;28106;41061.1787764249;41210.587894120676;41216;41630;41764;298681;301874;302786;303185;303208;25406.364840878385;25659.615105773802;25688.229353119437;25741.3564660885;38605.42091868568;36748.81625591855;36925.63074369329;37539.06152346213;37632.247355053296;38017.4297385545;33025.33949321048;34665.48001779925;34810.82594587011;34828.65171348355;35060.298794024486;33794.831025844716;34482.482762758074;34486;34786;35402.64597353993;31286.843565782026;34861.30277394489;35377;36566.81716591506;36983.8150809255;28730.712692872803;29630.259243518223;29691.257718557208;29705.405891882474;31440.371192575563;24569.385765356008;24659.506809863342;24704.752952470244;25055.123070693167;25211.369715757253 15:34:13 INFO - PROCESS | 4007 | |2;jquery.html;363.6563447542073;369.6543731610944;372.5752641988134;380.4065657574186;389.3595036165508;15892.364305427784;16298.918505407471;16518.25667844947;16568.834311656865;16878.240479178436;15072.246387680627;15228.619284517892;15271.694566108672;15385.92307038466;15872.84127158728;5013.398392192933;5106.412762532301;5158.174692049273;5268.394134674504;5274.498922602346;3722.4788529605876;5100.132977393833;5701.429857014306;6038.5471089668235;6061.030235162375;5964.1650168976375;5967.104934259874;5985.820425387224;5989.1016347548;6028.7588496460085;5878.911816322759;6028.246469191351;6072.332043475259;6073.878522429571;6107.114468402079;5105.489451054902;5284.682919024871;5294.41761406245;5296.523312901857;5301.946980530184;11510.712232194179;12199.878001219962;20350.28773992918;20623;20668.276610318717;1879.2952642758964;1997.9600407991904;2018.4584684459965;2040.4898775306174;2470.2465747946867;8928.73213803587;9221.53892305382;9317.627294908196;9479.146876781122;9688.46713430761;1649.6205872649239;1746.1269365317341;1756.956076098095;1760.6126652136509;1777.742227377036;67949;70365.64817175882;70394;71516.28483715201;71693.641531792;9766.316357855025;9838.65564705232;9946.602135914627;10040.748981275381;10051.949740251252;13438.193708377528;13441.462341506425;13448;13462.057655964185;13521.797173042412;6685.565438246498;6790;6872.931270687229;6905.620190889549;6972.895406568906;6383.36166383358;6415.326390728999;6560.573562718408;6581.111549940792;6581.670916454158;4215.388768628593;4278.657707383401;4308.80610372534;4410;4530.569595888385;1651.719207734688;1694.83899029592;1821.639376651612;1826.5524946387955;1877.6620208362353;899.6581299106298;938.8638647396226;957.9664711735056;1002.3935519010894;1025.958961641526;16293.592660183353;16715.080670563235;16715.832841671672;16998.575035623962;17102.743458848126;899.3839220134229;910.5538286239828;913.5295322908707;919.2645883293338;939.2579861909015;9178;9188.219001384823;9268.351215414856;9513.714588562216;9561.187299079656;292139;365359;369928;373974;374221;81237.59381203057;85468.57265713756;85839.57080214685;86030;87897.56051219703;963.1620490173594;994.328828041055;1001.0190013786384;1004.3923426326967;1007;15451.768223476432;15474.226288685746;15571;15605.531834044998;15954.202289885692;35839;36486.817565912;37161.62838371582;37300.253994920495;37668.81165594154;50026.74986625044;50586.49413505965;50974;51782;52393.7380313096;4807.735574543294;7292.869605211201;7469.365103966224;7711.961440192763;7780.610969451392;11268;11334.263272887236;11550.59572914944;11636.41817909118;11891.335213070004;9595.520223988913;10226.693199204035;10342.120919721909;10368;10767.246292759432;10226.977302269714;10276.948615257175;10339.468384414302;10347.068763810992;10494.632687855888;10307;10440.738981525523;10689.465526723478;10792.082672972885;10819.350838949687;7566.713658677928;7646;7674.424418168772;7823.374130069467;7891.881621775793;9756.26827987918;10312.175025997753;10392.688219353431;10476.16190704757;10710.089642380484 15:34:13 INFO - PROCESS | 4007 | |3;mootools.html;1453.549399686097;1472.6171195489173;1587.611035296352;1767.699491086515;1781.1094452773614;6906.5510741801745;7607.467477276593;7636.503627264224;7894.407919406039;7940.960295198523;7640.274173953466;7678.9232107679045;7713.460057795943;7766.572838493895;7813.765587032384;2121.416610432128;2165.8592191507582;2179.2699445685716;2180.4875854174256;2185.4754858833844;2158.935231943044;2186.628273193553;2195.3084778294788;2199.846010779246;2216.5899308627877;2168.945776355588;2181.0512427094186;2191.024993877725;2191.1783081344497;2202.537467131904;2158.6761985702115;2165.1123039553786;2166.8591541549827;2168.1219106261988;2168.3711723600136;2145.9785402145935;2184.8689078655175;2186.967195492069;2188.595109904657;2190.726159230096;7876.527408355517;7936.6825326986855;7959.12449630546;7994.160613135595;8009.719659811937;4472.619827314682;4685.461171965234;4701.694389864648;4713.740744259065;4748.928766068511;2984.3136078701805;3008.8796448142266;3036.483797754365;3047.08587423772;3143.387039527293;972.1348000279756;977.8386566216566;979.794243208927;992.9851052234222;1011.5245834457793;10584.788304233949;10651.467426628638;10748.516316765765;10759.30064545802;10793.460326983619;4158.8336466540995;4208.116295577963;4346.152500262482;4358.171947329997;4389.122175564899;9120.270378369847;9191.862122068174;9257.490838003974;9257.583408746623;9269.073092690676;4606.88482787933;4615.376924115269;4616.76916154191;4619;4641.837535686234;3796.5064541609413;4200.915981680349;4229;4249.022724773319;4288;3643.6720695137565;3768.246350729865;3806.7525610835205;3810.2950954073585;3813.370793819044;1217.4947396830394;1264.3930913161735;1269.4224128021729;1270.9872901271053;1271.262667652759;762.4472257613186;913.5295322908707;932.7528205025674;932.9207017403596;941.9952900235455;5599.720013999366;5610.158476228598;5639.746211420414;5733.111367738007;5797.536197104221;916.1388295002677;925.2690374603987;939.8402271613842;949.4018768176005;965.1410244882061;3733.5146430964346;3810.7904065276675;3814.275287695329;3843.8078096095082;3859.208862183246;9187.954060229657;9497.667581634609;9570.473623950611;9583.472908990072;9597.280203984728;9677.37097088687;9744.220462362993;9770.462624555717;9783.315167938319;9849.803003939882;7347.265273472717;7487.66305516253;7516.812079697942;7523.623818809147;7536.359409450149;5233.162693968947;5263.157894736823;5429.864253393696;5505.201745746925;5605.019121653776;8970.596323165604;9113.270938324786;9207.125323094295;9237;9339.252859771337;8978.490594319066;9169.77075573116;9193.632254709737;9314.72055838326;9365.765855853659;6070.271567411763;6736.4947628929;6743.123393958754;6820.283870193558;6952.339527744856;7197.1363436387965;7247.094113235846;7257.891131633135;7282.308180722823;7318.707251709872;6609.702563384755;6861.382475577222;6891.896621550581;6896.862062758616;7011.228764835966;6727.596344219362;6732.427743641845;6773.864522709617;6806.82982925411;6839.829004274734;6104.145419641342;6351.237851457855;6462.838429039123;6467.741290348334;6482.935170648233;4737.644676649196;4743.45450273223;4813.326134341265;4818.903621927471;4885.975570122127;4681.368015317888;4709.105269998689;4734.029523947652;4748.05038992196;4766.261229509431 15:34:13 INFO - PROCESS | 4007 | |4;prototype.html;313.8132810977468;319.5476559039167;323.2661857583286;323.67470691954566;328.25649902969764;5376;5471.5349195318395;5474.26097476841;5479.479449452306;5500.42245564216;5381.273528073709;5397.784088636459;5401.3248343957;5406.270153529273;5417.295751552293;4004.7797371144575;4062.2078694654556;4166.916661666764;4193.601607847249;4198.475190601175;4182.53992060873;4200.873973780776;4211.831526738927;4212.304969680014;4217.430646862665;4186.183694179636;4192.413062171298;4192.517860446042;4193.475815523059;4194.0982688721915;4085.428040074377;4116.794160291974;4187.623113919762;4195.265828480019;4196.9370459443135;3649.872254471081;3679.963200367989;3683.079230192452;3688.5942546319884;3706.129059670975;5127.102757017545;5139.383274007106;5164;5186.170212765977;5191.454897235812;4726.149293127236;4860.635452341088;4865.732384718839;4866.245731911559;4869.050535145648;5660.801871934463;5669;5675.886482270332;5690.3456102548325;5698.572607054446;4062.289099407592;4068.3897415387632;4068.413318805668;4078.4086307485545;4086.264472394968;5762.769489220426;5963.373845746221;5986.161937328778;5996.400359964013;5996.8500787480225;4162.895927601834;4190.182914331737;4190.224808410454;4198.076423186894;4202.97027228331;4239.533651298355;4248.638865696388;4253.617174454314;4256.489221293465;4271.829126834954;4449.377087207794;4726.621870250372;4823.710577365299;4833.081714474239;4858.562729354375;5638.33669067626;5689.288838895138;5691;5696.544276457874;5701.116326969326;1417.2701058954647;1428.0574820618342;1442.4086124688827;1447.1317209674112;1447.7611194152846;898.5462341517623;936.4677516576251;944.9291303152291;953.5947222430578;972.7519482531909;4960.751962401938;4975.925361119586;4991.226359914219;5007.924881126786;5010.248462730619;5735.243415562813;5813.941860581424;5814.680192589363;5815.418458154235;5828.446297601721;4879.4876537963;4885.41375034991;4950.727709975914;4952.133376659071;4982.153033984231;3103.997921340768;3115.158907095117;3116.096332063676;3147.7009684079976;3147.7324427423923;5366.812161574326;5406.621536492407;5430.51125398716;5437.592180586472;5443.074677304868;5805.36141024487;5927.73325200367;5961.821145365646;5965.701714914237;5969.731362088716;5385.299911011543;5392.786623009792;5454.91817622736;5456.017916774939;5457.836264912059;5632.493075623213;5766.8846623066465;5789.594728368974;5795.710214489343;5851.970740146272;5605.103183490622;5655.745491452977;5669.489745922887;5670.291213598301;5680.77276908919;5460.645058071213;5466.453354664661;5473.808416705396;5490.6431081979545;5492;3862.9806850965565;4068.0846809467635;4081.0817566047403;4081.6122468365456;4087.1212689271947;5874.911876321944;5880.294364676266;5890.7349169288345;5915.852103697442;5926.081457374114;5651.773929042793;5669.6314739541795;5682.573806964411;5694.373618902;5712.742926568231;5522.723863806874;5614.85962850932;5705.572082093777;5711.714414279187;5715.742791574472;5341.599380046589;5549.889002220014;5585.776568937197;5603.467670571289;5620.269364982526;5589.972050139723;5668.404817494104;5684.261046063985;5712.600117991867;5756;5539.19681646151;5553;5638;5667.838093190803;5671.6029877909805 15:34:13 INFO - PROCESS | 4007 | |5;yui.html;724.5362967700669;731.8463122744223;733.8495608400278;734.5959722152814;750.9023826902502;11793.941030294858;11879.34663593502;11928.522859085626;12128.575499857496;12148.453319600618;11708.882911170886;11934.64196074117;11967.880321196786;12092.395380230997;12095;642.2164958750317;793.6706266899258;797.7606717984596;807.0799288810761;807.6365635464065;811.8782182672617;812.252727490707;816.0859836982588;816.408104124508;816.7508909782514;852.842224188524;853.6628031927385;853.7054716122959;856.3620103023256;857.7726902370877;850.5832142250284;850.9872351914727;851.4295422067199;853.0531110467376;854.2525290370926;624.7282432142033;627.3569591169042;627.4008322052429;629.7418058595954;630.1776182082381;12170.75658486834;12214.816777748341;12228.755424891542;12287.93856030714;12311.69220769479;12816.359182040955;12873;13201.735965280737;13223.801642975362;13535.458581656721;9984.750381240454;10065.396076235449;10108.797824043479;10142.442165680885;10290.43402612856;3339.415602269593;3365.3437579671972;3428.5200071989943;3433.6909678129086;3450.8447119879415;42299.365509517076;44617.10765784699;44940.3258951116;45010.94901458884;45057.77471112656;9794.608215671436;10143.34068285559;10265.74335641615;10329.793404132026;10369;17187;17189.226484808212;17208.827911720724;17228.397006104726;17282.82717172812;6797.762078327334;6800.455963522906;6810.795676129724;6857.348551887562;6970.442364610819;3730.776153430803;3814.1608846053823;3816.255830113101;3820.9617903821163;3826.613123939442;2870.095919785261;2962.822230666167;2979.433907557557;2984.313607870202;2987.223321936269;546.1943633141085;546.9206964990134;553.3415235869303;558.4499268220799;566.1790403914341;581.8516278349078;595.7110801261384;603.5322624965687;619.4734475695623;627.7206643043893;7172.892406613905;7653.3494652954005;7686.461947663722;7798.649060792278;8055.677772889136;463.5133110234241;488.872893047803;537.8305833662383;565.4006752842;573.4695406748824;3499.2651543176216;3595.982020089883;3639.072354372527;3661.469086982426;3663.0476076220375;45760.54239457563;51298;55157.724211378685;55809.44190558124;55828.44171558314;40773.38839917404;41232;41464.37803432951;42394.57605423968;43938.78030609826;38858;39718.80140599279;39938.60061399349;40622.79688601538;41676.37485437721;7545.811354715956;7786.26030527099;7803.765887023172;7861.724839630586;8078.5960701963495;29065.564016539345;29072.563911541765;29286.560701589067;29432.852835735684;29760;32364.676353236166;32482.187945301557;34789.13027174341;37494.43758343573;38830.4175437363;10068.69793906184;10313;10452.425116618355;10600.310979786289;10795.244332896622;10738.677839664822;10739.946300268448;10793.29843560166;10967.122630189726;10989.560417583207;10589.735256618646;10682.09202217789;10778.885935282677;10867.565297388332;11280.774384512428;10449.21630877672;10860.945695271474;10995.560177593126;11360.943195283971;11458.255213411101;11036.337819730841;11303.943480282545;11321.09431245482;11334.093272538343;11446;9753.80492390134;9834.360766550151;9915;10089.89910100919;10102.141317988053;9558.95220523893;9620.75948101303;9843.60625574969;9919.702408927744;9966.50167491637 15:34:13 INFO - PROCESS | 4007 | __end_tp_report 15:34:13 INFO - PROCESS | 4007 | __start_cc_report 15:34:13 INFO - PROCESS | 4007 | _x_x_mozilla_cycle_collect,381 15:34:13 INFO - PROCESS | 4007 | __end_cc_report 15:34:13 INFO - PROCESS | 4007 | __startTimestamp1460673253181__endTimestamp 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - PROCESS | 4007 | ------- Summary: start ------- 15:34:13 INFO - PROCESS | 4007 | Number of tests: 6 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - PROCESS | 4007 | [#0] dojo.html Cycles:165 Average:4744.62 Median:4861.59 stddev:492.42 (10.1%) stddev-sans-first:465.33 15:34:13 INFO - PROCESS | 4007 | Values: 2636.2 2713.7 2754.4 2761.8 2774.1 4738.2 4783.0 4803.1 4812.4 4850.5 4692.9 4835.8 4845.2 4855.9 4902.4 4333.5 4356.2 4430.3 4435.1 4456.1 4333.8 4530.9 4537.1 4573.2 4577.3 4315.7 4393.3 4396.8 4441.0 4503.5 4320.1 4353.5 4410.6 4419.7 4449.2 4387.1 4425.8 4433.2 4439.3 4460.1 4616.5 4681.3 4701.3 4703.0 4704.3 5217.1 5224.9 5240.4 5251.5 5282.8 5147.1 5241.2 5242.6 5266.1 5312.8 4591.7 4783.5 4790.5 4834.2 4850.3 5281.2 5313.2 5356.6 5359.0 5374.2 5083.9 5087.6 5102.0 5107.3 5147.7 4969.8 5091.1 5163.1 5164.1 5202.7 4924.4 4999.5 5023.7 5028.7 5032.7 5017.9 5022.4 5034.2 5034.5 5036.2 4287.3 4299.9 4326.9 4331.3 4373.9 3770.3 3796.1 3820.7 3827.2 3847.1 4403.3 4461.0 4483.9 4494.4 4542.6 5037.7 5084.4 5110.9 5123.1 5133.2 4458.6 4472.0 4478.6 4484.7 4484.9 4504.2 4582.2 4585.0 4589.2 4630.7 4727.3 4779.3 4788.9 4805.9 4836.9 5127.2 5142.4 5154.9 5158.1 5181.5 4653.0 4842.2 4861.6 4874.0 4904.7 5021.1 5047.4 5047.6 5065.2 5099.7 5111.1 5111.4 5112.1 5125.6 5127.7 4752.9 4880.1 4902.1 4939.8 4968.0 4977.0 5043.1 5048.2 5063.4 5080.3 4876.1 4909.7 4928.5 4928.9 4929.5 4945.8 5030.8 5040.5 5041.3 5088.7 4917.0 4965.0 4979.0 4989.8 4992.5 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - PROCESS | 4007 | [#1] ext.html Cycles:180 Average:42751.97 Median:18276.05 stddev:75470.03 (412.9%) stddev-sans-first:75615.26 15:34:13 INFO - PROCESS | 4007 | Values: 561.0 596.5 607.9 614.1 635.8 35253.3 36255.5 36508.0 36596.6 36770.1 37187.4 37735.6 37750.4 37986.6 38044.4 7779.7 7940.9 7952.6 7965.0 7979.1 7818.5 7909.8 7930.8 7957.1 7961.1 7895.8 7946.9 7961.1 7978.6 7982.1 7841.1 7879.1 7920.5 7945.1 7966.3 7825.8 7888.3 7922.4 7928.9 7942.7 33815.8 33964.7 33982.8 34149.0 34226.7 2979.6 3102.7 3110.6 3119.1 3128.3 26541.9 26741.9 26947.6 26951.3 27091.6 3330.6 3341.9 3429.7 3476.5 3504.4 227780.0 228234.0 229523.0 230218.8 230751.0 33221.5 52069.7 52779.2 52810.5 52854.7 31675.4 31681.8 31814.0 31880.0 31917.0 13238.5 13429.6 13438.5 13516.1 13556.7 10327.2 10366.6 10368.3 10375.2 10404.7 7941.1 8134.8 8191.4 8195.3 8234.3 3242.5 3248.6 3257.0 3291.7 3315.7 925.3 1007.6 1021.3 1040.5 1062.9 27474.0 27971.6 28082.9 28184.6 28562.0 1007.2 1023.3 1026.6 1037.4 1048.5 14783.8 14968.4 15029.4 15376.2 15448.4 315933.0 319632.0 325052.0 325549.0 326310.0 48070.8 48208.5 48285.8 48374.3 48505.0 1212.2 1248.4 1256.4 1285.9 1292.2 26096.5 27672.9 27681.2 27761.6 28106.0 41061.2 41210.6 41216.0 41630.0 41764.0 298681.0 301874.0 302786.0 303185.0 303208.0 25406.4 25659.6 25688.2 25741.4 38605.4 36748.8 36925.6 37539.1 37632.2 38017.4 33025.3 34665.5 34810.8 34828.7 35060.3 33794.8 34482.5 34486.0 34786.0 35402.6 31286.8 34861.3 35377.0 36566.8 36983.8 28730.7 29630.3 29691.3 29705.4 31440.4 24569.4 24659.5 24704.8 25055.1 25211.4 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - PROCESS | 4007 | [#2] jquery.html Cycles:180 Average:23451.78 Median:2302.37 stddev:59391.07 (2579.6%) stddev-sans-first:59532.38 15:34:13 INFO - PROCESS | 4007 | Values: 363.7 369.7 372.6 380.4 389.4 15892.4 16298.9 16518.3 16568.8 16878.2 15072.2 15228.6 15271.7 15385.9 15872.8 5013.4 5106.4 5158.2 5268.4 5274.5 3722.5 5100.1 5701.4 6038.5 6061.0 5964.2 5967.1 5985.8 5989.1 6028.8 5878.9 6028.2 6072.3 6073.9 6107.1 5105.5 5284.7 5294.4 5296.5 5301.9 11510.7 12199.9 20350.3 20623.0 20668.3 1879.3 1998.0 2018.5 2040.5 2470.2 8928.7 9221.5 9317.6 9479.1 9688.5 1649.6 1746.1 1757.0 1760.6 1777.7 67949.0 70365.6 70394.0 71516.3 71693.6 9766.3 9838.7 9946.6 10040.7 10051.9 13438.2 13441.5 13448.0 13462.1 13521.8 6685.6 6790.0 6872.9 6905.6 6972.9 6383.4 6415.3 6560.6 6581.1 6581.7 4215.4 4278.7 4308.8 4410.0 4530.6 1651.7 1694.8 1821.6 1826.6 1877.7 899.7 938.9 958.0 1002.4 1026.0 16293.6 16715.1 16715.8 16998.6 17102.7 899.4 910.6 913.5 919.3 939.3 9178.0 9188.2 9268.4 9513.7 9561.2 292139.0 365359.0 369928.0 373974.0 374221.0 81237.6 85468.6 85839.6 86030.0 87897.6 963.2 994.3 1001.0 1004.4 1007.0 15451.8 15474.2 15571.0 15605.5 15954.2 35839.0 36486.8 37161.6 37300.3 37668.8 50026.7 50586.5 50974.0 51782.0 52393.7 4807.7 7292.9 7469.4 7712.0 7780.6 11268.0 11334.3 11550.6 11636.4 11891.3 9595.5 10226.7 10342.1 10368.0 10767.2 10227.0 10276.9 10339.5 10347.1 10494.6 10307.0 10440.7 10689.5 10792.1 10819.4 7566.7 7646.0 7674.4 7823.4 7891.9 9756.3 10312.2 10392.7 10476.2 10710.1 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - PROCESS | 4007 | [#3] mootools.html Cycles:180 Average:5216.46 Median:5602.37 stddev:2876.43 (51.3%) stddev-sans-first:2870.60 15:34:13 INFO - PROCESS | 4007 | Values: 1453.5 1472.6 1587.6 1767.7 1781.1 6906.6 7607.5 7636.5 7894.4 7941.0 7640.3 7678.9 7713.5 7766.6 7813.8 2121.4 2165.9 2179.3 2180.5 2185.5 2158.9 2186.6 2195.3 2199.8 2216.6 2168.9 2181.1 2191.0 2191.2 2202.5 2158.7 2165.1 2166.9 2168.1 2168.4 2146.0 2184.9 2187.0 2188.6 2190.7 7876.5 7936.7 7959.1 7994.2 8009.7 4472.6 4685.5 4701.7 4713.7 4748.9 2984.3 3008.9 3036.5 3047.1 3143.4 972.1 977.8 979.8 993.0 1011.5 10584.8 10651.5 10748.5 10759.3 10793.5 4158.8 4208.1 4346.2 4358.2 4389.1 9120.3 9191.9 9257.5 9257.6 9269.1 4606.9 4615.4 4616.8 4619.0 4641.8 3796.5 4200.9 4229.0 4249.0 4288.0 3643.7 3768.2 3806.8 3810.3 3813.4 1217.5 1264.4 1269.4 1271.0 1271.3 762.4 913.5 932.8 932.9 942.0 5599.7 5610.2 5639.7 5733.1 5797.5 916.1 925.3 939.8 949.4 965.1 3733.5 3810.8 3814.3 3843.8 3859.2 9188.0 9497.7 9570.5 9583.5 9597.3 9677.4 9744.2 9770.5 9783.3 9849.8 7347.3 7487.7 7516.8 7523.6 7536.4 5233.2 5263.2 5429.9 5505.2 5605.0 8970.6 9113.3 9207.1 9237.0 9339.3 8978.5 9169.8 9193.6 9314.7 9365.8 6070.3 6736.5 6743.1 6820.3 6952.3 7197.1 7247.1 7257.9 7282.3 7318.7 6609.7 6861.4 6891.9 6896.9 7011.2 6727.6 6732.4 6773.9 6806.8 6839.8 6104.1 6351.2 6462.8 6467.7 6482.9 4737.6 4743.5 4813.3 4818.9 4886.0 4681.4 4709.1 4734.0 4748.1 4766.3 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - PROCESS | 4007 | [#4] prototype.html Cycles:180 Average:4697.30 Median:5395.29 stddev:1369.24 (25.4%) stddev-sans-first:1332.96 15:34:13 INFO - PROCESS | 4007 | Values: 313.8 319.5 323.3 323.7 328.3 5376.0 5471.5 5474.3 5479.5 5500.4 5381.3 5397.8 5401.3 5406.3 5417.3 4004.8 4062.2 4166.9 4193.6 4198.5 4182.5 4200.9 4211.8 4212.3 4217.4 4186.2 4192.4 4192.5 4193.5 4194.1 4085.4 4116.8 4187.6 4195.3 4196.9 3649.9 3680.0 3683.1 3688.6 3706.1 5127.1 5139.4 5164.0 5186.2 5191.5 4726.1 4860.6 4865.7 4866.2 4869.1 5660.8 5669.0 5675.9 5690.3 5698.6 4062.3 4068.4 4068.4 4078.4 4086.3 5762.8 5963.4 5986.2 5996.4 5996.9 4162.9 4190.2 4190.2 4198.1 4203.0 4239.5 4248.6 4253.6 4256.5 4271.8 4449.4 4726.6 4823.7 4833.1 4858.6 5638.3 5689.3 5691.0 5696.5 5701.1 1417.3 1428.1 1442.4 1447.1 1447.8 898.5 936.5 944.9 953.6 972.8 4960.8 4975.9 4991.2 5007.9 5010.2 5735.2 5813.9 5814.7 5815.4 5828.4 4879.5 4885.4 4950.7 4952.1 4982.2 3104.0 3115.2 3116.1 3147.7 3147.7 5366.8 5406.6 5430.5 5437.6 5443.1 5805.4 5927.7 5961.8 5965.7 5969.7 5385.3 5392.8 5454.9 5456.0 5457.8 5632.5 5766.9 5789.6 5795.7 5852.0 5605.1 5655.7 5669.5 5670.3 5680.8 5460.6 5466.5 5473.8 5490.6 5492.0 3863.0 4068.1 4081.1 4081.6 4087.1 5874.9 5880.3 5890.7 5915.9 5926.1 5651.8 5669.6 5682.6 5694.4 5712.7 5522.7 5614.9 5705.6 5711.7 5715.7 5341.6 5549.9 5585.8 5603.5 5620.3 5590.0 5668.4 5684.3 5712.6 5756.0 5539.2 5553.0 5638.0 5667.8 5671.6 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - PROCESS | 4007 | [#5] yui.html Cycles:180 Average:12423.26 Median:39288.40 stddev:13797.08 (35.1%) stddev-sans-first:13807.82 15:34:13 INFO - PROCESS | 4007 | Values: 724.5 731.8 733.8 734.6 750.9 11793.9 11879.3 11928.5 12128.6 12148.5 11708.9 11934.6 11967.9 12092.4 12095.0 642.2 793.7 797.8 807.1 807.6 811.9 812.3 816.1 816.4 816.8 852.8 853.7 853.7 856.4 857.8 850.6 851.0 851.4 853.1 854.3 624.7 627.4 627.4 629.7 630.2 12170.8 12214.8 12228.8 12287.9 12311.7 12816.4 12873.0 13201.7 13223.8 13535.5 9984.8 10065.4 10108.8 10142.4 10290.4 3339.4 3365.3 3428.5 3433.7 3450.8 42299.4 44617.1 44940.3 45010.9 45057.8 9794.6 10143.3 10265.7 10329.8 10369.0 17187.0 17189.2 17208.8 17228.4 17282.8 6797.8 6800.5 6810.8 6857.3 6970.4 3730.8 3814.2 3816.3 3821.0 3826.6 2870.1 2962.8 2979.4 2984.3 2987.2 546.2 546.9 553.3 558.4 566.2 581.9 595.7 603.5 619.5 627.7 7172.9 7653.3 7686.5 7798.6 8055.7 463.5 488.9 537.8 565.4 573.5 3499.3 3596.0 3639.1 3661.5 3663.0 45760.5 51298.0 55157.7 55809.4 55828.4 40773.4 41232.0 41464.4 42394.6 43938.8 38858.0 39718.8 39938.6 40622.8 41676.4 7545.8 7786.3 7803.8 7861.7 8078.6 29065.6 29072.6 29286.6 29432.9 29760.0 32364.7 32482.2 34789.1 37494.4 38830.4 10068.7 10313.0 10452.4 10600.3 10795.2 10738.7 10739.9 10793.3 10967.1 10989.6 10589.7 10682.1 10778.9 10867.6 11280.8 10449.2 10860.9 10995.6 11360.9 11458.3 11036.3 11303.9 11321.1 11334.1 11446.0 9753.8 9834.4 9915.0 10089.9 10102.1 9559.0 9620.8 9843.6 9919.7 9966.5 15:34:13 INFO - PROCESS | 4007 | -------- Summary: end -------- 15:34:13 INFO - PROCESS | 4007 | 15:34:13 INFO - TEST-INFO | 4007: exit 0 15:34:13 INFO - TEST-OK | dromaeo_css | took 1115837ms 15:34:13 INFO - TEST-START | kraken 15:34:13 INFO - operating with platform_type : linux_ 15:34:13 INFO - Initialising browser for kraken test... 15:34:13 INFO - TEST-INFO | started process 4243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMlNoV/profile http://localhost:54273/getInfo.html) 15:34:17 INFO - PROCESS | 4243 | 15:34:17 INFO - PROCESS | 4243 | (process:4311): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:34:18 INFO - PROCESS | 4243 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:34:18 INFO - PROCESS | 4243 | __metrics Screen width/height:1600/1200 15:34:18 INFO - PROCESS | 4243 | colorDepth:24 15:34:18 INFO - PROCESS | 4243 | Browser inner width/height: 1024/697 15:34:18 INFO - PROCESS | 4243 | __metrics 15:34:19 ERROR - PROCESS | 4243 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:34:20 INFO - TEST-INFO | 4243: exit 0 15:34:20 INFO - Browser initialized. 15:34:20 INFO - Running cycle 1/1 for kraken test... 15:34:20 INFO - TEST-INFO | started process 4362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMlNoV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:22 INFO - PROCESS | 4362 | 15:34:22 INFO - PROCESS | 4362 | (process:4420): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:34:32 INFO - PROCESS | 4362 | RSS: Main: 164675584 15:34:32 INFO - PROCESS | 4362 | 15:34:34 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54273/tests/kraken/driver.html?testName=audio-beat-detection) 15:34:35 INFO - PROCESS | 4362 | RSS: Main: 169541632 15:34:35 INFO - PROCESS | 4362 | 15:34:38 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54273/tests/kraken/driver.html?testName=audio-dft) 15:34:39 INFO - PROCESS | 4362 | RSS: Main: 172273664 15:34:39 INFO - PROCESS | 4362 | 15:34:42 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54273/tests/kraken/driver.html?testName=audio-fft) 15:34:43 INFO - PROCESS | 4362 | RSS: Main: 162516992 15:34:43 INFO - PROCESS | 4362 | 15:34:45 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54273/tests/kraken/driver.html?testName=audio-oscillator) 15:34:45 INFO - PROCESS | 4362 | RSS: Main: 162971648 15:34:45 INFO - PROCESS | 4362 | 15:34:48 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:48 INFO - PROCESS | 4362 | RSS: Main: 165003264 15:34:48 INFO - PROCESS | 4362 | 15:34:51 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54273/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:52 INFO - PROCESS | 4362 | RSS: Main: 164626432 15:34:52 INFO - PROCESS | 4362 | 15:34:55 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54273/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:56 INFO - PROCESS | 4362 | RSS: Main: 164184064 15:34:56 INFO - PROCESS | 4362 | 15:34:59 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54273/tests/kraken/driver.html?testName=json-parse-financial) 15:35:00 INFO - PROCESS | 4362 | RSS: Main: 164569088 15:35:00 INFO - PROCESS | 4362 | 15:35:01 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:35:02 INFO - PROCESS | 4362 | RSS: Main: 164794368 15:35:02 INFO - PROCESS | 4362 | 15:35:04 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:35:05 INFO - PROCESS | 4362 | RSS: Main: 164941824 15:35:05 INFO - PROCESS | 4362 | 15:35:07 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:35:07 INFO - PROCESS | 4362 | RSS: Main: 165576704 15:35:07 INFO - PROCESS | 4362 | 15:35:10 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:35:11 INFO - PROCESS | 4362 | RSS: Main: 165814272 15:35:11 INFO - PROCESS | 4362 | 15:35:14 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:35:15 INFO - PROCESS | 4362 | RSS: Main: 165249024 15:35:15 INFO - PROCESS | 4362 | 15:35:16 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:54273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54273/tests/kraken/driver.html?testName=ai-astar) 15:35:17 INFO - PROCESS | 4362 | RSS: Main: 166981632 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | __start_tp_report 15:35:17 INFO - PROCESS | 4362 | _x_x_mozilla_page_load 15:35:17 INFO - PROCESS | 4362 | _x_x_mozilla_page_load_details 15:35:17 INFO - PROCESS | 4362 | |i|pagename|runs| 15:35:17 INFO - PROCESS | 4362 | |0;ai-astar;114;109;115;114;114;124;113;112;113;112 15:35:17 INFO - PROCESS | 4362 | |1;audio-beat-detection;159;144;162;192;135;164;154;134;195;154 15:35:17 INFO - PROCESS | 4362 | |2;audio-dft;162;162;163;178;163;162;162;162;164;161 15:35:17 INFO - PROCESS | 4362 | |3;audio-fft;74;74;76;166;75;77;73;75;157;75 15:35:17 INFO - PROCESS | 4362 | |4;audio-oscillator;94;94;150;93;94;94;137;93;93;148 15:35:17 INFO - PROCESS | 4362 | |5;imaging-gaussian-blur;118;118;119;118;117;117;118;118;118;118 15:35:17 INFO - PROCESS | 4362 | |6;imaging-darkroom;148;148;147;147;148;147;146;147;147;148 15:35:17 INFO - PROCESS | 4362 | |7;imaging-desaturate;96;96;96;96;96;96;96;97;96;96 15:35:17 INFO - PROCESS | 4362 | |8;json-parse-financial;69;69;69;68;67;68;67;84;65;66 15:35:17 INFO - PROCESS | 4362 | |9;json-stringify-tinderbox;68;65;65;66;65;65;65;65;64;65 15:35:17 INFO - PROCESS | 4362 | |10;stanford-crypto-aes;83;84;86;84;94;86;86;86;87;89 15:35:17 INFO - PROCESS | 4362 | |11;stanford-crypto-ccm;142;148;140;149;151;141;149;138;171;144 15:35:17 INFO - PROCESS | 4362 | |12;stanford-crypto-pbkdf2;184;177;181;178;181;179;178;176;181;174 15:35:17 INFO - PROCESS | 4362 | |13;stanford-crypto-sha256-iterative;74;75;73;74;76;75;71;74;74;71 15:35:17 INFO - PROCESS | 4362 | __end_tp_report 15:35:17 INFO - PROCESS | 4362 | __start_cc_report 15:35:17 INFO - PROCESS | 4362 | _x_x_mozilla_cycle_collect,907 15:35:17 INFO - PROCESS | 4362 | __end_cc_report 15:35:17 INFO - PROCESS | 4362 | __startTimestamp1460673317152__endTimestamp 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | ------- Summary: start ------- 15:35:17 INFO - PROCESS | 4362 | Number of tests: 14 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:3.89 (3.4%) stddev-sans-first:4.12 15:35:17 INFO - PROCESS | 4362 | Values: 114.0 109.0 115.0 114.0 114.0 124.0 113.0 112.0 113.0 112.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#1] audio-beat-detection Cycles:10 Average:159.30 Median:160.50 stddev:20.80 (13.0%) stddev-sans-first:22.06 15:35:17 INFO - PROCESS | 4362 | Values: 159.0 144.0 162.0 192.0 135.0 164.0 154.0 134.0 195.0 154.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#2] audio-dft Cycles:10 Average:163.90 Median:162.50 stddev:5.02 (3.1%) stddev-sans-first:5.28 15:35:17 INFO - PROCESS | 4362 | Values: 162.0 162.0 163.0 178.0 163.0 162.0 162.0 162.0 164.0 161.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#3] audio-fft Cycles:10 Average:92.20 Median:75.00 stddev:36.60 (48.8%) stddev-sans-first:38.23 15:35:17 INFO - PROCESS | 4362 | Values: 74.0 74.0 76.0 166.0 75.0 77.0 73.0 75.0 157.0 75.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.50 stddev:25.06 (26.8%) stddev-sans-first:25.99 15:35:17 INFO - PROCESS | 4362 | Values: 94.0 94.0 150.0 93.0 94.0 94.0 137.0 93.0 93.0 148.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:35:17 INFO - PROCESS | 4362 | Values: 118.0 118.0 119.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 15:35:17 INFO - PROCESS | 4362 | Values: 148.0 148.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 148.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:35:17 INFO - PROCESS | 4362 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:68.50 stddev:5.37 (7.8%) stddev-sans-first:5.70 15:35:17 INFO - PROCESS | 4362 | Values: 69.0 69.0 69.0 68.0 67.0 68.0 67.0 84.0 65.0 66.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:0.50 15:35:17 INFO - PROCESS | 4362 | Values: 68.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 64.0 65.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:3.14 (3.6%) stddev-sans-first:3.06 15:35:17 INFO - PROCESS | 4362 | Values: 83.0 84.0 86.0 84.0 94.0 86.0 86.0 86.0 87.0 89.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:148.50 stddev:9.43 (6.3%) stddev-sans-first:9.80 15:35:17 INFO - PROCESS | 4362 | Values: 142.0 148.0 140.0 149.0 151.0 141.0 149.0 138.0 171.0 144.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:180.00 stddev:2.92 (1.6%) stddev-sans-first:2.45 15:35:17 INFO - PROCESS | 4362 | Values: 184.0 177.0 181.0 178.0 181.0 179.0 178.0 176.0 181.0 174.0 15:35:17 INFO - PROCESS | 4362 | 15:35:17 INFO - PROCESS | 4362 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:74.00 stddev:1.64 (2.2%) stddev-sans-first:1.73 15:35:17 INFO - PROCESS | 4362 | Values: 74.0 75.0 73.0 74.0 76.0 75.0 71.0 74.0 74.0 71.0 15:35:17 INFO - PROCESS | 4362 | -------- Summary: end -------- 15:35:17 INFO - PROCESS | 4362 | 15:35:18 INFO - TEST-INFO | 4362: exit 0 15:35:18 INFO - TEST-OK | kraken | took 64258ms 15:35:18 INFO - SUITE-END | took 1180s 15:35:18 INFO - Completed test suite (00:19:40) 15:35:18 INFO - javascript benchmark 15:35:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.2486691292984, 2713.728627137286, 2754.449110177965, 2761.7514423701878, 2774.112284069096, 4738.194506933821, 4782.976085119578, 4803.087413391453, 4812.4225092988845, 4850.490698476662, 4692.882677933045, 4835.830745923893, 4845.1763200255955, 4855.902881942359, 4902.43621983472, 4333.479982402117, 4356.172327257811, 4430.313301438282, 4435.112977404516, 4456.086502267028, 4333.848315308965, 4530.886727831814, 4537.137943790685, 4573.176828170928, 4577.29051996941, 4315.741055536678, 4393.319035549495, 4396.780160991938, 4440.977795111036, 4503.48209955856, 4320.092780516095, 4353.542877997828, 4410.62509686677, 4419.668524860616, 4449.199144154051, 4387.122575484884, 4425.800838962255, 4433.179861725559, 4439.2675208590545, 4460.085682435093, 4616.492185859553, 4681.274402467623, 4701.294805779126, 4703.0, 4704.317873908299, 5217.060929032773, 5224.947750522484, 5240.371155461331, 5251.52736253739, 5282.788688452496, 5147.099257629937, 5241.213817927303, 5242.606804489678, 5266.104762190437, 5312.814051508218, 4591.7244965301525, 4783.521647835189, 4790.473047964721, 4834.226523756182, 4850.320955066293, 5281.234221037928, 5313.203019547099, 5356.625036247426, 5359.035373632783, 5374.167004114369, 5083.949160508348, 5087.567556757643, 5102.0, 5107.33604631403, 5147.6911385317, 4969.776360063805, 5091.1090559152, 5163.122269214243, 5164.147915593885, 5202.713850738246, 4924.433690125681, 4999.500049995044, 5023.673461225008, 5028.698278103326, 5032.6980381177245, 5017.9247311290355, 5022.447530771612, 5034.194528875362, 5034.521720436553, 5036.169032109661, 4287.3140297552245, 4299.903524601269, 4326.913461730811, 4331.328644060176, 4373.868783936487, 3770.2647983643474, 3796.088938654703, 3820.6943444524372, 3827.158025234444, 3847.076701591598, 4403.3174857897075, 4460.955390446119, 4483.887902802456, 4494.415725955605, 4542.591166795004, 5037.722925239147, 5084.3898732152375, 5110.948890511122, 5123.129068058439, 5133.23001549763, 4458.576435238647, 4471.955280447219, 4478.596926276586, 4484.730916145042, 4484.9103017940115, 4504.166729155117, 4582.24392975162, 4585.0, 4589.151007063704, 4630.745309008037, 4727.2909063640045, 4779.30700048498, 4788.856334309976, 4805.927911081407, 4836.927446088382, 5127.2052831811125, 5142.408623008402, 5154.871128221825, 5158.148905430562, 5181.455947125648, 4653.0, 4842.225243960949, 4861.586765125004, 4873.975630121827, 4904.6566740327835, 5021.071101846024, 5047.369078865142, 5047.570956468594, 5065.214891691794, 5099.6685215460875, 5111.05445492585, 5111.361079865017, 5112.079825631422, 5125.564327032095, 5127.717975511383, 4752.9287060694805, 4880.1215781159735, 4902.093112774148, 4939.777710002986, 4967.950320496749, 4976.950230497649, 5043.067032598981, 5048.167052436307, 5063.392392912874, 5080.26336181259, 4876.073546026244, 4909.729964851967, 4928.457869634409, 4928.926066109083, 4929.482404347492, 4945.77744001528, 5030.773615187252, 5040.521150490697, 5041.344625198701, 5088.6946783193125, 4917.041176970456, 4964.975175124101, 4979.029089327546, 4989.775460104232, 4992.475790042138], "value": 4713.899393554395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9663420194788, 596.5078809981765, 607.8632307730761, 614.1187396086615, 635.75523423482, 35253.2949341013, 36255.4561681575, 36508.0, 36596.634033659655, 36770.080747981345, 37187.4421883672, 37735.62264377355, 37750.43374349387, 37986.62013379866, 38044.42933355995, 7779.727709530168, 7940.880886786703, 7952.562609056499, 7965.044194696645, 7979.122296547375, 7818.45270831042, 7909.762707118795, 7930.762077137695, 7957.124716281204, 7961.1242763295995, 7895.802604934894, 7946.920530794705, 7961.124276329628, 7978.561179135145, 7982.082060563022, 7841.0982736985125, 7879.054513458393, 7920.52476851385, 7945.086315073754, 7966.283034526862, 7825.804354891174, 7888.329491993188, 7922.36621070313, 7928.920710792876, 7942.722004729807, 33815.83092084524, 33964.66035339639, 33982.83008584941, 34149.0, 34226.657733422595, 2979.567962645426, 3102.705243001911, 3110.5645209670665, 3119.111053349807, 3128.264857758425, 26541.867290663617, 26741.866290668615, 26947.595786063226, 26951.32621684454, 27091.593626095626, 3330.600327960636, 3341.8830340937952, 3429.742769292288, 3476.5480487536456, 3504.3692135415613, 227780.0, 228234.0, 229523.0, 230218.84890575608, 230751.0, 33221.50167747486, 52069.739651301505, 52779.20831187535, 52810.47189528133, 52854.73572632112, 31675.41622918845, 31681.841590791897, 31814.04557863268, 31880.0, 31917.0, 13238.53665121716, 13429.597112086652, 13438.462461501626, 13516.12145210578, 13556.661083472993, 10327.173826093895, 10366.585336586451, 10368.326058806153, 10375.221858360654, 10404.739881502872, 7941.126476087626, 8134.837303253902, 8191.443625711215, 8195.303399211134, 8234.300084492765, 3242.4974129010043, 3248.642649308574, 3256.967430325714, 3291.654376290503, 3315.7015868571943, 925.2644147902433, 1007.5717819926502, 1021.2544842265188, 1040.5369610523244, 1062.8671416072991, 27474.0, 27971.58042629362, 28082.85958570235, 28184.577231341547, 28562.0, 1007.219404961161, 1023.2530252915413, 1026.6355443817486, 1037.4345981440133, 1048.4757621189406, 14783.778243326144, 14968.401263949538, 15029.398824047134, 15376.154311512973, 15448.382064717285, 315933.0, 319632.0, 325052.0, 325549.0, 326310.0, 48070.75964620154, 48208.517914820404, 48285.75857120692, 48374.27438588354, 48505.0, 1212.2423485321674, 1248.3633346992917, 1256.378092844048, 1285.9228446293253, 1292.2440372382073, 26096.478070438865, 27672.861635691694, 27681.169564913085, 27761.58357624597, 28106.0, 41061.1787764249, 41210.587894120676, 41216.0, 41630.0, 41764.0, 298681.0, 301874.0, 302786.0, 303185.0, 303208.0, 25406.364840878385, 25659.615105773802, 25688.229353119437, 25741.3564660885, 38605.42091868568, 36748.81625591855, 36925.63074369329, 37539.06152346213, 37632.247355053296, 38017.4297385545, 33025.33949321048, 34665.48001779925, 34810.82594587011, 34828.65171348355, 35060.298794024486, 33794.831025844716, 34482.482762758074, 34486.0, 34786.0, 35402.64597353993, 31286.843565782026, 34861.30277394489, 35377.0, 36566.81716591506, 36983.8150809255, 28730.712692872803, 29630.259243518223, 29691.257718557208, 29705.405891882474, 31440.371192575563, 24569.385765356008, 24659.506809863342, 24704.752952470244, 25055.123070693167, 25211.369715757253], "value": 16159.28209044261, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.6563447542073, 369.6543731610944, 372.5752641988134, 380.4065657574186, 389.3595036165508, 15892.364305427784, 16298.918505407471, 16518.25667844947, 16568.834311656865, 16878.240479178436, 15072.246387680627, 15228.619284517892, 15271.694566108672, 15385.92307038466, 15872.84127158728, 5013.398392192933, 5106.412762532301, 5158.174692049273, 5268.394134674504, 5274.498922602346, 3722.4788529605876, 5100.132977393833, 5701.429857014306, 6038.5471089668235, 6061.030235162375, 5964.1650168976375, 5967.104934259874, 5985.820425387224, 5989.1016347548, 6028.7588496460085, 5878.911816322759, 6028.246469191351, 6072.332043475259, 6073.878522429571, 6107.114468402079, 5105.489451054902, 5284.682919024871, 5294.41761406245, 5296.523312901857, 5301.946980530184, 11510.712232194179, 12199.878001219962, 20350.28773992918, 20623.0, 20668.276610318717, 1879.2952642758964, 1997.9600407991904, 2018.4584684459965, 2040.4898775306174, 2470.2465747946867, 8928.73213803587, 9221.53892305382, 9317.627294908196, 9479.146876781122, 9688.46713430761, 1649.6205872649239, 1746.1269365317341, 1756.956076098095, 1760.6126652136509, 1777.742227377036, 67949.0, 70365.64817175882, 70394.0, 71516.28483715201, 71693.641531792, 9766.316357855025, 9838.65564705232, 9946.602135914627, 10040.748981275381, 10051.949740251252, 13438.193708377528, 13441.462341506425, 13448.0, 13462.057655964185, 13521.797173042412, 6685.565438246498, 6790.0, 6872.931270687229, 6905.620190889549, 6972.895406568906, 6383.36166383358, 6415.326390728999, 6560.573562718408, 6581.111549940792, 6581.670916454158, 4215.388768628593, 4278.657707383401, 4308.80610372534, 4410.0, 4530.569595888385, 1651.719207734688, 1694.83899029592, 1821.639376651612, 1826.5524946387955, 1877.6620208362353, 899.6581299106298, 938.8638647396226, 957.9664711735056, 1002.3935519010894, 1025.958961641526, 16293.592660183353, 16715.080670563235, 16715.832841671672, 16998.575035623962, 17102.743458848126, 899.3839220134229, 910.5538286239828, 913.5295322908707, 919.2645883293338, 939.2579861909015, 9178.0, 9188.219001384823, 9268.351215414856, 9513.714588562216, 9561.187299079656, 292139.0, 365359.0, 369928.0, 373974.0, 374221.0, 81237.59381203057, 85468.57265713756, 85839.57080214685, 86030.0, 87897.56051219703, 963.1620490173594, 994.328828041055, 1001.0190013786384, 1004.3923426326967, 1007.0, 15451.768223476432, 15474.226288685746, 15571.0, 15605.531834044998, 15954.202289885692, 35839.0, 36486.817565912, 37161.62838371582, 37300.253994920495, 37668.81165594154, 50026.74986625044, 50586.49413505965, 50974.0, 51782.0, 52393.7380313096, 4807.735574543294, 7292.869605211201, 7469.365103966224, 7711.961440192763, 7780.610969451392, 11268.0, 11334.263272887236, 11550.59572914944, 11636.41817909118, 11891.335213070004, 9595.520223988913, 10226.693199204035, 10342.120919721909, 10368.0, 10767.246292759432, 10226.977302269714, 10276.948615257175, 10339.468384414302, 10347.068763810992, 10494.632687855888, 10307.0, 10440.738981525523, 10689.465526723478, 10792.082672972885, 10819.350838949687, 7566.713658677928, 7646.0, 7674.424418168772, 7823.374130069467, 7891.881621775793, 9756.26827987918, 10312.175025997753, 10392.688219353431, 10476.16190704757, 10710.089642380484], "value": 8210.28979438286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.549399686097, 1472.6171195489173, 1587.611035296352, 1767.699491086515, 1781.1094452773614, 6906.5510741801745, 7607.467477276593, 7636.503627264224, 7894.407919406039, 7940.960295198523, 7640.274173953466, 7678.9232107679045, 7713.460057795943, 7766.572838493895, 7813.765587032384, 2121.416610432128, 2165.8592191507582, 2179.2699445685716, 2180.4875854174256, 2185.4754858833844, 2158.935231943044, 2186.628273193553, 2195.3084778294788, 2199.846010779246, 2216.5899308627877, 2168.945776355588, 2181.0512427094186, 2191.024993877725, 2191.1783081344497, 2202.537467131904, 2158.6761985702115, 2165.1123039553786, 2166.8591541549827, 2168.1219106261988, 2168.3711723600136, 2145.9785402145935, 2184.8689078655175, 2186.967195492069, 2188.595109904657, 2190.726159230096, 7876.527408355517, 7936.6825326986855, 7959.12449630546, 7994.160613135595, 8009.719659811937, 4472.619827314682, 4685.461171965234, 4701.694389864648, 4713.740744259065, 4748.928766068511, 2984.3136078701805, 3008.8796448142266, 3036.483797754365, 3047.08587423772, 3143.387039527293, 972.1348000279756, 977.8386566216566, 979.794243208927, 992.9851052234222, 1011.5245834457793, 10584.788304233949, 10651.467426628638, 10748.516316765765, 10759.30064545802, 10793.460326983619, 4158.8336466540995, 4208.116295577963, 4346.152500262482, 4358.171947329997, 4389.122175564899, 9120.270378369847, 9191.862122068174, 9257.490838003974, 9257.583408746623, 9269.073092690676, 4606.88482787933, 4615.376924115269, 4616.76916154191, 4619.0, 4641.837535686234, 3796.5064541609413, 4200.915981680349, 4229.0, 4249.022724773319, 4288.0, 3643.6720695137565, 3768.246350729865, 3806.7525610835205, 3810.2950954073585, 3813.370793819044, 1217.4947396830394, 1264.3930913161735, 1269.4224128021729, 1270.9872901271053, 1271.262667652759, 762.4472257613186, 913.5295322908707, 932.7528205025674, 932.9207017403596, 941.9952900235455, 5599.720013999366, 5610.158476228598, 5639.746211420414, 5733.111367738007, 5797.536197104221, 916.1388295002677, 925.2690374603987, 939.8402271613842, 949.4018768176005, 965.1410244882061, 3733.5146430964346, 3810.7904065276675, 3814.275287695329, 3843.8078096095082, 3859.208862183246, 9187.954060229657, 9497.667581634609, 9570.473623950611, 9583.472908990072, 9597.280203984728, 9677.37097088687, 9744.220462362993, 9770.462624555717, 9783.315167938319, 9849.803003939882, 7347.265273472717, 7487.66305516253, 7516.812079697942, 7523.623818809147, 7536.359409450149, 5233.162693968947, 5263.157894736823, 5429.864253393696, 5505.201745746925, 5605.019121653776, 8970.596323165604, 9113.270938324786, 9207.125323094295, 9237.0, 9339.252859771337, 8978.490594319066, 9169.77075573116, 9193.632254709737, 9314.72055838326, 9365.765855853659, 6070.271567411763, 6736.4947628929, 6743.123393958754, 6820.283870193558, 6952.339527744856, 7197.1363436387965, 7247.094113235846, 7257.891131633135, 7282.308180722823, 7318.707251709872, 6609.702563384755, 6861.382475577222, 6891.896621550581, 6896.862062758616, 7011.228764835966, 6727.596344219362, 6732.427743641845, 6773.864522709617, 6806.82982925411, 6839.829004274734, 6104.145419641342, 6351.237851457855, 6462.838429039123, 6467.741290348334, 6482.935170648233, 4737.644676649196, 4743.45450273223, 4813.326134341265, 4818.903621927471, 4885.975570122127, 4681.368015317888, 4709.105269998689, 4734.029523947652, 4748.05038992196, 4766.261229509431], "value": 4236.864566321604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.8132810977468, 319.5476559039167, 323.2661857583286, 323.67470691954566, 328.25649902969764, 5376.0, 5471.5349195318395, 5474.26097476841, 5479.479449452306, 5500.42245564216, 5381.273528073709, 5397.784088636459, 5401.3248343957, 5406.270153529273, 5417.295751552293, 4004.7797371144575, 4062.2078694654556, 4166.916661666764, 4193.601607847249, 4198.475190601175, 4182.53992060873, 4200.873973780776, 4211.831526738927, 4212.304969680014, 4217.430646862665, 4186.183694179636, 4192.413062171298, 4192.517860446042, 4193.475815523059, 4194.0982688721915, 4085.428040074377, 4116.794160291974, 4187.623113919762, 4195.265828480019, 4196.9370459443135, 3649.872254471081, 3679.963200367989, 3683.079230192452, 3688.5942546319884, 3706.129059670975, 5127.102757017545, 5139.383274007106, 5164.0, 5186.170212765977, 5191.454897235812, 4726.149293127236, 4860.635452341088, 4865.732384718839, 4866.245731911559, 4869.050535145648, 5660.801871934463, 5669.0, 5675.886482270332, 5690.3456102548325, 5698.572607054446, 4062.289099407592, 4068.3897415387632, 4068.413318805668, 4078.4086307485545, 4086.264472394968, 5762.769489220426, 5963.373845746221, 5986.161937328778, 5996.400359964013, 5996.8500787480225, 4162.895927601834, 4190.182914331737, 4190.224808410454, 4198.076423186894, 4202.97027228331, 4239.533651298355, 4248.638865696388, 4253.617174454314, 4256.489221293465, 4271.829126834954, 4449.377087207794, 4726.621870250372, 4823.710577365299, 4833.081714474239, 4858.562729354375, 5638.33669067626, 5689.288838895138, 5691.0, 5696.544276457874, 5701.116326969326, 1417.2701058954647, 1428.0574820618342, 1442.4086124688827, 1447.1317209674112, 1447.7611194152846, 898.5462341517623, 936.4677516576251, 944.9291303152291, 953.5947222430578, 972.7519482531909, 4960.751962401938, 4975.925361119586, 4991.226359914219, 5007.924881126786, 5010.248462730619, 5735.243415562813, 5813.941860581424, 5814.680192589363, 5815.418458154235, 5828.446297601721, 4879.4876537963, 4885.41375034991, 4950.727709975914, 4952.133376659071, 4982.153033984231, 3103.997921340768, 3115.158907095117, 3116.096332063676, 3147.7009684079976, 3147.7324427423923, 5366.812161574326, 5406.621536492407, 5430.51125398716, 5437.592180586472, 5443.074677304868, 5805.36141024487, 5927.73325200367, 5961.821145365646, 5965.701714914237, 5969.731362088716, 5385.299911011543, 5392.786623009792, 5454.91817622736, 5456.017916774939, 5457.836264912059, 5632.493075623213, 5766.8846623066465, 5789.594728368974, 5795.710214489343, 5851.970740146272, 5605.103183490622, 5655.745491452977, 5669.489745922887, 5670.291213598301, 5680.77276908919, 5460.645058071213, 5466.453354664661, 5473.808416705396, 5490.6431081979545, 5492.0, 3862.9806850965565, 4068.0846809467635, 4081.0817566047403, 4081.6122468365456, 4087.1212689271947, 5874.911876321944, 5880.294364676266, 5890.7349169288345, 5915.852103697442, 5926.081457374114, 5651.773929042793, 5669.6314739541795, 5682.573806964411, 5694.373618902, 5712.742926568231, 5522.723863806874, 5614.85962850932, 5705.572082093777, 5711.714414279187, 5715.742791574472, 5341.599380046589, 5549.889002220014, 5585.776568937197, 5603.467670571289, 5620.269364982526, 5589.972050139723, 5668.404817494104, 5684.261046063985, 5712.600117991867, 5756.0, 5539.19681646151, 5553.0, 5638.0, 5667.838093190803, 5671.6029877909805], "value": 4256.524548114934, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.5362967700669, 731.8463122744223, 733.8495608400278, 734.5959722152814, 750.9023826902502, 11793.941030294858, 11879.34663593502, 11928.522859085626, 12128.575499857496, 12148.453319600618, 11708.882911170886, 11934.64196074117, 11967.880321196786, 12092.395380230997, 12095.0, 642.2164958750317, 793.6706266899258, 797.7606717984596, 807.0799288810761, 807.6365635464065, 811.8782182672617, 812.252727490707, 816.0859836982588, 816.408104124508, 816.7508909782514, 852.842224188524, 853.6628031927385, 853.7054716122959, 856.3620103023256, 857.7726902370877, 850.5832142250284, 850.9872351914727, 851.4295422067199, 853.0531110467376, 854.2525290370926, 624.7282432142033, 627.3569591169042, 627.4008322052429, 629.7418058595954, 630.1776182082381, 12170.75658486834, 12214.816777748341, 12228.755424891542, 12287.93856030714, 12311.69220769479, 12816.359182040955, 12873.0, 13201.735965280737, 13223.801642975362, 13535.458581656721, 9984.750381240454, 10065.396076235449, 10108.797824043479, 10142.442165680885, 10290.43402612856, 3339.415602269593, 3365.3437579671972, 3428.5200071989943, 3433.6909678129086, 3450.8447119879415, 42299.365509517076, 44617.10765784699, 44940.3258951116, 45010.94901458884, 45057.77471112656, 9794.608215671436, 10143.34068285559, 10265.74335641615, 10329.793404132026, 10369.0, 17187.0, 17189.226484808212, 17208.827911720724, 17228.397006104726, 17282.82717172812, 6797.762078327334, 6800.455963522906, 6810.795676129724, 6857.348551887562, 6970.442364610819, 3730.776153430803, 3814.1608846053823, 3816.255830113101, 3820.9617903821163, 3826.613123939442, 2870.095919785261, 2962.822230666167, 2979.433907557557, 2984.313607870202, 2987.223321936269, 546.1943633141085, 546.9206964990134, 553.3415235869303, 558.4499268220799, 566.1790403914341, 581.8516278349078, 595.7110801261384, 603.5322624965687, 619.4734475695623, 627.7206643043893, 7172.892406613905, 7653.3494652954005, 7686.461947663722, 7798.649060792278, 8055.677772889136, 463.5133110234241, 488.872893047803, 537.8305833662383, 565.4006752842, 573.4695406748824, 3499.2651543176216, 3595.982020089883, 3639.072354372527, 3661.469086982426, 3663.0476076220375, 45760.54239457563, 51298.0, 55157.724211378685, 55809.44190558124, 55828.44171558314, 40773.38839917404, 41232.0, 41464.37803432951, 42394.57605423968, 43938.78030609826, 38858.0, 39718.80140599279, 39938.60061399349, 40622.79688601538, 41676.37485437721, 7545.811354715956, 7786.26030527099, 7803.765887023172, 7861.724839630586, 8078.5960701963495, 29065.564016539345, 29072.563911541765, 29286.560701589067, 29432.852835735684, 29760.0, 32364.676353236166, 32482.187945301557, 34789.13027174341, 37494.43758343573, 38830.4175437363, 10068.69793906184, 10313.0, 10452.425116618355, 10600.310979786289, 10795.244332896622, 10738.677839664822, 10739.946300268448, 10793.29843560166, 10967.122630189726, 10989.560417583207, 10589.735256618646, 10682.09202217789, 10778.885935282677, 10867.565297388332, 11280.774384512428, 10449.21630877672, 10860.945695271474, 10995.560177593126, 11360.943195283971, 11458.255213411101, 11036.337819730841, 11303.943480282545, 11321.09431245482, 11334.093272538343, 11446.0, 9753.80492390134, 9834.360766550151, 9915.0, 10089.89910100919, 10102.141317988053, 9558.95220523893, 9620.75948101303, 9843.60625574969, 9919.702408927744, 9966.50167491637], "value": 5889.170395275776, "unit": "score"}], "name": "dromaeo_css", "value": 6363.937448718344, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 115.0, 114.0, 114.0, 124.0, 113.0, 112.0, 113.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 144.0, 162.0, 192.0, 135.0, 164.0, 154.0, 134.0, 195.0, 154.0], "value": 159.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 178.0, 163.0, 162.0, 162.0, 162.0, 164.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 166.0, 75.0, 77.0, 73.0, 75.0, 157.0, 75.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 150.0, 93.0, 94.0, 94.0, 137.0, 93.0, 93.0, 148.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 68.0, 67.0, 68.0, 67.0, 84.0, 65.0, 66.0], "value": 69.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 84.0, 94.0, 86.0, 86.0, 86.0, 87.0, 89.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 148.0, 140.0, 149.0, 151.0, 141.0, 149.0, 138.0, 171.0, 144.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 177.0, 181.0, 178.0, 181.0, 179.0, 178.0, 176.0, 181.0, 174.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 74.0, 76.0, 75.0, 71.0, 74.0, 74.0, 71.0], "value": 73.7, "unit": "score"}], "name": "kraken", "value": 1620.6000000000001, "alertThreshold": 2.0}]} 15:35:18 INFO - Return code: 0 15:35:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:35:18 ERROR - # TBPL SUCCESS # 15:35:18 INFO - Running post-action listener: _resource_record_post_action 15:35:18 INFO - Running post-run listener: _resource_record_post_run 15:35:19 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 593920; Write bytes: 353374208; Read time: 108; Write time: 255068 15:35:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 68124672; Read time: 0; Write time: 35804 15:35:19 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 593920; Write bytes: 281149440; Read time: 108; Write time: 203840 15:35:19 INFO - Running post-run listener: _upload_blobber_files 15:35:19 INFO - Blob upload gear active. 15:35:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:35:19 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 15:35:19 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'] 15:35:19 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 15:35:19 INFO - (blobuploader) - INFO - Open directory for files ... 15:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:20 INFO - (blobuploader) - INFO - Done attempting. 15:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:21 INFO - (blobuploader) - INFO - Done attempting. 15:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 15:35:21 INFO - Return code: 0 15:35:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7c9aa0a22581cabdeccf3a6b1ed844dfade433011097d75ed56564d1d7fe99ebf7d4c089c1b1b212fb7bd6f587fe641c338bf4adf3aa032dd5f10544bd50aea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f83fc7728f9c2a007ec18c197a50a4013a57b73e51072a78dc71d20eecb27e352a535d12da126dcdabbec2c76538b32ee283ff153069e1db3386b991d4a94765"} 15:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:35:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:35:21 INFO - Contents: 15:35:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7c9aa0a22581cabdeccf3a6b1ed844dfade433011097d75ed56564d1d7fe99ebf7d4c089c1b1b212fb7bd6f587fe641c338bf4adf3aa032dd5f10544bd50aea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f83fc7728f9c2a007ec18c197a50a4013a57b73e51072a78dc71d20eecb27e352a535d12da126dcdabbec2c76538b32ee283ff153069e1db3386b991d4a94765"} 15:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 15:35:21 INFO - Copying logs to upload dir... 15:35:21 INFO - mkdir: /builds/slave/test/build/upload/logs 15:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.812021 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-14 15:35:21.712131) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 15:35:21.720025) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176 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/e7c9aa0a22581cabdeccf3a6b1ed844dfade433011097d75ed56564d1d7fe99ebf7d4c089c1b1b212fb7bd6f587fe641c338bf4adf3aa032dd5f10544bd50aea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f83fc7728f9c2a007ec18c197a50a4013a57b73e51072a78dc71d20eecb27e352a535d12da126dcdabbec2c76538b32ee283ff153069e1db3386b991d4a94765"} build_url:https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011483 build_url: 'https://queue.taskcluster.net/v1/task/EHlJAcyiSRKu_JWvhIn2Ow/artifacts/public/build/firefox-48.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/e7c9aa0a22581cabdeccf3a6b1ed844dfade433011097d75ed56564d1d7fe99ebf7d4c089c1b1b212fb7bd6f587fe641c338bf4adf3aa032dd5f10544bd50aea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f83fc7728f9c2a007ec18c197a50a4013a57b73e51072a78dc71d20eecb27e352a535d12da126dcdabbec2c76538b32ee283ff153069e1db3386b991d4a94765"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 15:35:21.752604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 15:35:21.752998) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1460672085.97980-808373176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 15:35:21.835661) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 15:35:21.836033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 15:35:21.836369) ========= ========= Total master_lag: 0.21 =========