builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1461839503.5 results: success (0) buildid: 20160428030702 builduid: 07d7f3686f2a487cb1b5ac98c5ea4e48 revision: 315ad011b1fd6fbda1f8938c28145e9a28e1b460 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.500839) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.501277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.501546) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.519136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.519600) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 03:31:44-- 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% 109M=0s 2016-04-28 03:31:44 (109 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.621209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.621516) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017847 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.670832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:43.671188) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 315ad011b1fd6fbda1f8938c28145e9a28e1b460 --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 315ad011b1fd6fbda1f8938c28145e9a28e1b460 --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=e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 03:31:44,260 truncating revision to first 12 chars 2016-04-28 03:31:44,260 Setting DEBUG logging. 2016-04-28 03:31:44,260 attempt 1/10 2016-04-28 03:31:44,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/315ad011b1fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 03:31:44,494 unpacking tar archive at: fx-team-315ad011b1fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.478619 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:44.162937) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:44.163292) ========= script_repo_revision: 315ad011b1fd6fbda1f8938c28145e9a28e1b460 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:44.163664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:44.163986) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 03:31:44.174018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-28 03:31:44.174280) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:44 INFO - MultiFileLogger online at 20160428 03:31:44 in /builds/slave/test 03:31:44 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 03:31:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:44 INFO - {'append_to_log': False, 03:31:44 INFO - 'base_work_dir': '/builds/slave/test', 03:31:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:31:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:44 INFO - 'branch': 'Fx-Team-Non-PGO', 03:31:44 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:44 INFO - 'config_files': ('talos/linux_config.py',), 03:31:44 INFO - 'default_actions': ('clobber', 03:31:44 INFO - 'read-buildbot-config', 03:31:44 INFO - 'download-and-extract', 03:31:44 INFO - 'populate-webroot', 03:31:44 INFO - 'create-virtualenv', 03:31:44 INFO - 'install', 03:31:44 INFO - 'run-tests'), 03:31:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:44 INFO - 'download_minidump_stackwalk': True, 03:31:44 INFO - 'download_symbols': 'ondemand', 03:31:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:44 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:44 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:44 INFO - 'installer_path': 'installer.exe', 03:31:44 INFO - 'log_level': 'info', 03:31:44 INFO - 'log_name': 'talos', 03:31:44 INFO - 'log_to_console': True, 03:31:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:44 INFO - 'opt_config_files': (), 03:31:44 INFO - 'pip_index': False, 03:31:44 INFO - 'sps_profile': False, 03:31:44 INFO - 'sps_profile_interval': 0, 03:31:44 INFO - 'suite': 'dromaeojs-e10s', 03:31:44 INFO - 'system_bits': '32', 03:31:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:44 INFO - 'title': 'talos-linux64-ix-067', 03:31:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:44 INFO - 'use_talos_json': True, 03:31:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:44 INFO - 'work_dir': 'build'} 03:31:44 INFO - ##### 03:31:44 INFO - ##### Running clobber step. 03:31:44 INFO - ##### 03:31:44 INFO - Running pre-action listener: _resource_record_pre_action 03:31:44 INFO - Running main action method: clobber 03:31:44 INFO - rmtree: /builds/slave/test/build 03:31:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:45 INFO - Running post-action listener: _resource_record_post_action 03:31:45 INFO - ##### 03:31:45 INFO - ##### Running read-buildbot-config step. 03:31:45 INFO - ##### 03:31:45 INFO - Running pre-action listener: _resource_record_pre_action 03:31:45 INFO - Running main action method: read_buildbot_config 03:31:45 INFO - Using buildbot properties: 03:31:45 INFO - { 03:31:45 INFO - "project": "", 03:31:45 INFO - "product": "firefox", 03:31:45 INFO - "script_repo_revision": "production", 03:31:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:31:45 INFO - "repository": "", 03:31:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:31:45 INFO - "buildid": "20160428030702", 03:31:45 INFO - "pgo_build": "False", 03:31:45 INFO - "basedir": "/builds/slave/test", 03:31:45 INFO - "buildnumber": 1230, 03:31:45 INFO - "slavename": "talos-linux64-ix-067", 03:31:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:31:45 INFO - "platform": "ubuntu64_hw", 03:31:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:31:45 INFO - "branch": "fx-team", 03:31:45 INFO - "repo_path": "integration/fx-team", 03:31:45 INFO - "revision": "315ad011b1fd6fbda1f8938c28145e9a28e1b460", 03:31:45 INFO - "stage_platform": "linux64", 03:31:45 INFO - "builduid": "07d7f3686f2a487cb1b5ac98c5ea4e48", 03:31:45 INFO - "slavebuilddir": "test" 03:31:45 INFO - } 03:31:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:31:45 INFO - Running post-action listener: _resource_record_post_action 03:31:45 INFO - ##### 03:31:45 INFO - ##### Running download-and-extract step. 03:31:45 INFO - ##### 03:31:45 INFO - Running pre-action listener: _resource_record_pre_action 03:31:45 INFO - Running main action method: download_and_extract 03:31:45 INFO - mkdir: /builds/slave/test/build/tests 03:31: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')]} 03:31:45 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:46 INFO - Downloaded 1361 bytes. 03:31:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:31:46 INFO - Using the following test package requirements: 03:31:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:31:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:46 INFO - u'jsshell-linux-x86_64.zip'], 03:31:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:31:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:31:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:47 INFO - Downloaded 22293734 bytes. 03:31:47 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'] 03:31:47 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 03:31:48 INFO - Return code: 0 03:31:48 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 03:31: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')]} 03:31:48 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:31:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:31:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:50 INFO - Downloaded 22293734 bytes. 03:31:50 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'] 03:31:50 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 03:31:51 INFO - Return code: 0 03:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:51 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:52 INFO - Downloaded 10840145 bytes. 03:31:52 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'] 03:31:52 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 03:31:52 INFO - Return code: 0 03:31:52 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')]} 03:31:52 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:31:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:31:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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 03:31:54 INFO - Downloaded 54841807 bytes. 03:31:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:31:54 INFO - mkdir: /builds/slave/test/properties 03:31:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:54 INFO - Contents: 03:31:54 INFO - build_url:https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:31:55 INFO - Running post-action listener: _resource_record_post_action 03:31:55 INFO - Running post-action listener: set_extra_try_arguments 03:31:55 INFO - ##### 03:31:55 INFO - ##### Running populate-webroot step. 03:31:55 INFO - ##### 03:31:55 INFO - Running pre-action listener: _resource_record_pre_action 03:31:55 INFO - Running main action method: populate_webroot 03:31:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:55 INFO - '--tppagecycles', 03:31:55 INFO - '7'], 03:31:55 INFO - 'tests': ['tsvgm']}}, 03:31:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:55 INFO - 'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:55 INFO - 'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['damp', 'tps']}, 03:31:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:55 INFO - 'tests': ['damp', 'tps']}, 03:31:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['dromaeo_dom']}, 03:31:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['a11yr', 03:31:55 INFO - 'ts_paint', 03:31:55 INFO - 'tpaint', 03:31:55 INFO - 'sessionrestore', 03:31:55 INFO - 'sessionrestore_no_auto_restore', 03:31:55 INFO - 'tabpaint']}, 03:31:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:55 INFO - 'ts_paint', 03:31:55 INFO - 'tpaint', 03:31:55 INFO - 'sessionrestore', 03:31:55 INFO - 'sessionrestore_no_auto_restore', 03:31:55 INFO - 'tabpaint']}, 03:31:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:55 INFO - 'ts_paint', 03:31:55 INFO - 'tpaint', 03:31:55 INFO - 'sessionrestore', 03:31:55 INFO - 'sessionrestore_no_auto_restore', 03:31:55 INFO - 'tabpaint']}, 03:31:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:55 INFO - 'ts_paint', 03:31:55 INFO - 'tpaint', 03:31:55 INFO - 'sessionrestore', 03:31:55 INFO - 'sessionrestore_no_auto_restore', 03:31:55 INFO - 'tabpaint']}, 03:31:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['a11yr', 03:31:55 INFO - 'ts_paint', 03:31:55 INFO - 'tpaint', 03:31:55 INFO - 'sessionrestore', 03:31:55 INFO - 'sessionrestore_no_auto_restore', 03:31:55 INFO - 'tabpaint']}, 03:31:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['a11yr', 03:31:55 INFO - 'ts_paint', 03:31:55 INFO - 'tpaint', 03:31:55 INFO - 'sessionrestore', 03:31:55 INFO - 'sessionrestore_no_auto_restore', 03:31:55 INFO - 'tabpaint']}, 03:31:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['tsvgx', 03:31:55 INFO - 'tsvgr_opacity', 03:31:55 INFO - 'tart', 03:31:55 INFO - 'tscrollx', 03:31:55 INFO - 'cart']}, 03:31:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:55 INFO - 'tsvgr_opacity', 03:31:55 INFO - 'tart', 03:31:55 INFO - 'tscrollx', 03:31:55 INFO - 'cart']}, 03:31:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:55 INFO - 'talos_options': ['--disable-e10s'], 03:31:55 INFO - 'tests': ['tp5o']}, 03:31:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:55 INFO - 'tests': ['tp5o']}, 03:31:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:55 INFO - 'talos_options': ['--disable-e10s', 03:31:55 INFO - '--xperf_path', 03:31:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:55 INFO - 'tests': ['tp5n']}, 03:31:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:55 INFO - 'talos_options': ['--xperf_path', 03:31:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:55 INFO - 'tests': ['tp5n']}}, 03:31:55 INFO - 'talos.zip': {'path': '', 03:31:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:55 INFO - Running post-action listener: _resource_record_post_action 03:31:55 INFO - ##### 03:31:55 INFO - ##### Running create-virtualenv step. 03:31:55 INFO - ##### 03:31:55 INFO - Running pre-action listener: _resource_record_pre_action 03:31:55 INFO - Running main action method: create_virtualenv 03:31:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:55 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 03:31:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:55 INFO - Using real prefix '/usr' 03:31:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:58 INFO - Installing pip.................done. 03:31:58 INFO - Return code: 0 03:31:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:31:58 INFO - Using env: {'DISPLAY': ':0', 03:31:58 INFO - 'HOME': '/home/cltbld', 03:31:58 INFO - 'LANG': 'en_US.UTF-8', 03:31:58 INFO - 'LANGUAGE': 'en_US:en', 03:31:58 INFO - 'LOGNAME': 'cltbld', 03:31:58 INFO - 'MAIL': '/var/mail/cltbld', 03:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:58 INFO - 'MOZ_NO_REMOTE': '1', 03:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:58 INFO - 'NO_EM_RESTART': '1', 03:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:58 INFO - 'PWD': '/builds/slave/test', 03:31:58 INFO - 'SHELL': '/bin/bash', 03:31:58 INFO - 'SHLVL': '1', 03:31:58 INFO - 'TERM': 'linux', 03:31:58 INFO - 'TMOUT': '86400', 03:31:58 INFO - 'USER': 'cltbld', 03:31:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:58 INFO - '_': '/tools/buildbot/bin/python'} 03:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:58 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 03:31:58 INFO - Cleaning up... 03:31:58 INFO - Return code: 0 03:31:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:31:58 INFO - Using env: {'DISPLAY': ':0', 03:31:58 INFO - 'HOME': '/home/cltbld', 03:31:58 INFO - 'LANG': 'en_US.UTF-8', 03:31:58 INFO - 'LANGUAGE': 'en_US:en', 03:31:58 INFO - 'LOGNAME': 'cltbld', 03:31:58 INFO - 'MAIL': '/var/mail/cltbld', 03:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:58 INFO - 'MOZ_NO_REMOTE': '1', 03:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:58 INFO - 'NO_EM_RESTART': '1', 03:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:58 INFO - 'PWD': '/builds/slave/test', 03:31:58 INFO - 'SHELL': '/bin/bash', 03:31:58 INFO - 'SHLVL': '1', 03:31:58 INFO - 'TERM': 'linux', 03:31:58 INFO - 'TMOUT': '86400', 03:31:58 INFO - 'USER': 'cltbld', 03:31:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:58 INFO - '_': '/tools/buildbot/bin/python'} 03:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:58 INFO - Downloading/unpacking psutil>=0.7.1 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:00 INFO - Installing collected packages: psutil 03:32:00 INFO - Running setup.py install for psutil 03:32:00 INFO - building 'psutil._psutil_linux' extension 03:32:00 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 03:32:00 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 03:32:00 INFO - building 'psutil._psutil_posix' extension 03:32:00 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 03:32:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:32:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:01 INFO - Successfully installed psutil 03:32:01 INFO - Cleaning up... 03:32:01 INFO - Return code: 0 03:32:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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', '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 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:32: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:32: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 mozsystemmonitor==0.0.0 03:32:01 INFO - Using env: {'DISPLAY': ':0', 03:32:01 INFO - 'HOME': '/home/cltbld', 03:32:01 INFO - 'LANG': 'en_US.UTF-8', 03:32:01 INFO - 'LANGUAGE': 'en_US:en', 03:32:01 INFO - 'LOGNAME': 'cltbld', 03:32:01 INFO - 'MAIL': '/var/mail/cltbld', 03:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:01 INFO - 'MOZ_NO_REMOTE': '1', 03:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:01 INFO - 'NO_EM_RESTART': '1', 03:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:01 INFO - 'PWD': '/builds/slave/test', 03:32:01 INFO - 'SHELL': '/bin/bash', 03:32:01 INFO - 'SHLVL': '1', 03:32:01 INFO - 'TERM': 'linux', 03:32:01 INFO - 'TMOUT': '86400', 03:32:01 INFO - 'USER': 'cltbld', 03:32:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:01 INFO - '_': '/tools/buildbot/bin/python'} 03:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:32:03 INFO - Installing collected packages: mozsystemmonitor 03:32:03 INFO - Running setup.py install for mozsystemmonitor 03:32:03 INFO - Successfully installed mozsystemmonitor 03:32:03 INFO - Cleaning up... 03:32:03 INFO - Return code: 0 03:32:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:03 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')]} 03:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 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')]} 03:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 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 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:32:03 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 03:32:03 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 03:32:03 INFO - Using env: {'DISPLAY': ':0', 03:32:03 INFO - 'HOME': '/home/cltbld', 03:32:03 INFO - 'LANG': 'en_US.UTF-8', 03:32:03 INFO - 'LANGUAGE': 'en_US:en', 03:32:03 INFO - 'LOGNAME': 'cltbld', 03:32:03 INFO - 'MAIL': '/var/mail/cltbld', 03:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:03 INFO - 'MOZ_NO_REMOTE': '1', 03:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:03 INFO - 'NO_EM_RESTART': '1', 03:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:03 INFO - 'PWD': '/builds/slave/test', 03:32:03 INFO - 'SHELL': '/bin/bash', 03:32:03 INFO - 'SHLVL': '1', 03:32:03 INFO - 'TERM': 'linux', 03:32:03 INFO - 'TMOUT': '86400', 03:32:03 INFO - 'USER': 'cltbld', 03:32:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:03 INFO - '_': '/tools/buildbot/bin/python'} 03:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:06 INFO - Downloading docopt-0.6.1.tar.gz 03:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:06 INFO - Running setup.py install for blobuploader 03:32:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:06 INFO - Running setup.py install for requests 03:32:06 INFO - Running setup.py install for docopt 03:32:06 INFO - Successfully installed blobuploader requests docopt 03:32:06 INFO - Cleaning up... 03:32:06 INFO - Return code: 0 03:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:06 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 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:32:06 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 03:32:06 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 03:32:06 INFO - Using env: {'DISPLAY': ':0', 03:32:06 INFO - 'HOME': '/home/cltbld', 03:32:06 INFO - 'LANG': 'en_US.UTF-8', 03:32:06 INFO - 'LANGUAGE': 'en_US:en', 03:32:06 INFO - 'LOGNAME': 'cltbld', 03:32:06 INFO - 'MAIL': '/var/mail/cltbld', 03:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:06 INFO - 'MOZ_NO_REMOTE': '1', 03:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:06 INFO - 'NO_EM_RESTART': '1', 03:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:06 INFO - 'PWD': '/builds/slave/test', 03:32:06 INFO - 'SHELL': '/bin/bash', 03:32:06 INFO - 'SHLVL': '1', 03:32:06 INFO - 'TERM': 'linux', 03:32:06 INFO - 'TMOUT': '86400', 03:32:06 INFO - 'USER': 'cltbld', 03:32:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:06 INFO - '_': '/tools/buildbot/bin/python'} 03:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:07 INFO - Running setup.py (path:/tmp/pip-3G9ZdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:07 INFO - Running setup.py (path:/tmp/pip-LB03PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:07 INFO - Running setup.py (path:/tmp/pip-iHd85k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:07 INFO - Running setup.py (path:/tmp/pip-xOssIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:07 INFO - Running setup.py (path:/tmp/pip-SYut9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:07 INFO - Running setup.py (path:/tmp/pip-0ZuLQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:07 INFO - Running setup.py (path:/tmp/pip-2AvBTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:07 INFO - Running setup.py (path:/tmp/pip-nMZGvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:07 INFO - Running setup.py (path:/tmp/pip-eu9Qrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:07 INFO - Running setup.py (path:/tmp/pip-j1Drrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:07 INFO - Running setup.py (path:/tmp/pip-pbBD7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:07 INFO - Running setup.py (path:/tmp/pip-t7GlTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:08 INFO - Running setup.py (path:/tmp/pip-ZRpeq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:08 INFO - Running setup.py (path:/tmp/pip-epcITi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:08 INFO - Running setup.py (path:/tmp/pip-FfuBHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:08 INFO - Running setup.py (path:/tmp/pip-WykwY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:08 INFO - Running setup.py (path:/tmp/pip-n5CAAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:08 INFO - Running setup.py install for manifestparser 03:32:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:08 INFO - Running setup.py install for mozcrash 03:32:08 INFO - Running setup.py install for mozdebug 03:32:08 INFO - Running setup.py install for mozdevice 03:32:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:08 INFO - Running setup.py install for mozfile 03:32:08 INFO - Running setup.py install for mozhttpd 03:32:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:08 INFO - Running setup.py install for mozinfo 03:32:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Running setup.py install for mozInstall 03:32:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Running setup.py install for mozleak 03:32:09 INFO - Running setup.py install for mozlog 03:32:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Running setup.py install for moznetwork 03:32:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Running setup.py install for mozprocess 03:32:09 INFO - Running setup.py install for mozprofile 03:32:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Running setup.py install for mozrunner 03:32:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:09 INFO - Running setup.py install for mozscreenshot 03:32:09 INFO - Running setup.py install for moztest 03:32:10 INFO - Running setup.py install for mozversion 03:32:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:10 INFO - Cleaning up... 03:32:10 INFO - Return code: 0 03:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 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 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:32:10 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 03:32:10 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 03:32:10 INFO - Using env: {'DISPLAY': ':0', 03:32:10 INFO - 'HOME': '/home/cltbld', 03:32:10 INFO - 'LANG': 'en_US.UTF-8', 03:32:10 INFO - 'LANGUAGE': 'en_US:en', 03:32:10 INFO - 'LOGNAME': 'cltbld', 03:32:10 INFO - 'MAIL': '/var/mail/cltbld', 03:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:10 INFO - 'MOZ_NO_REMOTE': '1', 03:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:10 INFO - 'NO_EM_RESTART': '1', 03:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:10 INFO - 'PWD': '/builds/slave/test', 03:32:10 INFO - 'SHELL': '/bin/bash', 03:32:10 INFO - 'SHLVL': '1', 03:32:10 INFO - 'TERM': 'linux', 03:32:10 INFO - 'TMOUT': '86400', 03:32:10 INFO - 'USER': 'cltbld', 03:32:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:10 INFO - '_': '/tools/buildbot/bin/python'} 03:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:10 INFO - Running setup.py (path:/tmp/pip-NArT8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:10 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)) 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:10 INFO - Running setup.py (path:/tmp/pip-VRUOoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:10 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)) 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:10 INFO - Running setup.py (path:/tmp/pip-KHjcXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:10 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)) 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:10 INFO - Running setup.py (path:/tmp/pip-FodzlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:10 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)) 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:10 INFO - Running setup.py (path:/tmp/pip-4U8sID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:10 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)) 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:10 INFO - Running setup.py (path:/tmp/pip-lSqg6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:10 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)) 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:10 INFO - Running setup.py (path:/tmp/pip-N1pLpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:10 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)) 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:10 INFO - Running setup.py (path:/tmp/pip-sFJfN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:10 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)) 03:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:10 INFO - Running setup.py (path:/tmp/pip-LHfKXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:11 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)) 03:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:11 INFO - Running setup.py (path:/tmp/pip-udduPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:11 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)) 03:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:11 INFO - Running setup.py (path:/tmp/pip-bipuRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:11 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)) 03:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:11 INFO - Running setup.py (path:/tmp/pip-u7PccK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:11 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)) 03:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:11 INFO - Running setup.py (path:/tmp/pip-sgmqCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:11 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)) 03:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:11 INFO - Running setup.py (path:/tmp/pip-90ztJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:11 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)) 03:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:11 INFO - Running setup.py (path:/tmp/pip-zzkt2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:11 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)) 03:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:11 INFO - Running setup.py (path:/tmp/pip-yXp6EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:11 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)) 03:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:11 INFO - Running setup.py (path:/tmp/pip-s0TXGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:11 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)) 03:32:11 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)) 03:32:11 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)) 03:32:11 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)) 03:32:11 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)) 03:32:11 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)) 03:32:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - Downloading blessings-1.6.tar.gz 03:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:13 INFO - Installing collected packages: blessings 03:32:13 INFO - Running setup.py install for blessings 03:32:13 INFO - Successfully installed blessings 03:32:13 INFO - Cleaning up... 03:32:13 INFO - Return code: 0 03:32:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:13 INFO - Reading from file tmpfile_stdout 03:32:13 INFO - Current package versions: 03:32:13 INFO - argparse == 1.2.1 03:32:13 INFO - blessings == 1.6 03:32:13 INFO - blobuploader == 1.2.4 03:32:13 INFO - docopt == 0.6.1 03:32:13 INFO - manifestparser == 1.1 03:32:13 INFO - mozInstall == 1.12 03:32:13 INFO - mozcrash == 0.17 03:32:13 INFO - mozdebug == 0.1 03:32:13 INFO - mozdevice == 0.48 03:32:13 INFO - mozfile == 1.2 03:32:13 INFO - mozhttpd == 0.7 03:32:13 INFO - mozinfo == 0.9 03:32:13 INFO - mozleak == 0.1 03:32:13 INFO - mozlog == 3.1 03:32:13 INFO - moznetwork == 0.27 03:32:13 INFO - mozprocess == 0.22 03:32:13 INFO - mozprofile == 0.28 03:32:13 INFO - mozrunner == 6.11 03:32:13 INFO - mozscreenshot == 0.1 03:32:13 INFO - mozsystemmonitor == 0.0 03:32:13 INFO - moztest == 0.7 03:32:13 INFO - mozversion == 1.4 03:32:13 INFO - psutil == 3.1.1 03:32:13 INFO - requests == 1.2.3 03:32:13 INFO - wsgiref == 0.1.2 03:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:13 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 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:32:13 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 03:32:13 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 03:32:13 INFO - Using env: {'DISPLAY': ':0', 03:32:13 INFO - 'HOME': '/home/cltbld', 03:32:13 INFO - 'LANG': 'en_US.UTF-8', 03:32:13 INFO - 'LANGUAGE': 'en_US:en', 03:32:13 INFO - 'LOGNAME': 'cltbld', 03:32:13 INFO - 'MAIL': '/var/mail/cltbld', 03:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:13 INFO - 'MOZ_NO_REMOTE': '1', 03:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:13 INFO - 'NO_EM_RESTART': '1', 03:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:13 INFO - 'PWD': '/builds/slave/test', 03:32:13 INFO - 'SHELL': '/bin/bash', 03:32:13 INFO - 'SHLVL': '1', 03:32:13 INFO - 'TERM': 'linux', 03:32:13 INFO - 'TMOUT': '86400', 03:32:13 INFO - 'USER': 'cltbld', 03:32:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:13 INFO - '_': '/tools/buildbot/bin/python'} 03:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 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)) 03:32:14 INFO - Cleaning up... 03:32:14 INFO - Return code: 0 03:32:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:14 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 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:32:14 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 03:32:14 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 03:32:14 INFO - Using env: {'DISPLAY': ':0', 03:32:14 INFO - 'HOME': '/home/cltbld', 03:32:14 INFO - 'LANG': 'en_US.UTF-8', 03:32:14 INFO - 'LANGUAGE': 'en_US:en', 03:32:14 INFO - 'LOGNAME': 'cltbld', 03:32:14 INFO - 'MAIL': '/var/mail/cltbld', 03:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:14 INFO - 'MOZ_NO_REMOTE': '1', 03:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:14 INFO - 'NO_EM_RESTART': '1', 03:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:14 INFO - 'PWD': '/builds/slave/test', 03:32:14 INFO - 'SHELL': '/bin/bash', 03:32:14 INFO - 'SHLVL': '1', 03:32:14 INFO - 'TERM': 'linux', 03:32:14 INFO - 'TMOUT': '86400', 03:32:14 INFO - 'USER': 'cltbld', 03:32:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:14 INFO - '_': '/tools/buildbot/bin/python'} 03:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:14 INFO - Downloading/unpacking jsonschema 03:32:14 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 03:32:14 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 03:32:14 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 03:32:14 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 03:32:14 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 03:32:14 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 03:32:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:16 INFO - Downloading/unpacking functools32 (from jsonschema) 03:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:16 INFO - warning: no files found matching '*.txt' 03:32:16 INFO - no previously-included directories found matching 'build' 03:32:16 INFO - no previously-included directories found matching 'dist' 03:32:16 INFO - no previously-included directories found matching '.git*' 03:32:16 INFO - Installing collected packages: jsonschema, functools32 03:32:16 INFO - Running setup.py install for functools32 03:32:16 INFO - warning: no files found matching '*.txt' 03:32:16 INFO - no previously-included directories found matching 'build' 03:32:16 INFO - no previously-included directories found matching 'dist' 03:32:16 INFO - no previously-included directories found matching '.git*' 03:32:16 INFO - Successfully installed jsonschema functools32 03:32:16 INFO - Cleaning up... 03:32:16 INFO - Return code: 0 03:32:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:16 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 0x7f874e0b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', '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 03:32:16 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 03:32:16 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 03:32:16 INFO - Using env: {'DISPLAY': ':0', 03:32:16 INFO - 'HOME': '/home/cltbld', 03:32:16 INFO - 'LANG': 'en_US.UTF-8', 03:32:16 INFO - 'LANGUAGE': 'en_US:en', 03:32:16 INFO - 'LOGNAME': 'cltbld', 03:32:16 INFO - 'MAIL': '/var/mail/cltbld', 03:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:16 INFO - 'MOZ_NO_REMOTE': '1', 03:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:16 INFO - 'NO_EM_RESTART': '1', 03:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:16 INFO - 'PWD': '/builds/slave/test', 03:32:16 INFO - 'SHELL': '/bin/bash', 03:32:16 INFO - 'SHLVL': '1', 03:32:16 INFO - 'TERM': 'linux', 03:32:16 INFO - 'TMOUT': '86400', 03:32:16 INFO - 'USER': 'cltbld', 03:32:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:16 INFO - '_': '/tools/buildbot/bin/python'} 03:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:16 INFO - Downloading/unpacking flake8 03:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:19 INFO - no previously-included directories found matching 'docs/_build' 03:32:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:19 INFO - Running setup.py install for pep8 03:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:19 INFO - no previously-included directories found matching 'docs/_build' 03:32:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:32:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:19 INFO - Cleaning up... 03:32:19 INFO - Return code: 0 03:32:19 INFO - Running post-action listener: _resource_record_post_action 03:32:19 INFO - Running post-action listener: _start_resource_monitoring 03:32:19 INFO - Starting resource monitoring. 03:32:19 INFO - ##### 03:32:19 INFO - ##### Running install step. 03:32:19 INFO - ##### 03:32:19 INFO - Running pre-action listener: _resource_record_pre_action 03:32:19 INFO - Running main action method: install 03:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:20 INFO - Reading from file tmpfile_stdout 03:32:20 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:20 INFO - Reading from file tmpfile_stdout 03:32:20 INFO - Output received: 03:32:20 INFO - Usage: mozinstall [options] installer 03:32:20 INFO - Options: 03:32:20 INFO - -h, --help show this help message and exit 03:32:20 INFO - -d DEST, --destination=DEST 03:32:20 INFO - Directory to install application into. [default: 03:32:20 INFO - "/builds/slave/test"] 03:32:20 INFO - --app=APP Application being installed. [default: firefox] 03:32:20 INFO - mkdir: /builds/slave/test/build/application 03:32:20 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'] 03:32:20 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 03:32:35 INFO - Reading from file tmpfile_stdout 03:32:35 INFO - Output received: 03:32:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:35 INFO - Running post-action listener: _resource_record_post_action 03:32:35 INFO - ##### 03:32:35 INFO - ##### Running run-tests step. 03:32:35 INFO - ##### 03:32:35 INFO - Running pre-action listener: _resource_record_pre_action 03:32:35 INFO - Running main action method: run_tests 03:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:35 INFO - Python 2.7.3 03:32:35 INFO - Return code: 0 03:32:35 INFO - grabbing minidump binary from tooltool 03:32:35 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')]} 03:32:35 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 0x232b410>, '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 0x232c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:35 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 03:32:35 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 03:32:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:35 INFO - Return code: 0 03:32:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:36 INFO - Return code: 0 03:32:36 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/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 03:32:36 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/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 03:32:36 INFO - Using env: {'DISPLAY': ':0', 03:32:36 INFO - 'HOME': '/home/cltbld', 03:32:36 INFO - 'LANG': 'en_US.UTF-8', 03:32:36 INFO - 'LANGUAGE': 'en_US:en', 03:32:36 INFO - 'LOGNAME': 'cltbld', 03:32:36 INFO - 'MAIL': '/var/mail/cltbld', 03:32:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:36 INFO - 'MOZ_NO_REMOTE': '1', 03:32:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:36 INFO - 'NO_EM_RESTART': '1', 03:32:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:36 INFO - 'PWD': '/builds/slave/test', 03:32:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:36 INFO - 'SHELL': '/bin/bash', 03:32:36 INFO - 'SHLVL': '1', 03:32:36 INFO - 'TERM': 'linux', 03:32:36 INFO - 'TMOUT': '86400', 03:32:36 INFO - 'USER': 'cltbld', 03:32:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052', 03:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:36 INFO - '_': '/tools/buildbot/bin/python'} 03:32:36 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/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 03:32:37 INFO - mozversion application_buildid: 20160428030702 03:32:37 INFO - mozversion application_changeset: 315ad011b1fd6fbda1f8938c28145e9a28e1b460 03:32:37 INFO - mozversion application_display_name: Nightly 03:32:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:37 INFO - mozversion application_name: Firefox 03:32:37 INFO - mozversion application_remotingname: firefox 03:32:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:32:37 INFO - mozversion application_vendor: Mozilla 03:32:37 INFO - mozversion application_version: 49.0a1 03:32:37 INFO - mozversion platform_buildid: 20160428030702 03:32:37 INFO - mozversion platform_changeset: 315ad011b1fd6fbda1f8938c28145e9a28e1b460 03:32:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:32:37 INFO - mozversion platform_version: 49.0a1 03:32:37 INFO - using testdate: 1461839557 03:32:37 INFO - actual date: 1461839557 03:32:37 INFO - starting webserver on 'localhost:42595' 03:32:37 INFO - SUITE-START | Running 2 tests 03:32:37 INFO - TEST-START | dromaeo_css 03:32:37 INFO - operating with platform_type : linux_ 03:32:37 INFO - Initialising browser for dromaeo_css test... 03:32:37 INFO - TEST-INFO | started process 27111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfUL3Wj/profile http://localhost:42595/getInfo.html) 03:32:40 INFO - PROCESS | 27111 | 03:32:40 INFO - PROCESS | 27111 | (process:27181): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:41 INFO - PROCESS | 27111 | __metrics Screen width/height:1600/1200 03:32:41 INFO - PROCESS | 27111 | colorDepth:24 03:32:41 INFO - PROCESS | 27111 | Browser inner width/height: 1024/697 03:32:41 INFO - PROCESS | 27111 | __metrics 03:32:42 ERROR - PROCESS | 27111 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:32:43 INFO - TEST-INFO | 27111: exit 0 03:32:43 INFO - Browser initialized. 03:32:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:43 INFO - TEST-INFO | started process 27232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfUL3Wj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:45 INFO - PROCESS | 27232 | 03:32:45 INFO - PROCESS | 27232 | (process:27291): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:55 INFO - PROCESS | 27232 | RSS: Main: 166633472 03:32:55 INFO - PROCESS | 27232 | 03:33:44 INFO - PROCESS | 27232 | 1461839624630 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] 03:35:56 INFO - PROCESS | 27232 | Cycle 1(1): loaded http://localhost:42595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42595/tests/dromaeo/cssquery-ext.html) 03:35:57 INFO - PROCESS | 27232 | RSS: Main: 170606592 03:35:57 INFO - PROCESS | 27232 | 03:38:59 INFO - PROCESS | 27232 | Cycle 1(1): loaded http://localhost:42595/tests/dromaeo/cssquery-ext.html (next: http://localhost:42595/tests/dromaeo/cssquery-jquery.html) 03:39:00 INFO - PROCESS | 27232 | RSS: Main: 167120896 03:39:00 INFO - PROCESS | 27232 | 03:42:02 INFO - PROCESS | 27232 | Cycle 1(1): loaded http://localhost:42595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42595/tests/dromaeo/cssquery-mootools.html) 03:42:02 INFO - PROCESS | 27232 | RSS: Main: 167968768 03:42:02 INFO - PROCESS | 27232 | 03:45:04 INFO - PROCESS | 27232 | Cycle 1(1): loaded http://localhost:42595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42595/tests/dromaeo/cssquery-prototype.html) 03:45:05 INFO - PROCESS | 27232 | RSS: Main: 166387712 03:45:05 INFO - PROCESS | 27232 | 03:48:08 INFO - PROCESS | 27232 | Cycle 1(1): loaded http://localhost:42595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42595/tests/dromaeo/cssquery-yui.html) 03:48:08 INFO - PROCESS | 27232 | RSS: Main: 167346176 03:48:08 INFO - PROCESS | 27232 | 03:51:10 INFO - PROCESS | 27232 | Cycle 1(1): loaded http://localhost:42595/tests/dromaeo/cssquery-yui.html (next: http://localhost:42595/tests/dromaeo/cssquery-dojo.html) 03:51:11 INFO - PROCESS | 27232 | RSS: Main: 169816064 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - PROCESS | 27232 | __start_tp_report 03:51:11 INFO - PROCESS | 27232 | _x_x_mozilla_page_load 03:51:11 INFO - PROCESS | 27232 | _x_x_mozilla_page_load_details 03:51:11 INFO - PROCESS | 27232 | |i|pagename|runs| 03:51:11 INFO - PROCESS | 27232 | |0;dojo.html;2646.0474229277456;2718.2117186016058;2734.835909845408;2748.299183708154;2753.297909033195;4717.29240613908;4822.156122678531;4833.806647734091;4859.3439885615435;4906.31311616374;4769.141554520185;4806.975965120169;4835.081334546434;4843.370361852954;4844.927326090103;4445.911081778362;4495.640348772106;4543.522930092342;4558.794854231567;4588.931166032512;4455.153520831048;4563.949579413412;4564.703294285878;4575.748333841638;4580.541945805426;4309.849155279581;4344.413504176927;4426.468823741139;4476.61948734358;4539.251023581105;4423.579759922803;4437.711548749321;4471.35165401015;4483.170613436525;4517.232070548015;4377;4421.07157496926;4434.645228381722;4438.933415998763;4464.799084041226;4643.674942754009;4679.344891715163;4706.647001474869;4710.105080034817;4753.928691069636;5124.974375128138;5126.5642420394315;5138.794448222066;5140.897182056338;5196;5153.2270159476;5184.066867963765;5186.740662966837;5190.2214667800135;5198.610104242197;4679.064187162581;4778.761061946889;4824.179889418807;4837.395325584302;4864.100141473838;5300;5348.786048558092;5360.463953604608;5373.35519737634;5435.565154787608;4938;5155.7679904404395;5191.9480805192225;5192.948070519322;5209.7916083356995;5187.014467251211;5191.844244672666;5205.869853253699;5244.816431424958;5255.39562950258;4972.080165169383;5043.773030213649;5045.2432135180015;5047.2429135629945;5051.217061355495;5116.309298244763;5129.794808207705;5134.897302053938;5168.715720635326;5229.032628963654;3923.862664806718;3976.8210430530694;3983.6813054956115;3983.7609743415487;4015.1367455996515;3576.213233088716;3582.229820588586;3582.426811710166;3588.982055089708;3618.9638103619154;4347.152305300499;4353.651707863363;4379.737215767064;4402.207602631557;4411.514733379326;5098.566621837185;5212.035773381936;5241.633085683966;5274;5297.311349524537;4329.502107257643;4330.17726631939;4333.978330108329;4366.716163449366;4371.300591905344;4638.373819534319;4659.138059459011;4673.135469938073;4677.46209185948;4717.43390793107;4801.9039619208115;4886.926696099561;4909.214525675875;4970.776315065903;4972.801087956586;5156.071907056766;5181.974090129676;5193.0652482553505;5195.610329225247;5204.2714020036465;4928.137575924127;4935.481774413778;4938.975305123451;4943;4955.430125535466;5012.598992080552;5132.230165475208;5136.30659860914;5184.896302074013;5219.2953951216095;5176.7152806596;5209.244659524272;5229.816956406507;5243;5289.41816400188;4888.804447822189;5036.395632524121;5051.520105589963;5069.7718602662235;5081.11080560893;4924.852254432372;4933.333999909966;4957.330760347307;4978;5037.420696619789;4894.657373983787;4952.331435256195;4968.726720030433;5010.123228435083;5012.373453318335;5065.949340506548;5069.1635880079375;5071.39143302806;5080.110980578458;5133.101707201299;4781.211100168433;4818.132736107535;4873.366462359871;4879.39007624047;4915.65590408668 03:51:11 INFO - PROCESS | 27232 | |1;ext.html;574.6638216643263;607.8449995251214;616.3774587666456;633.1958412815723;639.2456900856993;32252.19369515763;33108.503372449406;33166.1708457289;33224.33551328972;33230.16924576887;35466.82266588663;36457;36483.817580912124;36541.26917461649;36679.449808252895;7505.362044226247;7694.884576731325;7695.615219239044;7698.461107722462;7704.19105993871;7630.160682324939;7715.922840771605;7747.9612601936915;7758.069031716173;7779.105402878685;7671.961640191791;7780.221977802231;7794.64924078415;7804.960975195145;7807.102183248914;7618.657160427794;7656.923430765704;7706.537607743525;7707.460477766558;7722.57525836076;7502.6623801929045;7654.693812247503;7680.807979800494;7701.22987701231;7703.922960770433;34015.31969360599;34793.30413391718;34852.477212841826;34984;35057.12357191065;2962;3080.9537856932166;3111.7510599152015;3392.2028323343993;3458.360203362386;27075.864620676966;27338.179854604394;27368.726312737017;27398.5890211647;27456.176314710592;3131.840377167859;3148.3073723780963;3157.747380209578;3201.167696398953;3358.580177477815;197299;198230;198376.0081199599;198727;198810;29771;30555.847220763753;50017;50703.239451408255;50740.74629626902;30882.69117308843;30922.690773092432;31079.689203108133;31118.53322200169;31134.37731245408;13215;13295.66760830987;13371.465141394236;13400.731985360238;13425.530106446227;10991.285566438315;11016.779664406668;11034.558617655204;11047.337159770439;11111.83332250017;7722.498037627536;7844.64699088531;7970.402219833536;8001.679932802623;8012.679492820338;3078.676738942379;3170.61952565689;3187.0916788715567;3228.1284053305476;3236.482162853979;937.128470522407;951.6771687354583;992.8113658405024;1002.3334482569155;1023.6212601337404;27569;27635.30911727223;27686.169414917586;27890.72109278881;27984.44031119407;932.8740620016347;1017.7455636090978;1079.4063265204106;1081.8701755789198;1085.1264731890903;12836.871631283568;13080.738385232242;13404.262765547794;13474.326283685776;13487.325633718276;263226;268639;269501;270405;271259;45376.77311613421;45644.315335269996;46133.30800038002;46203.5379646206;46388;1252.586646406702;1258.2953546014078;1268.2770820632336;1276.1322300835336;1289.1040726694857;24209;25518.768652425835;26141.346466338495;26196.73803261943;26262.34344141412;39797.60202398055;40205.19589608133;40338;40402.191956160124;40421.1915761689;230063;231218;231280;231606;231682;24384;24478.388040299134;24620.75379246256;24895.87552062228;25011.12461063927;39615.603843961195;39886.60113398829;40039;40222.39666405065;40583;32941.50587741234;33351.164616069465;33918.321633566695;34255.657443426244;35091.47362789611;33663.326733465685;34189.82905085558;34246.828765856015;34421.655783442846;34528.309433811686;26558.64143639004;30901.8454907724;31682.366352673278;34403.31193376169;34767.30465390627;27988.44023119567;29031.838726450704;29081.418371632026;29330.120096397142;29380.265493362836;22524.436889077904;22795.658065128704;23635.88182059079;24247;24308.56496861387 03:51:11 INFO - PROCESS | 27232 | |2;jquery.html;375.318796384562;379.80929785123647;390.3753993610223;398.9620986006328;400.8596991053134;14888.702225955474;15526.611834704137;16115.75826362604;16207.108609026498;16301.83698163018;15137.621559461018;15405.306761195745;15883.444079457222;16043.518694439186;16146.192690365493;5037.194048952159;5221.556167725748;5249.86875328116;5249.973750131263;5250.422453530108;3718.3307004739136;5680.573956953224;5974.79088231912;5982;5989.431004054608;5810.477057064863;5906.438888305625;5922.31893332268;5941.257342832146;5948.702564871761;5621.550275977912;5751.511121554673;5770.711464426762;5775.48020678141;5777.220075289824;4982.402111746577;5043.798248070073;5071.112555302807;5082.79668813247;5222.373315202162;18116.63766724658;18354.90822545892;18355.632887342177;19014.239430422767;19750.11124499401;1897.9963389406762;2438.37821355555;2442.059806974328;2450.105711415338;2484.080890070685;8916.866247006301;9005.864912026325;9082.273418126533;9155.746231143292;9320.487373194472;1770.1768677564994;1787.7586525818979;1793.8564914806784;1887.8584106191954;1890.6218756248668;59515.70242148805;62206.0669089964;62350.37649623491;62992.370076299565;63201.683991580205;9836.213102951746;9925.3548519346;9946.104850563484;9975.750606234757;9990.650327238513;13762.724745505035;13871.583852484442;13873;13908.652283692787;13919.652008699864;6921.515493915478;7115.181754098241;7253.492255542062;7355.411567074621;7440.255974402517;6609.1077704510235;6615.305392933673;6714.932850671431;6719.395254427125;6722.394984451325;4335.393044973706;4364.258076127066;4390.582894625006;4429.645628349725;4491.483479399911;1669.595782073834;1767.7613522174343;1849.8150184981394;1858.8419984301215;1870.653929023135;863.9913600864037;881.6605606841413;901.3465237702613;915.8855143107112;984.694744629153;15004;15117.54647360581;15314.234288285541;15522.301496432689;15562.743402206843;909.7907481279343;918.2929144558652;919.6459363145103;933.7338858425317;951.1249650321721;8919.598618062202;9266.907330926604;9314.161725444743;9388.577514011886;9447.102525260088;377826;383403;389936;392225;397362;63114.36885631177;63744.68127659332;63945.68027159834;65919;66238.33761662418;907.2016625369632;909.9636014559476;919.7532709535351;927.355487935878;975.658519518163;13864.237466939416;13876.167429954236;13962;13973.231472269123;14352.856471435569;26855.194344169708;30107.096787096423;30173.396532069673;30397.240068998453;30467.085987420414;43805.56194438142;44420.55579444164;44647.55352446564;44658;44999.550004499535;7651.584456875496;7763.146053934176;7780.88328675059;7786.688532458638;7792.220777922163;7900.130985591695;10506.317089389166;11385.373804440835;11519.942400287944;11573.18987670855;9827.606895724377;10157.9492102539;10346.37921724699;10351.896481035094;10722.463876805972;10057.899421005697;10104.292699511258;10196.031377019171;10325.225608079274;10362.481875906326;10096.394216347042;10204.540795664065;10509.78980420372;10538.841917371092;10789.298695584763;7254.927450725425;7361.926380736124;7401.96299018523;7407.518511296748;7445.329920306982;8908.376413651242;10301.278910476194;10303.484825758533;10390;10437.530311136168 03:51:11 INFO - PROCESS | 27232 | |3;mootools.html;1457.4825936792438;1499.0481044536718;1595.704794612996;1730.2386949742113;1733.6272701369203;6600.603963762178;7243.239459856718;7317.414606831454;7533.585652789101;7567.6594553245095;7098.467614928888;7137.357637812595;7160.892586611192;7178.318059784325;7192.244814294502;2169.902354394052;2217.667349897512;2219.7003404540424;2219.711437513129;2225.376894469551;2148.6884401761736;2163.372621939636;2174.8803815790125;2178.1396348442354;2189.6824960380736;2198.6372248578964;2207.8233741300737;2210.767869373709;2251.7860803223666;2252.042881775247;2130.3928380411508;2151.8493705440624;2152.4726442021647;2153.1495059451586;2155.407263002679;2116.0795054151495;2128.8509804313703;2134.263679030732;2142.4429648291557;2145.324222869791;7686.769396918102;7703.845923081563;7716.459847810655;7717.884231736529;7783.416243781682;4652.930206046912;4839.177339852198;4851.27230915362;4863.8540843774745;4884.535969082932;2966.61434013579;2992.9102126936227;3144.7200779434957;3162.256869635634;3168.778185527014;887.60057973912;968.5786682793008;994.2841154368842;997.0976266478848;999.980000399988;10475.685729428129;10591.470426478645;10595.523201455953;10623.36259824413;10630;4275.123599662062;4339.674524410681;4353.085851971058;4407.515173330931;4444.2222611042935;8954.149355811187;8960.68637597681;8996.100389961082;9001.819963600692;9057.592408341641;4804.615630749532;4816.807327706852;4862.440819305754;4866.31871537985;4867.805287788519;3748.231612519427;4153.169366126786;4326.4159338489535;4381.9123617527475;4416.24923762961;3621;3655.0862284428895;3729.9627003730157;3768.1144930941205;3768.9246215075545;1240.3736113262744;1279.2836011833404;1280.8206851040861;1281.6859869331886;1293.605450337656;776.6194564663388;900.1493588558749;917.5045475443186;931.5098262926739;934.8691183234353;5116.411612664517;5247.580193584504;5314.043472174968;5322.33470816148;5374.677519348852;439.281774299017;445.6746575000268;448.7957979119558;450.1761775950069;453.42415132781184;3649;3739.439084137401;3820.789856557916;3902.590228026073;3918.5885482024546;8579.442336248125;8618.353623478264;8724.389292749447;8765.342599305077;8837.91162088371;8698.739037828875;8713.3464990126;8721.60752766127;8728.56357182151;8736.78158046054;6845.349691779273;7066.505344625827;7120.323569260912;7147.499675022803;7185.784426467214;5347.973260133675;5486.533644640251;5682.318121825242;5731.426857314235;5752.13717942312;8235.341172706288;8263.214994575506;8317.916820831957;8567.74296771098;8623.094575069777;8323.458975166595;8547.145285471403;8605.526696031779;8609.65561377538;8672.78318042054;6003.609765365237;6467.611943283418;6519.08732777402;6605.801825945229;6720.764773232913;7353.411727061715;7423.962880185564;7452.590107544137;7457.6271186441545;7484.952106704956;6641.369069938348;6747.122874026345;6775.93224067753;6786.660666966533;6863.656817159222;6536.3136870627895;6597.868042639025;6621.073049772939;6669.6331701754925;6698.330166983457;6416.807495775134;6485.156929599122;6489.318621544669;6507.869842603216;6524.3149469305035;4555.20283950314;4625.606823420047;4628.120657075145;4667.393238878924;4766.547178018082;4370.934435983399;4512.142692888341;4710.364100846342;4756.548127927841;4763.54746299101 03:51:11 INFO - PROCESS | 27232 | |4;prototype.html;287.8316185031756;301.8928280460437;304.66182537383486;308.52641195764494;310.4706475459341;4790.520947905207;4908.386451693538;4918.96701692645;4987.2346378484235;5017.1220036493605;4930.433000204968;4943.530364615356;4945.233488809231;4973.552380285773;4976.004799040188;3903.438624550174;3918.8628398006076;3936.6063393660693;3936.921261574767;3947.3289540778064;3678.5217921670146;3936.311145549532;3936.8031598420107;3937.606239376054;3939.153082087351;3785.0726571989903;3798.1074447504816;3818.694504439638;3836.156045669962;3861.131245469775;3846.442265871447;3847.1343947611845;3854.3447613905423;3856.1709232514863;3867.2652196082936;3365.2428203654226;3368.34317308125;3373.696367326928;3376.324735052999;3385.80041860442;4651.86044418668;4739.336492890998;4767.475577686451;4795.880102997418;4808.975955120202;4339.934900976488;4350.543192964757;4358.564143585648;4370.562943705636;4399.23013472641;5162.76093737504;5180.4560521145495;5197.818076367347;5206.427292997767;5213.817516386908;3556.7332450066347;3670.743047986642;3674.0998455378603;3674.1365779041903;3681.815909204529;5411.702356370437;5416.945830541684;5421;5474.178873169057;5499.367572729107;3729.9813500932323;3742.73800833939;3746.157114649182;3748.5876553579083;3749.4750734897134;3792.2984247914223;3804.1250512382308;3806.410006449005;3819.040243811013;3830.367989281793;4232.619064284229;4321.308590625485;4328.783560821947;4328.935065974013;4372.956270437318;5137.409197942285;5141.357330333708;5173.327467429285;5178.323390392788;5226.242194881721;1270.434656577814;1301.537954026326;1338.4311667541451;1341.5908148014753;1343.9596812095654;892.6652505310509;908.6823129384709;913.7578541686458;915.6840889892976;926.0924294191595;4578.610818080434;4608.078384323148;4610.170169369546;4615.284630882219;4626.930596041062;5603.7478313475995;5611.551075913917;5628.85927851807;5630.943690563042;5658.801941932095;4227.8097485613225;4623.4451865775645;4623.630109591292;4629.328747331618;4638.605718513897;3078.1996680863135;3083.260017595806;3083.7378822799865;3089.536569514546;3104.130843363862;5520.834374968757;5531.723413829292;5537.418571049981;5547.140193270049;5565.1095824667855;5826.271716035496;5919.4968427684125;5937.139114828412;5941.257342832146;5943.167956486095;5428.511433970962;5444.428335024765;5450.454954504517;5459.535939445192;5488.341399032141;5604.215409842707;5767;5788.13178023283;5797.420257974169;5802.448767367094;5626.662400255997;5650.576206784425;5661.971690141688;5663.7451314690115;5700.059490184073;5446.183072539151;5463.180522921593;5505.6696598204235;5537.584681148849;5547.140193270049;3658.1403370208513;3884.203738233599;3993.5607083221403;4019.4372787809143;4032.8386864526265;5115.309433226466;5282.4717528246865;5337.306150200449;5360.3299587551555;5361.142217245222;5061.6962982221185;5142.537171654569;5185.351831021122;5202.921956170585;5218.4259731430275;5168.9483105168465;5176.61875537257;5182.689038657692;5183.92224116631;5196.506331898464;4895.16782147043;5123.33396658447;5127.897442051063;5135.717535535581;5165.509276618715;5201.141811601044;5243.23973023917;5274.89450210986;5289.603279754111;5302.833376657283;5071.847844564669;5091.058154241329;5110.259012443249;5120.4111527174855;5163.8192663256605 03:51:11 INFO - PROCESS | 27232 | |5;yui.html;642.7878799996001;745.4148493432657;768.7808974442281;773.1920143450094;785.6268272570529;11666.766664666713;12384.690382740437;12515.624531264077;12542.184757990724;12642.873571264285;10388.324758890685;10730.785384292309;10763.35419874808;10764.515596798143;11322.660320190387;805.5166899860067;815.0056930544755;817.0644611919349;821.4332110843499;821.5768879027306;812.7317985064944;813.5403497024192;815.1115284340068;816.7998840284139;817.0562999735315;852.9616167272487;854.8033952191;857.0358346859783;857.4640849469082;858.7252079334615;849.6558893648051;854.2781349759413;854.5214679779343;855.8545047341936;856.751542052804;618.3167599802243;623.8814625221194;625.4121126141413;625.7966160997648;627.3287582286955;11326.490307936081;11342.60300889465;11407.25852819564;11431.371274579895;11466.942665286704;9916.851247231298;9937.801243975153;9968.202543796478;9989.150922171624;10180.643677471253;8985.23625491834;9215.631374745002;9243.722688319362;9439.433633981915;9442.38624489406;3107.254258977852;3154.810711357326;3171.334019855833;3195.72836308914;3267.1015470745497;43525.564744352465;43867;43958.12083758339;44192.779036104934;44773.552264477265;7363.733735322069;7600.885986710093;7626.733064342721;8183.427160098736;8231.218034286732;13728.382222799799;13794.241316727675;13840;13880.652983675287;13886.4445422184;6134.570580059442;6237.5945563539135;6609.702563384659;6767.898481522781;6841.521093523405;3587.892363229107;3739.1026153723456;3748.025513366544;3769.6230376962085;3795.4686343911876;2758.3931535062256;2848.6154369160313;2854.5432730763396;2855.11491437655;2863.8997635083088;501.40082601291107;505.8280184737207;515.5720751776092;516.4293455731363;519.4078750224746;439.0691733524948;521.0256819747098;629.222909706512;632.4624069540854;640.4620119099978;7322.524035937647;7460.701571937062;7566.470347075762;7662.770116896502;7688.500247483896;523.6727045596502;578.6036564952936;580.0255570641278;609.8201030695956;627.5607075047485;3737.2151848111657;3753.4557489163917;3771.5097037385513;3889.9805500972316;3939.4090886366703;51213;51518.742406287725;51565;51657.225141622905;51773.741131294104;46458.767706161256;47482.76258618754;47559.5244047562;48390.27414588784;48920;43086.56913430826;43726.78136609297;44615.77692111519;44943.77528112339;45850.312245316345;7262.9273707262255;7468.925310746823;7608.16310205888;7627.237276272328;7628.8474230516185;29312.706872930998;29337.85331073331;29927.700722992493;29928.551071733506;30297.394052119274;34236.65763342335;38740.80629596834;39097.41353879637;39241.80379098086;39319;9012.729618111467;9078.273738101068;9092.22716069115;9272.768180795534;9439.764005899908;9253.768655783659;9473.715788526355;9475.763105922408;9578.090081442251;9752.073553012453;9165.220956218796;9261.351705380559;9472.384295020802;9540.856887146838;9643.807123857623;9915.801683966425;9941.552630131806;11767.176297659082;11794.52821887115;11846;10531.473426328806;10846.403447810131;10935.83596246041;11192.272502287326;11716.23844450108;9213.355065145375;9355.766105847408;9443.575039123118;9890.208783297463;10264.948675256876;8934.374593778373;9309;9390.765230869283;9397.837108818847;9451.810963780823 03:51:11 INFO - PROCESS | 27232 | __end_tp_report 03:51:11 INFO - PROCESS | 27232 | __start_cc_report 03:51:11 INFO - PROCESS | 27232 | _x_x_mozilla_cycle_collect,380 03:51:11 INFO - PROCESS | 27232 | __end_cc_report 03:51:11 INFO - PROCESS | 27232 | __startTimestamp1461840671161__endTimestamp 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - PROCESS | 27232 | ------- Summary: start ------- 03:51:11 INFO - PROCESS | 27232 | Number of tests: 6 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - PROCESS | 27232 | [#0] dojo.html Cycles:165 Average:4756.75 Median:4906.31 stddev:533.14 (10.9%) stddev-sans-first:508.41 03:51:11 INFO - PROCESS | 27232 | Values: 2646.0 2718.2 2734.8 2748.3 2753.3 4717.3 4822.2 4833.8 4859.3 4906.3 4769.1 4807.0 4835.1 4843.4 4844.9 4445.9 4495.6 4543.5 4558.8 4588.9 4455.2 4563.9 4564.7 4575.7 4580.5 4309.8 4344.4 4426.5 4476.6 4539.3 4423.6 4437.7 4471.4 4483.2 4517.2 4377.0 4421.1 4434.6 4438.9 4464.8 4643.7 4679.3 4706.6 4710.1 4753.9 5125.0 5126.6 5138.8 5140.9 5196.0 5153.2 5184.1 5186.7 5190.2 5198.6 4679.1 4778.8 4824.2 4837.4 4864.1 5300.0 5348.8 5360.5 5373.4 5435.6 4938.0 5155.8 5191.9 5192.9 5209.8 5187.0 5191.8 5205.9 5244.8 5255.4 4972.1 5043.8 5045.2 5047.2 5051.2 5116.3 5129.8 5134.9 5168.7 5229.0 3923.9 3976.8 3983.7 3983.8 4015.1 3576.2 3582.2 3582.4 3589.0 3619.0 4347.2 4353.7 4379.7 4402.2 4411.5 5098.6 5212.0 5241.6 5274.0 5297.3 4329.5 4330.2 4334.0 4366.7 4371.3 4638.4 4659.1 4673.1 4677.5 4717.4 4801.9 4886.9 4909.2 4970.8 4972.8 5156.1 5182.0 5193.1 5195.6 5204.3 4928.1 4935.5 4939.0 4943.0 4955.4 5012.6 5132.2 5136.3 5184.9 5219.3 5176.7 5209.2 5229.8 5243.0 5289.4 4888.8 5036.4 5051.5 5069.8 5081.1 4924.9 4933.3 4957.3 4978.0 5037.4 4894.7 4952.3 4968.7 5010.1 5012.4 5065.9 5069.2 5071.4 5080.1 5133.1 4781.2 4818.1 4873.4 4879.4 4915.7 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - PROCESS | 27232 | [#1] ext.html Cycles:180 Average:37693.31 Median:17726.68 stddev:61169.68 (345.1%) stddev-sans-first:61277.79 03:51:11 INFO - PROCESS | 27232 | Values: 574.7 607.8 616.4 633.2 639.2 32252.2 33108.5 33166.2 33224.3 33230.2 35466.8 36457.0 36483.8 36541.3 36679.4 7505.4 7694.9 7695.6 7698.5 7704.2 7630.2 7715.9 7748.0 7758.1 7779.1 7672.0 7780.2 7794.6 7805.0 7807.1 7618.7 7656.9 7706.5 7707.5 7722.6 7502.7 7654.7 7680.8 7701.2 7703.9 34015.3 34793.3 34852.5 34984.0 35057.1 2962.0 3081.0 3111.8 3392.2 3458.4 27075.9 27338.2 27368.7 27398.6 27456.2 3131.8 3148.3 3157.7 3201.2 3358.6 197299.0 198230.0 198376.0 198727.0 198810.0 29771.0 30555.8 50017.0 50703.2 50740.7 30882.7 30922.7 31079.7 31118.5 31134.4 13215.0 13295.7 13371.5 13400.7 13425.5 10991.3 11016.8 11034.6 11047.3 11111.8 7722.5 7844.6 7970.4 8001.7 8012.7 3078.7 3170.6 3187.1 3228.1 3236.5 937.1 951.7 992.8 1002.3 1023.6 27569.0 27635.3 27686.2 27890.7 27984.4 932.9 1017.7 1079.4 1081.9 1085.1 12836.9 13080.7 13404.3 13474.3 13487.3 263226.0 268639.0 269501.0 270405.0 271259.0 45376.8 45644.3 46133.3 46203.5 46388.0 1252.6 1258.3 1268.3 1276.1 1289.1 24209.0 25518.8 26141.3 26196.7 26262.3 39797.6 40205.2 40338.0 40402.2 40421.2 230063.0 231218.0 231280.0 231606.0 231682.0 24384.0 24478.4 24620.8 24895.9 25011.1 39615.6 39886.6 40039.0 40222.4 40583.0 32941.5 33351.2 33918.3 34255.7 35091.5 33663.3 34189.8 34246.8 34421.7 34528.3 26558.6 30901.8 31682.4 34403.3 34767.3 27988.4 29031.8 29081.4 29330.1 29380.3 22524.4 22795.7 23635.9 24247.0 24308.6 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - PROCESS | 27232 | [#2] jquery.html Cycles:180 Average:23114.91 Median:24574.74 stddev:63647.83 (259.0%) stddev-sans-first:63803.47 03:51:11 INFO - PROCESS | 27232 | Values: 375.3 379.8 390.4 399.0 400.9 14888.7 15526.6 16115.8 16207.1 16301.8 15137.6 15405.3 15883.4 16043.5 16146.2 5037.2 5221.6 5249.9 5250.0 5250.4 3718.3 5680.6 5974.8 5982.0 5989.4 5810.5 5906.4 5922.3 5941.3 5948.7 5621.6 5751.5 5770.7 5775.5 5777.2 4982.4 5043.8 5071.1 5082.8 5222.4 18116.6 18354.9 18355.6 19014.2 19750.1 1898.0 2438.4 2442.1 2450.1 2484.1 8916.9 9005.9 9082.3 9155.7 9320.5 1770.2 1787.8 1793.9 1887.9 1890.6 59515.7 62206.1 62350.4 62992.4 63201.7 9836.2 9925.4 9946.1 9975.8 9990.7 13762.7 13871.6 13873.0 13908.7 13919.7 6921.5 7115.2 7253.5 7355.4 7440.3 6609.1 6615.3 6714.9 6719.4 6722.4 4335.4 4364.3 4390.6 4429.6 4491.5 1669.6 1767.8 1849.8 1858.8 1870.7 864.0 881.7 901.3 915.9 984.7 15004.0 15117.5 15314.2 15522.3 15562.7 909.8 918.3 919.6 933.7 951.1 8919.6 9266.9 9314.2 9388.6 9447.1 377826.0 383403.0 389936.0 392225.0 397362.0 63114.4 63744.7 63945.7 65919.0 66238.3 907.2 910.0 919.8 927.4 975.7 13864.2 13876.2 13962.0 13973.2 14352.9 26855.2 30107.1 30173.4 30397.2 30467.1 43805.6 44420.6 44647.6 44658.0 44999.6 7651.6 7763.1 7780.9 7786.7 7792.2 7900.1 10506.3 11385.4 11519.9 11573.2 9827.6 10157.9 10346.4 10351.9 10722.5 10057.9 10104.3 10196.0 10325.2 10362.5 10096.4 10204.5 10509.8 10538.8 10789.3 7254.9 7361.9 7402.0 7407.5 7445.3 8908.4 10301.3 10303.5 10390.0 10437.5 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - PROCESS | 27232 | [#3] mootools.html Cycles:180 Average:5055.02 Median:5182.00 stddev:2717.03 (52.4%) stddev-sans-first:2711.20 03:51:11 INFO - PROCESS | 27232 | Values: 1457.5 1499.0 1595.7 1730.2 1733.6 6600.6 7243.2 7317.4 7533.6 7567.7 7098.5 7137.4 7160.9 7178.3 7192.2 2169.9 2217.7 2219.7 2219.7 2225.4 2148.7 2163.4 2174.9 2178.1 2189.7 2198.6 2207.8 2210.8 2251.8 2252.0 2130.4 2151.8 2152.5 2153.1 2155.4 2116.1 2128.9 2134.3 2142.4 2145.3 7686.8 7703.8 7716.5 7717.9 7783.4 4652.9 4839.2 4851.3 4863.9 4884.5 2966.6 2992.9 3144.7 3162.3 3168.8 887.6 968.6 994.3 997.1 1000.0 10475.7 10591.5 10595.5 10623.4 10630.0 4275.1 4339.7 4353.1 4407.5 4444.2 8954.1 8960.7 8996.1 9001.8 9057.6 4804.6 4816.8 4862.4 4866.3 4867.8 3748.2 4153.2 4326.4 4381.9 4416.2 3621.0 3655.1 3730.0 3768.1 3768.9 1240.4 1279.3 1280.8 1281.7 1293.6 776.6 900.1 917.5 931.5 934.9 5116.4 5247.6 5314.0 5322.3 5374.7 439.3 445.7 448.8 450.2 453.4 3649.0 3739.4 3820.8 3902.6 3918.6 8579.4 8618.4 8724.4 8765.3 8837.9 8698.7 8713.3 8721.6 8728.6 8736.8 6845.3 7066.5 7120.3 7147.5 7185.8 5348.0 5486.5 5682.3 5731.4 5752.1 8235.3 8263.2 8317.9 8567.7 8623.1 8323.5 8547.1 8605.5 8609.7 8672.8 6003.6 6467.6 6519.1 6605.8 6720.8 7353.4 7424.0 7452.6 7457.6 7485.0 6641.4 6747.1 6775.9 6786.7 6863.7 6536.3 6597.9 6621.1 6669.6 6698.3 6416.8 6485.2 6489.3 6507.9 6524.3 4555.2 4625.6 4628.1 4667.4 4766.5 4370.9 4512.1 4710.4 4756.5 4763.5 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - PROCESS | 27232 | [#4] prototype.html Cycles:180 Average:4400.79 Median:4944.38 stddev:1312.46 (26.5%) stddev-sans-first:1279.32 03:51:11 INFO - PROCESS | 27232 | Values: 287.8 301.9 304.7 308.5 310.5 4790.5 4908.4 4919.0 4987.2 5017.1 4930.4 4943.5 4945.2 4973.6 4976.0 3903.4 3918.9 3936.6 3936.9 3947.3 3678.5 3936.3 3936.8 3937.6 3939.2 3785.1 3798.1 3818.7 3836.2 3861.1 3846.4 3847.1 3854.3 3856.2 3867.3 3365.2 3368.3 3373.7 3376.3 3385.8 4651.9 4739.3 4767.5 4795.9 4809.0 4339.9 4350.5 4358.6 4370.6 4399.2 5162.8 5180.5 5197.8 5206.4 5213.8 3556.7 3670.7 3674.1 3674.1 3681.8 5411.7 5416.9 5421.0 5474.2 5499.4 3730.0 3742.7 3746.2 3748.6 3749.5 3792.3 3804.1 3806.4 3819.0 3830.4 4232.6 4321.3 4328.8 4328.9 4373.0 5137.4 5141.4 5173.3 5178.3 5226.2 1270.4 1301.5 1338.4 1341.6 1344.0 892.7 908.7 913.8 915.7 926.1 4578.6 4608.1 4610.2 4615.3 4626.9 5603.7 5611.6 5628.9 5630.9 5658.8 4227.8 4623.4 4623.6 4629.3 4638.6 3078.2 3083.3 3083.7 3089.5 3104.1 5520.8 5531.7 5537.4 5547.1 5565.1 5826.3 5919.5 5937.1 5941.3 5943.2 5428.5 5444.4 5450.5 5459.5 5488.3 5604.2 5767.0 5788.1 5797.4 5802.4 5626.7 5650.6 5662.0 5663.7 5700.1 5446.2 5463.2 5505.7 5537.6 5547.1 3658.1 3884.2 3993.6 4019.4 4032.8 5115.3 5282.5 5337.3 5360.3 5361.1 5061.7 5142.5 5185.4 5202.9 5218.4 5168.9 5176.6 5182.7 5183.9 5196.5 4895.2 5123.3 5127.9 5135.7 5165.5 5201.1 5243.2 5274.9 5289.6 5302.8 5071.8 5091.1 5110.3 5120.4 5163.8 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - PROCESS | 27232 | [#5] yui.html Cycles:180 Average:12271.69 Median:3372.20 stddev:14484.88 (429.5%) stddev-sans-first:14499.19 03:51:11 INFO - PROCESS | 27232 | Values: 642.8 745.4 768.8 773.2 785.6 11666.8 12384.7 12515.6 12542.2 12642.9 10388.3 10730.8 10763.4 10764.5 11322.7 805.5 815.0 817.1 821.4 821.6 812.7 813.5 815.1 816.8 817.1 853.0 854.8 857.0 857.5 858.7 849.7 854.3 854.5 855.9 856.8 618.3 623.9 625.4 625.8 627.3 11326.5 11342.6 11407.3 11431.4 11466.9 9916.9 9937.8 9968.2 9989.2 10180.6 8985.2 9215.6 9243.7 9439.4 9442.4 3107.3 3154.8 3171.3 3195.7 3267.1 43525.6 43867.0 43958.1 44192.8 44773.6 7363.7 7600.9 7626.7 8183.4 8231.2 13728.4 13794.2 13840.0 13880.7 13886.4 6134.6 6237.6 6609.7 6767.9 6841.5 3587.9 3739.1 3748.0 3769.6 3795.5 2758.4 2848.6 2854.5 2855.1 2863.9 501.4 505.8 515.6 516.4 519.4 439.1 521.0 629.2 632.5 640.5 7322.5 7460.7 7566.5 7662.8 7688.5 523.7 578.6 580.0 609.8 627.6 3737.2 3753.5 3771.5 3890.0 3939.4 51213.0 51518.7 51565.0 51657.2 51773.7 46458.8 47482.8 47559.5 48390.3 48920.0 43086.6 43726.8 44615.8 44943.8 45850.3 7262.9 7468.9 7608.2 7627.2 7628.8 29312.7 29337.9 29927.7 29928.6 30297.4 34236.7 38740.8 39097.4 39241.8 39319.0 9012.7 9078.3 9092.2 9272.8 9439.8 9253.8 9473.7 9475.8 9578.1 9752.1 9165.2 9261.4 9472.4 9540.9 9643.8 9915.8 9941.6 11767.2 11794.5 11846.0 10531.5 10846.4 10935.8 11192.3 11716.2 9213.4 9355.8 9443.6 9890.2 10264.9 8934.4 9309.0 9390.8 9397.8 9451.8 03:51:11 INFO - PROCESS | 27232 | -------- Summary: end -------- 03:51:11 INFO - PROCESS | 27232 | 03:51:11 INFO - TEST-INFO | 27232: exit 0 03:51:11 INFO - TEST-OK | dromaeo_css | took 1114885ms 03:51:11 INFO - TEST-START | kraken 03:51:11 INFO - operating with platform_type : linux_ 03:51:11 INFO - Initialising browser for kraken test... 03:51:11 INFO - TEST-INFO | started process 27461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_wcgc/profile http://localhost:42595/getInfo.html) 03:51:15 INFO - PROCESS | 27461 | 03:51:15 INFO - PROCESS | 27461 | (process:27533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:16 INFO - PROCESS | 27461 | __metrics Screen width/height:1600/1200 03:51:16 INFO - PROCESS | 27461 | colorDepth:24 03:51:16 INFO - PROCESS | 27461 | Browser inner width/height: 1024/697 03:51:16 INFO - PROCESS | 27461 | __metrics 03:51:16 ERROR - PROCESS | 27461 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:51:17 INFO - TEST-INFO | 27461: exit 0 03:51:17 INFO - Browser initialized. 03:51:17 INFO - Running cycle 1/1 for kraken test... 03:51:17 INFO - TEST-INFO | started process 27584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_wcgc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:19 INFO - PROCESS | 27584 | 03:51:19 INFO - PROCESS | 27584 | (process:27646): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:29 INFO - PROCESS | 27584 | RSS: Main: 165519360 03:51:29 INFO - PROCESS | 27584 | 03:51:32 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42595/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:33 INFO - PROCESS | 27584 | RSS: Main: 170254336 03:51:33 INFO - PROCESS | 27584 | 03:51:36 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42595/tests/kraken/driver.html?testName=audio-dft) 03:51:36 INFO - PROCESS | 27584 | RSS: Main: 173662208 03:51:36 INFO - PROCESS | 27584 | 03:51:39 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42595/tests/kraken/driver.html?testName=audio-fft) 03:51:40 INFO - PROCESS | 27584 | RSS: Main: 166322176 03:51:40 INFO - PROCESS | 27584 | 03:51:42 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42595/tests/kraken/driver.html?testName=audio-oscillator) 03:51:43 INFO - PROCESS | 27584 | RSS: Main: 166871040 03:51:43 INFO - PROCESS | 27584 | 03:51:45 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:46 INFO - PROCESS | 27584 | RSS: Main: 167096320 03:51:46 INFO - PROCESS | 27584 | 03:51:49 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42595/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:49 INFO - PROCESS | 27584 | RSS: Main: 167428096 03:51:49 INFO - PROCESS | 27584 | 03:51:53 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42595/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:54 INFO - PROCESS | 27584 | RSS: Main: 164720640 03:51:54 INFO - PROCESS | 27584 | 03:51:57 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42595/tests/kraken/driver.html?testName=json-parse-financial) 03:51:57 INFO - PROCESS | 27584 | RSS: Main: 165273600 03:51:57 INFO - PROCESS | 27584 | 03:51:59 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:00 INFO - PROCESS | 27584 | RSS: Main: 165842944 03:52:00 INFO - PROCESS | 27584 | 03:52:01 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42595/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:02 INFO - PROCESS | 27584 | RSS: Main: 165703680 03:52:02 INFO - PROCESS | 27584 | 03:52:04 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:05 INFO - PROCESS | 27584 | RSS: Main: 166215680 03:52:05 INFO - PROCESS | 27584 | 03:52:08 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:08 INFO - PROCESS | 27584 | RSS: Main: 166477824 03:52:08 INFO - PROCESS | 27584 | 03:52:12 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:12 INFO - PROCESS | 27584 | RSS: Main: 165912576 03:52:12 INFO - PROCESS | 27584 | 03:52:14 INFO - PROCESS | 27584 | Cycle 1(1): loaded http://localhost:42595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42595/tests/kraken/driver.html?testName=ai-astar) 03:52:15 INFO - PROCESS | 27584 | RSS: Main: 167694336 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | __start_tp_report 03:52:15 INFO - PROCESS | 27584 | _x_x_mozilla_page_load 03:52:15 INFO - PROCESS | 27584 | _x_x_mozilla_page_load_details 03:52:15 INFO - PROCESS | 27584 | |i|pagename|runs| 03:52:15 INFO - PROCESS | 27584 | |0;ai-astar;115;107;114;112;114;123;114;113;113;114 03:52:15 INFO - PROCESS | 27584 | |1;audio-beat-detection;158;137;162;189;134;167;159;139;191;135 03:52:15 INFO - PROCESS | 27584 | |2;audio-dft;163;164;165;176;163;163;163;163;166;162 03:52:15 INFO - PROCESS | 27584 | |3;audio-fft;74;74;75;161;75;75;74;78;162;76 03:52:15 INFO - PROCESS | 27584 | |4;audio-oscillator;95;96;155;95;95;94;154;96;95;150 03:52:15 INFO - PROCESS | 27584 | |5;imaging-gaussian-blur;118;118;117;118;118;117;117;118;118;118 03:52:15 INFO - PROCESS | 27584 | |6;imaging-darkroom;147;147;148;149;148;148;148;148;147;147 03:52:15 INFO - PROCESS | 27584 | |7;imaging-desaturate;95;96;95;95;95;96;95;96;97;96 03:52:15 INFO - PROCESS | 27584 | |8;json-parse-financial;65;67;65;65;66;66;65;85;64;69 03:52:15 INFO - PROCESS | 27584 | |9;json-stringify-tinderbox;65;65;65;64;64;64;65;64;65;65 03:52:15 INFO - PROCESS | 27584 | |10;stanford-crypto-aes;79;79;82;81;83;81;81;81;82;82 03:52:15 INFO - PROCESS | 27584 | |11;stanford-crypto-ccm;140;135;139;138;134;138;159;136;176;142 03:52:15 INFO - PROCESS | 27584 | |12;stanford-crypto-pbkdf2;221;219;218;220;219;220;218;219;216;220 03:52:15 INFO - PROCESS | 27584 | |13;stanford-crypto-sha256-iterative;88;76;76;76;79;77;73;75;74;74 03:52:15 INFO - PROCESS | 27584 | __end_tp_report 03:52:15 INFO - PROCESS | 27584 | __start_cc_report 03:52:15 INFO - PROCESS | 27584 | _x_x_mozilla_cycle_collect,939 03:52:15 INFO - PROCESS | 27584 | __end_cc_report 03:52:15 INFO - PROCESS | 27584 | __startTimestamp1461840735095__endTimestamp 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | ------- Summary: start ------- 03:52:15 INFO - PROCESS | 27584 | Number of tests: 14 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:3.90 (3.4%) stddev-sans-first:4.12 03:52:15 INFO - PROCESS | 27584 | Values: 115.0 107.0 114.0 112.0 114.0 123.0 114.0 113.0 113.0 114.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:160.50 stddev:21.21 (13.2%) stddev-sans-first:22.49 03:52:15 INFO - PROCESS | 27584 | Values: 158.0 137.0 162.0 189.0 134.0 167.0 159.0 139.0 191.0 135.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.10 (2.5%) stddev-sans-first:4.30 03:52:15 INFO - PROCESS | 27584 | Values: 163.0 164.0 165.0 176.0 163.0 163.0 163.0 163.0 166.0 162.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:36.44 (48.6%) stddev-sans-first:38.04 03:52:15 INFO - PROCESS | 27584 | Values: 74.0 74.0 75.0 161.0 75.0 75.0 74.0 78.0 162.0 76.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:95.00 stddev:27.98 (29.5%) stddev-sans-first:28.95 03:52:15 INFO - PROCESS | 27584 | Values: 95.0 96.0 155.0 95.0 95.0 94.0 154.0 96.0 95.0 150.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:52:15 INFO - PROCESS | 27584 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 03:52:15 INFO - PROCESS | 27584 | Values: 147.0 147.0 148.0 149.0 148.0 148.0 148.0 148.0 147.0 147.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 03:52:15 INFO - PROCESS | 27584 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 97.0 96.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:66.00 stddev:6.24 (9.4%) stddev-sans-first:6.54 03:52:15 INFO - PROCESS | 27584 | Values: 65.0 67.0 65.0 65.0 66.0 66.0 65.0 85.0 64.0 69.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 03:52:15 INFO - PROCESS | 27584 | Values: 65.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.50 stddev:1.29 (1.6%) stddev-sans-first:1.12 03:52:15 INFO - PROCESS | 27584 | Values: 79.0 79.0 82.0 81.0 83.0 81.0 81.0 81.0 82.0 82.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:139.50 stddev:13.38 (9.6%) stddev-sans-first:14.12 03:52:15 INFO - PROCESS | 27584 | Values: 140.0 135.0 139.0 138.0 134.0 138.0 159.0 136.0 176.0 142.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:219.00 Median:219.50 stddev:1.41 (0.6%) stddev-sans-first:1.30 03:52:15 INFO - PROCESS | 27584 | Values: 221.0 219.0 218.0 220.0 219.0 220.0 218.0 219.0 216.0 220.0 03:52:15 INFO - PROCESS | 27584 | 03:52:15 INFO - PROCESS | 27584 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:76.00 stddev:4.29 (5.6%) stddev-sans-first:1.81 03:52:15 INFO - PROCESS | 27584 | Values: 88.0 76.0 76.0 76.0 79.0 77.0 73.0 75.0 74.0 74.0 03:52:15 INFO - PROCESS | 27584 | -------- Summary: end -------- 03:52:15 INFO - PROCESS | 27584 | 03:52:16 INFO - TEST-INFO | 27584: exit 0 03:52:16 INFO - TEST-OK | kraken | took 64172ms 03:52:16 INFO - SUITE-END | took 1179s 03:52:16 INFO - Completed test suite (00:19:39) 03:52:16 INFO - javascript benchmark 03:52:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.0474229277456, 2718.2117186016058, 2734.835909845408, 2748.299183708154, 2753.297909033195, 4717.29240613908, 4822.156122678531, 4833.806647734091, 4859.3439885615435, 4906.31311616374, 4769.141554520185, 4806.975965120169, 4835.081334546434, 4843.370361852954, 4844.927326090103, 4445.911081778362, 4495.640348772106, 4543.522930092342, 4558.794854231567, 4588.931166032512, 4455.153520831048, 4563.949579413412, 4564.703294285878, 4575.748333841638, 4580.541945805426, 4309.849155279581, 4344.413504176927, 4426.468823741139, 4476.61948734358, 4539.251023581105, 4423.579759922803, 4437.711548749321, 4471.35165401015, 4483.170613436525, 4517.232070548015, 4377.0, 4421.07157496926, 4434.645228381722, 4438.933415998763, 4464.799084041226, 4643.674942754009, 4679.344891715163, 4706.647001474869, 4710.105080034817, 4753.928691069636, 5124.974375128138, 5126.5642420394315, 5138.794448222066, 5140.897182056338, 5196.0, 5153.2270159476, 5184.066867963765, 5186.740662966837, 5190.2214667800135, 5198.610104242197, 4679.064187162581, 4778.761061946889, 4824.179889418807, 4837.395325584302, 4864.100141473838, 5300.0, 5348.786048558092, 5360.463953604608, 5373.35519737634, 5435.565154787608, 4938.0, 5155.7679904404395, 5191.9480805192225, 5192.948070519322, 5209.7916083356995, 5187.014467251211, 5191.844244672666, 5205.869853253699, 5244.816431424958, 5255.39562950258, 4972.080165169383, 5043.773030213649, 5045.2432135180015, 5047.2429135629945, 5051.217061355495, 5116.309298244763, 5129.794808207705, 5134.897302053938, 5168.715720635326, 5229.032628963654, 3923.862664806718, 3976.8210430530694, 3983.6813054956115, 3983.7609743415487, 4015.1367455996515, 3576.213233088716, 3582.229820588586, 3582.426811710166, 3588.982055089708, 3618.9638103619154, 4347.152305300499, 4353.651707863363, 4379.737215767064, 4402.207602631557, 4411.514733379326, 5098.566621837185, 5212.035773381936, 5241.633085683966, 5274.0, 5297.311349524537, 4329.502107257643, 4330.17726631939, 4333.978330108329, 4366.716163449366, 4371.300591905344, 4638.373819534319, 4659.138059459011, 4673.135469938073, 4677.46209185948, 4717.43390793107, 4801.9039619208115, 4886.926696099561, 4909.214525675875, 4970.776315065903, 4972.801087956586, 5156.071907056766, 5181.974090129676, 5193.0652482553505, 5195.610329225247, 5204.2714020036465, 4928.137575924127, 4935.481774413778, 4938.975305123451, 4943.0, 4955.430125535466, 5012.598992080552, 5132.230165475208, 5136.30659860914, 5184.896302074013, 5219.2953951216095, 5176.7152806596, 5209.244659524272, 5229.816956406507, 5243.0, 5289.41816400188, 4888.804447822189, 5036.395632524121, 5051.520105589963, 5069.7718602662235, 5081.11080560893, 4924.852254432372, 4933.333999909966, 4957.330760347307, 4978.0, 5037.420696619789, 4894.657373983787, 4952.331435256195, 4968.726720030433, 5010.123228435083, 5012.373453318335, 5065.949340506548, 5069.1635880079375, 5071.39143302806, 5080.110980578458, 5133.101707201299, 4781.211100168433, 4818.132736107535, 4873.366462359871, 4879.39007624047, 4915.65590408668], "value": 4720.991316001417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6638216643263, 607.8449995251214, 616.3774587666456, 633.1958412815723, 639.2456900856993, 32252.19369515763, 33108.503372449406, 33166.1708457289, 33224.33551328972, 33230.16924576887, 35466.82266588663, 36457.0, 36483.817580912124, 36541.26917461649, 36679.449808252895, 7505.362044226247, 7694.884576731325, 7695.615219239044, 7698.461107722462, 7704.19105993871, 7630.160682324939, 7715.922840771605, 7747.9612601936915, 7758.069031716173, 7779.105402878685, 7671.961640191791, 7780.221977802231, 7794.64924078415, 7804.960975195145, 7807.102183248914, 7618.657160427794, 7656.923430765704, 7706.537607743525, 7707.460477766558, 7722.57525836076, 7502.6623801929045, 7654.693812247503, 7680.807979800494, 7701.22987701231, 7703.922960770433, 34015.31969360599, 34793.30413391718, 34852.477212841826, 34984.0, 35057.12357191065, 2962.0, 3080.9537856932166, 3111.7510599152015, 3392.2028323343993, 3458.360203362386, 27075.864620676966, 27338.179854604394, 27368.726312737017, 27398.5890211647, 27456.176314710592, 3131.840377167859, 3148.3073723780963, 3157.747380209578, 3201.167696398953, 3358.580177477815, 197299.0, 198230.0, 198376.0081199599, 198727.0, 198810.0, 29771.0, 30555.847220763753, 50017.0, 50703.239451408255, 50740.74629626902, 30882.69117308843, 30922.690773092432, 31079.689203108133, 31118.53322200169, 31134.37731245408, 13215.0, 13295.66760830987, 13371.465141394236, 13400.731985360238, 13425.530106446227, 10991.285566438315, 11016.779664406668, 11034.558617655204, 11047.337159770439, 11111.83332250017, 7722.498037627536, 7844.64699088531, 7970.402219833536, 8001.679932802623, 8012.679492820338, 3078.676738942379, 3170.61952565689, 3187.0916788715567, 3228.1284053305476, 3236.482162853979, 937.128470522407, 951.6771687354583, 992.8113658405024, 1002.3334482569155, 1023.6212601337404, 27569.0, 27635.30911727223, 27686.169414917586, 27890.72109278881, 27984.44031119407, 932.8740620016347, 1017.7455636090978, 1079.4063265204106, 1081.8701755789198, 1085.1264731890903, 12836.871631283568, 13080.738385232242, 13404.262765547794, 13474.326283685776, 13487.325633718276, 263226.0, 268639.0, 269501.0, 270405.0, 271259.0, 45376.77311613421, 45644.315335269996, 46133.30800038002, 46203.5379646206, 46388.0, 1252.586646406702, 1258.2953546014078, 1268.2770820632336, 1276.1322300835336, 1289.1040726694857, 24209.0, 25518.768652425835, 26141.346466338495, 26196.73803261943, 26262.34344141412, 39797.60202398055, 40205.19589608133, 40338.0, 40402.191956160124, 40421.1915761689, 230063.0, 231218.0, 231280.0, 231606.0, 231682.0, 24384.0, 24478.388040299134, 24620.75379246256, 24895.87552062228, 25011.12461063927, 39615.603843961195, 39886.60113398829, 40039.0, 40222.39666405065, 40583.0, 32941.50587741234, 33351.164616069465, 33918.321633566695, 34255.657443426244, 35091.47362789611, 33663.326733465685, 34189.82905085558, 34246.828765856015, 34421.655783442846, 34528.309433811686, 26558.64143639004, 30901.8454907724, 31682.366352673278, 34403.31193376169, 34767.30465390627, 27988.44023119567, 29031.838726450704, 29081.418371632026, 29330.120096397142, 29380.265493362836, 22524.436889077904, 22795.658065128704, 23635.88182059079, 24247.0, 24308.56496861387], "value": 15462.098602857392, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.318796384562, 379.80929785123647, 390.3753993610223, 398.9620986006328, 400.8596991053134, 14888.702225955474, 15526.611834704137, 16115.75826362604, 16207.108609026498, 16301.83698163018, 15137.621559461018, 15405.306761195745, 15883.444079457222, 16043.518694439186, 16146.192690365493, 5037.194048952159, 5221.556167725748, 5249.86875328116, 5249.973750131263, 5250.422453530108, 3718.3307004739136, 5680.573956953224, 5974.79088231912, 5982.0, 5989.431004054608, 5810.477057064863, 5906.438888305625, 5922.31893332268, 5941.257342832146, 5948.702564871761, 5621.550275977912, 5751.511121554673, 5770.711464426762, 5775.48020678141, 5777.220075289824, 4982.402111746577, 5043.798248070073, 5071.112555302807, 5082.79668813247, 5222.373315202162, 18116.63766724658, 18354.90822545892, 18355.632887342177, 19014.239430422767, 19750.11124499401, 1897.9963389406762, 2438.37821355555, 2442.059806974328, 2450.105711415338, 2484.080890070685, 8916.866247006301, 9005.864912026325, 9082.273418126533, 9155.746231143292, 9320.487373194472, 1770.1768677564994, 1787.7586525818979, 1793.8564914806784, 1887.8584106191954, 1890.6218756248668, 59515.70242148805, 62206.0669089964, 62350.37649623491, 62992.370076299565, 63201.683991580205, 9836.213102951746, 9925.3548519346, 9946.104850563484, 9975.750606234757, 9990.650327238513, 13762.724745505035, 13871.583852484442, 13873.0, 13908.652283692787, 13919.652008699864, 6921.515493915478, 7115.181754098241, 7253.492255542062, 7355.411567074621, 7440.255974402517, 6609.1077704510235, 6615.305392933673, 6714.932850671431, 6719.395254427125, 6722.394984451325, 4335.393044973706, 4364.258076127066, 4390.582894625006, 4429.645628349725, 4491.483479399911, 1669.595782073834, 1767.7613522174343, 1849.8150184981394, 1858.8419984301215, 1870.653929023135, 863.9913600864037, 881.6605606841413, 901.3465237702613, 915.8855143107112, 984.694744629153, 15004.0, 15117.54647360581, 15314.234288285541, 15522.301496432689, 15562.743402206843, 909.7907481279343, 918.2929144558652, 919.6459363145103, 933.7338858425317, 951.1249650321721, 8919.598618062202, 9266.907330926604, 9314.161725444743, 9388.577514011886, 9447.102525260088, 377826.0, 383403.0, 389936.0, 392225.0, 397362.0, 63114.36885631177, 63744.68127659332, 63945.68027159834, 65919.0, 66238.33761662418, 907.2016625369632, 909.9636014559476, 919.7532709535351, 927.355487935878, 975.658519518163, 13864.237466939416, 13876.167429954236, 13962.0, 13973.231472269123, 14352.856471435569, 26855.194344169708, 30107.096787096423, 30173.396532069673, 30397.240068998453, 30467.085987420414, 43805.56194438142, 44420.55579444164, 44647.55352446564, 44658.0, 44999.550004499535, 7651.584456875496, 7763.146053934176, 7780.88328675059, 7786.688532458638, 7792.220777922163, 7900.130985591695, 10506.317089389166, 11385.373804440835, 11519.942400287944, 11573.18987670855, 9827.606895724377, 10157.9492102539, 10346.37921724699, 10351.896481035094, 10722.463876805972, 10057.899421005697, 10104.292699511258, 10196.031377019171, 10325.225608079274, 10362.481875906326, 10096.394216347042, 10204.540795664065, 10509.78980420372, 10538.841917371092, 10789.298695584763, 7254.927450725425, 7361.926380736124, 7401.96299018523, 7407.518511296748, 7445.329920306982, 8908.376413651242, 10301.278910476194, 10303.484825758533, 10390.0, 10437.530311136168], "value": 8039.880658883357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.4825936792438, 1499.0481044536718, 1595.704794612996, 1730.2386949742113, 1733.6272701369203, 6600.603963762178, 7243.239459856718, 7317.414606831454, 7533.585652789101, 7567.6594553245095, 7098.467614928888, 7137.357637812595, 7160.892586611192, 7178.318059784325, 7192.244814294502, 2169.902354394052, 2217.667349897512, 2219.7003404540424, 2219.711437513129, 2225.376894469551, 2148.6884401761736, 2163.372621939636, 2174.8803815790125, 2178.1396348442354, 2189.6824960380736, 2198.6372248578964, 2207.8233741300737, 2210.767869373709, 2251.7860803223666, 2252.042881775247, 2130.3928380411508, 2151.8493705440624, 2152.4726442021647, 2153.1495059451586, 2155.407263002679, 2116.0795054151495, 2128.8509804313703, 2134.263679030732, 2142.4429648291557, 2145.324222869791, 7686.769396918102, 7703.845923081563, 7716.459847810655, 7717.884231736529, 7783.416243781682, 4652.930206046912, 4839.177339852198, 4851.27230915362, 4863.8540843774745, 4884.535969082932, 2966.61434013579, 2992.9102126936227, 3144.7200779434957, 3162.256869635634, 3168.778185527014, 887.60057973912, 968.5786682793008, 994.2841154368842, 997.0976266478848, 999.980000399988, 10475.685729428129, 10591.470426478645, 10595.523201455953, 10623.36259824413, 10630.0, 4275.123599662062, 4339.674524410681, 4353.085851971058, 4407.515173330931, 4444.2222611042935, 8954.149355811187, 8960.68637597681, 8996.100389961082, 9001.819963600692, 9057.592408341641, 4804.615630749532, 4816.807327706852, 4862.440819305754, 4866.31871537985, 4867.805287788519, 3748.231612519427, 4153.169366126786, 4326.4159338489535, 4381.9123617527475, 4416.24923762961, 3621.0, 3655.0862284428895, 3729.9627003730157, 3768.1144930941205, 3768.9246215075545, 1240.3736113262744, 1279.2836011833404, 1280.8206851040861, 1281.6859869331886, 1293.605450337656, 776.6194564663388, 900.1493588558749, 917.5045475443186, 931.5098262926739, 934.8691183234353, 5116.411612664517, 5247.580193584504, 5314.043472174968, 5322.33470816148, 5374.677519348852, 439.281774299017, 445.6746575000268, 448.7957979119558, 450.1761775950069, 453.42415132781184, 3649.0, 3739.439084137401, 3820.789856557916, 3902.590228026073, 3918.5885482024546, 8579.442336248125, 8618.353623478264, 8724.389292749447, 8765.342599305077, 8837.91162088371, 8698.739037828875, 8713.3464990126, 8721.60752766127, 8728.56357182151, 8736.78158046054, 6845.349691779273, 7066.505344625827, 7120.323569260912, 7147.499675022803, 7185.784426467214, 5347.973260133675, 5486.533644640251, 5682.318121825242, 5731.426857314235, 5752.13717942312, 8235.341172706288, 8263.214994575506, 8317.916820831957, 8567.74296771098, 8623.094575069777, 8323.458975166595, 8547.145285471403, 8605.526696031779, 8609.65561377538, 8672.78318042054, 6003.609765365237, 6467.611943283418, 6519.08732777402, 6605.801825945229, 6720.764773232913, 7353.411727061715, 7423.962880185564, 7452.590107544137, 7457.6271186441545, 7484.952106704956, 6641.369069938348, 6747.122874026345, 6775.93224067753, 6786.660666966533, 6863.656817159222, 6536.3136870627895, 6597.868042639025, 6621.073049772939, 6669.6331701754925, 6698.330166983457, 6416.807495775134, 6485.156929599122, 6489.318621544669, 6507.869842603216, 6524.3149469305035, 4555.20283950314, 4625.606823420047, 4628.120657075145, 4667.393238878924, 4766.547178018082, 4370.934435983399, 4512.142692888341, 4710.364100846342, 4756.548127927841, 4763.54746299101], "value": 4077.8605390428447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.8316185031756, 301.8928280460437, 304.66182537383486, 308.52641195764494, 310.4706475459341, 4790.520947905207, 4908.386451693538, 4918.96701692645, 4987.2346378484235, 5017.1220036493605, 4930.433000204968, 4943.530364615356, 4945.233488809231, 4973.552380285773, 4976.004799040188, 3903.438624550174, 3918.8628398006076, 3936.6063393660693, 3936.921261574767, 3947.3289540778064, 3678.5217921670146, 3936.311145549532, 3936.8031598420107, 3937.606239376054, 3939.153082087351, 3785.0726571989903, 3798.1074447504816, 3818.694504439638, 3836.156045669962, 3861.131245469775, 3846.442265871447, 3847.1343947611845, 3854.3447613905423, 3856.1709232514863, 3867.2652196082936, 3365.2428203654226, 3368.34317308125, 3373.696367326928, 3376.324735052999, 3385.80041860442, 4651.86044418668, 4739.336492890998, 4767.475577686451, 4795.880102997418, 4808.975955120202, 4339.934900976488, 4350.543192964757, 4358.564143585648, 4370.562943705636, 4399.23013472641, 5162.76093737504, 5180.4560521145495, 5197.818076367347, 5206.427292997767, 5213.817516386908, 3556.7332450066347, 3670.743047986642, 3674.0998455378603, 3674.1365779041903, 3681.815909204529, 5411.702356370437, 5416.945830541684, 5421.0, 5474.178873169057, 5499.367572729107, 3729.9813500932323, 3742.73800833939, 3746.157114649182, 3748.5876553579083, 3749.4750734897134, 3792.2984247914223, 3804.1250512382308, 3806.410006449005, 3819.040243811013, 3830.367989281793, 4232.619064284229, 4321.308590625485, 4328.783560821947, 4328.935065974013, 4372.956270437318, 5137.409197942285, 5141.357330333708, 5173.327467429285, 5178.323390392788, 5226.242194881721, 1270.434656577814, 1301.537954026326, 1338.4311667541451, 1341.5908148014753, 1343.9596812095654, 892.6652505310509, 908.6823129384709, 913.7578541686458, 915.6840889892976, 926.0924294191595, 4578.610818080434, 4608.078384323148, 4610.170169369546, 4615.284630882219, 4626.930596041062, 5603.7478313475995, 5611.551075913917, 5628.85927851807, 5630.943690563042, 5658.801941932095, 4227.8097485613225, 4623.4451865775645, 4623.630109591292, 4629.328747331618, 4638.605718513897, 3078.1996680863135, 3083.260017595806, 3083.7378822799865, 3089.536569514546, 3104.130843363862, 5520.834374968757, 5531.723413829292, 5537.418571049981, 5547.140193270049, 5565.1095824667855, 5826.271716035496, 5919.4968427684125, 5937.139114828412, 5941.257342832146, 5943.167956486095, 5428.511433970962, 5444.428335024765, 5450.454954504517, 5459.535939445192, 5488.341399032141, 5604.215409842707, 5767.0, 5788.13178023283, 5797.420257974169, 5802.448767367094, 5626.662400255997, 5650.576206784425, 5661.971690141688, 5663.7451314690115, 5700.059490184073, 5446.183072539151, 5463.180522921593, 5505.6696598204235, 5537.584681148849, 5547.140193270049, 3658.1403370208513, 3884.203738233599, 3993.5607083221403, 4019.4372787809143, 4032.8386864526265, 5115.309433226466, 5282.4717528246865, 5337.306150200449, 5360.3299587551555, 5361.142217245222, 5061.6962982221185, 5142.537171654569, 5185.351831021122, 5202.921956170585, 5218.4259731430275, 5168.9483105168465, 5176.61875537257, 5182.689038657692, 5183.92224116631, 5196.506331898464, 4895.16782147043, 5123.33396658447, 5127.897442051063, 5135.717535535581, 5165.509276618715, 5201.141811601044, 5243.23973023917, 5274.89450210986, 5289.603279754111, 5302.833376657283, 5071.847844564669, 5091.058154241329, 5110.259012443249, 5120.4111527174855, 5163.8192663256605], "value": 3983.588471239272, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.7878799996001, 745.4148493432657, 768.7808974442281, 773.1920143450094, 785.6268272570529, 11666.766664666713, 12384.690382740437, 12515.624531264077, 12542.184757990724, 12642.873571264285, 10388.324758890685, 10730.785384292309, 10763.35419874808, 10764.515596798143, 11322.660320190387, 805.5166899860067, 815.0056930544755, 817.0644611919349, 821.4332110843499, 821.5768879027306, 812.7317985064944, 813.5403497024192, 815.1115284340068, 816.7998840284139, 817.0562999735315, 852.9616167272487, 854.8033952191, 857.0358346859783, 857.4640849469082, 858.7252079334615, 849.6558893648051, 854.2781349759413, 854.5214679779343, 855.8545047341936, 856.751542052804, 618.3167599802243, 623.8814625221194, 625.4121126141413, 625.7966160997648, 627.3287582286955, 11326.490307936081, 11342.60300889465, 11407.25852819564, 11431.371274579895, 11466.942665286704, 9916.851247231298, 9937.801243975153, 9968.202543796478, 9989.150922171624, 10180.643677471253, 8985.23625491834, 9215.631374745002, 9243.722688319362, 9439.433633981915, 9442.38624489406, 3107.254258977852, 3154.810711357326, 3171.334019855833, 3195.72836308914, 3267.1015470745497, 43525.564744352465, 43867.0, 43958.12083758339, 44192.779036104934, 44773.552264477265, 7363.733735322069, 7600.885986710093, 7626.733064342721, 8183.427160098736, 8231.218034286732, 13728.382222799799, 13794.241316727675, 13840.0, 13880.652983675287, 13886.4445422184, 6134.570580059442, 6237.5945563539135, 6609.702563384659, 6767.898481522781, 6841.521093523405, 3587.892363229107, 3739.1026153723456, 3748.025513366544, 3769.6230376962085, 3795.4686343911876, 2758.3931535062256, 2848.6154369160313, 2854.5432730763396, 2855.11491437655, 2863.8997635083088, 501.40082601291107, 505.8280184737207, 515.5720751776092, 516.4293455731363, 519.4078750224746, 439.0691733524948, 521.0256819747098, 629.222909706512, 632.4624069540854, 640.4620119099978, 7322.524035937647, 7460.701571937062, 7566.470347075762, 7662.770116896502, 7688.500247483896, 523.6727045596502, 578.6036564952936, 580.0255570641278, 609.8201030695956, 627.5607075047485, 3737.2151848111657, 3753.4557489163917, 3771.5097037385513, 3889.9805500972316, 3939.4090886366703, 51213.0, 51518.742406287725, 51565.0, 51657.225141622905, 51773.741131294104, 46458.767706161256, 47482.76258618754, 47559.5244047562, 48390.27414588784, 48920.0, 43086.56913430826, 43726.78136609297, 44615.77692111519, 44943.77528112339, 45850.312245316345, 7262.9273707262255, 7468.925310746823, 7608.16310205888, 7627.237276272328, 7628.8474230516185, 29312.706872930998, 29337.85331073331, 29927.700722992493, 29928.551071733506, 30297.394052119274, 34236.65763342335, 38740.80629596834, 39097.41353879637, 39241.80379098086, 39319.0, 9012.729618111467, 9078.273738101068, 9092.22716069115, 9272.768180795534, 9439.764005899908, 9253.768655783659, 9473.715788526355, 9475.763105922408, 9578.090081442251, 9752.073553012453, 9165.220956218796, 9261.351705380559, 9472.384295020802, 9540.856887146838, 9643.807123857623, 9915.801683966425, 9941.552630131806, 11767.176297659082, 11794.52821887115, 11846.0, 10531.473426328806, 10846.403447810131, 10935.83596246041, 11192.272502287326, 11716.23844450108, 9213.355065145375, 9355.766105847408, 9443.575039123118, 9890.208783297463, 10264.948675256876, 8934.374593778373, 9309.0, 9390.765230869283, 9397.837108818847, 9451.810963780823], "value": 5673.900461084739, "unit": "score"}], "name": "dromaeo_css", "value": 6149.838405963731, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 114.0, 112.0, 114.0, 123.0, 114.0, 113.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 137.0, 162.0, 189.0, 134.0, 167.0, 159.0, 139.0, 191.0, 135.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 176.0, 163.0, 163.0, 163.0, 163.0, 166.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 161.0, 75.0, 75.0, 74.0, 78.0, 162.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 155.0, 95.0, 95.0, 94.0, 154.0, 96.0, 95.0, 150.0], "value": 112.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 66.0, 66.0, 65.0, 85.0, 64.0, 69.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 82.0, 81.0, 83.0, 81.0, 81.0, 81.0, 82.0, 82.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 139.0, 138.0, 134.0, 138.0, 159.0, 136.0, 176.0, 142.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 219.0, 218.0, 220.0, 219.0, 220.0, 218.0, 219.0, 216.0, 220.0], "value": 219.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 76.0, 76.0, 76.0, 79.0, 77.0, 73.0, 75.0, 74.0, 74.0], "value": 76.8, "unit": "score"}], "name": "kraken", "value": 1654.6, "alertThreshold": 2.0}]} 03:52:16 INFO - Return code: 0 03:52:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:52:16 ERROR - # TBPL SUCCESS # 03:52:16 INFO - Running post-action listener: _resource_record_post_action 03:52:16 INFO - Running post-run listener: _resource_record_post_run 03:52:17 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 525979648; Read time: 100; Write time: 492568 03:52:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 242176000; Read time: 88; Write time: 308296 03:52:17 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283803648; Read time: 12; Write time: 184272 03:52:17 INFO - Running post-run listener: _upload_blobber_files 03:52:17 INFO - Blob upload gear active. 03:52:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:17 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 03:52:17 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'] 03:52:17 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 03:52:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:18 INFO - (blobuploader) - INFO - Done attempting. 03:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:52:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:19 INFO - (blobuploader) - INFO - Done attempting. 03:52:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:19 INFO - Return code: 0 03:52:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c218ce860171f6360cfdf8c52fecdb1042b3d9d94f42a933f34c4bd5de74559fffdfd375470db078e1f22ec2296babd53ab10e26c9c8aa8b4ccda05d3c00b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a300dbfdb2e071154952726c712c53f05c2654dc0c468f5a25c220c19bad65e0541ae6b87642fbff23101c40ae17b82dd893438e8e3480cfb751843a565eb2c"} 03:52:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:19 INFO - Contents: 03:52:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c218ce860171f6360cfdf8c52fecdb1042b3d9d94f42a933f34c4bd5de74559fffdfd375470db078e1f22ec2296babd53ab10e26c9c8aa8b4ccda05d3c00b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a300dbfdb2e071154952726c712c53f05c2654dc0c468f5a25c220c19bad65e0541ae6b87642fbff23101c40ae17b82dd893438e8e3480cfb751843a565eb2c"} 03:52:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:19 INFO - Copying logs to upload dir... 03:52:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.744356 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-28 03:52:18.925053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 03:52:18.928445) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052 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/7c218ce860171f6360cfdf8c52fecdb1042b3d9d94f42a933f34c4bd5de74559fffdfd375470db078e1f22ec2296babd53ab10e26c9c8aa8b4ccda05d3c00b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a300dbfdb2e071154952726c712c53f05c2654dc0c468f5a25c220c19bad65e0541ae6b87642fbff23101c40ae17b82dd893438e8e3480cfb751843a565eb2c"} build_url:https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/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/7c218ce860171f6360cfdf8c52fecdb1042b3d9d94f42a933f34c4bd5de74559fffdfd375470db078e1f22ec2296babd53ab10e26c9c8aa8b4ccda05d3c00b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a300dbfdb2e071154952726c712c53f05c2654dc0c468f5a25c220c19bad65e0541ae6b87642fbff23101c40ae17b82dd893438e8e3480cfb751843a565eb2c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 03:52:18.955051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:52:18.955663) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461839503.379443-872446052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:52:19.039520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 03:52:19.039875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 03:52:19.040213) ========= ========= Total master_lag: 0.16 =========