builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1461962045.0 results: success (0) buildid: 20160429124142 builduid: 61bfefa969d1459e81e8017f529649f7 revision: d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:04.999639) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.000172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.000481) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.017686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.017979) ========= 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=33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 13:34:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.7M=0s 2016-04-29 13:34:05 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129753 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.161806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.162129) ========= 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=33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017736 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.211448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.211816) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 --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 d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 --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=33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 13:34:05,453 truncating revision to first 12 chars 2016-04-29 13:34:05,453 Setting DEBUG logging. 2016-04-29 13:34:05,453 attempt 1/10 2016-04-29 13:34:05,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d2674a65a6e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 13:34:05,725 unpacking tar archive at: fx-team-d2674a65a6e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539773 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.764538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.764875) ========= script_repo_revision: d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.765295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.765576) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 13:34:05.776165) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-29 13:34:05.776490) ========= /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=33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:34:06 INFO - MultiFileLogger online at 20160429 13:34:06 in /builds/slave/test 13:34:06 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 13:34:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:34:06 INFO - {'append_to_log': False, 13:34:06 INFO - 'base_work_dir': '/builds/slave/test', 13:34:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:34:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:34:06 INFO - 'branch': 'Fx-Team-Non-PGO', 13:34:06 INFO - 'buildbot_json_path': 'buildprops.json', 13:34:06 INFO - 'config_files': ('talos/linux_config.py',), 13:34:06 INFO - 'default_actions': ('clobber', 13:34:06 INFO - 'read-buildbot-config', 13:34:06 INFO - 'download-and-extract', 13:34:06 INFO - 'populate-webroot', 13:34:06 INFO - 'create-virtualenv', 13:34:06 INFO - 'install', 13:34:06 INFO - 'run-tests'), 13:34:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:34:06 INFO - 'download_minidump_stackwalk': True, 13:34:06 INFO - 'download_symbols': 'ondemand', 13:34:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:34:06 INFO - 'tooltool.py': '/tools/tooltool.py', 13:34:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:34:06 INFO - '/tools/misc-python/virtualenv.py')}, 13:34:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:34:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:34:06 INFO - 'installer_path': 'installer.exe', 13:34:06 INFO - 'log_level': 'info', 13:34:06 INFO - 'log_name': 'talos', 13:34:06 INFO - 'log_to_console': True, 13:34:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:34:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:34:06 INFO - 'opt_config_files': (), 13:34:06 INFO - 'pip_index': False, 13:34:06 INFO - 'sps_profile': False, 13:34:06 INFO - 'sps_profile_interval': 0, 13:34:06 INFO - 'suite': 'dromaeojs-e10s', 13:34:06 INFO - 'system_bits': '32', 13:34:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:34:06 INFO - 'title': 'talos-linux64-ix-063', 13:34:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:34:06 INFO - 'use_talos_json': True, 13:34:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:34:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:34:06 INFO - 'work_dir': 'build'} 13:34:06 INFO - ##### 13:34:06 INFO - ##### Running clobber step. 13:34:06 INFO - ##### 13:34:06 INFO - Running pre-action listener: _resource_record_pre_action 13:34:06 INFO - Running main action method: clobber 13:34:06 INFO - rmtree: /builds/slave/test/build 13:34:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:34:06 INFO - Running post-action listener: _resource_record_post_action 13:34:06 INFO - ##### 13:34:06 INFO - ##### Running read-buildbot-config step. 13:34:06 INFO - ##### 13:34:06 INFO - Running pre-action listener: _resource_record_pre_action 13:34:06 INFO - Running main action method: read_buildbot_config 13:34:06 INFO - Using buildbot properties: 13:34:06 INFO - { 13:34:06 INFO - "project": "", 13:34:06 INFO - "product": "firefox", 13:34:06 INFO - "script_repo_revision": "production", 13:34:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:34:06 INFO - "repository": "", 13:34:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:34:06 INFO - "buildid": "20160429124142", 13:34:06 INFO - "pgo_build": "False", 13:34:06 INFO - "basedir": "/builds/slave/test", 13:34:06 INFO - "buildnumber": 1222, 13:34:06 INFO - "slavename": "talos-linux64-ix-063", 13:34:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:34:06 INFO - "platform": "ubuntu64_hw", 13:34:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:34:06 INFO - "branch": "fx-team", 13:34:06 INFO - "repo_path": "integration/fx-team", 13:34:06 INFO - "revision": "d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57", 13:34:06 INFO - "stage_platform": "linux64", 13:34:06 INFO - "builduid": "61bfefa969d1459e81e8017f529649f7", 13:34:06 INFO - "slavebuilddir": "test" 13:34:06 INFO - } 13:34:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:34:06 INFO - Running post-action listener: _resource_record_post_action 13:34:06 INFO - ##### 13:34:06 INFO - ##### Running download-and-extract step. 13:34:06 INFO - ##### 13:34:06 INFO - Running pre-action listener: _resource_record_pre_action 13:34:06 INFO - Running main action method: download_and_extract 13:34:06 INFO - mkdir: /builds/slave/test/build/tests 13:34:06 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')]} 13:34:06 INFO - https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:34:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:34:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:34:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:34:07 INFO - Downloaded 1361 bytes. 13:34:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:34:07 INFO - Using the following test package requirements: 13:34:07 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:34:07 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:34:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:34:07 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:34:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:34:07 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:34:07 INFO - u'jsshell-linux-x86_64.zip'], 13:34:07 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:34:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:34:07 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:34:07 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:34:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:34:07 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:34:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:34:07 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:34:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:34:07 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:34:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:34:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:07 INFO - https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:34:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:34:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:34:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:34:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:34:18 INFO - Downloaded 22301604 bytes. 13:34:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:34:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:34:19 INFO - Return code: 0 13:34:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:34:19 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')]} 13:34:19 INFO - https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:34:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:34:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:34:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:34:20 INFO - Downloaded 22301604 bytes. 13:34:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:34:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:34:22 INFO - Return code: 0 13:34:22 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')]} 13:34:22 INFO - https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:34:23 INFO - Downloaded 10840145 bytes. 13:34:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:34:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:34:23 INFO - Return code: 0 13:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:23 INFO - https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:34:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:34:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:34:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:34:41 INFO - Downloaded 54853161 bytes. 13:34:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:34:41 INFO - mkdir: /builds/slave/test/properties 13:34:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:34:41 INFO - Writing to file /builds/slave/test/properties/build_url 13:34:41 INFO - Contents: 13:34:41 INFO - build_url:https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:34:42 INFO - Running post-action listener: _resource_record_post_action 13:34:42 INFO - Running post-action listener: set_extra_try_arguments 13:34:42 INFO - ##### 13:34:42 INFO - ##### Running populate-webroot step. 13:34:42 INFO - ##### 13:34:42 INFO - Running pre-action listener: _resource_record_pre_action 13:34:42 INFO - Running main action method: populate_webroot 13:34:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:34:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:34:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:34:42 INFO - '--tppagecycles', 13:34:42 INFO - '7'], 13:34:42 INFO - 'tests': ['tsvgm']}}, 13:34:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:34:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:34:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:34:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:34:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:42 INFO - 'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:34:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:34:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:42 INFO - 'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['damp', 'tps']}, 13:34:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:42 INFO - 'tests': ['damp', 'tps']}, 13:34:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['dromaeo_dom']}, 13:34:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:34:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['a11yr', 13:34:42 INFO - 'ts_paint', 13:34:42 INFO - 'tpaint', 13:34:42 INFO - 'sessionrestore', 13:34:42 INFO - 'sessionrestore_no_auto_restore', 13:34:42 INFO - 'tabpaint']}, 13:34:42 INFO - 'other-e10s': {'tests': ['a11yr', 13:34:42 INFO - 'ts_paint', 13:34:42 INFO - 'tpaint', 13:34:42 INFO - 'sessionrestore', 13:34:42 INFO - 'sessionrestore_no_auto_restore', 13:34:42 INFO - 'tabpaint']}, 13:34:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:34:42 INFO - 'ts_paint', 13:34:42 INFO - 'tpaint', 13:34:42 INFO - 'sessionrestore', 13:34:42 INFO - 'sessionrestore_no_auto_restore', 13:34:42 INFO - 'tabpaint']}, 13:34:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:34:42 INFO - 'ts_paint', 13:34:42 INFO - 'tpaint', 13:34:42 INFO - 'sessionrestore', 13:34:42 INFO - 'sessionrestore_no_auto_restore', 13:34:42 INFO - 'tabpaint']}, 13:34:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['a11yr', 13:34:42 INFO - 'ts_paint', 13:34:42 INFO - 'tpaint', 13:34:42 INFO - 'sessionrestore', 13:34:42 INFO - 'sessionrestore_no_auto_restore', 13:34:42 INFO - 'tabpaint']}, 13:34:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['a11yr', 13:34:42 INFO - 'ts_paint', 13:34:42 INFO - 'tpaint', 13:34:42 INFO - 'sessionrestore', 13:34:42 INFO - 'sessionrestore_no_auto_restore', 13:34:42 INFO - 'tabpaint']}, 13:34:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['tsvgx', 13:34:42 INFO - 'tsvgr_opacity', 13:34:42 INFO - 'tart', 13:34:42 INFO - 'tscrollx', 13:34:42 INFO - 'cart']}, 13:34:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:34:42 INFO - 'tsvgr_opacity', 13:34:42 INFO - 'tart', 13:34:42 INFO - 'tscrollx', 13:34:42 INFO - 'cart']}, 13:34:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:42 INFO - 'talos_options': ['--disable-e10s'], 13:34:42 INFO - 'tests': ['tp5o']}, 13:34:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:42 INFO - 'tests': ['tp5o']}, 13:34:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:42 INFO - 'talos_options': ['--disable-e10s', 13:34:42 INFO - '--xperf_path', 13:34:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:42 INFO - 'tests': ['tp5n']}, 13:34:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:42 INFO - 'talos_options': ['--xperf_path', 13:34:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:42 INFO - 'tests': ['tp5n']}}, 13:34:42 INFO - 'talos.zip': {'path': '', 13:34:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:34:42 INFO - Running post-action listener: _resource_record_post_action 13:34:42 INFO - ##### 13:34:42 INFO - ##### Running create-virtualenv step. 13:34:42 INFO - ##### 13:34:42 INFO - Running pre-action listener: _resource_record_pre_action 13:34:42 INFO - Running main action method: create_virtualenv 13:34:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:34:42 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 13:34:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:34:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:34:42 INFO - Using real prefix '/usr' 13:34:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:34:43 INFO - Installing distribute.............................................................................................................................................................................................done. 13:34:45 INFO - Installing pip.................done. 13:34:45 INFO - Return code: 0 13:34:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:45 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 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:34:45 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 13:34:45 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 13:34:45 INFO - Using env: {'DISPLAY': ':0', 13:34:45 INFO - 'HOME': '/home/cltbld', 13:34:45 INFO - 'LANG': 'en_US.UTF-8', 13:34:45 INFO - 'LANGUAGE': 'en_US:en', 13:34:45 INFO - 'LOGNAME': 'cltbld', 13:34:45 INFO - 'MAIL': '/var/mail/cltbld', 13:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:45 INFO - 'MOZ_NO_REMOTE': '1', 13:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:45 INFO - 'NO_EM_RESTART': '1', 13:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:45 INFO - 'PWD': '/builds/slave/test', 13:34:45 INFO - 'SHELL': '/bin/bash', 13:34:45 INFO - 'SHLVL': '1', 13:34:45 INFO - 'TERM': 'linux', 13:34:45 INFO - 'TMOUT': '86400', 13:34:45 INFO - 'USER': 'cltbld', 13:34:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:45 INFO - '_': '/tools/buildbot/bin/python'} 13:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:45 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 13:34:45 INFO - Cleaning up... 13:34:45 INFO - Return code: 0 13:34:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:45 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 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:34:45 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 13:34:45 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 13:34:45 INFO - Using env: {'DISPLAY': ':0', 13:34:45 INFO - 'HOME': '/home/cltbld', 13:34:45 INFO - 'LANG': 'en_US.UTF-8', 13:34:45 INFO - 'LANGUAGE': 'en_US:en', 13:34:45 INFO - 'LOGNAME': 'cltbld', 13:34:45 INFO - 'MAIL': '/var/mail/cltbld', 13:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:45 INFO - 'MOZ_NO_REMOTE': '1', 13:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:45 INFO - 'NO_EM_RESTART': '1', 13:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:45 INFO - 'PWD': '/builds/slave/test', 13:34:45 INFO - 'SHELL': '/bin/bash', 13:34:45 INFO - 'SHLVL': '1', 13:34:45 INFO - 'TERM': 'linux', 13:34:45 INFO - 'TMOUT': '86400', 13:34:45 INFO - 'USER': 'cltbld', 13:34:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:45 INFO - '_': '/tools/buildbot/bin/python'} 13:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:46 INFO - Downloading/unpacking psutil>=0.7.1 13:34:46 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 13:34:46 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 13:34:46 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 13:34:46 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 13:34:46 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 13:34:46 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 13:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:34:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:34:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:34:48 INFO - Installing collected packages: psutil 13:34:48 INFO - Running setup.py install for psutil 13:34:48 INFO - building 'psutil._psutil_linux' extension 13:34:48 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 13:34:48 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 13:34:48 INFO - building 'psutil._psutil_posix' extension 13:34:48 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 13:34:48 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 13:34:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:34:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:34:48 INFO - Successfully installed psutil 13:34:48 INFO - Cleaning up... 13:34:48 INFO - Return code: 0 13:34:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:34: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')]} 13:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34: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')]} 13:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:48 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 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:34:48 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 13:34:48 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 13:34:48 INFO - Using env: {'DISPLAY': ':0', 13:34:48 INFO - 'HOME': '/home/cltbld', 13:34:48 INFO - 'LANG': 'en_US.UTF-8', 13:34:48 INFO - 'LANGUAGE': 'en_US:en', 13:34:48 INFO - 'LOGNAME': 'cltbld', 13:34:48 INFO - 'MAIL': '/var/mail/cltbld', 13:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:48 INFO - 'MOZ_NO_REMOTE': '1', 13:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:48 INFO - 'NO_EM_RESTART': '1', 13:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:48 INFO - 'PWD': '/builds/slave/test', 13:34:48 INFO - 'SHELL': '/bin/bash', 13:34:48 INFO - 'SHLVL': '1', 13:34:48 INFO - 'TERM': 'linux', 13:34:48 INFO - 'TMOUT': '86400', 13:34:48 INFO - 'USER': 'cltbld', 13:34:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:48 INFO - '_': '/tools/buildbot/bin/python'} 13:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:34:48 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 13:34:48 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 13:34:48 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 13:34:48 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 13:34:48 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 13:34:48 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 13:34:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:34:50 INFO - Installing collected packages: mozsystemmonitor 13:34:50 INFO - Running setup.py install for mozsystemmonitor 13:34:50 INFO - Successfully installed mozsystemmonitor 13:34:50 INFO - Cleaning up... 13:34:50 INFO - Return code: 0 13:34:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:34: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')]} 13:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34: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')]} 13:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:50 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 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:34:50 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 13:34:50 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 13:34:50 INFO - Using env: {'DISPLAY': ':0', 13:34:50 INFO - 'HOME': '/home/cltbld', 13:34:50 INFO - 'LANG': 'en_US.UTF-8', 13:34:50 INFO - 'LANGUAGE': 'en_US:en', 13:34:50 INFO - 'LOGNAME': 'cltbld', 13:34:50 INFO - 'MAIL': '/var/mail/cltbld', 13:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:50 INFO - 'MOZ_NO_REMOTE': '1', 13:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:50 INFO - 'NO_EM_RESTART': '1', 13:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:50 INFO - 'PWD': '/builds/slave/test', 13:34:50 INFO - 'SHELL': '/bin/bash', 13:34:50 INFO - 'SHLVL': '1', 13:34:50 INFO - 'TERM': 'linux', 13:34:50 INFO - 'TMOUT': '86400', 13:34:50 INFO - 'USER': 'cltbld', 13:34:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:50 INFO - '_': '/tools/buildbot/bin/python'} 13:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:51 INFO - Downloading/unpacking blobuploader==1.2.4 13:34:51 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 13:34:51 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 13:34:51 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 13:34:51 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 13:34:51 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 13:34:51 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 13:34:52 INFO - Downloading blobuploader-1.2.4.tar.gz 13:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:34:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:34:52 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 13:34:52 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 13:34:52 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 13:34:52 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 13:34:52 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 13:34:52 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 13:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:34:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:34:53 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 13:34:53 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 13:34:53 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 13:34:53 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 13:34:53 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 13:34:53 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 13:34:53 INFO - Downloading docopt-0.6.1.tar.gz 13:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:34:53 INFO - Installing collected packages: blobuploader, requests, docopt 13:34:53 INFO - Running setup.py install for blobuploader 13:34:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:34:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:34:53 INFO - Running setup.py install for requests 13:34:54 INFO - Running setup.py install for docopt 13:34:54 INFO - Successfully installed blobuploader requests docopt 13:34:54 INFO - Cleaning up... 13:34:54 INFO - Return code: 0 13:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34: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')]} 13:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34: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')]} 13:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:54 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 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:34:54 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 13:34:54 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 13:34:54 INFO - Using env: {'DISPLAY': ':0', 13:34:54 INFO - 'HOME': '/home/cltbld', 13:34:54 INFO - 'LANG': 'en_US.UTF-8', 13:34:54 INFO - 'LANGUAGE': 'en_US:en', 13:34:54 INFO - 'LOGNAME': 'cltbld', 13:34:54 INFO - 'MAIL': '/var/mail/cltbld', 13:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:54 INFO - 'MOZ_NO_REMOTE': '1', 13:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:54 INFO - 'NO_EM_RESTART': '1', 13:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:54 INFO - 'PWD': '/builds/slave/test', 13:34:54 INFO - 'SHELL': '/bin/bash', 13:34:54 INFO - 'SHLVL': '1', 13:34:54 INFO - 'TERM': 'linux', 13:34:54 INFO - 'TMOUT': '86400', 13:34:54 INFO - 'USER': 'cltbld', 13:34:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:54 INFO - '_': '/tools/buildbot/bin/python'} 13:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:34:54 INFO - Running setup.py (path:/tmp/pip-N3whqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:34:54 INFO - Running setup.py (path:/tmp/pip-zTnVw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:34:54 INFO - Running setup.py (path:/tmp/pip-3VVxnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:34:54 INFO - Running setup.py (path:/tmp/pip-62VcC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:34:54 INFO - Running setup.py (path:/tmp/pip-nHqwbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:34:54 INFO - Running setup.py (path:/tmp/pip-__JTiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:34:54 INFO - Running setup.py (path:/tmp/pip-dn94t_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:34:54 INFO - Running setup.py (path:/tmp/pip-dBo_1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:34:55 INFO - Running setup.py (path:/tmp/pip-hKsdus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:34:55 INFO - Running setup.py (path:/tmp/pip-KA3gXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:34:55 INFO - Running setup.py (path:/tmp/pip-3r7coB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:34:55 INFO - Running setup.py (path:/tmp/pip-FfX7yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:34:55 INFO - Running setup.py (path:/tmp/pip-UktRYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:34:55 INFO - Running setup.py (path:/tmp/pip-PN1lSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:55 INFO - Running setup.py (path:/tmp/pip-aE4UzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:34:55 INFO - Running setup.py (path:/tmp/pip-XgUing-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:34:55 INFO - Running setup.py (path:/tmp/pip-CpUGpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:34:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:34:55 INFO - Running setup.py install for manifestparser 13:34:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:34:55 INFO - Running setup.py install for mozcrash 13:34:55 INFO - Running setup.py install for mozdebug 13:34:55 INFO - Running setup.py install for mozdevice 13:34:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Running setup.py install for mozfile 13:34:56 INFO - Running setup.py install for mozhttpd 13:34:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Running setup.py install for mozinfo 13:34:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Running setup.py install for mozInstall 13:34:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Running setup.py install for mozleak 13:34:56 INFO - Running setup.py install for mozlog 13:34:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Running setup.py install for moznetwork 13:34:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:34:56 INFO - Running setup.py install for mozprocess 13:34:56 INFO - Running setup.py install for mozprofile 13:34:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:34:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:34:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:34:57 INFO - Running setup.py install for mozrunner 13:34:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:34:57 INFO - Running setup.py install for mozscreenshot 13:34:57 INFO - Running setup.py install for moztest 13:34:57 INFO - Running setup.py install for mozversion 13:34:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:34:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:34:57 INFO - Cleaning up... 13:34:57 INFO - Return code: 0 13:34:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:57 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 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:34:57 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 13:34:57 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 13:34:57 INFO - Using env: {'DISPLAY': ':0', 13:34:57 INFO - 'HOME': '/home/cltbld', 13:34:57 INFO - 'LANG': 'en_US.UTF-8', 13:34:57 INFO - 'LANGUAGE': 'en_US:en', 13:34:57 INFO - 'LOGNAME': 'cltbld', 13:34:57 INFO - 'MAIL': '/var/mail/cltbld', 13:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:57 INFO - 'MOZ_NO_REMOTE': '1', 13:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:57 INFO - 'NO_EM_RESTART': '1', 13:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:57 INFO - 'PWD': '/builds/slave/test', 13:34:57 INFO - 'SHELL': '/bin/bash', 13:34:57 INFO - 'SHLVL': '1', 13:34:57 INFO - 'TERM': 'linux', 13:34:57 INFO - 'TMOUT': '86400', 13:34:57 INFO - 'USER': 'cltbld', 13:34:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:57 INFO - '_': '/tools/buildbot/bin/python'} 13:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:34:57 INFO - Running setup.py (path:/tmp/pip-M1G8hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:34:57 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)) 13:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:34:57 INFO - Running setup.py (path:/tmp/pip-YLI5cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:34:57 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)) 13:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:34:57 INFO - Running setup.py (path:/tmp/pip-ND2BpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:34:57 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)) 13:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:34:57 INFO - Running setup.py (path:/tmp/pip-EhZLFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:34:57 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)) 13:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:34:57 INFO - Running setup.py (path:/tmp/pip-1HOKuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:34:58 INFO - Running setup.py (path:/tmp/pip-zfIjuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:34:58 INFO - Running setup.py (path:/tmp/pip-gZHc0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:34:58 INFO - Running setup.py (path:/tmp/pip-Qd3HnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:34:58 INFO - Running setup.py (path:/tmp/pip-5KkbnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:34:58 INFO - Running setup.py (path:/tmp/pip-JVgK01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:34:58 INFO - Running setup.py (path:/tmp/pip-ER9EYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:34:58 INFO - Running setup.py (path:/tmp/pip-TFHfre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:34:58 INFO - Running setup.py (path:/tmp/pip-8aAR8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:34:58 INFO - Running setup.py (path:/tmp/pip-M2oqWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:58 INFO - Running setup.py (path:/tmp/pip-VcqGNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:58 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)) 13:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:34:58 INFO - Running setup.py (path:/tmp/pip-uhEUEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:34:59 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)) 13:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:34:59 INFO - Running setup.py (path:/tmp/pip-EYvoKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:34:59 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)) 13:34:59 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)) 13:34:59 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)) 13:34:59 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)) 13:34:59 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)) 13:34:59 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)) 13:34:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:34: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 13:34: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 13:34: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 13:34: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 13:34: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 13:34: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 13:35:00 INFO - Downloading blessings-1.6.tar.gz 13:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:35:01 INFO - Installing collected packages: blessings 13:35:01 INFO - Running setup.py install for blessings 13:35:01 INFO - Successfully installed blessings 13:35:01 INFO - Cleaning up... 13:35:01 INFO - Return code: 0 13:35:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:01 INFO - Reading from file tmpfile_stdout 13:35:01 INFO - Current package versions: 13:35:01 INFO - argparse == 1.2.1 13:35:01 INFO - blessings == 1.6 13:35:01 INFO - blobuploader == 1.2.4 13:35:01 INFO - docopt == 0.6.1 13:35:01 INFO - manifestparser == 1.1 13:35:01 INFO - mozInstall == 1.12 13:35:01 INFO - mozcrash == 0.17 13:35:01 INFO - mozdebug == 0.1 13:35:01 INFO - mozdevice == 0.48 13:35:01 INFO - mozfile == 1.2 13:35:01 INFO - mozhttpd == 0.7 13:35:01 INFO - mozinfo == 0.9 13:35:01 INFO - mozleak == 0.1 13:35:01 INFO - mozlog == 3.1 13:35:01 INFO - moznetwork == 0.27 13:35:01 INFO - mozprocess == 0.22 13:35:01 INFO - mozprofile == 0.28 13:35:01 INFO - mozrunner == 6.11 13:35:01 INFO - mozscreenshot == 0.1 13:35:01 INFO - mozsystemmonitor == 0.0 13:35:01 INFO - moztest == 0.7 13:35:01 INFO - mozversion == 1.4 13:35:01 INFO - psutil == 3.1.1 13:35:01 INFO - requests == 1.2.3 13:35:01 INFO - wsgiref == 0.1.2 13:35:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:01 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 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:35:01 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 13:35:01 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 13:35:01 INFO - Using env: {'DISPLAY': ':0', 13:35:01 INFO - 'HOME': '/home/cltbld', 13:35:01 INFO - 'LANG': 'en_US.UTF-8', 13:35:01 INFO - 'LANGUAGE': 'en_US:en', 13:35:01 INFO - 'LOGNAME': 'cltbld', 13:35:01 INFO - 'MAIL': '/var/mail/cltbld', 13:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:01 INFO - 'MOZ_NO_REMOTE': '1', 13:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:01 INFO - 'NO_EM_RESTART': '1', 13:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:01 INFO - 'PWD': '/builds/slave/test', 13:35:01 INFO - 'SHELL': '/bin/bash', 13:35:01 INFO - 'SHLVL': '1', 13:35:01 INFO - 'TERM': 'linux', 13:35:01 INFO - 'TMOUT': '86400', 13:35:01 INFO - 'USER': 'cltbld', 13:35:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:01 INFO - '_': '/tools/buildbot/bin/python'} 13:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 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)) 13:35:01 INFO - Cleaning up... 13:35:01 INFO - Return code: 0 13:35:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:01 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 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:35:01 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 13:35:01 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 13:35:01 INFO - Using env: {'DISPLAY': ':0', 13:35:01 INFO - 'HOME': '/home/cltbld', 13:35:01 INFO - 'LANG': 'en_US.UTF-8', 13:35:01 INFO - 'LANGUAGE': 'en_US:en', 13:35:01 INFO - 'LOGNAME': 'cltbld', 13:35:01 INFO - 'MAIL': '/var/mail/cltbld', 13:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:01 INFO - 'MOZ_NO_REMOTE': '1', 13:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:01 INFO - 'NO_EM_RESTART': '1', 13:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:01 INFO - 'PWD': '/builds/slave/test', 13:35:01 INFO - 'SHELL': '/bin/bash', 13:35:01 INFO - 'SHLVL': '1', 13:35:01 INFO - 'TERM': 'linux', 13:35:01 INFO - 'TMOUT': '86400', 13:35:01 INFO - 'USER': 'cltbld', 13:35:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:01 INFO - '_': '/tools/buildbot/bin/python'} 13:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:01 INFO - Downloading/unpacking jsonschema 13:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:35:03 INFO - Downloading/unpacking functools32 (from jsonschema) 13:35:03 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 13:35:03 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 13:35:03 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 13:35:03 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 13:35:03 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 13:35:03 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 13:35:03 INFO - Downloading functools32-3.2.3-2.tar.gz 13:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:35:04 INFO - warning: no files found matching '*.txt' 13:35:04 INFO - no previously-included directories found matching 'build' 13:35:04 INFO - no previously-included directories found matching 'dist' 13:35:04 INFO - no previously-included directories found matching '.git*' 13:35:04 INFO - Installing collected packages: jsonschema, functools32 13:35:04 INFO - Running setup.py install for functools32 13:35:04 INFO - warning: no files found matching '*.txt' 13:35:04 INFO - no previously-included directories found matching 'build' 13:35:04 INFO - no previously-included directories found matching 'dist' 13:35:04 INFO - no previously-included directories found matching '.git*' 13:35:04 INFO - Successfully installed jsonschema functools32 13:35:04 INFO - Cleaning up... 13:35:04 INFO - Return code: 0 13:35:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:35: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')]} 13:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35: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')]} 13:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8132b2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', '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 13:35: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', 'flake8'] in /builds/slave/test/build 13:35: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 flake8 13:35:04 INFO - Using env: {'DISPLAY': ':0', 13:35:04 INFO - 'HOME': '/home/cltbld', 13:35:04 INFO - 'LANG': 'en_US.UTF-8', 13:35:04 INFO - 'LANGUAGE': 'en_US:en', 13:35:04 INFO - 'LOGNAME': 'cltbld', 13:35:04 INFO - 'MAIL': '/var/mail/cltbld', 13:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:04 INFO - 'MOZ_NO_REMOTE': '1', 13:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:04 INFO - 'NO_EM_RESTART': '1', 13:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:04 INFO - 'PWD': '/builds/slave/test', 13:35:04 INFO - 'SHELL': '/bin/bash', 13:35:04 INFO - 'SHLVL': '1', 13:35:04 INFO - 'TERM': 'linux', 13:35:04 INFO - 'TMOUT': '86400', 13:35:04 INFO - 'USER': 'cltbld', 13:35:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:04 INFO - '_': '/tools/buildbot/bin/python'} 13:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:04 INFO - Downloading/unpacking flake8 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:35:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:35:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:35:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:35:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:35:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:35:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:35:07 INFO - no previously-included directories found matching 'docs/_build' 13:35:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:35:07 INFO - Running setup.py install for pep8 13:35:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:35:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:35:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:35:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:35:07 INFO - no previously-included directories found matching 'docs/_build' 13:35:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:35:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:35:07 INFO - Cleaning up... 13:35:07 INFO - Return code: 0 13:35:07 INFO - Running post-action listener: _resource_record_post_action 13:35:07 INFO - Running post-action listener: _start_resource_monitoring 13:35:07 INFO - Starting resource monitoring. 13:35:07 INFO - ##### 13:35:07 INFO - ##### Running install step. 13:35:07 INFO - ##### 13:35:07 INFO - Running pre-action listener: _resource_record_pre_action 13:35:07 INFO - Running main action method: install 13:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:07 INFO - Reading from file tmpfile_stdout 13:35:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:35:07 INFO - Reading from file tmpfile_stdout 13:35:07 INFO - Output received: 13:35:07 INFO - Usage: mozinstall [options] installer 13:35:07 INFO - Options: 13:35:07 INFO - -h, --help show this help message and exit 13:35:07 INFO - -d DEST, --destination=DEST 13:35:07 INFO - Directory to install application into. [default: 13:35:07 INFO - "/builds/slave/test"] 13:35:07 INFO - --app=APP Application being installed. [default: firefox] 13:35:07 INFO - mkdir: /builds/slave/test/build/application 13:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:35:23 INFO - Reading from file tmpfile_stdout 13:35:23 INFO - Output received: 13:35:23 INFO - /builds/slave/test/build/application/firefox/firefox 13:35:23 INFO - Running post-action listener: _resource_record_post_action 13:35:23 INFO - ##### 13:35:23 INFO - ##### Running run-tests step. 13:35:23 INFO - ##### 13:35:23 INFO - Running pre-action listener: _resource_record_pre_action 13:35:23 INFO - Running main action method: run_tests 13:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:35:23 INFO - Python 2.7.3 13:35:23 INFO - Return code: 0 13:35:23 INFO - grabbing minidump binary from tooltool 13:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:23 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 0xdcb410>, '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 0xdcc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:35:23 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 13:35:23 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 13:35:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:35:23 INFO - Return code: 0 13:35:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:35:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:35:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:35:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:35:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:35:24 INFO - Return code: 0 13:35:24 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/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:35:24 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/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 13:35:24 INFO - Using env: {'DISPLAY': ':0', 13:35:24 INFO - 'HOME': '/home/cltbld', 13:35:24 INFO - 'LANG': 'en_US.UTF-8', 13:35:24 INFO - 'LANGUAGE': 'en_US:en', 13:35:24 INFO - 'LOGNAME': 'cltbld', 13:35:24 INFO - 'MAIL': '/var/mail/cltbld', 13:35:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:35:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:24 INFO - 'MOZ_NO_REMOTE': '1', 13:35:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:24 INFO - 'NO_EM_RESTART': '1', 13:35:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:24 INFO - 'PWD': '/builds/slave/test', 13:35:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:35:24 INFO - 'SHELL': '/bin/bash', 13:35:24 INFO - 'SHLVL': '1', 13:35:24 INFO - 'TERM': 'linux', 13:35:24 INFO - 'TMOUT': '86400', 13:35:24 INFO - 'USER': 'cltbld', 13:35:24 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295', 13:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:24 INFO - '_': '/tools/buildbot/bin/python'} 13:35:24 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/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:35:24 INFO - mozversion application_buildid: 20160429124142 13:35:24 INFO - mozversion application_changeset: d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 13:35:24 INFO - mozversion application_display_name: Nightly 13:35:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:35:24 INFO - mozversion application_name: Firefox 13:35:24 INFO - mozversion application_remotingname: firefox 13:35:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:35:24 INFO - mozversion application_vendor: Mozilla 13:35:24 INFO - mozversion application_version: 49.0a1 13:35:24 INFO - mozversion platform_buildid: 20160429124142 13:35:24 INFO - mozversion platform_changeset: d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 13:35:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:35:24 INFO - mozversion platform_version: 49.0a1 13:35:24 INFO - using testdate: 1461962124 13:35:24 INFO - actual date: 1461962124 13:35:24 INFO - starting webserver on 'localhost:41024' 13:35:24 INFO - SUITE-START | Running 2 tests 13:35:24 INFO - TEST-START | dromaeo_css 13:35:24 INFO - operating with platform_type : linux_ 13:35:24 INFO - Initialising browser for dromaeo_css test... 13:35:24 INFO - TEST-INFO | started process 11401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1zKgUr/profile http://localhost:41024/getInfo.html) 13:35:29 INFO - PROCESS | 11401 | 13:35:29 INFO - PROCESS | 11401 | (process:11467): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:35:29 INFO - PROCESS | 11401 | __metrics Screen width/height:1600/1200 13:35:29 INFO - PROCESS | 11401 | colorDepth:24 13:35:29 INFO - PROCESS | 11401 | Browser inner width/height: 1024/697 13:35:29 INFO - PROCESS | 11401 | __metrics 13:35:30 ERROR - PROCESS | 11401 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:35:31 INFO - TEST-INFO | 11401: exit 0 13:35:31 INFO - Browser initialized. 13:35:31 INFO - Running cycle 1/1 for dromaeo_css test... 13:35:31 INFO - TEST-INFO | started process 11518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1zKgUr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:35:33 INFO - PROCESS | 11518 | 13:35:33 INFO - PROCESS | 11518 | (process:11578): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:35:43 INFO - PROCESS | 11518 | RSS: Main: 166330368 13:35:43 INFO - PROCESS | 11518 | 13:36:33 INFO - PROCESS | 11518 | 1461962193106 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] 13:38:45 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:41024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41024/tests/dromaeo/cssquery-ext.html) 13:38:46 INFO - PROCESS | 11518 | RSS: Main: 168996864 13:38:46 INFO - PROCESS | 11518 | 13:41:48 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:41024/tests/dromaeo/cssquery-ext.html (next: http://localhost:41024/tests/dromaeo/cssquery-jquery.html) 13:41:49 INFO - PROCESS | 11518 | RSS: Main: 166789120 13:41:49 INFO - PROCESS | 11518 | 13:44:51 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:41024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41024/tests/dromaeo/cssquery-mootools.html) 13:44:51 INFO - PROCESS | 11518 | RSS: Main: 168124416 13:44:51 INFO - PROCESS | 11518 | 13:47:53 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:41024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41024/tests/dromaeo/cssquery-prototype.html) 13:47:54 INFO - PROCESS | 11518 | RSS: Main: 165654528 13:47:54 INFO - PROCESS | 11518 | 13:50:56 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:41024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41024/tests/dromaeo/cssquery-yui.html) 13:50:57 INFO - PROCESS | 11518 | RSS: Main: 166506496 13:50:57 INFO - PROCESS | 11518 | 13:53:59 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:41024/tests/dromaeo/cssquery-yui.html (next: http://localhost:41024/tests/dromaeo/cssquery-dojo.html) 13:54:00 INFO - PROCESS | 11518 | RSS: Main: 169185280 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - PROCESS | 11518 | __start_tp_report 13:54:00 INFO - PROCESS | 11518 | _x_x_mozilla_page_load 13:54:00 INFO - PROCESS | 11518 | _x_x_mozilla_page_load_details 13:54:00 INFO - PROCESS | 11518 | |i|pagename|runs| 13:54:00 INFO - PROCESS | 11518 | |0;dojo.html;2632.947341053179;2689.69068557116;2714.375693590473;2720.673519177699;2734.9999999999986;4731;4760.381150450441;4785.641076919228;4789.233722604384;4838.879028024301;4663.860084197479;4731.124741922747;4748.169070412672;4760.785764640591;4797.520247975201;4343.500497442795;4386.363977223301;4403.3394990751485;4407.823687052514;4411.448568928884;10.193975674037436;4057.5794507339297;4298.183345164409;4351.151525452538;4451.310046942729;4363.38912552243;4388.034632380903;4389.5390983946545;4408.29467285236;4439.4228750262255;4379.737215767064;4386.56134386562;4401.097774956126;4410.073884484262;4441.777911104432;4337.240982828024;4367.432233809616;4375.803088860977;4397.494288156871;4439.245328294198;4629.282461218517;4668.4631267404;4671.43942726875;4671.462781780071;4727.22000869856;4908.239222920453;5046.066477701637;5091.032703786269;5101.795928162869;5128;4972.453030166679;5026.195808670632;5044.192929131322;5137.280780690707;5198.636095473318;4709.175894218498;4710.317004034464;4710.69380490267;4740.146773580754;4741.66808323421;5135.717535535507;5137.998090372416;5189.169732842803;5228.738563071831;5240.68555886648;4960.776765045582;4968.975155124273;4969.0807200668;4996.475370086161;5044.571211446994;5014.272930425068;5062.291279220912;5067.645264831426;5075.416327122354;5121.820736274287;5001.7464198393145;5022.3219865317715;5082.313887625197;5098.745062746848;5103.362079740033;4959.404871415453;4981.950180498148;4982.327385802871;4991.301217829507;5044.1172794761505;4179.2059508693255;4280.5505421930875;4282.122164956177;4290.37789520524;4323.48118225815;3651.908702282464;3720.6837418819164;3753;3776.055986003499;3788.6400791924725;4338.067315527177;4348.956510434855;4372.519022907478;4392.231359512072;4419.0719948810465;4958.628102892298;5091.363579552556;5095.261187127846;5099.566536844335;5106.15748401517;4342.696011279243;4395.164918665508;4398.64810815134;4424.668149888771;4437.356583295404;4542.068875880436;4550.249208880564;4561.931571026437;4596.5863072323655;4600.263957766741;4640.327152562927;4717.198076327101;4758.78585463655;4778.95221047799;4798.856034319046;5109.718965456936;5131.25596788471;5172.5344718973965;5174.689518628894;5181.689098654093;4819.807207711792;4830.855074347775;4831.758412079453;4839.903201936012;4866.513348665105;4913.533214344631;5016.996600679806;5052.747362631927;5055.216441451581;5090.134677104827;5073.188289873602;5089.312942752681;5109.3613298337705;5115.539601435739;5149.7682604282145;4953.108440480748;4955.0337684151245;4964;4964.503549645006;4967.975160124176;4769.594584460359;4864.927026094682;4938.975305123451;4995.075910956485;5000.399952005782;4865;4872.853814385574;4907.411110666742;4945.23348880924;4962.330085438564;5016.774245158904;5021.4225364083595;5022.949770502249;5023.070731914608;5024.246363045572;4738.31294462308;4823.155947709207;4898.657094003528;4911.852644420673;4964.35463389757 13:54:00 INFO - PROCESS | 11518 | |1;ext.html;574.9798757043504;591.8668299632583;605.5004621187521;617.4257940115691;617.8300967234012;35102.824485877565;35920.82039589805;36221.818890905575;36250;36267.274654506895;39451.60548394515;40297.395539066936;40423.19153616926;40487.19025619486;40543.59456405435;7542.924570754304;7801.648925798353;7811.101723301807;7833.099193592724;7854.764357069268;7927.1676473970265;8054.114047454776;8067.556284404355;8094.028716554022;8101.351891848667;8016.759497215093;8021.759347219593;8076.313513351372;8116.553589552572;8119.675212991473;7998.560079195642;8001.8799718004275;8009.719659811908;8083.514989100673;8097.676092956274;7745.535267883945;7801.258880406353;7820.608969551499;7827.412944029221;7847.843043139163;39727.40408893869;39956.600433995576;40191.7990410049;40243.195136097405;40435.39346909799;3211.4701074322707;3214.4696125139326;3214.8231847248394;3281.868725250987;3392.0671815250757;29602.851985740148;29687.018269699412;29726.256843578867;30734.231644209074;30775.38449231003;3024.138120635608;3030.712082352173;3054.8167109973474;3072.9846350768325;3160.920976975571;241250;244393;244400;244771;245185;57819;58224.4177558219;58228.70885645544;58268.7086564573;58321;58661;59941;60186;60283.397166027775;60313;14153.150810951376;14260.572182834532;14335.78496322556;14340;14364.712705746035;10833.512491937881;10849.511771970281;10883.619073332395;10892.128629709763;10924.781504369868;19677.50806229856;20201.393958181277;20212;20261.797382026285;20315.796842031687;7581.431392645573;7641;7654.578998155043;7818.726344577913;7851.367693061121;906.5603182456504;989.7129832348683;1006.7684432580547;1056.9682909512726;1069.3476979042778;28595.57106643402;28693;28822;29173.7082629171;29274.707252927623;945.7115579748105;1012.4785735346303;1032.4734385463469;1051.1433181956681;1082.6373164989816;15066.773998390034;15411.949794782005;15568.377264909503;15621.375144994301;15807.920960395124;393204;401376;401767;402200;403762;51202;51402.228966564784;51786.741066294424;52005.47994520082;52017.7399113002;1258.5280519805074;1260.5021016698536;1264.0203842022506;1266.170658218868;1282.410091357967;27330.863345683145;27722.584161237195;28441.573376398956;28641.28396790097;28672.426551468438;44156.11687766291;44720;44723.10553788971;44790.3281450772;44821.55178448174;320780;326359;327182;327878;328230;26349.473010540067;26682.466350673265;26779.464410711287;26882.462350753267;26914.461710766067;43708.125837483705;44091.338629919934;44206.33690494709;45091.32363014623;45117.774411127735;37558.43662345012;37560;37663;37693.676402966696;37876.212378761906;37188.81405592955;37674.246515069;37679;37743.81128094342;37809.62190378171;28274.2931426716;34434.31131377409;34465;34602.48096278508;36336.4549531752;34786.30427391388;34959;35516;35687.82156089203;35759;27332.726672733814;28149.296267593472;28189.43621127607;28451.288717781394;29893.402131956806 13:54:00 INFO - PROCESS | 11518 | |2;jquery.html;373.96260373962605;375.32254281022745;379.1969186518106;384.5596791673536;388.17125437191595;15465.458708945189;15747.212639368028;16266.83733162668;16533.421330253444;16565.83434165658;15052.924735376308;15998.60003499913;16681.08254046027;16687.83312166878;16695.49913502597;5177.119889618755;5281;5315.760790764425;5318.734063296839;5330.760115794798;5188.584913206953;5208.869778255536;5262.9473705263035;5283.947160528384;5289.709066001368;5465.808696695616;5508.586855985797;5512.4211957744465;5512.834614961557;5517.117261238202;5224.947750522484;5468.7265636718;5482.2873026506495;5503.889922201573;5504.532114770249;5043.2435134730085;5297.284866543006;5311.681299122065;5356.11624082026;5367.543758780508;12010.879891201152;12195.207311524811;12276.263424194487;12319.199252048678;17787.911060444745;1873.4473330367575;1892.924283028677;1922.1350392323511;1986.5728868293386;2028.3205126282712;9247.953760231223;9410.62357505699;9526.714198574055;9643.758906027335;10846.648610375267;1745.9476215713548;1849.4081893793991;1852.8054554271878;1860.618573192506;1864.2263460663808;69147.65426172837;73225;74585.62707186483;75284;75669.62165189139;9972.750681233027;10163.542640581192;10231.94884025575;10420;10709.946450267698;14451.855481445262;14458;14463.566093017016;14515.403305636371;14550.563483095524;6888.276730943279;7141.607211603307;7204.92795072053;7362.153352364439;7366.263373662591;6574.474042076622;6600.240972288152;6648.53460257787;6674.16572928384;6765.35729105744;4463.062756821104;4482.820687172477;4490.7754612269255;4524.864254072383;4529.433820772403;1847.584293533971;1893.9053047347577;1904.8857068575653;1911.111333230027;1931.4881556387568;848.3849209323191;866.4757821518017;883.9071897450804;887.3744010472731;955.5174636808367;16459.177041147894;16557.172141392883;16762.83237167637;16981.660366792596;17083.31666733317;861.9396642234983;900.7297810656777;924.1728652855656;940.9529523523796;953.4422362917633;9192.49441280736;9551.42691438516;9585.760355991157;9757.21942244633;9767.511624418892;358931;366316;388332;405415;416128;58737.706311468166;70755;79205;79205;81396;929.3030227329502;947.3842002698163;963.7542426681151;967.8983706710835;975.4586204656342;15336.76994845056;15375.615609609402;15389.538313850602;15500.5349839505;15564.766528502309;35057.82471087628;35641.46537801883;35845.28309433849;36488.81755591205;36559.634403655626;46938.295925561826;51448;51546.22680659868;51550.484495156066;52100.21849672334;7483.176850546327;7501.399888009056;7523.473356864967;7530.510516816608;7721.227877212234;9430.575624096795;10582;10969.122470202525;11116.388598626829;11264.324140551593;9007.189352958003;9314.20829229496;9757.414555126716;9847.556859941176;9989.200863930722;9934.205263578751;9997.900020999989;10045.799084018425;10059.49702514886;10168.135708464863;9567.712968610953;9644.855327170239;9659.661911833053;9755.170810481188;9959.203263738738;7616.466847320635;7630.809229769078;7702.537847729154;7747.147813740371;7779.649915753692;8520.70177543783;9157.221636161;9314.301427392837;9486.525673716425;9593.664221752206 13:54:00 INFO - PROCESS | 11518 | |3;mootools.html;1448.1166488442052;1453.8836893048558;1581.9920900395496;1717.9226934787932;1758.7537744715742;6823.874060779978;7342.412606991441;7475.73834915778;7676.38588912887;7683.654235559399;7446.925530744705;7562.205968373324;7564.054493188351;7574.659140338684;7630.961845190766;2171.326888664515;2230.2528652901296;2245.7305123385217;2253.0649780341137;2256.345659758668;2212.723409573803;2236.474428509299;2245.348848833836;2259.367377134405;2260.8078313343385;2177.1182671018264;2189.2994241842616;2257.052038143975;2268.4669102760836;2271.931842044741;2172.1745736620064;2172.8587641803233;2180.5420861619077;2182.7271591051117;2187.1470126650697;2149.344449942767;2157.2018353209414;2160.8811515366647;2161.448830548216;2164.6644770060666;7635.541867487968;7645.350145237661;7657.042869641295;7717.035370578677;7727.343175830061;4320.24395730749;4420.535843736426;4421.6904816662845;4424.004598965207;4427.446569178853;2759.6274502942247;2781.485425196345;2858.428314337141;2865.498537755884;2869.626948496703;895.2882458445551;929.8791157149595;933.710549729586;942.6229508196708;954.3033585482636;10269.127124194378;10274.7431314217;10284.588616455332;10366.533505992249;10403.479826008745;4143.834246630101;4176.206520761046;4239.957600424018;4251.829926802893;4261.105167914772;8885.644574216958;8894.155055269739;8903.910960890438;8904.332175086765;8907.866382004275;4526.117407105583;4550.112728018004;4602.7468489233415;4605.309203619484;4610.631149508098;3654.744167908221;4055.6755459563756;4179.414881916534;4209.684273679486;4211.136716973013;3601.7838929664304;3622.637736226409;3725.9254814904093;3729.328720830277;3753.2868754936476;1198.5984695127056;1224.2103843021202;1241.1994263700044;1248.7939489984233;1258.8615252322238;753.9132999704995;855.6449073634496;866.6620018192909;875.8554838451712;891.1219135878728;5040.949590504048;5328.733563321896;5381.569474442035;5452.645578037414;5475.178723191473;420.43241623807614;420.8148414697523;421.1093537168927;427.2715020889376;432.60200615433877;3655.561332640047;3723.0878434783654;3754.624537546278;3769.5792364160156;3819.52255968004;9448.291378146667;9830.262730295257;9929.50352482373;9950.45272510019;9990.100890919706;9785.608575657036;9835.754106147404;9844.114029737215;9879.209663226924;9888.65389711371;6870.45036397087;7412.629368531444;7458.366038886756;7504.774856754306;7535.321821036133;5249.160134378481;5365.2220428036935;5372.1941708744;5516.062269414289;5519.668819870821;8374.413791034813;8841.513716745641;8863;8948.74717539558;8982.101789821227;8682.43564168327;8844;8872.689455869013;8889;8955.776105597412;6153.938460615515;6349.523785716182;6589.703463344065;6758.391744742997;6877.037214790033;7089.7873063808165;7121.109861267341;7170.211276759448;7199.388052015637;7234.710611575478;6351.745930162741;6634.767783127568;6705.430038446787;6736.730530778714;6793.864122717617;6573.244076931022;6605.504587155887;6631.502637302318;6635.402813746593;6698.263191049078;5994.610350327215;6073.817785466443;6082.391760824059;6099.329073801967;6103.176071230327;4421.823127074881;4434.51220365753;4436;4545.6590755694115;4563.178627847019;4500.8649740507835;4510.977445112753;4572.108438854524;4580.450345958507;4658 13:54:00 INFO - PROCESS | 11518 | |4;prototype.html;305.2902002843388;305.3282777888645;309.53106044342826;316.3467439736942;316.6390315040854;4936.3829521309835;4996.350474438323;4998.400191976968;5005.949940500594;5020.39755229373;4920.655554111214;4924.409070911487;4926.655134140611;4952.3561936948145;4958.330625365575;3690.833912473932;3774.735768496206;3847.5190601174854;3867.7679339239594;3889.6775096467195;3866.9226615467674;3892.70804689648;3900.083480382108;3903.902402439933;3905.6484916357663;3842.1739326044894;3851.7496362736474;3855.8264878080554;3878.7975727524417;3888.5722570517364;3792.1467669774356;3863.439801228806;3870.4774855394444;3895.571487136427;3934.996575873134;3460.9826950865086;3468.358353704573;3481.0775144586705;3482.791032538056;3498.632643572439;4678.508756580544;4718.245080787092;4720.59874910633;4747.240441529373;4750.881227969294;4454.042380888092;4465.776711164462;4503;4506.3916371290115;4536.818527258939;5012.393555351234;5258.1849813279005;5262.158054711228;5285.022270879899;5297.390800058004;3708.8516459341595;3715.758475699071;3730.626937306248;3740.3828368319196;3741.251749650081;5476.123820188751;5535.723213839332;5537.920105579374;5540.584456165763;5563.304586926634;3585.4980302757635;3802.4866643003393;3803.4675145479655;3806.1245913440066;3810.5617853946596;3864.14988702485;3865.7100717446306;3869.8258578364043;3880.5731369549326;3881.6118388160958;4404.07514421975;4419.40338054365;4422.314541246048;4422.469303683579;4449.777511124431;5040.546350828443;5182.2485739567555;5235.528802407802;5249.685018898802;5259.15853463444;1391.074935168122;1402.9438822447191;1402.95089671861;1404.9016568840289;1406.1984668738721;864.8443280209497;907.396581273459;939.9707320484059;951.46242373059;954.341504361988;4424.84513042042;4551.635869130461;4556.521565235669;4577.29051996941;4613.907721845544;5368.812091576776;5393.514583687487;5396.217548455452;5398.217258497496;5422.810201642924;4391.84628538006;4571.954280457219;4582.289745089516;4584.931226031612;4596.747178905125;3066.6013418255484;3066.9079927602206;3081.922951926175;3089.0269565086924;3090.134762266569;5361.705106219196;5375.381831089475;5382.569394448435;5391.137418013099;5414.40441551429;5281.656692314988;5599.552035837123;5605.243292155506;5872.677002764889;5894.204282421818;5077.172218001517;5130.153524668388;5132.717700526432;5153.768080436389;5178.8964220716125;5428.104362780255;5456.836294911159;5457.61796674229;5462.535684466706;5486.423925487926;5180.963807238642;5283.630145889904;5308.575313974796;5309.725665840093;5335.706536140549;5095.490450954875;5096.592272618108;5100.132977393778;5109.974450127875;5125.359330083739;3699.315626609086;3727.3849814780256;3730.365837807525;3742.7005839532226;3772.6607054495257;5290.338707661543;5392.460753924576;5394.32570928634;5406.621536492565;5440.727963601725;5234.607404444606;5245.580353571629;5248.3701955765555;5251.844594189272;5256.342957130359;4982.327385803015;5240.240165176105;5241.344831896013;5241.816536421207;5249.2415040961705;5188.610854186027;5193.948060519347;5200.141976573823;5208.5312321891215;5224.817131400383;4997.800967574256;5084.618653601069;5245.895082098413;5247.7113758743635;5283.286756287852;5109.489051094861;5131.923021154611;5143.459936706592;5153.7165455900285;5158.200478925773 13:54:00 INFO - PROCESS | 11518 | |5;yui.html;583.7635757518207;667.4360165660017;680.733844957169;689.2211800665248;692.5152393324672;11050.226484146113;11066.723331916706;11149.609763658274;11297.830532542019;11319.660410187696;11531.884681153186;11584.59453919113;11623.825642615368;11625.941870290659;11688.298702077882;639.143547646154;739.0872272743158;788.6884680551179;800.5036877136183;800.6437135474716;808.5027707959592;809.5264270401822;809.6599428240153;810.0805585660288;812.0174588747623;846.2299307630058;846.5047946951041;847.089378917666;847.2840449819893;849.587949844325;837.2464781696461;838.1450920061565;838.5388036579857;839.911809260028;841.5119230846155;616.5807251069272;618.761776715963;620.0265583034637;620.9348018458087;622.365187508743;11726.413679316;11734.354610496419;11798;11941.522339106425;12026.879731202664;11259.099272058298;11415.657530274106;11546.653600391917;11669.066474682006;11843.230190037706;9538.403554709146;9612.375195612263;9643.855342169873;9794.559244834;9829.508524573743;3137.748980081588;3142.1673256587023;3149.716525512692;3205.2627895584146;3281.5733954585753;48081.03837923257;48803.26795098041;49171.50828491705;49184.50815491835;49453.75273123611;8681.30549556034;8931.419457735226;9000.954995224982;9114.908850911539;9308.162265396011;15386.769198462032;15577.610559735871;15617;15617.3753049879;15625.921870390803;6425;6540;6593.967030164818;6667.933320666732;6771.52599318043;3467.219875527986;3539.823008849547;3549.8402571884326;3558.6975107116186;3566.964330356715;2697.865106744655;2731.207949694566;2753.8623068846478;2765.723427657218;2786.4427114577165;512.7795048129266;517.5276338816062;522.8849653076317;523.6596212461855;530.4244894289661;499.9075171093359;561.0126177926878;580.4688709830458;612.0941007309208;617.4042049422329;7396.852062958711;7531.8117047073165;7582.165961744204;7702.268284513074;7830.295273425305;531.9095753721799;544.9836055755986;627.5324882962223;642.5791106825037;649.4090377756219;3494.266204097117;3663.19409729859;3675.2649470106085;3694.833732482045;3778.5843557208686;57198.714006430535;58488.41511584915;59362;59616;60031;46748.29877551839;49280.260796088085;50578;51270.230946535834;51383.22925156126;45252;45847.77076114665;46184;46244.768776156576;46439.99999999932;8091.474054186459;8153.306968907709;8207.876881846896;8296.211859873303;8424.199701028392;27042.729572704022;27719;28753.856230718713;30435.086947391614;32072.839635801673;36345.81827090848;38575.42136867893;41577.505349679115;41887.790561047;42521.36217956671;10985.670429887115;10991.61529346469;11023.44882755843;11142.108631309313;11221.66335009951;10776.353418794897;11404.657860263873;11595.768084638428;11847.407629618658;12203.328816915155;11227.438628068401;11411;11549.942250288696;11570.19008669385;11630.476628551567;10669.35983840972;11111.111111111253;11174.49714762854;11229.157813163882;12015.279083255033;9008.369414140947;10646.520906559379;10816.729581760519;10994.835077473685;11090.279131856403;9179.678711245075;9529.857052144085;9785.902140978784;9913.058259465339;10170.288079834341;9231.630734770803;9262.305327100628;9468.289878259297;9593.13661770444;9687.757806054906 13:54:00 INFO - PROCESS | 11518 | __end_tp_report 13:54:00 INFO - PROCESS | 11518 | __start_cc_report 13:54:00 INFO - PROCESS | 11518 | _x_x_mozilla_cycle_collect,383 13:54:00 INFO - PROCESS | 11518 | __end_cc_report 13:54:00 INFO - PROCESS | 11518 | __startTimestamp1461963240156__endTimestamp 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - PROCESS | 11518 | ------- Summary: start ------- 13:54:00 INFO - PROCESS | 11518 | Number of tests: 6 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - PROCESS | 11518 | [#0] dojo.html Cycles:165 Average:4667.08 Median:4823.16 stddev:608.71 (12.6%) stddev-sans-first:589.29 13:54:00 INFO - PROCESS | 11518 | Values: 2632.9 2689.7 2714.4 2720.7 2735.0 4731.0 4760.4 4785.6 4789.2 4838.9 4663.9 4731.1 4748.2 4760.8 4797.5 4343.5 4386.4 4403.3 4407.8 4411.4 10.2 4057.6 4298.2 4351.2 4451.3 4363.4 4388.0 4389.5 4408.3 4439.4 4379.7 4386.6 4401.1 4410.1 4441.8 4337.2 4367.4 4375.8 4397.5 4439.2 4629.3 4668.5 4671.4 4671.5 4727.2 4908.2 5046.1 5091.0 5101.8 5128.0 4972.5 5026.2 5044.2 5137.3 5198.6 4709.2 4710.3 4710.7 4740.1 4741.7 5135.7 5138.0 5189.2 5228.7 5240.7 4960.8 4969.0 4969.1 4996.5 5044.6 5014.3 5062.3 5067.6 5075.4 5121.8 5001.7 5022.3 5082.3 5098.7 5103.4 4959.4 4982.0 4982.3 4991.3 5044.1 4179.2 4280.6 4282.1 4290.4 4323.5 3651.9 3720.7 3753.0 3776.1 3788.6 4338.1 4349.0 4372.5 4392.2 4419.1 4958.6 5091.4 5095.3 5099.6 5106.2 4342.7 4395.2 4398.6 4424.7 4437.4 4542.1 4550.2 4561.9 4596.6 4600.3 4640.3 4717.2 4758.8 4779.0 4798.9 5109.7 5131.3 5172.5 5174.7 5181.7 4819.8 4830.9 4831.8 4839.9 4866.5 4913.5 5017.0 5052.7 5055.2 5090.1 5073.2 5089.3 5109.4 5115.5 5149.8 4953.1 4955.0 4964.0 4964.5 4968.0 4769.6 4864.9 4939.0 4995.1 5000.4 4865.0 4872.9 4907.4 4945.2 4962.3 5016.8 5021.4 5022.9 5023.1 5024.2 4738.3 4823.2 4898.7 4911.9 4964.4 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - PROCESS | 11518 | [#1] ext.html Cycles:180 Average:48630.46 Median:36301.86 stddev:86828.16 (239.2%) stddev-sans-first:86996.76 13:54:00 INFO - PROCESS | 11518 | Values: 575.0 591.9 605.5 617.4 617.8 35102.8 35920.8 36221.8 36250.0 36267.3 39451.6 40297.4 40423.2 40487.2 40543.6 7542.9 7801.6 7811.1 7833.1 7854.8 7927.2 8054.1 8067.6 8094.0 8101.4 8016.8 8021.8 8076.3 8116.6 8119.7 7998.6 8001.9 8009.7 8083.5 8097.7 7745.5 7801.3 7820.6 7827.4 7847.8 39727.4 39956.6 40191.8 40243.2 40435.4 3211.5 3214.5 3214.8 3281.9 3392.1 29602.9 29687.0 29726.3 30734.2 30775.4 3024.1 3030.7 3054.8 3073.0 3160.9 241250.0 244393.0 244400.0 244771.0 245185.0 57819.0 58224.4 58228.7 58268.7 58321.0 58661.0 59941.0 60186.0 60283.4 60313.0 14153.2 14260.6 14335.8 14340.0 14364.7 10833.5 10849.5 10883.6 10892.1 10924.8 19677.5 20201.4 20212.0 20261.8 20315.8 7581.4 7641.0 7654.6 7818.7 7851.4 906.6 989.7 1006.8 1057.0 1069.3 28595.6 28693.0 28822.0 29173.7 29274.7 945.7 1012.5 1032.5 1051.1 1082.6 15066.8 15411.9 15568.4 15621.4 15807.9 393204.0 401376.0 401767.0 402200.0 403762.0 51202.0 51402.2 51786.7 52005.5 52017.7 1258.5 1260.5 1264.0 1266.2 1282.4 27330.9 27722.6 28441.6 28641.3 28672.4 44156.1 44720.0 44723.1 44790.3 44821.6 320780.0 326359.0 327182.0 327878.0 328230.0 26349.5 26682.5 26779.5 26882.5 26914.5 43708.1 44091.3 44206.3 45091.3 45117.8 37558.4 37560.0 37663.0 37693.7 37876.2 37188.8 37674.2 37679.0 37743.8 37809.6 28274.3 34434.3 34465.0 34602.5 36336.5 34786.3 34959.0 35516.0 35687.8 35759.0 27332.7 28149.3 28189.4 28451.3 29893.4 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - PROCESS | 11518 | [#2] jquery.html Cycles:180 Average:23928.75 Median:5293.50 stddev:64094.82 (1210.8%) stddev-sans-first:64250.23 13:54:00 INFO - PROCESS | 11518 | Values: 374.0 375.3 379.2 384.6 388.2 15465.5 15747.2 16266.8 16533.4 16565.8 15052.9 15998.6 16681.1 16687.8 16695.5 5177.1 5281.0 5315.8 5318.7 5330.8 5188.6 5208.9 5262.9 5283.9 5289.7 5465.8 5508.6 5512.4 5512.8 5517.1 5224.9 5468.7 5482.3 5503.9 5504.5 5043.2 5297.3 5311.7 5356.1 5367.5 12010.9 12195.2 12276.3 12319.2 17787.9 1873.4 1892.9 1922.1 1986.6 2028.3 9248.0 9410.6 9526.7 9643.8 10846.6 1745.9 1849.4 1852.8 1860.6 1864.2 69147.7 73225.0 74585.6 75284.0 75669.6 9972.8 10163.5 10231.9 10420.0 10709.9 14451.9 14458.0 14463.6 14515.4 14550.6 6888.3 7141.6 7204.9 7362.2 7366.3 6574.5 6600.2 6648.5 6674.2 6765.4 4463.1 4482.8 4490.8 4524.9 4529.4 1847.6 1893.9 1904.9 1911.1 1931.5 848.4 866.5 883.9 887.4 955.5 16459.2 16557.2 16762.8 16981.7 17083.3 861.9 900.7 924.2 941.0 953.4 9192.5 9551.4 9585.8 9757.2 9767.5 358931.0 366316.0 388332.0 405415.0 416128.0 58737.7 70755.0 79205.0 79205.0 81396.0 929.3 947.4 963.8 967.9 975.5 15336.8 15375.6 15389.5 15500.5 15564.8 35057.8 35641.5 35845.3 36488.8 36559.6 46938.3 51448.0 51546.2 51550.5 52100.2 7483.2 7501.4 7523.5 7530.5 7721.2 9430.6 10582.0 10969.1 11116.4 11264.3 9007.2 9314.2 9757.4 9847.6 9989.2 9934.2 9997.9 10045.8 10059.5 10168.1 9567.7 9644.9 9659.7 9755.2 9959.2 7616.5 7630.8 7702.5 7747.1 7779.6 8520.7 9157.2 9314.3 9486.5 9593.7 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - PROCESS | 11518 | [#3] mootools.html Cycles:180 Average:5082.35 Median:5145.05 stddev:2839.65 (55.2%) stddev-sans-first:2834.48 13:54:00 INFO - PROCESS | 11518 | Values: 1448.1 1453.9 1582.0 1717.9 1758.8 6823.9 7342.4 7475.7 7676.4 7683.7 7446.9 7562.2 7564.1 7574.7 7631.0 2171.3 2230.3 2245.7 2253.1 2256.3 2212.7 2236.5 2245.3 2259.4 2260.8 2177.1 2189.3 2257.1 2268.5 2271.9 2172.2 2172.9 2180.5 2182.7 2187.1 2149.3 2157.2 2160.9 2161.4 2164.7 7635.5 7645.4 7657.0 7717.0 7727.3 4320.2 4420.5 4421.7 4424.0 4427.4 2759.6 2781.5 2858.4 2865.5 2869.6 895.3 929.9 933.7 942.6 954.3 10269.1 10274.7 10284.6 10366.5 10403.5 4143.8 4176.2 4240.0 4251.8 4261.1 8885.6 8894.2 8903.9 8904.3 8907.9 4526.1 4550.1 4602.7 4605.3 4610.6 3654.7 4055.7 4179.4 4209.7 4211.1 3601.8 3622.6 3725.9 3729.3 3753.3 1198.6 1224.2 1241.2 1248.8 1258.9 753.9 855.6 866.7 875.9 891.1 5040.9 5328.7 5381.6 5452.6 5475.2 420.4 420.8 421.1 427.3 432.6 3655.6 3723.1 3754.6 3769.6 3819.5 9448.3 9830.3 9929.5 9950.5 9990.1 9785.6 9835.8 9844.1 9879.2 9888.7 6870.5 7412.6 7458.4 7504.8 7535.3 5249.2 5365.2 5372.2 5516.1 5519.7 8374.4 8841.5 8863.0 8948.7 8982.1 8682.4 8844.0 8872.7 8889.0 8955.8 6153.9 6349.5 6589.7 6758.4 6877.0 7089.8 7121.1 7170.2 7199.4 7234.7 6351.7 6634.8 6705.4 6736.7 6793.9 6573.2 6605.5 6631.5 6635.4 6698.3 5994.6 6073.8 6082.4 6099.3 6103.2 4421.8 4434.5 4436.0 4545.7 4563.2 4500.9 4511.0 4572.1 4580.5 4658.0 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - PROCESS | 11518 | [#4] prototype.html Cycles:180 Average:4363.57 Median:4970.33 stddev:1263.69 (25.4%) stddev-sans-first:1229.97 13:54:00 INFO - PROCESS | 11518 | Values: 305.3 305.3 309.5 316.3 316.6 4936.4 4996.4 4998.4 5005.9 5020.4 4920.7 4924.4 4926.7 4952.4 4958.3 3690.8 3774.7 3847.5 3867.8 3889.7 3866.9 3892.7 3900.1 3903.9 3905.6 3842.2 3851.7 3855.8 3878.8 3888.6 3792.1 3863.4 3870.5 3895.6 3935.0 3461.0 3468.4 3481.1 3482.8 3498.6 4678.5 4718.2 4720.6 4747.2 4750.9 4454.0 4465.8 4503.0 4506.4 4536.8 5012.4 5258.2 5262.2 5285.0 5297.4 3708.9 3715.8 3730.6 3740.4 3741.3 5476.1 5535.7 5537.9 5540.6 5563.3 3585.5 3802.5 3803.5 3806.1 3810.6 3864.1 3865.7 3869.8 3880.6 3881.6 4404.1 4419.4 4422.3 4422.5 4449.8 5040.5 5182.2 5235.5 5249.7 5259.2 1391.1 1402.9 1403.0 1404.9 1406.2 864.8 907.4 940.0 951.5 954.3 4424.8 4551.6 4556.5 4577.3 4613.9 5368.8 5393.5 5396.2 5398.2 5422.8 4391.8 4572.0 4582.3 4584.9 4596.7 3066.6 3066.9 3081.9 3089.0 3090.1 5361.7 5375.4 5382.6 5391.1 5414.4 5281.7 5599.6 5605.2 5872.7 5894.2 5077.2 5130.2 5132.7 5153.8 5178.9 5428.1 5456.8 5457.6 5462.5 5486.4 5181.0 5283.6 5308.6 5309.7 5335.7 5095.5 5096.6 5100.1 5110.0 5125.4 3699.3 3727.4 3730.4 3742.7 3772.7 5290.3 5392.5 5394.3 5406.6 5440.7 5234.6 5245.6 5248.4 5251.8 5256.3 4982.3 5240.2 5241.3 5241.8 5249.2 5188.6 5193.9 5200.1 5208.5 5224.8 4997.8 5084.6 5245.9 5247.7 5283.3 5109.5 5131.9 5143.5 5153.7 5158.2 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - PROCESS | 11518 | [#5] yui.html Cycles:180 Average:13066.00 Median:49367.01 stddev:15662.39 (31.7%) stddev-sans-first:15678.28 13:54:00 INFO - PROCESS | 11518 | Values: 583.8 667.4 680.7 689.2 692.5 11050.2 11066.7 11149.6 11297.8 11319.7 11531.9 11584.6 11623.8 11625.9 11688.3 639.1 739.1 788.7 800.5 800.6 808.5 809.5 809.7 810.1 812.0 846.2 846.5 847.1 847.3 849.6 837.2 838.1 838.5 839.9 841.5 616.6 618.8 620.0 620.9 622.4 11726.4 11734.4 11798.0 11941.5 12026.9 11259.1 11415.7 11546.7 11669.1 11843.2 9538.4 9612.4 9643.9 9794.6 9829.5 3137.7 3142.2 3149.7 3205.3 3281.6 48081.0 48803.3 49171.5 49184.5 49453.8 8681.3 8931.4 9001.0 9114.9 9308.2 15386.8 15577.6 15617.0 15617.4 15625.9 6425.0 6540.0 6594.0 6667.9 6771.5 3467.2 3539.8 3549.8 3558.7 3567.0 2697.9 2731.2 2753.9 2765.7 2786.4 512.8 517.5 522.9 523.7 530.4 499.9 561.0 580.5 612.1 617.4 7396.9 7531.8 7582.2 7702.3 7830.3 531.9 545.0 627.5 642.6 649.4 3494.3 3663.2 3675.3 3694.8 3778.6 57198.7 58488.4 59362.0 59616.0 60031.0 46748.3 49280.3 50578.0 51270.2 51383.2 45252.0 45847.8 46184.0 46244.8 46440.0 8091.5 8153.3 8207.9 8296.2 8424.2 27042.7 27719.0 28753.9 30435.1 32072.8 36345.8 38575.4 41577.5 41887.8 42521.4 10985.7 10991.6 11023.4 11142.1 11221.7 10776.4 11404.7 11595.8 11847.4 12203.3 11227.4 11411.0 11549.9 11570.2 11630.5 10669.4 11111.1 11174.5 11229.2 12015.3 9008.4 10646.5 10816.7 10994.8 11090.3 9179.7 9529.9 9785.9 9913.1 10170.3 9231.6 9262.3 9468.3 9593.1 9687.8 13:54:00 INFO - PROCESS | 11518 | -------- Summary: end -------- 13:54:00 INFO - PROCESS | 11518 | 13:54:00 INFO - TEST-INFO | 11518: exit 0 13:54:00 INFO - TEST-OK | dromaeo_css | took 1116317ms 13:54:00 INFO - TEST-START | kraken 13:54:00 INFO - operating with platform_type : linux_ 13:54:00 INFO - Initialising browser for kraken test... 13:54:00 INFO - TEST-INFO | started process 11752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnpfb1K/profile http://localhost:41024/getInfo.html) 13:54:05 INFO - PROCESS | 11752 | 13:54:05 INFO - PROCESS | 11752 | (process:11820): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:54:06 INFO - PROCESS | 11752 | __metrics Screen width/height:1600/1200 13:54:06 INFO - PROCESS | 11752 | colorDepth:24 13:54:06 INFO - PROCESS | 11752 | Browser inner width/height: 1024/697 13:54:06 INFO - PROCESS | 11752 | __metrics 13:54:06 ERROR - PROCESS | 11752 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:54:07 INFO - TEST-INFO | 11752: exit 0 13:54:07 INFO - Browser initialized. 13:54:07 INFO - Running cycle 1/1 for kraken test... 13:54:07 INFO - TEST-INFO | started process 11871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnpfb1K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:54:09 INFO - PROCESS | 11871 | 13:54:09 INFO - PROCESS | 11871 | (process:11931): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:54:19 INFO - PROCESS | 11871 | RSS: Main: 165855232 13:54:19 INFO - PROCESS | 11871 | 13:54:22 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41024/tests/kraken/driver.html?testName=audio-beat-detection) 13:54:23 INFO - PROCESS | 11871 | RSS: Main: 170512384 13:54:23 INFO - PROCESS | 11871 | 13:54:26 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41024/tests/kraken/driver.html?testName=audio-dft) 13:54:26 INFO - PROCESS | 11871 | RSS: Main: 174006272 13:54:26 INFO - PROCESS | 11871 | 13:54:29 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41024/tests/kraken/driver.html?testName=audio-fft) 13:54:30 INFO - PROCESS | 11871 | RSS: Main: 164659200 13:54:30 INFO - PROCESS | 11871 | 13:54:32 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41024/tests/kraken/driver.html?testName=audio-oscillator) 13:54:33 INFO - PROCESS | 11871 | RSS: Main: 164143104 13:54:33 INFO - PROCESS | 11871 | 13:54:35 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:54:35 INFO - PROCESS | 11871 | RSS: Main: 165572608 13:54:35 INFO - PROCESS | 11871 | 13:54:39 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41024/tests/kraken/driver.html?testName=imaging-darkroom) 13:54:39 INFO - PROCESS | 11871 | RSS: Main: 165965824 13:54:39 INFO - PROCESS | 11871 | 13:54:43 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41024/tests/kraken/driver.html?testName=imaging-desaturate) 13:54:43 INFO - PROCESS | 11871 | RSS: Main: 165494784 13:54:43 INFO - PROCESS | 11871 | 13:54:46 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41024/tests/kraken/driver.html?testName=json-parse-financial) 13:54:47 INFO - PROCESS | 11871 | RSS: Main: 166600704 13:54:47 INFO - PROCESS | 11871 | 13:54:49 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:54:49 INFO - PROCESS | 11871 | RSS: Main: 166821888 13:54:49 INFO - PROCESS | 11871 | 13:54:51 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41024/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:54:52 INFO - PROCESS | 11871 | RSS: Main: 166871040 13:54:52 INFO - PROCESS | 11871 | 13:54:54 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:54:55 INFO - PROCESS | 11871 | RSS: Main: 167079936 13:54:55 INFO - PROCESS | 11871 | 13:54:57 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:54:58 INFO - PROCESS | 11871 | RSS: Main: 167452672 13:54:58 INFO - PROCESS | 11871 | 13:55:01 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:55:02 INFO - PROCESS | 11871 | RSS: Main: 167395328 13:55:02 INFO - PROCESS | 11871 | 13:55:03 INFO - PROCESS | 11871 | Cycle 1(1): loaded http://localhost:41024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41024/tests/kraken/driver.html?testName=ai-astar) 13:55:04 INFO - PROCESS | 11871 | RSS: Main: 168685568 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | __start_tp_report 13:55:04 INFO - PROCESS | 11871 | _x_x_mozilla_page_load 13:55:04 INFO - PROCESS | 11871 | _x_x_mozilla_page_load_details 13:55:04 INFO - PROCESS | 11871 | |i|pagename|runs| 13:55:04 INFO - PROCESS | 11871 | |0;ai-astar;114;111;113;114;115;125;114;113;113;114 13:55:04 INFO - PROCESS | 11871 | |1;audio-beat-detection;163;131;158;189;134;163;156;134;190;135 13:55:04 INFO - PROCESS | 11871 | |2;audio-dft;163;162;165;167;167;164;163;162;167;161 13:55:04 INFO - PROCESS | 11871 | |3;audio-fft;75;73;74;157;75;83;77;74;169;75 13:55:04 INFO - PROCESS | 11871 | |4;audio-oscillator;93;94;149;93;94;94;134;101;93;142 13:55:04 INFO - PROCESS | 11871 | |5;imaging-gaussian-blur;117;118;118;118;118;119;120;118;119;118 13:55:04 INFO - PROCESS | 11871 | |6;imaging-darkroom;148;148;148;147;148;147;148;149;147;148 13:55:04 INFO - PROCESS | 11871 | |7;imaging-desaturate;96;96;96;95;105;95;96;97;96;96 13:55:04 INFO - PROCESS | 11871 | |8;json-parse-financial;66;66;65;65;68;65;65;85;64;63 13:55:04 INFO - PROCESS | 11871 | |9;json-stringify-tinderbox;65;65;65;65;65;69;65;65;65;64 13:55:04 INFO - PROCESS | 11871 | |10;stanford-crypto-aes;88;86;82;84;82;80;82;88;91;82 13:55:04 INFO - PROCESS | 11871 | |11;stanford-crypto-ccm;141;132;132;138;134;143;137;130;165;132 13:55:04 INFO - PROCESS | 11871 | |12;stanford-crypto-pbkdf2;179;182;176;175;178;181;178;174;176;173 13:55:04 INFO - PROCESS | 11871 | |13;stanford-crypto-sha256-iterative;74;71;77;73;73;73;72;70;72;72 13:55:04 INFO - PROCESS | 11871 | __end_tp_report 13:55:04 INFO - PROCESS | 11871 | __start_cc_report 13:55:04 INFO - PROCESS | 11871 | _x_x_mozilla_cycle_collect,931 13:55:04 INFO - PROCESS | 11871 | __end_cc_report 13:55:04 INFO - PROCESS | 11871 | __startTimestamp1461963304224__endTimestamp 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | ------- Summary: start ------- 13:55:04 INFO - PROCESS | 11871 | Number of tests: 14 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:3.81 (3.3%) stddev-sans-first:4.03 13:55:04 INFO - PROCESS | 11871 | Values: 114.0 111.0 113.0 114.0 115.0 125.0 114.0 113.0 113.0 114.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:160.50 stddev:22.05 (13.7%) stddev-sans-first:23.21 13:55:04 INFO - PROCESS | 11871 | Values: 163.0 131.0 158.0 189.0 134.0 163.0 156.0 134.0 190.0 135.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:2.28 (1.4%) stddev-sans-first:2.39 13:55:04 INFO - PROCESS | 11871 | Values: 163.0 162.0 165.0 167.0 167.0 164.0 163.0 162.0 167.0 161.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:37.00 (49.3%) stddev-sans-first:38.65 13:55:04 INFO - PROCESS | 11871 | Values: 75.0 73.0 74.0 157.0 75.0 83.0 77.0 74.0 169.0 75.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:23.14 (24.9%) stddev-sans-first:23.84 13:55:04 INFO - PROCESS | 11871 | Values: 93.0 94.0 149.0 93.0 94.0 94.0 134.0 101.0 93.0 142.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 13:55:04 INFO - PROCESS | 11871 | Values: 117.0 118.0 118.0 118.0 118.0 119.0 120.0 118.0 119.0 118.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:55:04 INFO - PROCESS | 11871 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 148.0 149.0 147.0 148.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:2.94 (3.1%) stddev-sans-first:3.10 13:55:04 INFO - PROCESS | 11871 | Values: 96.0 96.0 96.0 95.0 105.0 95.0 96.0 97.0 96.0 96.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:65.50 stddev:6.39 (9.8%) stddev-sans-first:6.76 13:55:04 INFO - PROCESS | 11871 | Values: 66.0 66.0 65.0 65.0 68.0 65.0 65.0 85.0 64.0 63.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 13:55:04 INFO - PROCESS | 11871 | Values: 65.0 65.0 65.0 65.0 65.0 69.0 65.0 65.0 65.0 64.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:3.57 (4.2%) stddev-sans-first:3.55 13:55:04 INFO - PROCESS | 11871 | Values: 88.0 86.0 82.0 84.0 82.0 80.0 82.0 88.0 91.0 82.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:137.50 stddev:10.28 (7.5%) stddev-sans-first:10.86 13:55:04 INFO - PROCESS | 11871 | Values: 141.0 132.0 132.0 138.0 134.0 143.0 137.0 130.0 165.0 132.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:178.00 stddev:2.94 (1.6%) stddev-sans-first:3.04 13:55:04 INFO - PROCESS | 11871 | Values: 179.0 182.0 176.0 175.0 178.0 181.0 178.0 174.0 176.0 173.0 13:55:04 INFO - PROCESS | 11871 | 13:55:04 INFO - PROCESS | 11871 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.89 (2.6%) stddev-sans-first:1.94 13:55:04 INFO - PROCESS | 11871 | Values: 74.0 71.0 77.0 73.0 73.0 73.0 72.0 70.0 72.0 72.0 13:55:04 INFO - PROCESS | 11871 | -------- Summary: end -------- 13:55:04 INFO - PROCESS | 11871 | 13:55:05 INFO - TEST-INFO | 11871: exit 0 13:55:05 INFO - TEST-OK | kraken | took 64365ms 13:55:05 INFO - SUITE-END | took 1180s 13:55:05 INFO - Completed test suite (00:19:40) 13:55:05 INFO - javascript benchmark 13:55:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.947341053179, 2689.69068557116, 2714.375693590473, 2720.673519177699, 2734.9999999999986, 4731.0, 4760.381150450441, 4785.641076919228, 4789.233722604384, 4838.879028024301, 4663.860084197479, 4731.124741922747, 4748.169070412672, 4760.785764640591, 4797.520247975201, 4343.500497442795, 4386.363977223301, 4403.3394990751485, 4407.823687052514, 4411.448568928884, 10.193975674037436, 4057.5794507339297, 4298.183345164409, 4351.151525452538, 4451.310046942729, 4363.38912552243, 4388.034632380903, 4389.5390983946545, 4408.29467285236, 4439.4228750262255, 4379.737215767064, 4386.56134386562, 4401.097774956126, 4410.073884484262, 4441.777911104432, 4337.240982828024, 4367.432233809616, 4375.803088860977, 4397.494288156871, 4439.245328294198, 4629.282461218517, 4668.4631267404, 4671.43942726875, 4671.462781780071, 4727.22000869856, 4908.239222920453, 5046.066477701637, 5091.032703786269, 5101.795928162869, 5128.0, 4972.453030166679, 5026.195808670632, 5044.192929131322, 5137.280780690707, 5198.636095473318, 4709.175894218498, 4710.317004034464, 4710.69380490267, 4740.146773580754, 4741.66808323421, 5135.717535535507, 5137.998090372416, 5189.169732842803, 5228.738563071831, 5240.68555886648, 4960.776765045582, 4968.975155124273, 4969.0807200668, 4996.475370086161, 5044.571211446994, 5014.272930425068, 5062.291279220912, 5067.645264831426, 5075.416327122354, 5121.820736274287, 5001.7464198393145, 5022.3219865317715, 5082.313887625197, 5098.745062746848, 5103.362079740033, 4959.404871415453, 4981.950180498148, 4982.327385802871, 4991.301217829507, 5044.1172794761505, 4179.2059508693255, 4280.5505421930875, 4282.122164956177, 4290.37789520524, 4323.48118225815, 3651.908702282464, 3720.6837418819164, 3753.0, 3776.055986003499, 3788.6400791924725, 4338.067315527177, 4348.956510434855, 4372.519022907478, 4392.231359512072, 4419.0719948810465, 4958.628102892298, 5091.363579552556, 5095.261187127846, 5099.566536844335, 5106.15748401517, 4342.696011279243, 4395.164918665508, 4398.64810815134, 4424.668149888771, 4437.356583295404, 4542.068875880436, 4550.249208880564, 4561.931571026437, 4596.5863072323655, 4600.263957766741, 4640.327152562927, 4717.198076327101, 4758.78585463655, 4778.95221047799, 4798.856034319046, 5109.718965456936, 5131.25596788471, 5172.5344718973965, 5174.689518628894, 5181.689098654093, 4819.807207711792, 4830.855074347775, 4831.758412079453, 4839.903201936012, 4866.513348665105, 4913.533214344631, 5016.996600679806, 5052.747362631927, 5055.216441451581, 5090.134677104827, 5073.188289873602, 5089.312942752681, 5109.3613298337705, 5115.539601435739, 5149.7682604282145, 4953.108440480748, 4955.0337684151245, 4964.0, 4964.503549645006, 4967.975160124176, 4769.594584460359, 4864.927026094682, 4938.975305123451, 4995.075910956485, 5000.399952005782, 4865.0, 4872.853814385574, 4907.411110666742, 4945.23348880924, 4962.330085438564, 5016.774245158904, 5021.4225364083595, 5022.949770502249, 5023.070731914608, 5024.246363045572, 4738.31294462308, 4823.155947709207, 4898.657094003528, 4911.852644420673, 4964.35463389757], "value": 4631.062439468343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.9798757043504, 591.8668299632583, 605.5004621187521, 617.4257940115691, 617.8300967234012, 35102.824485877565, 35920.82039589805, 36221.818890905575, 36250.0, 36267.274654506895, 39451.60548394515, 40297.395539066936, 40423.19153616926, 40487.19025619486, 40543.59456405435, 7542.924570754304, 7801.648925798353, 7811.101723301807, 7833.099193592724, 7854.764357069268, 7927.1676473970265, 8054.114047454776, 8067.556284404355, 8094.028716554022, 8101.351891848667, 8016.759497215093, 8021.759347219593, 8076.313513351372, 8116.553589552572, 8119.675212991473, 7998.560079195642, 8001.8799718004275, 8009.719659811908, 8083.514989100673, 8097.676092956274, 7745.535267883945, 7801.258880406353, 7820.608969551499, 7827.412944029221, 7847.843043139163, 39727.40408893869, 39956.600433995576, 40191.7990410049, 40243.195136097405, 40435.39346909799, 3211.4701074322707, 3214.4696125139326, 3214.8231847248394, 3281.868725250987, 3392.0671815250757, 29602.851985740148, 29687.018269699412, 29726.256843578867, 30734.231644209074, 30775.38449231003, 3024.138120635608, 3030.712082352173, 3054.8167109973474, 3072.9846350768325, 3160.920976975571, 241250.0, 244393.0, 244400.0, 244771.0, 245185.0, 57819.0, 58224.4177558219, 58228.70885645544, 58268.7086564573, 58321.0, 58661.0, 59941.0, 60186.0, 60283.397166027775, 60313.0, 14153.150810951376, 14260.572182834532, 14335.78496322556, 14340.0, 14364.712705746035, 10833.512491937881, 10849.511771970281, 10883.619073332395, 10892.128629709763, 10924.781504369868, 19677.50806229856, 20201.393958181277, 20212.0, 20261.797382026285, 20315.796842031687, 7581.431392645573, 7641.0, 7654.578998155043, 7818.726344577913, 7851.367693061121, 906.5603182456504, 989.7129832348683, 1006.7684432580547, 1056.9682909512726, 1069.3476979042778, 28595.57106643402, 28693.0, 28822.0, 29173.7082629171, 29274.707252927623, 945.7115579748105, 1012.4785735346303, 1032.4734385463469, 1051.1433181956681, 1082.6373164989816, 15066.773998390034, 15411.949794782005, 15568.377264909503, 15621.375144994301, 15807.920960395124, 393204.0, 401376.0, 401767.0, 402200.0, 403762.0, 51202.0, 51402.228966564784, 51786.741066294424, 52005.47994520082, 52017.7399113002, 1258.5280519805074, 1260.5021016698536, 1264.0203842022506, 1266.170658218868, 1282.410091357967, 27330.863345683145, 27722.584161237195, 28441.573376398956, 28641.28396790097, 28672.426551468438, 44156.11687766291, 44720.0, 44723.10553788971, 44790.3281450772, 44821.55178448174, 320780.0, 326359.0, 327182.0, 327878.0, 328230.0, 26349.473010540067, 26682.466350673265, 26779.464410711287, 26882.462350753267, 26914.461710766067, 43708.125837483705, 44091.338629919934, 44206.33690494709, 45091.32363014623, 45117.774411127735, 37558.43662345012, 37560.0, 37663.0, 37693.676402966696, 37876.212378761906, 37188.81405592955, 37674.246515069, 37679.0, 37743.81128094342, 37809.62190378171, 28274.2931426716, 34434.31131377409, 34465.0, 34602.48096278508, 36336.4549531752, 34786.30427391388, 34959.0, 35516.0, 35687.82156089203, 35759.0, 27332.726672733814, 28149.296267593472, 28189.43621127607, 28451.288717781394, 29893.402131956806], "value": 18111.901948563303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.96260373962605, 375.32254281022745, 379.1969186518106, 384.5596791673536, 388.17125437191595, 15465.458708945189, 15747.212639368028, 16266.83733162668, 16533.421330253444, 16565.83434165658, 15052.924735376308, 15998.60003499913, 16681.08254046027, 16687.83312166878, 16695.49913502597, 5177.119889618755, 5281.0, 5315.760790764425, 5318.734063296839, 5330.760115794798, 5188.584913206953, 5208.869778255536, 5262.9473705263035, 5283.947160528384, 5289.709066001368, 5465.808696695616, 5508.586855985797, 5512.4211957744465, 5512.834614961557, 5517.117261238202, 5224.947750522484, 5468.7265636718, 5482.2873026506495, 5503.889922201573, 5504.532114770249, 5043.2435134730085, 5297.284866543006, 5311.681299122065, 5356.11624082026, 5367.543758780508, 12010.879891201152, 12195.207311524811, 12276.263424194487, 12319.199252048678, 17787.911060444745, 1873.4473330367575, 1892.924283028677, 1922.1350392323511, 1986.5728868293386, 2028.3205126282712, 9247.953760231223, 9410.62357505699, 9526.714198574055, 9643.758906027335, 10846.648610375267, 1745.9476215713548, 1849.4081893793991, 1852.8054554271878, 1860.618573192506, 1864.2263460663808, 69147.65426172837, 73225.0, 74585.62707186483, 75284.0, 75669.62165189139, 9972.750681233027, 10163.542640581192, 10231.94884025575, 10420.0, 10709.946450267698, 14451.855481445262, 14458.0, 14463.566093017016, 14515.403305636371, 14550.563483095524, 6888.276730943279, 7141.607211603307, 7204.92795072053, 7362.153352364439, 7366.263373662591, 6574.474042076622, 6600.240972288152, 6648.53460257787, 6674.16572928384, 6765.35729105744, 4463.062756821104, 4482.820687172477, 4490.7754612269255, 4524.864254072383, 4529.433820772403, 1847.584293533971, 1893.9053047347577, 1904.8857068575653, 1911.111333230027, 1931.4881556387568, 848.3849209323191, 866.4757821518017, 883.9071897450804, 887.3744010472731, 955.5174636808367, 16459.177041147894, 16557.172141392883, 16762.83237167637, 16981.660366792596, 17083.31666733317, 861.9396642234983, 900.7297810656777, 924.1728652855656, 940.9529523523796, 953.4422362917633, 9192.49441280736, 9551.42691438516, 9585.760355991157, 9757.21942244633, 9767.511624418892, 358931.0, 366316.0, 388332.0, 405415.0, 416128.0, 58737.706311468166, 70755.0, 79205.0, 79205.0, 81396.0, 929.3030227329502, 947.3842002698163, 963.7542426681151, 967.8983706710835, 975.4586204656342, 15336.76994845056, 15375.615609609402, 15389.538313850602, 15500.5349839505, 15564.766528502309, 35057.82471087628, 35641.46537801883, 35845.28309433849, 36488.81755591205, 36559.634403655626, 46938.295925561826, 51448.0, 51546.22680659868, 51550.484495156066, 52100.21849672334, 7483.176850546327, 7501.399888009056, 7523.473356864967, 7530.510516816608, 7721.227877212234, 9430.575624096795, 10582.0, 10969.122470202525, 11116.388598626829, 11264.324140551593, 9007.189352958003, 9314.20829229496, 9757.414555126716, 9847.556859941176, 9989.200863930722, 9934.205263578751, 9997.900020999989, 10045.799084018425, 10059.49702514886, 10168.135708464863, 9567.712968610953, 9644.855327170239, 9659.661911833053, 9755.170810481188, 9959.203263738738, 7616.466847320635, 7630.809229769078, 7702.537847729154, 7747.147813740371, 7779.649915753692, 8520.70177543783, 9157.221636161, 9314.301427392837, 9486.525673716425, 9593.664221752206], "value": 8090.445804468773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.1166488442052, 1453.8836893048558, 1581.9920900395496, 1717.9226934787932, 1758.7537744715742, 6823.874060779978, 7342.412606991441, 7475.73834915778, 7676.38588912887, 7683.654235559399, 7446.925530744705, 7562.205968373324, 7564.054493188351, 7574.659140338684, 7630.961845190766, 2171.326888664515, 2230.2528652901296, 2245.7305123385217, 2253.0649780341137, 2256.345659758668, 2212.723409573803, 2236.474428509299, 2245.348848833836, 2259.367377134405, 2260.8078313343385, 2177.1182671018264, 2189.2994241842616, 2257.052038143975, 2268.4669102760836, 2271.931842044741, 2172.1745736620064, 2172.8587641803233, 2180.5420861619077, 2182.7271591051117, 2187.1470126650697, 2149.344449942767, 2157.2018353209414, 2160.8811515366647, 2161.448830548216, 2164.6644770060666, 7635.541867487968, 7645.350145237661, 7657.042869641295, 7717.035370578677, 7727.343175830061, 4320.24395730749, 4420.535843736426, 4421.6904816662845, 4424.004598965207, 4427.446569178853, 2759.6274502942247, 2781.485425196345, 2858.428314337141, 2865.498537755884, 2869.626948496703, 895.2882458445551, 929.8791157149595, 933.710549729586, 942.6229508196708, 954.3033585482636, 10269.127124194378, 10274.7431314217, 10284.588616455332, 10366.533505992249, 10403.479826008745, 4143.834246630101, 4176.206520761046, 4239.957600424018, 4251.829926802893, 4261.105167914772, 8885.644574216958, 8894.155055269739, 8903.910960890438, 8904.332175086765, 8907.866382004275, 4526.117407105583, 4550.112728018004, 4602.7468489233415, 4605.309203619484, 4610.631149508098, 3654.744167908221, 4055.6755459563756, 4179.414881916534, 4209.684273679486, 4211.136716973013, 3601.7838929664304, 3622.637736226409, 3725.9254814904093, 3729.328720830277, 3753.2868754936476, 1198.5984695127056, 1224.2103843021202, 1241.1994263700044, 1248.7939489984233, 1258.8615252322238, 753.9132999704995, 855.6449073634496, 866.6620018192909, 875.8554838451712, 891.1219135878728, 5040.949590504048, 5328.733563321896, 5381.569474442035, 5452.645578037414, 5475.178723191473, 420.43241623807614, 420.8148414697523, 421.1093537168927, 427.2715020889376, 432.60200615433877, 3655.561332640047, 3723.0878434783654, 3754.624537546278, 3769.5792364160156, 3819.52255968004, 9448.291378146667, 9830.262730295257, 9929.50352482373, 9950.45272510019, 9990.100890919706, 9785.608575657036, 9835.754106147404, 9844.114029737215, 9879.209663226924, 9888.65389711371, 6870.45036397087, 7412.629368531444, 7458.366038886756, 7504.774856754306, 7535.321821036133, 5249.160134378481, 5365.2220428036935, 5372.1941708744, 5516.062269414289, 5519.668819870821, 8374.413791034813, 8841.513716745641, 8863.0, 8948.74717539558, 8982.101789821227, 8682.43564168327, 8844.0, 8872.689455869013, 8889.0, 8955.776105597412, 6153.938460615515, 6349.523785716182, 6589.703463344065, 6758.391744742997, 6877.037214790033, 7089.7873063808165, 7121.109861267341, 7170.211276759448, 7199.388052015637, 7234.710611575478, 6351.745930162741, 6634.767783127568, 6705.430038446787, 6736.730530778714, 6793.864122717617, 6573.244076931022, 6605.504587155887, 6631.502637302318, 6635.402813746593, 6698.263191049078, 5994.610350327215, 6073.817785466443, 6082.391760824059, 6099.329073801967, 6103.176071230327, 4421.823127074881, 4434.51220365753, 4436.0, 4545.6590755694115, 4563.178627847019, 4500.8649740507835, 4510.977445112753, 4572.108438854524, 4580.450345958507, 4658.0], "value": 4052.8164181613515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.2902002843388, 305.3282777888645, 309.53106044342826, 316.3467439736942, 316.6390315040854, 4936.3829521309835, 4996.350474438323, 4998.400191976968, 5005.949940500594, 5020.39755229373, 4920.655554111214, 4924.409070911487, 4926.655134140611, 4952.3561936948145, 4958.330625365575, 3690.833912473932, 3774.735768496206, 3847.5190601174854, 3867.7679339239594, 3889.6775096467195, 3866.9226615467674, 3892.70804689648, 3900.083480382108, 3903.902402439933, 3905.6484916357663, 3842.1739326044894, 3851.7496362736474, 3855.8264878080554, 3878.7975727524417, 3888.5722570517364, 3792.1467669774356, 3863.439801228806, 3870.4774855394444, 3895.571487136427, 3934.996575873134, 3460.9826950865086, 3468.358353704573, 3481.0775144586705, 3482.791032538056, 3498.632643572439, 4678.508756580544, 4718.245080787092, 4720.59874910633, 4747.240441529373, 4750.881227969294, 4454.042380888092, 4465.776711164462, 4503.0, 4506.3916371290115, 4536.818527258939, 5012.393555351234, 5258.1849813279005, 5262.158054711228, 5285.022270879899, 5297.390800058004, 3708.8516459341595, 3715.758475699071, 3730.626937306248, 3740.3828368319196, 3741.251749650081, 5476.123820188751, 5535.723213839332, 5537.920105579374, 5540.584456165763, 5563.304586926634, 3585.4980302757635, 3802.4866643003393, 3803.4675145479655, 3806.1245913440066, 3810.5617853946596, 3864.14988702485, 3865.7100717446306, 3869.8258578364043, 3880.5731369549326, 3881.6118388160958, 4404.07514421975, 4419.40338054365, 4422.314541246048, 4422.469303683579, 4449.777511124431, 5040.546350828443, 5182.2485739567555, 5235.528802407802, 5249.685018898802, 5259.15853463444, 1391.074935168122, 1402.9438822447191, 1402.95089671861, 1404.9016568840289, 1406.1984668738721, 864.8443280209497, 907.396581273459, 939.9707320484059, 951.46242373059, 954.341504361988, 4424.84513042042, 4551.635869130461, 4556.521565235669, 4577.29051996941, 4613.907721845544, 5368.812091576776, 5393.514583687487, 5396.217548455452, 5398.217258497496, 5422.810201642924, 4391.84628538006, 4571.954280457219, 4582.289745089516, 4584.931226031612, 4596.747178905125, 3066.6013418255484, 3066.9079927602206, 3081.922951926175, 3089.0269565086924, 3090.134762266569, 5361.705106219196, 5375.381831089475, 5382.569394448435, 5391.137418013099, 5414.40441551429, 5281.656692314988, 5599.552035837123, 5605.243292155506, 5872.677002764889, 5894.204282421818, 5077.172218001517, 5130.153524668388, 5132.717700526432, 5153.768080436389, 5178.8964220716125, 5428.104362780255, 5456.836294911159, 5457.61796674229, 5462.535684466706, 5486.423925487926, 5180.963807238642, 5283.630145889904, 5308.575313974796, 5309.725665840093, 5335.706536140549, 5095.490450954875, 5096.592272618108, 5100.132977393778, 5109.974450127875, 5125.359330083739, 3699.315626609086, 3727.3849814780256, 3730.365837807525, 3742.7005839532226, 3772.6607054495257, 5290.338707661543, 5392.460753924576, 5394.32570928634, 5406.621536492565, 5440.727963601725, 5234.607404444606, 5245.580353571629, 5248.3701955765555, 5251.844594189272, 5256.342957130359, 4982.327385803015, 5240.240165176105, 5241.344831896013, 5241.816536421207, 5249.2415040961705, 5188.610854186027, 5193.948060519347, 5200.141976573823, 5208.5312321891215, 5224.817131400383, 4997.800967574256, 5084.618653601069, 5245.895082098413, 5247.7113758743635, 5283.286756287852, 5109.489051094861, 5131.923021154611, 5143.459936706592, 5153.7165455900285, 5158.200478925773], "value": 3967.257967761946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.7635757518207, 667.4360165660017, 680.733844957169, 689.2211800665248, 692.5152393324672, 11050.226484146113, 11066.723331916706, 11149.609763658274, 11297.830532542019, 11319.660410187696, 11531.884681153186, 11584.59453919113, 11623.825642615368, 11625.941870290659, 11688.298702077882, 639.143547646154, 739.0872272743158, 788.6884680551179, 800.5036877136183, 800.6437135474716, 808.5027707959592, 809.5264270401822, 809.6599428240153, 810.0805585660288, 812.0174588747623, 846.2299307630058, 846.5047946951041, 847.089378917666, 847.2840449819893, 849.587949844325, 837.2464781696461, 838.1450920061565, 838.5388036579857, 839.911809260028, 841.5119230846155, 616.5807251069272, 618.761776715963, 620.0265583034637, 620.9348018458087, 622.365187508743, 11726.413679316, 11734.354610496419, 11798.0, 11941.522339106425, 12026.879731202664, 11259.099272058298, 11415.657530274106, 11546.653600391917, 11669.066474682006, 11843.230190037706, 9538.403554709146, 9612.375195612263, 9643.855342169873, 9794.559244834, 9829.508524573743, 3137.748980081588, 3142.1673256587023, 3149.716525512692, 3205.2627895584146, 3281.5733954585753, 48081.03837923257, 48803.26795098041, 49171.50828491705, 49184.50815491835, 49453.75273123611, 8681.30549556034, 8931.419457735226, 9000.954995224982, 9114.908850911539, 9308.162265396011, 15386.769198462032, 15577.610559735871, 15617.0, 15617.3753049879, 15625.921870390803, 6425.0, 6540.0, 6593.967030164818, 6667.933320666732, 6771.52599318043, 3467.219875527986, 3539.823008849547, 3549.8402571884326, 3558.6975107116186, 3566.964330356715, 2697.865106744655, 2731.207949694566, 2753.8623068846478, 2765.723427657218, 2786.4427114577165, 512.7795048129266, 517.5276338816062, 522.8849653076317, 523.6596212461855, 530.4244894289661, 499.9075171093359, 561.0126177926878, 580.4688709830458, 612.0941007309208, 617.4042049422329, 7396.852062958711, 7531.8117047073165, 7582.165961744204, 7702.268284513074, 7830.295273425305, 531.9095753721799, 544.9836055755986, 627.5324882962223, 642.5791106825037, 649.4090377756219, 3494.266204097117, 3663.19409729859, 3675.2649470106085, 3694.833732482045, 3778.5843557208686, 57198.714006430535, 58488.41511584915, 59362.0, 59616.0, 60031.0, 46748.29877551839, 49280.260796088085, 50578.0, 51270.230946535834, 51383.22925156126, 45252.0, 45847.77076114665, 46184.0, 46244.768776156576, 46439.99999999932, 8091.474054186459, 8153.306968907709, 8207.876881846896, 8296.211859873303, 8424.199701028392, 27042.729572704022, 27719.0, 28753.856230718713, 30435.086947391614, 32072.839635801673, 36345.81827090848, 38575.42136867893, 41577.505349679115, 41887.790561047, 42521.36217956671, 10985.670429887115, 10991.61529346469, 11023.44882755843, 11142.108631309313, 11221.66335009951, 10776.353418794897, 11404.657860263873, 11595.768084638428, 11847.407629618658, 12203.328816915155, 11227.438628068401, 11411.0, 11549.942250288696, 11570.19008669385, 11630.476628551567, 10669.35983840972, 11111.111111111253, 11174.49714762854, 11229.157813163882, 12015.279083255033, 9008.369414140947, 10646.520906559379, 10816.729581760519, 10994.835077473685, 11090.279131856403, 9179.678711245075, 9529.857052144085, 9785.902140978784, 9913.058259465339, 10170.288079834341, 9231.630734770803, 9262.305327100628, 9468.289878259297, 9593.13661770444, 9687.757806054906], "value": 5863.722723462881, "unit": "score"}], "name": "dromaeo_css", "value": 6324.332185657354, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 114.0, 115.0, 125.0, 114.0, 113.0, 113.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 158.0, 189.0, 134.0, 163.0, 156.0, 134.0, 190.0, 135.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 167.0, 167.0, 164.0, 163.0, 162.0, 167.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 157.0, 75.0, 83.0, 77.0, 74.0, 169.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 149.0, 93.0, 94.0, 94.0, 134.0, 101.0, 93.0, 142.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 120.0, 118.0, 119.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 149.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 105.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 68.0, 65.0, 65.0, 85.0, 64.0, 63.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 69.0, 65.0, 65.0, 65.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 82.0, 84.0, 82.0, 80.0, 82.0, 88.0, 91.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 132.0, 138.0, 134.0, 143.0, 137.0, 130.0, 165.0, 132.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 182.0, 176.0, 175.0, 178.0, 181.0, 178.0, 174.0, 176.0, 173.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 77.0, 73.0, 73.0, 73.0, 72.0, 70.0, 72.0, 72.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1604.1000000000001, "alertThreshold": 2.0}]} 13:55:05 INFO - Return code: 0 13:55:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:55:05 ERROR - # TBPL SUCCESS # 13:55:05 INFO - Running post-action listener: _resource_record_post_action 13:55:05 INFO - Running post-run listener: _resource_record_post_run 13:55:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310325248; Read time: 16; Write time: 406948 13:55:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20029440; Read time: 0; Write time: 16792 13:55:06 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290295808; Read time: 16; Write time: 390156 13:55:06 INFO - Running post-run listener: _upload_blobber_files 13:55:06 INFO - Blob upload gear active. 13:55:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:55:06 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 13:55:06 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'] 13:55:06 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 13:55:07 INFO - (blobuploader) - INFO - Open directory for files ... 13:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:07 INFO - (blobuploader) - INFO - Done attempting. 13:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:08 INFO - (blobuploader) - INFO - Done attempting. 13:55:08 INFO - (blobuploader) - INFO - Iteration through files over. 13:55:08 INFO - Return code: 0 13:55:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:55:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:55:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f718af083c142852a11edb18b929e22cb7ff4c77a8b01e8f0101b490b426a811abfc9704d82900920dce0dd0523d1e962f0feaa06455435dd306fbbd597a8cac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3064efb091243eccb4fe2d11a7e26b737fa8fc4b4a1aff4f0668965aa5eb19fb63559c9cae910b9f08bfab5d034461390ecc204932619b8c5c5c67da3b3a4054"} 13:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:55:08 INFO - Contents: 13:55:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f718af083c142852a11edb18b929e22cb7ff4c77a8b01e8f0101b490b426a811abfc9704d82900920dce0dd0523d1e962f0feaa06455435dd306fbbd597a8cac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3064efb091243eccb4fe2d11a7e26b737fa8fc4b4a1aff4f0668965aa5eb19fb63559c9cae910b9f08bfab5d034461390ecc204932619b8c5c5c67da3b3a4054"} 13:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 13:55:08 INFO - Copying logs to upload dir... 13:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 13:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.726344 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-29 13:55:08.515489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 13:55:08.519079) ========= 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=33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295 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/f718af083c142852a11edb18b929e22cb7ff4c77a8b01e8f0101b490b426a811abfc9704d82900920dce0dd0523d1e962f0feaa06455435dd306fbbd597a8cac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3064efb091243eccb4fe2d11a7e26b737fa8fc4b4a1aff4f0668965aa5eb19fb63559c9cae910b9f08bfab5d034461390ecc204932619b8c5c5c67da3b3a4054"} build_url:https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/bZXG1ZhtQa2ztW-S2gLUVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f718af083c142852a11edb18b929e22cb7ff4c77a8b01e8f0101b490b426a811abfc9704d82900920dce0dd0523d1e962f0feaa06455435dd306fbbd597a8cac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3064efb091243eccb4fe2d11a7e26b737fa8fc4b4a1aff4f0668965aa5eb19fb63559c9cae910b9f08bfab5d034461390ecc204932619b8c5c5c67da3b3a4054"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 13:55:08.548872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:55:08.549663) ========= 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=33d5923976266a1c518c4bf7000001ab-1461961778.726904-201128295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:55:08.634446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 13:55:08.636349) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 13:55:08.636998) ========= ========= Total master_lag: 0.17 =========