builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1461953515.92 results: success (0) buildid: 20160429101348 builduid: 201814c460594d4ba49129a13698efa5 revision: e828b778e62c0795a1e85dd39f782b59dcebd445 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:55.919352) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:55.919955) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:55.920232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:55.947013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:55.947281) ========= 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=0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 11:11:56-- 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% 88.2M=0s 2016-04-29 11:11:56 (88.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:56.079988) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:56.080313) ========= 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=0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014830 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:56.129438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:56.129797) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e828b778e62c0795a1e85dd39f782b59dcebd445 --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 e828b778e62c0795a1e85dd39f782b59dcebd445 --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=0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 11:11:56,780 truncating revision to first 12 chars 2016-04-29 11:11:56,780 Setting DEBUG logging. 2016-04-29 11:11:56,780 attempt 1/10 2016-04-29 11:11:56,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e828b778e62c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 11:11:57,064 unpacking tar archive at: fx-team-e828b778e62c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532879 ========= master_lag: 0.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:57.032054) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:57.032351) ========= script_repo_revision: e828b778e62c0795a1e85dd39f782b59dcebd445 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:57.032747) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:57.033026) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 11:11:57.071993) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-29 11:11:57.072269) ========= /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=0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:57 INFO - MultiFileLogger online at 20160429 11:11:57 in /builds/slave/test 11:11:57 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 11:11:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:57 INFO - {'append_to_log': False, 11:11:57 INFO - 'base_work_dir': '/builds/slave/test', 11:11:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:11:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:57 INFO - 'branch': 'Fx-Team-Non-PGO', 11:11:57 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:57 INFO - 'config_files': ('talos/linux_config.py',), 11:11:57 INFO - 'default_actions': ('clobber', 11:11:57 INFO - 'read-buildbot-config', 11:11:57 INFO - 'download-and-extract', 11:11:57 INFO - 'populate-webroot', 11:11:57 INFO - 'create-virtualenv', 11:11:57 INFO - 'install', 11:11:57 INFO - 'run-tests'), 11:11:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:57 INFO - 'download_minidump_stackwalk': True, 11:11:57 INFO - 'download_symbols': 'ondemand', 11:11:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:57 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:57 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:57 INFO - 'installer_path': 'installer.exe', 11:11:57 INFO - 'log_level': 'info', 11:11:57 INFO - 'log_name': 'talos', 11:11:57 INFO - 'log_to_console': True, 11:11:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:57 INFO - 'opt_config_files': (), 11:11:57 INFO - 'pip_index': False, 11:11:57 INFO - 'sps_profile': False, 11:11:57 INFO - 'sps_profile_interval': 0, 11:11:57 INFO - 'suite': 'dromaeojs-e10s', 11:11:57 INFO - 'system_bits': '32', 11:11:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:57 INFO - 'title': 'talos-linux64-ix-017', 11:11:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:57 INFO - 'use_talos_json': True, 11:11:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:57 INFO - 'work_dir': 'build'} 11:11:57 INFO - ##### 11:11:57 INFO - ##### Running clobber step. 11:11:57 INFO - ##### 11:11:57 INFO - Running pre-action listener: _resource_record_pre_action 11:11:57 INFO - Running main action method: clobber 11:11:57 INFO - rmtree: /builds/slave/test/build 11:11:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:58 INFO - Running post-action listener: _resource_record_post_action 11:11:58 INFO - ##### 11:11:58 INFO - ##### Running read-buildbot-config step. 11:11:58 INFO - ##### 11:11:58 INFO - Running pre-action listener: _resource_record_pre_action 11:11:58 INFO - Running main action method: read_buildbot_config 11:11:58 INFO - Using buildbot properties: 11:11:58 INFO - { 11:11:58 INFO - "project": "", 11:11:58 INFO - "product": "firefox", 11:11:58 INFO - "script_repo_revision": "production", 11:11:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:11:58 INFO - "repository": "", 11:11:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:11:58 INFO - "buildid": "20160429101348", 11:11:58 INFO - "pgo_build": "False", 11:11:58 INFO - "basedir": "/builds/slave/test", 11:11:58 INFO - "buildnumber": 1220, 11:11:58 INFO - "slavename": "talos-linux64-ix-017", 11:11:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:11:58 INFO - "platform": "ubuntu64_hw", 11:11:58 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:11:58 INFO - "branch": "fx-team", 11:11:58 INFO - "repo_path": "integration/fx-team", 11:11:58 INFO - "revision": "e828b778e62c0795a1e85dd39f782b59dcebd445", 11:11:58 INFO - "stage_platform": "linux64", 11:11:58 INFO - "builduid": "201814c460594d4ba49129a13698efa5", 11:11:58 INFO - "slavebuilddir": "test" 11:11:58 INFO - } 11:11:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:11:58 INFO - Running post-action listener: _resource_record_post_action 11:11:58 INFO - ##### 11:11:58 INFO - ##### Running download-and-extract step. 11:11:58 INFO - ##### 11:11:58 INFO - Running pre-action listener: _resource_record_pre_action 11:11:58 INFO - Running main action method: download_and_extract 11:11:58 INFO - mkdir: /builds/slave/test/build/tests 11:11: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')]} 11:11:58 INFO - https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:05 INFO - Downloaded 1361 bytes. 11:12:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:12:05 INFO - Using the following test package requirements: 11:12:05 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:05 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:12:05 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:12:05 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:05 INFO - u'jsshell-linux-x86_64.zip'], 11:12:05 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:12:05 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:05 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:12:05 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:12:05 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:12:05 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:12:05 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:12:05 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')]} 11:12:05 INFO - https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:12:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:12:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:14 INFO - Downloaded 22301146 bytes. 11:12:14 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'] 11:12:14 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 11:12:15 INFO - Return code: 0 11:12:15 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 11:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:15 INFO - https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:18 INFO - Downloaded 22301146 bytes. 11:12:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:12:19 INFO - Return code: 0 11:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:19 INFO - https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:20 INFO - Downloaded 10840145 bytes. 11:12:20 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'] 11:12:20 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 11:12:21 INFO - Return code: 0 11:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:21 INFO - https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Liqx010QSQyaX1Jm3b93-Q/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 11:12:26 INFO - Downloaded 54855319 bytes. 11:12:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:12:26 INFO - mkdir: /builds/slave/test/properties 11:12:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:26 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:26 INFO - Contents: 11:12:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:12:27 INFO - Running post-action listener: _resource_record_post_action 11:12:27 INFO - Running post-action listener: set_extra_try_arguments 11:12:27 INFO - ##### 11:12:27 INFO - ##### Running populate-webroot step. 11:12:27 INFO - ##### 11:12:27 INFO - Running pre-action listener: _resource_record_pre_action 11:12:27 INFO - Running main action method: populate_webroot 11:12:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:27 INFO - '--tppagecycles', 11:12:27 INFO - '7'], 11:12:27 INFO - 'tests': ['tsvgm']}}, 11:12:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['damp', 'tps']}, 11:12:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'tests': ['damp', 'tps']}, 11:12:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['dromaeo_dom']}, 11:12:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore', 11:12:27 INFO - 'tabpaint']}, 11:12:27 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore', 11:12:27 INFO - 'tabpaint']}, 11:12:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore', 11:12:27 INFO - 'tabpaint']}, 11:12:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore', 11:12:27 INFO - 'tabpaint']}, 11:12:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore', 11:12:27 INFO - 'tabpaint']}, 11:12:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore', 11:12:27 INFO - 'tabpaint']}, 11:12:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['tsvgx', 11:12:27 INFO - 'tsvgr_opacity', 11:12:27 INFO - 'tart', 11:12:27 INFO - 'tscrollx', 11:12:27 INFO - 'cart']}, 11:12:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:27 INFO - 'tsvgr_opacity', 11:12:27 INFO - 'tart', 11:12:27 INFO - 'tscrollx', 11:12:27 INFO - 'cart']}, 11:12:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--disable-e10s'], 11:12:27 INFO - 'tests': ['tp5o']}, 11:12:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'tests': ['tp5o']}, 11:12:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--disable-e10s', 11:12:27 INFO - '--xperf_path', 11:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:27 INFO - 'tests': ['tp5n']}, 11:12:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--xperf_path', 11:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:27 INFO - 'tests': ['tp5n']}}, 11:12:27 INFO - 'talos.zip': {'path': '', 11:12:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:27 INFO - Running post-action listener: _resource_record_post_action 11:12:27 INFO - ##### 11:12:27 INFO - ##### Running create-virtualenv step. 11:12:27 INFO - ##### 11:12:27 INFO - Running pre-action listener: _resource_record_pre_action 11:12:27 INFO - Running main action method: create_virtualenv 11:12:27 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:27 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 11:12:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:27 INFO - Using real prefix '/usr' 11:12:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:28 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:29 INFO - Installing pip.................done. 11:12:29 INFO - Return code: 0 11:12:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12:29 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')]} 11:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:29 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')]} 11:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:29 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 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:29 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 11:12:29 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 11:12:29 INFO - Using env: {'DISPLAY': ':0', 11:12:29 INFO - 'HOME': '/home/cltbld', 11:12:29 INFO - 'LANG': 'en_US.UTF-8', 11:12:29 INFO - 'LANGUAGE': 'en_US:en', 11:12:29 INFO - 'LOGNAME': 'cltbld', 11:12:29 INFO - 'MAIL': '/var/mail/cltbld', 11:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:29 INFO - 'MOZ_NO_REMOTE': '1', 11:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:29 INFO - 'NO_EM_RESTART': '1', 11:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:29 INFO - 'PWD': '/builds/slave/test', 11:12:29 INFO - 'SHELL': '/bin/bash', 11:12:29 INFO - 'SHLVL': '1', 11:12:29 INFO - 'TERM': 'linux', 11:12:29 INFO - 'TMOUT': '86400', 11:12:29 INFO - 'USER': 'cltbld', 11:12:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:30 INFO - '_': '/tools/buildbot/bin/python'} 11:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:30 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 11:12:30 INFO - Cleaning up... 11:12:30 INFO - Return code: 0 11:12:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:30 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 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:30 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 11:12:30 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 11:12:30 INFO - Using env: {'DISPLAY': ':0', 11:12:30 INFO - 'HOME': '/home/cltbld', 11:12:30 INFO - 'LANG': 'en_US.UTF-8', 11:12:30 INFO - 'LANGUAGE': 'en_US:en', 11:12:30 INFO - 'LOGNAME': 'cltbld', 11:12:30 INFO - 'MAIL': '/var/mail/cltbld', 11:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:30 INFO - 'MOZ_NO_REMOTE': '1', 11:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:30 INFO - 'NO_EM_RESTART': '1', 11:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:30 INFO - 'PWD': '/builds/slave/test', 11:12:30 INFO - 'SHELL': '/bin/bash', 11:12:30 INFO - 'SHLVL': '1', 11:12:30 INFO - 'TERM': 'linux', 11:12:30 INFO - 'TMOUT': '86400', 11:12:30 INFO - 'USER': 'cltbld', 11:12:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:30 INFO - '_': '/tools/buildbot/bin/python'} 11:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:30 INFO - Downloading/unpacking psutil>=0.7.1 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:32 INFO - Installing collected packages: psutil 11:12:32 INFO - Running setup.py install for psutil 11:12:32 INFO - building 'psutil._psutil_linux' extension 11:12:32 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 11:12:32 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 11:12:32 INFO - building 'psutil._psutil_posix' extension 11:12:32 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 11:12:32 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 11:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:32 INFO - Successfully installed psutil 11:12:32 INFO - Cleaning up... 11:12:32 INFO - Return code: 0 11:12:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:12:32 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')]} 11:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:32 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')]} 11:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:32 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 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:32 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 11:12:32 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 11:12:32 INFO - Using env: {'DISPLAY': ':0', 11:12:32 INFO - 'HOME': '/home/cltbld', 11:12:32 INFO - 'LANG': 'en_US.UTF-8', 11:12:32 INFO - 'LANGUAGE': 'en_US:en', 11:12:32 INFO - 'LOGNAME': 'cltbld', 11:12:32 INFO - 'MAIL': '/var/mail/cltbld', 11:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:32 INFO - 'MOZ_NO_REMOTE': '1', 11:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:32 INFO - 'NO_EM_RESTART': '1', 11:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:32 INFO - 'PWD': '/builds/slave/test', 11:12:32 INFO - 'SHELL': '/bin/bash', 11:12:32 INFO - 'SHLVL': '1', 11:12:32 INFO - 'TERM': 'linux', 11:12:32 INFO - 'TMOUT': '86400', 11:12:32 INFO - 'USER': 'cltbld', 11:12:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:32 INFO - '_': '/tools/buildbot/bin/python'} 11:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:12:33 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 11:12:33 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 11:12:33 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 11:12:33 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 11:12:33 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 11:12:33 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 11:12:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:12:35 INFO - Installing collected packages: mozsystemmonitor 11:12:35 INFO - Running setup.py install for mozsystemmonitor 11:12:35 INFO - Successfully installed mozsystemmonitor 11:12:35 INFO - Cleaning up... 11:12:35 INFO - Return code: 0 11:12:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:35 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 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:35 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 11:12:35 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 11:12:35 INFO - Using env: {'DISPLAY': ':0', 11:12:35 INFO - 'HOME': '/home/cltbld', 11:12:35 INFO - 'LANG': 'en_US.UTF-8', 11:12:35 INFO - 'LANGUAGE': 'en_US:en', 11:12:35 INFO - 'LOGNAME': 'cltbld', 11:12:35 INFO - 'MAIL': '/var/mail/cltbld', 11:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:35 INFO - 'MOZ_NO_REMOTE': '1', 11:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:35 INFO - 'NO_EM_RESTART': '1', 11:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:35 INFO - 'PWD': '/builds/slave/test', 11:12:35 INFO - 'SHELL': '/bin/bash', 11:12:35 INFO - 'SHLVL': '1', 11:12:35 INFO - 'TERM': 'linux', 11:12:35 INFO - 'TMOUT': '86400', 11:12:35 INFO - 'USER': 'cltbld', 11:12:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:35 INFO - '_': '/tools/buildbot/bin/python'} 11:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:38 INFO - Downloading docopt-0.6.1.tar.gz 11:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:38 INFO - Running setup.py install for blobuploader 11:12:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:38 INFO - Running setup.py install for requests 11:12:38 INFO - Running setup.py install for docopt 11:12:38 INFO - Successfully installed blobuploader requests docopt 11:12:38 INFO - Cleaning up... 11:12:38 INFO - Return code: 0 11:12:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:38 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')]} 11:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:38 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')]} 11:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:38 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 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:38 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 11:12:38 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 11:12:38 INFO - Using env: {'DISPLAY': ':0', 11:12:38 INFO - 'HOME': '/home/cltbld', 11:12:38 INFO - 'LANG': 'en_US.UTF-8', 11:12:38 INFO - 'LANGUAGE': 'en_US:en', 11:12:38 INFO - 'LOGNAME': 'cltbld', 11:12:38 INFO - 'MAIL': '/var/mail/cltbld', 11:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:38 INFO - 'MOZ_NO_REMOTE': '1', 11:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:38 INFO - 'NO_EM_RESTART': '1', 11:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:38 INFO - 'PWD': '/builds/slave/test', 11:12:38 INFO - 'SHELL': '/bin/bash', 11:12:38 INFO - 'SHLVL': '1', 11:12:38 INFO - 'TERM': 'linux', 11:12:38 INFO - 'TMOUT': '86400', 11:12:38 INFO - 'USER': 'cltbld', 11:12:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:38 INFO - '_': '/tools/buildbot/bin/python'} 11:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:38 INFO - Running setup.py (path:/tmp/pip-qJjqYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:38 INFO - Running setup.py (path:/tmp/pip-ns8ynr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:39 INFO - Running setup.py (path:/tmp/pip-fQ3Kx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:39 INFO - Running setup.py (path:/tmp/pip-Op0MAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:39 INFO - Running setup.py (path:/tmp/pip-03nUWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:39 INFO - Running setup.py (path:/tmp/pip-rgXVjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:39 INFO - Running setup.py (path:/tmp/pip-VxZxL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:39 INFO - Running setup.py (path:/tmp/pip-5maJtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:39 INFO - Running setup.py (path:/tmp/pip-1U6kyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:39 INFO - Running setup.py (path:/tmp/pip-oy47wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:39 INFO - Running setup.py (path:/tmp/pip-Oslrnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:39 INFO - Running setup.py (path:/tmp/pip-ElB1_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:39 INFO - Running setup.py (path:/tmp/pip-YDwAqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:39 INFO - Running setup.py (path:/tmp/pip-3vENBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:39 INFO - Running setup.py (path:/tmp/pip-sJOeQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:39 INFO - Running setup.py (path:/tmp/pip-WvB8vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:40 INFO - Running setup.py (path:/tmp/pip-oEus_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:40 INFO - Running setup.py install for manifestparser 11:12:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Running setup.py install for mozcrash 11:12:40 INFO - Running setup.py install for mozdebug 11:12:40 INFO - Running setup.py install for mozdevice 11:12:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Running setup.py install for mozfile 11:12:40 INFO - Running setup.py install for mozhttpd 11:12:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Running setup.py install for mozinfo 11:12:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Running setup.py install for mozInstall 11:12:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:40 INFO - Running setup.py install for mozleak 11:12:40 INFO - Running setup.py install for mozlog 11:12:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:41 INFO - Running setup.py install for moznetwork 11:12:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:41 INFO - Running setup.py install for mozprocess 11:12:41 INFO - Running setup.py install for mozprofile 11:12:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:41 INFO - Running setup.py install for mozrunner 11:12:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:41 INFO - Running setup.py install for mozscreenshot 11:12:41 INFO - Running setup.py install for moztest 11:12:41 INFO - Running setup.py install for mozversion 11:12:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:41 INFO - Cleaning up... 11:12:41 INFO - Return code: 0 11:12:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:41 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')]} 11:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:41 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')]} 11:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:41 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 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:41 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 11:12:41 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 11:12:41 INFO - Using env: {'DISPLAY': ':0', 11:12:41 INFO - 'HOME': '/home/cltbld', 11:12:41 INFO - 'LANG': 'en_US.UTF-8', 11:12:41 INFO - 'LANGUAGE': 'en_US:en', 11:12:41 INFO - 'LOGNAME': 'cltbld', 11:12:41 INFO - 'MAIL': '/var/mail/cltbld', 11:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:41 INFO - 'MOZ_NO_REMOTE': '1', 11:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:41 INFO - 'NO_EM_RESTART': '1', 11:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:41 INFO - 'PWD': '/builds/slave/test', 11:12:41 INFO - 'SHELL': '/bin/bash', 11:12:41 INFO - 'SHLVL': '1', 11:12:41 INFO - 'TERM': 'linux', 11:12:41 INFO - 'TMOUT': '86400', 11:12:41 INFO - 'USER': 'cltbld', 11:12:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:41 INFO - '_': '/tools/buildbot/bin/python'} 11:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:42 INFO - Running setup.py (path:/tmp/pip-Z4A7Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:42 INFO - Running setup.py (path:/tmp/pip-9lr2YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:42 INFO - Running setup.py (path:/tmp/pip-cpJXWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:42 INFO - Running setup.py (path:/tmp/pip-l1x9NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:42 INFO - Running setup.py (path:/tmp/pip-325Kf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:42 INFO - Running setup.py (path:/tmp/pip-z7rwXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:42 INFO - Running setup.py (path:/tmp/pip-TBf4R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:42 INFO - Running setup.py (path:/tmp/pip-JM87yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:42 INFO - Running setup.py (path:/tmp/pip-ZBqPqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:42 INFO - Running setup.py (path:/tmp/pip-Iqh2WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:42 INFO - Running setup.py (path:/tmp/pip-ECBfMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:42 INFO - Running setup.py (path:/tmp/pip-ER357I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:42 INFO - Running setup.py (path:/tmp/pip-J7sI6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:43 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)) 11:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:43 INFO - Running setup.py (path:/tmp/pip-0odWGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:43 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)) 11:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:43 INFO - Running setup.py (path:/tmp/pip-CUcoir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:43 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)) 11:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:43 INFO - Running setup.py (path:/tmp/pip-_qoTEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:43 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)) 11:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:43 INFO - Running setup.py (path:/tmp/pip-6hYFEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:43 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)) 11:12:43 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)) 11:12:43 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)) 11:12:43 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)) 11:12:43 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)) 11:12:43 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)) 11:12:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:43 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 11:12:43 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 11:12:43 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 11:12:43 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 11:12:43 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 11:12:43 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 11:12:45 INFO - Downloading blessings-1.6.tar.gz 11:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:45 INFO - Installing collected packages: blessings 11:12:45 INFO - Running setup.py install for blessings 11:12:45 INFO - Successfully installed blessings 11:12:45 INFO - Cleaning up... 11:12:45 INFO - Return code: 0 11:12:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:45 INFO - Reading from file tmpfile_stdout 11:12:45 INFO - Current package versions: 11:12:45 INFO - argparse == 1.2.1 11:12:45 INFO - blessings == 1.6 11:12:45 INFO - blobuploader == 1.2.4 11:12:45 INFO - docopt == 0.6.1 11:12:45 INFO - manifestparser == 1.1 11:12:45 INFO - mozInstall == 1.12 11:12:45 INFO - mozcrash == 0.17 11:12:45 INFO - mozdebug == 0.1 11:12:45 INFO - mozdevice == 0.48 11:12:45 INFO - mozfile == 1.2 11:12:45 INFO - mozhttpd == 0.7 11:12:45 INFO - mozinfo == 0.9 11:12:45 INFO - mozleak == 0.1 11:12:45 INFO - mozlog == 3.1 11:12:45 INFO - moznetwork == 0.27 11:12:45 INFO - mozprocess == 0.22 11:12:45 INFO - mozprofile == 0.28 11:12:45 INFO - mozrunner == 6.11 11:12:45 INFO - mozscreenshot == 0.1 11:12:45 INFO - mozsystemmonitor == 0.0 11:12:45 INFO - moztest == 0.7 11:12:45 INFO - mozversion == 1.4 11:12:45 INFO - psutil == 3.1.1 11:12:45 INFO - requests == 1.2.3 11:12:45 INFO - wsgiref == 0.1.2 11:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:45 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 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:45 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 11:12:45 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 11:12:45 INFO - Using env: {'DISPLAY': ':0', 11:12:45 INFO - 'HOME': '/home/cltbld', 11:12:45 INFO - 'LANG': 'en_US.UTF-8', 11:12:45 INFO - 'LANGUAGE': 'en_US:en', 11:12:45 INFO - 'LOGNAME': 'cltbld', 11:12:45 INFO - 'MAIL': '/var/mail/cltbld', 11:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:45 INFO - 'MOZ_NO_REMOTE': '1', 11:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:45 INFO - 'NO_EM_RESTART': '1', 11:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:45 INFO - 'PWD': '/builds/slave/test', 11:12:45 INFO - 'SHELL': '/bin/bash', 11:12:45 INFO - 'SHLVL': '1', 11:12:45 INFO - 'TERM': 'linux', 11:12:45 INFO - 'TMOUT': '86400', 11:12:45 INFO - 'USER': 'cltbld', 11:12:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:45 INFO - '_': '/tools/buildbot/bin/python'} 11:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 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)) 11:12:45 INFO - Cleaning up... 11:12:45 INFO - Return code: 0 11:12:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:12:45 INFO - Using env: {'DISPLAY': ':0', 11:12:45 INFO - 'HOME': '/home/cltbld', 11:12:45 INFO - 'LANG': 'en_US.UTF-8', 11:12:45 INFO - 'LANGUAGE': 'en_US:en', 11:12:45 INFO - 'LOGNAME': 'cltbld', 11:12:45 INFO - 'MAIL': '/var/mail/cltbld', 11:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:45 INFO - 'MOZ_NO_REMOTE': '1', 11:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:45 INFO - 'NO_EM_RESTART': '1', 11:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:45 INFO - 'PWD': '/builds/slave/test', 11:12:45 INFO - 'SHELL': '/bin/bash', 11:12:45 INFO - 'SHLVL': '1', 11:12:45 INFO - 'TERM': 'linux', 11:12:45 INFO - 'TMOUT': '86400', 11:12:45 INFO - 'USER': 'cltbld', 11:12:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:45 INFO - '_': '/tools/buildbot/bin/python'} 11:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:46 INFO - Downloading/unpacking jsonschema 11:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:48 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:48 INFO - warning: no files found matching '*.txt' 11:12:48 INFO - no previously-included directories found matching 'build' 11:12:48 INFO - no previously-included directories found matching 'dist' 11:12:48 INFO - no previously-included directories found matching '.git*' 11:12:48 INFO - Installing collected packages: jsonschema, functools32 11:12:48 INFO - Running setup.py install for functools32 11:12:48 INFO - warning: no files found matching '*.txt' 11:12:48 INFO - no previously-included directories found matching 'build' 11:12:48 INFO - no previously-included directories found matching 'dist' 11:12:48 INFO - no previously-included directories found matching '.git*' 11:12:48 INFO - Successfully installed jsonschema functools32 11:12:48 INFO - Cleaning up... 11:12:48 INFO - Return code: 0 11:12:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08cc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', '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 11:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:12:48 INFO - Using env: {'DISPLAY': ':0', 11:12:48 INFO - 'HOME': '/home/cltbld', 11:12:48 INFO - 'LANG': 'en_US.UTF-8', 11:12:48 INFO - 'LANGUAGE': 'en_US:en', 11:12:48 INFO - 'LOGNAME': 'cltbld', 11:12:48 INFO - 'MAIL': '/var/mail/cltbld', 11:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:48 INFO - 'MOZ_NO_REMOTE': '1', 11:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:48 INFO - 'NO_EM_RESTART': '1', 11:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:48 INFO - 'PWD': '/builds/slave/test', 11:12:48 INFO - 'SHELL': '/bin/bash', 11:12:48 INFO - 'SHLVL': '1', 11:12:48 INFO - 'TERM': 'linux', 11:12:48 INFO - 'TMOUT': '86400', 11:12:48 INFO - 'USER': 'cltbld', 11:12:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:48 INFO - '_': '/tools/buildbot/bin/python'} 11:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:48 INFO - Downloading/unpacking flake8 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:51 INFO - no previously-included directories found matching 'docs/_build' 11:12:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:51 INFO - Running setup.py install for pep8 11:12:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:51 INFO - no previously-included directories found matching 'docs/_build' 11:12:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:51 INFO - Cleaning up... 11:12:51 INFO - Return code: 0 11:12:51 INFO - Running post-action listener: _resource_record_post_action 11:12:51 INFO - Running post-action listener: _start_resource_monitoring 11:12:51 INFO - Starting resource monitoring. 11:12:51 INFO - ##### 11:12:51 INFO - ##### Running install step. 11:12:51 INFO - ##### 11:12:51 INFO - Running pre-action listener: _resource_record_pre_action 11:12:51 INFO - Running main action method: install 11:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:51 INFO - Reading from file tmpfile_stdout 11:12:51 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:51 INFO - Reading from file tmpfile_stdout 11:12:51 INFO - Output received: 11:12:51 INFO - Usage: mozinstall [options] installer 11:12:51 INFO - Options: 11:12:51 INFO - -h, --help show this help message and exit 11:12:51 INFO - -d DEST, --destination=DEST 11:12:51 INFO - Directory to install application into. [default: 11:12:51 INFO - "/builds/slave/test"] 11:12:51 INFO - --app=APP Application being installed. [default: firefox] 11:12:51 INFO - mkdir: /builds/slave/test/build/application 11:12:51 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'] 11:12:51 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 11:13:07 INFO - Reading from file tmpfile_stdout 11:13:07 INFO - Output received: 11:13:07 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:07 INFO - Running post-action listener: _resource_record_post_action 11:13:07 INFO - ##### 11:13:07 INFO - ##### Running run-tests step. 11:13:07 INFO - ##### 11:13:07 INFO - Running pre-action listener: _resource_record_pre_action 11:13:07 INFO - Running main action method: run_tests 11:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:07 INFO - Python 2.7.3 11:13:07 INFO - Return code: 0 11:13:07 INFO - grabbing minidump binary from tooltool 11:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:07 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 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:07 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 11:13:07 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 11:13:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:07 INFO - Return code: 0 11:13:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:13:08 INFO - Return code: 0 11:13:08 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/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 11:13:08 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/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 11:13:08 INFO - Using env: {'DISPLAY': ':0', 11:13:08 INFO - 'HOME': '/home/cltbld', 11:13:08 INFO - 'LANG': 'en_US.UTF-8', 11:13:08 INFO - 'LANGUAGE': 'en_US:en', 11:13:08 INFO - 'LOGNAME': 'cltbld', 11:13:08 INFO - 'MAIL': '/var/mail/cltbld', 11:13:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:08 INFO - 'MOZ_NO_REMOTE': '1', 11:13:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:08 INFO - 'NO_EM_RESTART': '1', 11:13:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:08 INFO - 'PWD': '/builds/slave/test', 11:13:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:08 INFO - 'SHELL': '/bin/bash', 11:13:08 INFO - 'SHLVL': '1', 11:13:08 INFO - 'TERM': 'linux', 11:13:08 INFO - 'TMOUT': '86400', 11:13:08 INFO - 'USER': 'cltbld', 11:13:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843', 11:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:08 INFO - '_': '/tools/buildbot/bin/python'} 11:13:08 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/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 11:13:08 INFO - mozversion application_buildid: 20160429101348 11:13:08 INFO - mozversion application_changeset: e828b778e62c0795a1e85dd39f782b59dcebd445 11:13:08 INFO - mozversion application_display_name: Nightly 11:13:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:08 INFO - mozversion application_name: Firefox 11:13:08 INFO - mozversion application_remotingname: firefox 11:13:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:13:08 INFO - mozversion application_vendor: Mozilla 11:13:08 INFO - mozversion application_version: 49.0a1 11:13:08 INFO - mozversion platform_buildid: 20160429101348 11:13:08 INFO - mozversion platform_changeset: e828b778e62c0795a1e85dd39f782b59dcebd445 11:13:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:13:08 INFO - mozversion platform_version: 49.0a1 11:13:08 INFO - using testdate: 1461953588 11:13:08 INFO - actual date: 1461953588 11:13:08 INFO - starting webserver on 'localhost:43276' 11:13:08 INFO - SUITE-START | Running 2 tests 11:13:08 INFO - TEST-START | dromaeo_css 11:13:08 INFO - operating with platform_type : linux_ 11:13:08 INFO - Initialising browser for dromaeo_css test... 11:13:08 INFO - TEST-INFO | started process 5712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9gaC7/profile http://localhost:43276/getInfo.html) 11:13:12 INFO - PROCESS | 5712 | 11:13:12 INFO - PROCESS | 5712 | (process:5782): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:13:13 INFO - PROCESS | 5712 | __metrics Screen width/height:1600/1200 11:13:13 INFO - PROCESS | 5712 | colorDepth:24 11:13:13 INFO - PROCESS | 5712 | Browser inner width/height: 1024/697 11:13:13 INFO - PROCESS | 5712 | __metrics 11:13:14 ERROR - PROCESS | 5712 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:13:14 INFO - TEST-INFO | 5712: exit 0 11:13:14 INFO - Browser initialized. 11:13:14 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:14 INFO - TEST-INFO | started process 5833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9gaC7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:16 INFO - PROCESS | 5833 | 11:13:16 INFO - PROCESS | 5833 | (process:5894): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:13:26 INFO - PROCESS | 5833 | RSS: Main: 166019072 11:13:26 INFO - PROCESS | 5833 | 11:14:16 INFO - PROCESS | 5833 | 1461953656541 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] 11:16:29 INFO - PROCESS | 5833 | Cycle 1(1): loaded http://localhost:43276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43276/tests/dromaeo/cssquery-ext.html) 11:16:30 INFO - PROCESS | 5833 | RSS: Main: 167505920 11:16:30 INFO - PROCESS | 5833 | 11:19:32 INFO - PROCESS | 5833 | Cycle 1(1): loaded http://localhost:43276/tests/dromaeo/cssquery-ext.html (next: http://localhost:43276/tests/dromaeo/cssquery-jquery.html) 11:19:33 INFO - PROCESS | 5833 | RSS: Main: 167354368 11:19:33 INFO - PROCESS | 5833 | 11:22:35 INFO - PROCESS | 5833 | Cycle 1(1): loaded http://localhost:43276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43276/tests/dromaeo/cssquery-mootools.html) 11:22:35 INFO - PROCESS | 5833 | RSS: Main: 167915520 11:22:35 INFO - PROCESS | 5833 | 11:25:37 INFO - PROCESS | 5833 | Cycle 1(1): loaded http://localhost:43276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43276/tests/dromaeo/cssquery-prototype.html) 11:25:38 INFO - PROCESS | 5833 | RSS: Main: 166113280 11:25:38 INFO - PROCESS | 5833 | 11:28:41 INFO - PROCESS | 5833 | Cycle 1(1): loaded http://localhost:43276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43276/tests/dromaeo/cssquery-yui.html) 11:28:41 INFO - PROCESS | 5833 | RSS: Main: 167280640 11:28:41 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | Cycle 1(1): loaded http://localhost:43276/tests/dromaeo/cssquery-yui.html (next: http://localhost:43276/tests/dromaeo/cssquery-dojo.html) 11:31:44 INFO - PROCESS | 5833 | RSS: Main: 169078784 11:31:44 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | __start_tp_report 11:31:44 INFO - PROCESS | 5833 | _x_x_mozilla_page_load 11:31:44 INFO - PROCESS | 5833 | _x_x_mozilla_page_load_details 11:31:44 INFO - PROCESS | 5833 | |i|pagename|runs| 11:31:44 INFO - PROCESS | 5833 | |0;dojo.html;2597.805164612654;2677.9598306025414;2697.824641398308;2706.648135742353;2709.1601603502913;4724.314974328725;4753.144434001878;4774.522547745228;4781.569658730714;4821.27680847873;4693.202155633542;4705.200115980283;4724.102420540095;4802.111609352263;4808.543188397105;4364.585364390377;4376.781160941956;4431.822727090913;4436.689431739779;4477.350784136298;4390.341448782676;4485.461744590637;4487.618552423048;4525.343825145352;4529.864104076866;4228.4080228768;4352.7605981670995;4389.034412429261;4428.202923473774;4462.1968045751755;4358.128374325148;4377.03705184862;4394.033312671239;4394.4287242658565;4432.180046691373;4347.043650396908;4357.673174511892;4365.911581118419;4384.802683879233;4407.294832826732;4613.261878099522;4630.814767409333;4674.836380726658;4698.08387364464;4706.7175969441605;4976.626752993504;5007.84976450707;5016.072026675077;5030.270610761456;5079.746012699387;4955.182394904837;5044.8234311798915;5065.822696205615;5066.088104141253;5108.948910510884;4721.197396442579;4733.739644319596;4758.762061896891;4778.976105119452;4789.640776941674;5113.923291150636;5163.044836705221;5180.067587834226;5180.834312279782;5213.791448342024;4800.991791723777;4926.0886735953245;4962.379702537183;4983.202687569971;4997.125503036954;4937.802487900443;5097.923531147036;5130.230465430141;5136.948630513722;5176.663516871391;5032.3961124665275;5050.747462626854;5056.317397151338;5058.418281897555;5099.464556221617;4854.95145048545;4979.925301120486;5005.074061298671;5011.84964451067;5061.038402703474;4266.975925777853;4268.445102136702;4283.87148385549;4305.655547556188;4331.177076355482;3715.405535114369;3721.3115573618966;3721.981390093032;3751.0434839116397;3766.5103536540073;4211.873643790691;4337.371081193272;4340;4368.781560922005;4395.714278571946;5054.115529782273;5054.368203974504;5057.190849464068;5077.568406685399;5114.156164232934;4349.586789255016;4359.956400436018;4366.454193225847;4377.978110109493;4402.031553058322;4395.318725597537;4530.88672783183;4536.8638940831825;4549.385832912581;4596.080783843245;4689.273162659793;4715.434147902137;4720.622350211906;4730.148573256847;4734.21885388907;4988.501149884983;4994.875128121826;5022.296878437095;5032.723200223876;5040.49595040493;4615.446146462312;4746.5490778376;4756.571908528249;4788.233882578771;4812.8796780080775;4930.161872481615;4956.3804524434445;4964.404271487445;4989.351384320015;5015.623828212826;4940.975295123501;5041.823536176216;5060.165072762953;5062.392512898476;5103.617228707788;4867.513248675245;4900.92648610264;4952.5542701157065;4967.82612608557;4974.204127339608;4886.975565122151;4901.779419926183;4909.569762967354;4918.532739389752;4982.8754281143265;4738.384010078667;4836.371271734652;4843.370361852936;4847.200211964986;4854.150523658416;4883.267509873547;4893.339399181207;4930.038642464829;4955.752212389438;4970.130227210296;4812.157872372391;4829.106615276185;4839.274108883696;4846.127697014571;4881.829135980223 11:31:44 INFO - PROCESS | 5833 | |1;ext.html;581.0151792711356;602.743833870605;621.0994058615008;631.2015300644682;636.2619361540613;33871;34721.30557388851;34891.127721806966;34913;34969;36784;37954;38022.8098859506;38065;38137.809310953475;7594.468387212897;7785.610719464004;7825.921740782576;7826.7651970440975;7857.214278572125;7695.922570840087;7775.1447340792465;7790.493617914845;7792.220777922191;7806.024246969129;7673.654685539164;7802.375809935192;7816.648250828698;7831.099423566277;7853.64658590362;7661.118971318314;7711.691532338672;7725.884111738328;7753.457257991887;7808.180141085161;7510.436717246173;7533.2466753324225;7619.199984001655;7626.504277222019;7661.961690191569;35408.82295588506;36132.63867361319;36138;36149;36183.819080904424;2391.641253811925;2836.517791975369;3073.9077827665205;3129.937401251985;3139.7331226845745;25427.745722542724;26146.34634134143;26185.500483979016;26419.47161056768;27209;3000.354923691395;3033.8786448542032;3036.2561172512874;3088.644805847334;3152.7320177784914;168861.71260580662;168931.15534422372;169728;169817.99999999878;170201;32610.18474538108;33552.161195969806;33584;33748.156296092304;33755;34331.25349971996;34390.82804585961;34467.65532344695;34509.65490345115;34668.826655867066;12905.290209038592;13166;13172.934135329262;13200.73598528024;13202.537911173064;10437.32157409766;10472.947635261775;10493.160547156362;10499.580016799395;10509.316894401993;8217.753467395987;8273.586320683942;8296.626651800683;8313.459625124347;8393.6222869971;3228.1284053305476;3246.902592922216;3250.8212048337095;3291.8189499577275;3302.488114342281;849.76631426357;894.3381897395881;925.5141050948172;972.8881178664402;1026.1636766035658;27690.723092769218;28979.855100724362;28998.42003159925;29029.41941161165;29181.270468238465;1001.3040936549174;1019.7654539455818;1024.109025148111;1084.5336505302637;1111.6109361723331;15182.544523664308;15535.223238838013;15584.142872142142;15663.14743510123;15673.373065077269;371193;376601;377267;378302;379866;50923;51121;51368;51468.74265628648;51833;1224.8285240066398;1232.1990706041145;1233.2415564427993;1246.401727170945;1327.9575533206387;26672.466550669265;27815.582766258118;28095.43809123847;28284.292892677848;28976.13071607855;37500.62499374971;37711.81144094262;37718.43422348612;37921.051973699774;38217.235655287295;303299;311982;312099;312639;315292;25916.31543949637;26103.738962610132;26260.474790504464;26366;26383.34041648974;42299.365509518;43260.35109473298;43631.78184109059;43707.78146109249;43998.560014400726;36495.27009459849;36880.631193688794;37395;37487.43768843524;37925;36822.631773682995;36865.63134368622;36889.44665830069;37312.067198320256;37760.22397760202;27150.72849271561;32417.513737293488;32567.348653026333;32736.34527309488;36405;28925.56611650785;29286.560701589067;31757.8412107938;32458.188545286557;32523.512147317335;24020.039198431867;24666.753332467164;24751.25746227616;24774.464946120483;24878.253652390456 11:31:44 INFO - PROCESS | 5833 | |2;jquery.html;375.8985074030012;377.18716166660846;378.594903453305;381.75376881911166;387.3241194116267;15497.457588984387;15771.0537367758;16999.49001529956;17174.656506869855;17184.398546050907;15621.84378156218;16315.184240787972;16926.576835579086;17019.40432084877;17049.147542622883;5128.333316668837;5292.708901010443;5294.391145018334;5337.866553336159;5340.599455040868;2701.5272327342736;5186.403563590197;5234.241035049916;5239.030779305841;5247.344081989751;4979.427365852937;5097.082525145473;5105.821296254632;5109.795608175668;5130.07658621448;5129.871753206163;5132.384113906318;5168.896622067557;5171.7672704728375;5175;4489.910201795946;4589.1510070636705;4648.023914977859;4651.534846515356;4661.580457758818;19946.70079948802;20101.79898201014;20563.897180514152;20735.688964665544;20744.792552074436;1970.1429878003114;2160.157538559963;2438.2807071913826;2577.6391305217285;2608.373990242347;12900.677483062904;13222.206667599974;13358.131721438172;13449.462021519226;13799.172049677052;1816.1827177770056;1873.400511836213;2006.0772044859236;2010.678291473372;2038.9490262743402;59880.700596497176;61883.381166188214;64805.02792458164;68032.659836701;73025.26974730291;9585.568649410654;10014.449205293633;10128.088472037552;10282.742931426774;10314.226433017404;14290.499832505813;14328.641783955485;14404.639884002774;14415.63960900965;14427.42290308376;6904.13698287714;7041.119860017498;7123.857522849514;7136.857262854817;7142.4286057115305;6338.968305158444;6352.428281454691;6432.2602900667025;6528.60828350291;6543.541952063405;4429.424174857248;4470.195364834296;4493.370928070073;4497.752623605733;4559.224931761609;1835.4952388093382;1898.5760679490381;1923.7499125113925;1932.3043704266454;1940.1172466527696;954.737447202025;956.6986399284203;956.7129861041799;992.0327680511443;995.711243739322;16293.348266069224;16841.915790421215;16974;17026.404075857285;17073.829261707226;859;882.8499155143512;893.3523195683208;954.7565370830532;955.9753438025989;9150;9505.19205867509;9577.377470464398;9634.403878124647;9676.12914837668;407865.41380986804;409289;414811;420200;423240;64631;76023.23976760161;78274;79601.60199198966;83431.58284208662;944.0465130218391;950.2113246005798;955.8422860228123;978.9853152202722;980.7106903463496;15348.769768453705;15386.461473848361;15432.305546250222;15515.30181141874;15900.204989750235;25342;32193.35613287768;34855.128621783646;35222.8238858804;37072.81463592665;50526.494735053646;50534.241986370966;50735.74632126963;51008.97982040413;51387.48612513827;7254.927450725425;7595.5442673439775;7706.922930770621;7809.3362064225175;7815.101263354787;9955.253355998184;10140.594376224868;10482;11147.609833655782;11768.646940591796;9767.15618961064;9842.212622990286;9970.102690757867;9998.400095994264;10100.040496152853;9765.951170244103;9906.900930990598;10014.3490673106;10164.949175254076;10360.533775979948;9528.19010384125;9808.362456440309;10040.598376064876;10194.694159175237;10325.554422380723;7324.63376831167;7413.888791668021;7905.367570594223;7923.405744569065;8023.157568455228;8699.56502174876;9634.759131021781;9657.951710241405;9805.215582753506;9924.801503970024 11:31:44 INFO - PROCESS | 5833 | |3;mootools.html;1451.7532019556677;1472.271225743257;1629.8696104311657;1754.482427683833;1781.77727784027;6825.761098361559;7327.743528976487;7381.151167615726;7793.961030194848;7801.687932482701;7366.96316518418;7396.4082873370135;7441.702331906731;7441.9255807441905;7503.587302698349;2152.5264441822774;2217.079911836586;2218.7781221877763;2219.2343641443676;2224.73303203615;2157.385145233609;2164.2208804830248;2230.07451907459;2247.045005872506;2248.2243625949104;2198.1866709317574;2205.1179528188773;2206;2217.2018073493527;2223.466368071667;2135.9999999999923;2163.8485306028583;2167;2174.4672555223915;2176.270949232009;2137.871727696343;2155.5904378168098;2171.8479706420558;2185.0495034659975;2200.3728937252968;7629.2752188542;7713.807154821175;7714.575698336589;7715.1899050600005;7721.961390193013;4274.807633656493;4509.301058335963;4534.59188673021;4540.023894862587;4547.86356409305;2731.221601843465;2815.9859200704072;2833.951437967965;2854.3863069439963;2881.726236007576;857.3998201259144;865.5542395666174;866.9219770220648;882.6910581296495;888.6312180445108;10321.174306055498;10323.432211228379;10342.638007669695;10365.63720269787;10369.170466362748;4118.299889018874;4150.667946564267;4215.78921053946;4275.40144379787;4276.31578947367;8932.330075244383;8981.910180898238;8986.101389861093;8989.325800564853;9030.729078127666;4618.30725391194;4694.647901407408;4700.435947686299;4712.81148754046;4718.05638872227;3651.6713495785507;4096.09885825118;4197.3284274516545;4203.936940945889;4322.200392927319;3609.8917032489067;3651.379265524867;3695.316366472211;3702.1114932416026;3752.2870654575545;1206.6922934651607;1251.5056552661829;1252.5616034387892;1255.8492980842175;1259.1437822280755;759.3507551043889;867.5835598912557;892.4377642085444;905.2215095018279;935.219092058139;5000.474950130257;5079.619028572872;5159.484051594811;5185.325907632059;5275.287836142148;857.5583574459158;904.3488688144525;906.7687739626354;915.4232833315102;924.6024209589941;3549.449835275485;3567.7502574820032;3640.9453858192146;3650.324689932371;3652.6712595866497;9384.155426011692;9684.56419461126;9784.657536986171;9785.706428807147;9792.461414622121;9563.61745530171;9634;9714.979927107694;9720.07659272368;9803.754906127404;6732.259451460335;7103.2541583133025;7123.928760712327;7179.533330333512;7450.2549745026145;5372.62391632582;5458.263134476795;5510.641808282448;5516.282883225155;5696.917585658712;8494.193051660082;8700.608472618875;8808.91191088081;8811.691590794291;8896.911030889867;8625.39622226438;8936;9109.04355042711;9295.209907157698;9326;6159.692015399122;6309.621422714652;6483.902741458787;6632.568883022588;6787.389134977876;6985.511014229159;7004.579725216503;7016.789496315118;7068.11648543932;7071.045408869737;6222.657753823583;6466.385693359123;6516.250631177475;6541.738330466728;6596.043573681885;6300.527460440577;6417.422431981144;6575.736970521126;6789.830254243683;6847.726090956306;6196.659183744938;6265.96867015662;6270.341614130633;6306.968465157828;6316.368363163647;4471.195184866625;4557.453105627346;4651.279051746985;4660.743659098782;4745.264484004984;4534.229181039165;4545.2954792007295;4593.908121837611;4610.492845786894;4629.259318509023 11:31:44 INFO - PROCESS | 5833 | |4;prototype.html;295.75895645049286;297.2420328163186;303.7979743470592;304.13170398512244;312.2490410562597;5011.198208286671;5030.974845125774;5040.571551418125;5063.696178229309;5070.540787717954;4938.925916111261;4939.28380384844;4953.529414705597;4958.950410495894;4978.427480839705;3697.7411581189394;3790.9620903791024;3922.8029156237717;3928.469656596366;3939.3106206413904;3921.901952451183;3930.2925473414916;3944.644981951624;3945.2109578084355;3954.090559171392;3919.8432062717457;3934.5081864766903;3937.7243592948507;3941.3299739044432;3948.802559872009;3819.1788765415567;3916.6096035907412;3925.6466917977377;3930.233604447134;3932.252871954348;3482.407990641597;3485.9651403485896;3488.529048578435;3489.8778542750883;3512.5082488451635;4744.288356746481;4752.500987396308;4759.428868535798;4764.904701905977;4768.141734487791;4316.740995540277;4492.932606010912;4510.075434535912;4517.954820451786;4531.56950089741;5147.948520514784;5170.922436163461;5185.481451854822;5208.583313334924;5211.817586384458;3781.5273090863643;3799.67702745267;3804.828782704757;3816.46569480273;3837.2517359114986;5405;5437.34751829779;5439.592030597721;5456.454354564551;5476.863078423032;3572.28554289138;3775.6035616259896;3799.810009499514;3810.028442747137;3812;3824.388097904322;3834.1373191031794;3846.6922646188796;3863.2273545291055;3868.265029644415;4369.519352871182;4389.670774691911;4403.119376124788;4409.867703968886;4416.602505774432;5066.36670416198;5203.531682148625;5216.426193118754;5261.921071183935;5271.130263506555;1400.6078298076352;1403.8525954774807;1408.2888141488688;1412.1950488221821;1414.6675531250148;872.8777971084053;909.4452384045727;923.6951805904035;941.9952900235455;945.7588314979773;4466.486354069324;4598.632109431237;4617.882929022896;4622.375979242759;4632.675712700146;5336.866578335573;5354.223637572531;5360.381742323993;5408.891822163535;5417.024935511567;4434.512203657595;4591.609713174351;4599.563041511051;4599.942013336951;4629.421322334708;3065.7394121499924;3088.6448058473115;3104.301532155292;3113.190570451699;3122.7814053016073;5452.91820622683;5455.727213639302;5475.890482190334;5487.094629386186;5490.396056433789;5337.6797392156595;5608.383077861432;5626.015447296707;5889.911651325234;5925.170476133345;5113.1052065888325;5114.718690471986;5129.615003948988;5173.4221062575525;5192.299039629753;5485.286912701324;5486.61593688438;5500.1199808032125;5507.044999025288;5518.19986102021;5178.275041494118;5248.790048398021;5328.200769884548;5329.200619907045;5339.279197308314;5115;5124.948750512447;5142.717150556606;5164.509371609691;5172.19830926207;3820.789856557916;3871.787051712183;3873.3415319396336;3873.7094717896834;3883.30100581898;5332.0004998125705;5400.837974860603;5401.297831281908;5418.539424148991;5426.782928682808;5170.819021334386;5235.60732945023;5239.9782042502875;5246.239295302236;5312.893742125213;5083.593312535062;5191.766370513412;5200.6619569727845;5269.78920843162;5299.178627312773;5092.618053645917;5192.07893079563;5215.956808638211;5236.554892834151;5248.317718696545;5040.521150490697;5064.366954130734;5262.447443018428;5264.473552644705;5284.233786101071;5091.261767043832;5105.285260063668;5122.129238029618;5149.768260428365;5157.381114266162 11:31:44 INFO - PROCESS | 5833 | |5;yui.html;611.513846492039;668.3283300283215;677.2888467109536;698.9930100698991;702.3573430311266;11661.941690291558;11723.179377443572;11886.940565297173;11892.64322070337;12008.819867701981;12068.637940861767;12093.334866582334;12098;12138.453769580368;12164.452599633016;626.6866566716642;782.12402109637;794.1700922535935;805.1465446626565;815.7634286057037;807.1041144329789;807.8828569857396;809.3767798794925;811.809224832164;813.3005615170948;836.1513064239801;837.4975014991018;837.7193640130564;843.4180415513307;847.9618417171212;832.2634468495364;833.1793183714067;838.0822998816348;839.0686338164633;842.3934766967774;615.6029361062135;618.1068356225256;619.2970977940025;619.9597026193283;623.0498489803041;10466.52900619474;10500.317479363894;10507.159427245879;10510.632127875488;10515.369077855354;11662.825057624057;11802.881971180264;12108.21296615717;12154.141355895199;12312.384380780924;9330.58012389444;9403.341766076377;9411.529423528797;9454.43273403598;9494.762630934281;3156.447621666199;3167.683231676814;3189.4577921753357;3231.709146176832;3253.4469140246215;44165.558344416786;44368.55631443709;44405.33391999122;45821.08357832858;46075.769621152016;9276.814463710823;9287.860682089775;9355.95322023399;9426.481543515172;9727.07592778685;16969.406070787463;17028;17033.148342582823;17037.914810425867;17109.486715398558;6334.271558770708;6457.1282876811965;6486.254080780676;6549.279579246279;6678.532502724763;3754.324221640131;3766.9246615067545;3772.5095737553943;3820.4460353248624;3823.923521529554;2781.9443611127663;2811.1566530041314;2828.702986186462;2839.559868220429;2844.587534807483;485.0807719371771;505.1160469178937;507.1530543991543;514.3801718928682;514.6860415146757;559.6669981361084;605.1950905295946;610.8747706720112;611.5443994224331;644.1979735229669;7408.370288525428;7789.1042530108625;7806.921930780733;8072.596370181467;8121.309688676529;545.7544105152697;575.4274496875552;584.4360192414341;591.9200907877467;605.9394060593994;3659.323025240339;3745.606711295329;3803.31540322739;3822.6559609635265;3830.8276127574327;51175;51734;52173.47826521762;53055.734721326146;53137.468625314024;45855;46254;46701.5329846704;48205.75897120492;48852;41725.37411938823;42183.578164218576;43056.569434305886;43406.565934340884;44026;7225.169105552718;7230.819229519304;7291.234420385783;7334.156571994289;7751.8837217442915;26956.191314260603;27854.16437506878;28077;28545.571816423184;29415;39230.41154382744;39519.407208892466;39579.80210098931;39596.20807583775;40511.797441012604;10214.131798796889;10232.897671023493;10292.382457052301;10407.427591482541;10585.841212381974;11708.941455292668;11709.180357375242;11843.23019003762;11996.280223186637;12003.579874704343;10730;10812.189085818753;11381.601643942422;11565.248258863146;11617.419129043683;10425.165986721197;10707.839382409426;10847.349159050482;11152.665420037412;11182.608608698656;10631.8936810634;10842.186835987175;10923.508442119964;11044.668659940215;11188.272762270426;8501.702440414803;9094.363394562317;9156.292538052221;9972.152367048882;10102.494875256061;8849.823003540021;8918.10818918129;9006.09652667612;9064.682736104205;9144.58849351794 11:31:44 INFO - PROCESS | 5833 | __end_tp_report 11:31:44 INFO - PROCESS | 5833 | __start_cc_report 11:31:44 INFO - PROCESS | 5833 | _x_x_mozilla_cycle_collect,380 11:31:44 INFO - PROCESS | 5833 | __end_cc_report 11:31:44 INFO - PROCESS | 5833 | __startTimestamp1461954704503__endTimestamp 11:31:44 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | ------- Summary: start ------- 11:31:44 INFO - PROCESS | 5833 | Number of tests: 6 11:31:44 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | [#0] dojo.html Cycles:165 Average:4673.43 Median:4800.99 stddev:476.30 (9.9%) stddev-sans-first:449.07 11:31:44 INFO - PROCESS | 5833 | Values: 2597.8 2678.0 2697.8 2706.6 2709.2 4724.3 4753.1 4774.5 4781.6 4821.3 4693.2 4705.2 4724.1 4802.1 4808.5 4364.6 4376.8 4431.8 4436.7 4477.4 4390.3 4485.5 4487.6 4525.3 4529.9 4228.4 4352.8 4389.0 4428.2 4462.2 4358.1 4377.0 4394.0 4394.4 4432.2 4347.0 4357.7 4365.9 4384.8 4407.3 4613.3 4630.8 4674.8 4698.1 4706.7 4976.6 5007.8 5016.1 5030.3 5079.7 4955.2 5044.8 5065.8 5066.1 5108.9 4721.2 4733.7 4758.8 4779.0 4789.6 5113.9 5163.0 5180.1 5180.8 5213.8 4801.0 4926.1 4962.4 4983.2 4997.1 4937.8 5097.9 5130.2 5136.9 5176.7 5032.4 5050.7 5056.3 5058.4 5099.5 4855.0 4979.9 5005.1 5011.8 5061.0 4267.0 4268.4 4283.9 4305.7 4331.2 3715.4 3721.3 3722.0 3751.0 3766.5 4211.9 4337.4 4340.0 4368.8 4395.7 5054.1 5054.4 5057.2 5077.6 5114.2 4349.6 4360.0 4366.5 4378.0 4402.0 4395.3 4530.9 4536.9 4549.4 4596.1 4689.3 4715.4 4720.6 4730.1 4734.2 4988.5 4994.9 5022.3 5032.7 5040.5 4615.4 4746.5 4756.6 4788.2 4812.9 4930.2 4956.4 4964.4 4989.4 5015.6 4941.0 5041.8 5060.2 5062.4 5103.6 4867.5 4900.9 4952.6 4967.8 4974.2 4887.0 4901.8 4909.6 4918.5 4982.9 4738.4 4836.4 4843.4 4847.2 4854.2 4883.3 4893.3 4930.0 4955.8 4970.1 4812.2 4829.1 4839.3 4846.1 4881.8 11:31:44 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | [#1] ext.html Cycles:180 Average:42688.87 Median:34101.13 stddev:78969.50 (231.6%) stddev-sans-first:79127.75 11:31:44 INFO - PROCESS | 5833 | Values: 581.0 602.7 621.1 631.2 636.3 33871.0 34721.3 34891.1 34913.0 34969.0 36784.0 37954.0 38022.8 38065.0 38137.8 7594.5 7785.6 7825.9 7826.8 7857.2 7695.9 7775.1 7790.5 7792.2 7806.0 7673.7 7802.4 7816.6 7831.1 7853.6 7661.1 7711.7 7725.9 7753.5 7808.2 7510.4 7533.2 7619.2 7626.5 7662.0 35408.8 36132.6 36138.0 36149.0 36183.8 2391.6 2836.5 3073.9 3129.9 3139.7 25427.7 26146.3 26185.5 26419.5 27209.0 3000.4 3033.9 3036.3 3088.6 3152.7 168861.7 168931.2 169728.0 169818.0 170201.0 32610.2 33552.2 33584.0 33748.2 33755.0 34331.3 34390.8 34467.7 34509.7 34668.8 12905.3 13166.0 13172.9 13200.7 13202.5 10437.3 10472.9 10493.2 10499.6 10509.3 8217.8 8273.6 8296.6 8313.5 8393.6 3228.1 3246.9 3250.8 3291.8 3302.5 849.8 894.3 925.5 972.9 1026.2 27690.7 28979.9 28998.4 29029.4 29181.3 1001.3 1019.8 1024.1 1084.5 1111.6 15182.5 15535.2 15584.1 15663.1 15673.4 371193.0 376601.0 377267.0 378302.0 379866.0 50923.0 51121.0 51368.0 51468.7 51833.0 1224.8 1232.2 1233.2 1246.4 1328.0 26672.5 27815.6 28095.4 28284.3 28976.1 37500.6 37711.8 37718.4 37921.1 38217.2 303299.0 311982.0 312099.0 312639.0 315292.0 25916.3 26103.7 26260.5 26366.0 26383.3 42299.4 43260.4 43631.8 43707.8 43998.6 36495.3 36880.6 37395.0 37487.4 37925.0 36822.6 36865.6 36889.4 37312.1 37760.2 27150.7 32417.5 32567.3 32736.3 36405.0 28925.6 29286.6 31757.8 32458.2 32523.5 24020.0 24666.8 24751.3 24774.5 24878.3 11:31:44 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | [#2] jquery.html Cycles:180 Average:24771.88 Median:4820.50 stddev:68311.15 (1417.1%) stddev-sans-first:68478.22 11:31:44 INFO - PROCESS | 5833 | Values: 375.9 377.2 378.6 381.8 387.3 15497.5 15771.1 16999.5 17174.7 17184.4 15621.8 16315.2 16926.6 17019.4 17049.1 5128.3 5292.7 5294.4 5337.9 5340.6 2701.5 5186.4 5234.2 5239.0 5247.3 4979.4 5097.1 5105.8 5109.8 5130.1 5129.9 5132.4 5168.9 5171.8 5175.0 4489.9 4589.2 4648.0 4651.5 4661.6 19946.7 20101.8 20563.9 20735.7 20744.8 1970.1 2160.2 2438.3 2577.6 2608.4 12900.7 13222.2 13358.1 13449.5 13799.2 1816.2 1873.4 2006.1 2010.7 2038.9 59880.7 61883.4 64805.0 68032.7 73025.3 9585.6 10014.4 10128.1 10282.7 10314.2 14290.5 14328.6 14404.6 14415.6 14427.4 6904.1 7041.1 7123.9 7136.9 7142.4 6339.0 6352.4 6432.3 6528.6 6543.5 4429.4 4470.2 4493.4 4497.8 4559.2 1835.5 1898.6 1923.7 1932.3 1940.1 954.7 956.7 956.7 992.0 995.7 16293.3 16841.9 16974.0 17026.4 17073.8 859.0 882.8 893.4 954.8 956.0 9150.0 9505.2 9577.4 9634.4 9676.1 407865.4 409289.0 414811.0 420200.0 423240.0 64631.0 76023.2 78274.0 79601.6 83431.6 944.0 950.2 955.8 979.0 980.7 15348.8 15386.5 15432.3 15515.3 15900.2 25342.0 32193.4 34855.1 35222.8 37072.8 50526.5 50534.2 50735.7 51009.0 51387.5 7254.9 7595.5 7706.9 7809.3 7815.1 9955.3 10140.6 10482.0 11147.6 11768.6 9767.2 9842.2 9970.1 9998.4 10100.0 9766.0 9906.9 10014.3 10164.9 10360.5 9528.2 9808.4 10040.6 10194.7 10325.6 7324.6 7413.9 7905.4 7923.4 8023.2 8699.6 9634.8 9658.0 9805.2 9924.8 11:31:44 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | [#3] mootools.html Cycles:180 Average:5080.97 Median:5415.44 stddev:2806.41 (51.8%) stddev-sans-first:2801.03 11:31:44 INFO - PROCESS | 5833 | Values: 1451.8 1472.3 1629.9 1754.5 1781.8 6825.8 7327.7 7381.2 7794.0 7801.7 7367.0 7396.4 7441.7 7441.9 7503.6 2152.5 2217.1 2218.8 2219.2 2224.7 2157.4 2164.2 2230.1 2247.0 2248.2 2198.2 2205.1 2206.0 2217.2 2223.5 2136.0 2163.8 2167.0 2174.5 2176.3 2137.9 2155.6 2171.8 2185.0 2200.4 7629.3 7713.8 7714.6 7715.2 7722.0 4274.8 4509.3 4534.6 4540.0 4547.9 2731.2 2816.0 2834.0 2854.4 2881.7 857.4 865.6 866.9 882.7 888.6 10321.2 10323.4 10342.6 10365.6 10369.2 4118.3 4150.7 4215.8 4275.4 4276.3 8932.3 8981.9 8986.1 8989.3 9030.7 4618.3 4694.6 4700.4 4712.8 4718.1 3651.7 4096.1 4197.3 4203.9 4322.2 3609.9 3651.4 3695.3 3702.1 3752.3 1206.7 1251.5 1252.6 1255.8 1259.1 759.4 867.6 892.4 905.2 935.2 5000.5 5079.6 5159.5 5185.3 5275.3 857.6 904.3 906.8 915.4 924.6 3549.4 3567.8 3640.9 3650.3 3652.7 9384.2 9684.6 9784.7 9785.7 9792.5 9563.6 9634.0 9715.0 9720.1 9803.8 6732.3 7103.3 7123.9 7179.5 7450.3 5372.6 5458.3 5510.6 5516.3 5696.9 8494.2 8700.6 8808.9 8811.7 8896.9 8625.4 8936.0 9109.0 9295.2 9326.0 6159.7 6309.6 6483.9 6632.6 6787.4 6985.5 7004.6 7016.8 7068.1 7071.0 6222.7 6466.4 6516.3 6541.7 6596.0 6300.5 6417.4 6575.7 6789.8 6847.7 6196.7 6266.0 6270.3 6307.0 6316.4 4471.2 4557.5 4651.3 4660.7 4745.3 4534.2 4545.3 4593.9 4610.5 4629.3 11:31:44 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | [#4] prototype.html Cycles:180 Average:4380.47 Median:5021.09 stddev:1262.30 (25.1%) stddev-sans-first:1228.04 11:31:44 INFO - PROCESS | 5833 | Values: 295.8 297.2 303.8 304.1 312.2 5011.2 5031.0 5040.6 5063.7 5070.5 4938.9 4939.3 4953.5 4959.0 4978.4 3697.7 3791.0 3922.8 3928.5 3939.3 3921.9 3930.3 3944.6 3945.2 3954.1 3919.8 3934.5 3937.7 3941.3 3948.8 3819.2 3916.6 3925.6 3930.2 3932.3 3482.4 3486.0 3488.5 3489.9 3512.5 4744.3 4752.5 4759.4 4764.9 4768.1 4316.7 4492.9 4510.1 4518.0 4531.6 5147.9 5170.9 5185.5 5208.6 5211.8 3781.5 3799.7 3804.8 3816.5 3837.3 5405.0 5437.3 5439.6 5456.5 5476.9 3572.3 3775.6 3799.8 3810.0 3812.0 3824.4 3834.1 3846.7 3863.2 3868.3 4369.5 4389.7 4403.1 4409.9 4416.6 5066.4 5203.5 5216.4 5261.9 5271.1 1400.6 1403.9 1408.3 1412.2 1414.7 872.9 909.4 923.7 942.0 945.8 4466.5 4598.6 4617.9 4622.4 4632.7 5336.9 5354.2 5360.4 5408.9 5417.0 4434.5 4591.6 4599.6 4599.9 4629.4 3065.7 3088.6 3104.3 3113.2 3122.8 5452.9 5455.7 5475.9 5487.1 5490.4 5337.7 5608.4 5626.0 5889.9 5925.2 5113.1 5114.7 5129.6 5173.4 5192.3 5485.3 5486.6 5500.1 5507.0 5518.2 5178.3 5248.8 5328.2 5329.2 5339.3 5115.0 5124.9 5142.7 5164.5 5172.2 3820.8 3871.8 3873.3 3873.7 3883.3 5332.0 5400.8 5401.3 5418.5 5426.8 5170.8 5235.6 5240.0 5246.2 5312.9 5083.6 5191.8 5200.7 5269.8 5299.2 5092.6 5192.1 5216.0 5236.6 5248.3 5040.5 5064.4 5262.4 5264.5 5284.2 5091.3 5105.3 5122.1 5149.8 5157.4 11:31:44 INFO - PROCESS | 5833 | 11:31:44 INFO - PROCESS | 5833 | [#5] yui.html Cycles:180 Average:12570.91 Median:45965.38 stddev:14472.83 (31.5%) stddev-sans-first:14485.56 11:31:44 INFO - PROCESS | 5833 | Values: 611.5 668.3 677.3 699.0 702.4 11661.9 11723.2 11886.9 11892.6 12008.8 12068.6 12093.3 12098.0 12138.5 12164.5 626.7 782.1 794.2 805.1 815.8 807.1 807.9 809.4 811.8 813.3 836.2 837.5 837.7 843.4 848.0 832.3 833.2 838.1 839.1 842.4 615.6 618.1 619.3 620.0 623.0 10466.5 10500.3 10507.2 10510.6 10515.4 11662.8 11802.9 12108.2 12154.1 12312.4 9330.6 9403.3 9411.5 9454.4 9494.8 3156.4 3167.7 3189.5 3231.7 3253.4 44165.6 44368.6 44405.3 45821.1 46075.8 9276.8 9287.9 9356.0 9426.5 9727.1 16969.4 17028.0 17033.1 17037.9 17109.5 6334.3 6457.1 6486.3 6549.3 6678.5 3754.3 3766.9 3772.5 3820.4 3823.9 2781.9 2811.2 2828.7 2839.6 2844.6 485.1 505.1 507.2 514.4 514.7 559.7 605.2 610.9 611.5 644.2 7408.4 7789.1 7806.9 8072.6 8121.3 545.8 575.4 584.4 591.9 605.9 3659.3 3745.6 3803.3 3822.7 3830.8 51175.0 51734.0 52173.5 53055.7 53137.5 45855.0 46254.0 46701.5 48205.8 48852.0 41725.4 42183.6 43056.6 43406.6 44026.0 7225.2 7230.8 7291.2 7334.2 7751.9 26956.2 27854.2 28077.0 28545.6 29415.0 39230.4 39519.4 39579.8 39596.2 40511.8 10214.1 10232.9 10292.4 10407.4 10585.8 11708.9 11709.2 11843.2 11996.3 12003.6 10730.0 10812.2 11381.6 11565.2 11617.4 10425.2 10707.8 10847.3 11152.7 11182.6 10631.9 10842.2 10923.5 11044.7 11188.3 8501.7 9094.4 9156.3 9972.2 10102.5 8849.8 8918.1 9006.1 9064.7 9144.6 11:31:44 INFO - PROCESS | 5833 | -------- Summary: end -------- 11:31:44 INFO - PROCESS | 5833 | 11:31:45 INFO - TEST-INFO | 5833: exit 0 11:31:45 INFO - TEST-OK | dromaeo_css | took 1116426ms 11:31:45 INFO - TEST-START | kraken 11:31:45 INFO - operating with platform_type : linux_ 11:31:45 INFO - Initialising browser for kraken test... 11:31:45 INFO - TEST-INFO | started process 6067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnX63Ap/profile http://localhost:43276/getInfo.html) 11:31:48 INFO - PROCESS | 6067 | 11:31:48 INFO - PROCESS | 6067 | (process:6133): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:31:49 INFO - PROCESS | 6067 | __metrics Screen width/height:1600/1200 11:31:49 INFO - PROCESS | 6067 | colorDepth:24 11:31:49 INFO - PROCESS | 6067 | Browser inner width/height: 1024/697 11:31:49 INFO - PROCESS | 6067 | __metrics 11:31:50 ERROR - PROCESS | 6067 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:31:51 INFO - TEST-INFO | 6067: exit 0 11:31:51 INFO - Browser initialized. 11:31:51 INFO - Running cycle 1/1 for kraken test... 11:31:51 INFO - TEST-INFO | started process 6184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnX63Ap/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:53 INFO - PROCESS | 6184 | 11:31:53 INFO - PROCESS | 6184 | (process:6244): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:32:03 INFO - PROCESS | 6184 | RSS: Main: 165867520 11:32:03 INFO - PROCESS | 6184 | 11:32:05 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43276/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:06 INFO - PROCESS | 6184 | RSS: Main: 169537536 11:32:06 INFO - PROCESS | 6184 | 11:32:09 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43276/tests/kraken/driver.html?testName=audio-dft) 11:32:10 INFO - PROCESS | 6184 | RSS: Main: 172765184 11:32:10 INFO - PROCESS | 6184 | 11:32:13 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43276/tests/kraken/driver.html?testName=audio-fft) 11:32:13 INFO - PROCESS | 6184 | RSS: Main: 164876288 11:32:13 INFO - PROCESS | 6184 | 11:32:15 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43276/tests/kraken/driver.html?testName=audio-oscillator) 11:32:16 INFO - PROCESS | 6184 | RSS: Main: 165412864 11:32:16 INFO - PROCESS | 6184 | 11:32:18 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:19 INFO - PROCESS | 6184 | RSS: Main: 166731776 11:32:19 INFO - PROCESS | 6184 | 11:32:22 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43276/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:23 INFO - PROCESS | 6184 | RSS: Main: 166191104 11:32:23 INFO - PROCESS | 6184 | 11:32:26 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43276/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:27 INFO - PROCESS | 6184 | RSS: Main: 165928960 11:32:27 INFO - PROCESS | 6184 | 11:32:30 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43276/tests/kraken/driver.html?testName=json-parse-financial) 11:32:30 INFO - PROCESS | 6184 | RSS: Main: 166133760 11:32:30 INFO - PROCESS | 6184 | 11:32:32 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:33 INFO - PROCESS | 6184 | RSS: Main: 166461440 11:32:33 INFO - PROCESS | 6184 | 11:32:34 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43276/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:35 INFO - PROCESS | 6184 | RSS: Main: 166473728 11:32:35 INFO - PROCESS | 6184 | 11:32:37 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:38 INFO - PROCESS | 6184 | RSS: Main: 167002112 11:32:38 INFO - PROCESS | 6184 | 11:32:41 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:41 INFO - PROCESS | 6184 | RSS: Main: 167317504 11:32:41 INFO - PROCESS | 6184 | 11:32:44 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:45 INFO - PROCESS | 6184 | RSS: Main: 167596032 11:32:45 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | Cycle 1(1): loaded http://localhost:43276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43276/tests/kraken/driver.html?testName=ai-astar) 11:32:47 INFO - PROCESS | 6184 | RSS: Main: 168321024 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | __start_tp_report 11:32:47 INFO - PROCESS | 6184 | _x_x_mozilla_page_load 11:32:47 INFO - PROCESS | 6184 | _x_x_mozilla_page_load_details 11:32:47 INFO - PROCESS | 6184 | |i|pagename|runs| 11:32:47 INFO - PROCESS | 6184 | |0;ai-astar;113;107;117;113;116;125;113;113;112;113 11:32:47 INFO - PROCESS | 6184 | |1;audio-beat-detection;174;133;166;189;134;164;157;133;196;133 11:32:47 INFO - PROCESS | 6184 | |2;audio-dft;166;162;165;172;164;160;162;162;164;163 11:32:47 INFO - PROCESS | 6184 | |3;audio-fft;77;76;74;157;78;76;74;76;156;74 11:32:47 INFO - PROCESS | 6184 | |4;audio-oscillator;94;94;153;95;94;94;148;94;93;140 11:32:47 INFO - PROCESS | 6184 | |5;imaging-gaussian-blur;118;118;119;117;118;118;118;117;118;117 11:32:47 INFO - PROCESS | 6184 | |6;imaging-darkroom;149;147;147;147;148;147;147;147;147;147 11:32:47 INFO - PROCESS | 6184 | |7;imaging-desaturate;95;96;95;96;97;96;95;95;95;96 11:32:47 INFO - PROCESS | 6184 | |8;json-parse-financial;67;68;66;65;65;65;67;82;66;65 11:32:47 INFO - PROCESS | 6184 | |9;json-stringify-tinderbox;67;66;66;67;68;68;66;65;66;66 11:32:47 INFO - PROCESS | 6184 | |10;stanford-crypto-aes;78;82;79;79;81;80;80;80;81;81 11:32:47 INFO - PROCESS | 6184 | |11;stanford-crypto-ccm;141;132;129;138;133;129;134;136;180;150 11:32:47 INFO - PROCESS | 6184 | |12;stanford-crypto-pbkdf2;174;172;174;182;183;173;175;179;180;174 11:32:47 INFO - PROCESS | 6184 | |13;stanford-crypto-sha256-iterative;72;73;74;71;72;76;75;72;72;74 11:32:47 INFO - PROCESS | 6184 | __end_tp_report 11:32:47 INFO - PROCESS | 6184 | __start_cc_report 11:32:47 INFO - PROCESS | 6184 | _x_x_mozilla_cycle_collect,932 11:32:47 INFO - PROCESS | 6184 | __end_cc_report 11:32:47 INFO - PROCESS | 6184 | __startTimestamp1461954767500__endTimestamp 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | ------- Summary: start ------- 11:32:47 INFO - PROCESS | 6184 | Number of tests: 14 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#0] ai-astar Cycles:10 Average:114.20 Median:113.00 stddev:4.61 (4.1%) stddev-sans-first:4.87 11:32:47 INFO - PROCESS | 6184 | Values: 113.0 107.0 117.0 113.0 116.0 125.0 113.0 113.0 112.0 113.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:165.00 stddev:24.07 (14.6%) stddev-sans-first:24.81 11:32:47 INFO - PROCESS | 6184 | Values: 174.0 133.0 166.0 189.0 134.0 164.0 157.0 133.0 196.0 133.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:3.30 (2.0%) stddev-sans-first:3.42 11:32:47 INFO - PROCESS | 6184 | Values: 166.0 162.0 165.0 172.0 164.0 160.0 162.0 162.0 164.0 163.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.00 stddev:34.13 (44.9%) stddev-sans-first:35.77 11:32:47 INFO - PROCESS | 6184 | Values: 77.0 76.0 74.0 157.0 78.0 76.0 74.0 76.0 156.0 74.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:94.00 stddev:25.79 (27.4%) stddev-sans-first:26.71 11:32:47 INFO - PROCESS | 6184 | Values: 94.0 94.0 153.0 95.0 94.0 94.0 148.0 94.0 93.0 140.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:32:47 INFO - PROCESS | 6184 | Values: 118.0 118.0 119.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.33 11:32:47 INFO - PROCESS | 6184 | Values: 149.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 11:32:47 INFO - PROCESS | 6184 | Values: 95.0 96.0 95.0 96.0 97.0 96.0 95.0 95.0 95.0 96.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:66.50 stddev:5.17 (7.8%) stddev-sans-first:5.48 11:32:47 INFO - PROCESS | 6184 | Values: 67.0 68.0 66.0 65.0 65.0 65.0 67.0 82.0 66.0 65.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 11:32:47 INFO - PROCESS | 6184 | Values: 67.0 66.0 66.0 67.0 68.0 68.0 66.0 65.0 66.0 66.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.50 stddev:1.20 (1.5%) stddev-sans-first:1.00 11:32:47 INFO - PROCESS | 6184 | Values: 78.0 82.0 79.0 79.0 81.0 80.0 80.0 80.0 81.0 81.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:137.00 stddev:15.32 (11.2%) stddev-sans-first:16.24 11:32:47 INFO - PROCESS | 6184 | Values: 141.0 132.0 129.0 138.0 133.0 129.0 134.0 136.0 180.0 150.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.00 stddev:4.01 (2.3%) stddev-sans-first:4.14 11:32:47 INFO - PROCESS | 6184 | Values: 174.0 172.0 174.0 182.0 183.0 173.0 175.0 179.0 180.0 174.0 11:32:47 INFO - PROCESS | 6184 | 11:32:47 INFO - PROCESS | 6184 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.50 stddev:1.60 (2.2%) stddev-sans-first:1.64 11:32:47 INFO - PROCESS | 6184 | Values: 72.0 73.0 74.0 71.0 72.0 76.0 75.0 72.0 72.0 74.0 11:32:47 INFO - PROCESS | 6184 | -------- Summary: end -------- 11:32:47 INFO - PROCESS | 6184 | 11:32:48 INFO - TEST-INFO | 6184: exit 0 11:32:48 INFO - TEST-OK | kraken | took 63306ms 11:32:48 INFO - SUITE-END | took 1179s 11:32:48 INFO - Completed test suite (00:19:39) 11:32:48 INFO - javascript benchmark 11:32:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2597.805164612654, 2677.9598306025414, 2697.824641398308, 2706.648135742353, 2709.1601603502913, 4724.314974328725, 4753.144434001878, 4774.522547745228, 4781.569658730714, 4821.27680847873, 4693.202155633542, 4705.200115980283, 4724.102420540095, 4802.111609352263, 4808.543188397105, 4364.585364390377, 4376.781160941956, 4431.822727090913, 4436.689431739779, 4477.350784136298, 4390.341448782676, 4485.461744590637, 4487.618552423048, 4525.343825145352, 4529.864104076866, 4228.4080228768, 4352.7605981670995, 4389.034412429261, 4428.202923473774, 4462.1968045751755, 4358.128374325148, 4377.03705184862, 4394.033312671239, 4394.4287242658565, 4432.180046691373, 4347.043650396908, 4357.673174511892, 4365.911581118419, 4384.802683879233, 4407.294832826732, 4613.261878099522, 4630.814767409333, 4674.836380726658, 4698.08387364464, 4706.7175969441605, 4976.626752993504, 5007.84976450707, 5016.072026675077, 5030.270610761456, 5079.746012699387, 4955.182394904837, 5044.8234311798915, 5065.822696205615, 5066.088104141253, 5108.948910510884, 4721.197396442579, 4733.739644319596, 4758.762061896891, 4778.976105119452, 4789.640776941674, 5113.923291150636, 5163.044836705221, 5180.067587834226, 5180.834312279782, 5213.791448342024, 4800.991791723777, 4926.0886735953245, 4962.379702537183, 4983.202687569971, 4997.125503036954, 4937.802487900443, 5097.923531147036, 5130.230465430141, 5136.948630513722, 5176.663516871391, 5032.3961124665275, 5050.747462626854, 5056.317397151338, 5058.418281897555, 5099.464556221617, 4854.95145048545, 4979.925301120486, 5005.074061298671, 5011.84964451067, 5061.038402703474, 4266.975925777853, 4268.445102136702, 4283.87148385549, 4305.655547556188, 4331.177076355482, 3715.405535114369, 3721.3115573618966, 3721.981390093032, 3751.0434839116397, 3766.5103536540073, 4211.873643790691, 4337.371081193272, 4340.0, 4368.781560922005, 4395.714278571946, 5054.115529782273, 5054.368203974504, 5057.190849464068, 5077.568406685399, 5114.156164232934, 4349.586789255016, 4359.956400436018, 4366.454193225847, 4377.978110109493, 4402.031553058322, 4395.318725597537, 4530.88672783183, 4536.8638940831825, 4549.385832912581, 4596.080783843245, 4689.273162659793, 4715.434147902137, 4720.622350211906, 4730.148573256847, 4734.21885388907, 4988.501149884983, 4994.875128121826, 5022.296878437095, 5032.723200223876, 5040.49595040493, 4615.446146462312, 4746.5490778376, 4756.571908528249, 4788.233882578771, 4812.8796780080775, 4930.161872481615, 4956.3804524434445, 4964.404271487445, 4989.351384320015, 5015.623828212826, 4940.975295123501, 5041.823536176216, 5060.165072762953, 5062.392512898476, 5103.617228707788, 4867.513248675245, 4900.92648610264, 4952.5542701157065, 4967.82612608557, 4974.204127339608, 4886.975565122151, 4901.779419926183, 4909.569762967354, 4918.532739389752, 4982.8754281143265, 4738.384010078667, 4836.371271734652, 4843.370361852936, 4847.200211964986, 4854.150523658416, 4883.267509873547, 4893.339399181207, 4930.038642464829, 4955.752212389438, 4970.130227210296, 4812.157872372391, 4829.106615276185, 4839.274108883696, 4846.127697014571, 4881.829135980223], "value": 4643.856011848793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.0151792711356, 602.743833870605, 621.0994058615008, 631.2015300644682, 636.2619361540613, 33871.0, 34721.30557388851, 34891.127721806966, 34913.0, 34969.0, 36784.0, 37954.0, 38022.8098859506, 38065.0, 38137.809310953475, 7594.468387212897, 7785.610719464004, 7825.921740782576, 7826.7651970440975, 7857.214278572125, 7695.922570840087, 7775.1447340792465, 7790.493617914845, 7792.220777922191, 7806.024246969129, 7673.654685539164, 7802.375809935192, 7816.648250828698, 7831.099423566277, 7853.64658590362, 7661.118971318314, 7711.691532338672, 7725.884111738328, 7753.457257991887, 7808.180141085161, 7510.436717246173, 7533.2466753324225, 7619.199984001655, 7626.504277222019, 7661.961690191569, 35408.82295588506, 36132.63867361319, 36138.0, 36149.0, 36183.819080904424, 2391.641253811925, 2836.517791975369, 3073.9077827665205, 3129.937401251985, 3139.7331226845745, 25427.745722542724, 26146.34634134143, 26185.500483979016, 26419.47161056768, 27209.0, 3000.354923691395, 3033.8786448542032, 3036.2561172512874, 3088.644805847334, 3152.7320177784914, 168861.71260580662, 168931.15534422372, 169728.0, 169817.99999999878, 170201.0, 32610.18474538108, 33552.161195969806, 33584.0, 33748.156296092304, 33755.0, 34331.25349971996, 34390.82804585961, 34467.65532344695, 34509.65490345115, 34668.826655867066, 12905.290209038592, 13166.0, 13172.934135329262, 13200.73598528024, 13202.537911173064, 10437.32157409766, 10472.947635261775, 10493.160547156362, 10499.580016799395, 10509.316894401993, 8217.753467395987, 8273.586320683942, 8296.626651800683, 8313.459625124347, 8393.6222869971, 3228.1284053305476, 3246.902592922216, 3250.8212048337095, 3291.8189499577275, 3302.488114342281, 849.76631426357, 894.3381897395881, 925.5141050948172, 972.8881178664402, 1026.1636766035658, 27690.723092769218, 28979.855100724362, 28998.42003159925, 29029.41941161165, 29181.270468238465, 1001.3040936549174, 1019.7654539455818, 1024.109025148111, 1084.5336505302637, 1111.6109361723331, 15182.544523664308, 15535.223238838013, 15584.142872142142, 15663.14743510123, 15673.373065077269, 371193.0, 376601.0, 377267.0, 378302.0, 379866.0, 50923.0, 51121.0, 51368.0, 51468.74265628648, 51833.0, 1224.8285240066398, 1232.1990706041145, 1233.2415564427993, 1246.401727170945, 1327.9575533206387, 26672.466550669265, 27815.582766258118, 28095.43809123847, 28284.292892677848, 28976.13071607855, 37500.62499374971, 37711.81144094262, 37718.43422348612, 37921.051973699774, 38217.235655287295, 303299.0, 311982.0, 312099.0, 312639.0, 315292.0, 25916.31543949637, 26103.738962610132, 26260.474790504464, 26366.0, 26383.34041648974, 42299.365509518, 43260.35109473298, 43631.78184109059, 43707.78146109249, 43998.560014400726, 36495.27009459849, 36880.631193688794, 37395.0, 37487.43768843524, 37925.0, 36822.631773682995, 36865.63134368622, 36889.44665830069, 37312.067198320256, 37760.22397760202, 27150.72849271561, 32417.513737293488, 32567.348653026333, 32736.34527309488, 36405.0, 28925.56611650785, 29286.560701589067, 31757.8412107938, 32458.188545286557, 32523.512147317335, 24020.039198431867, 24666.753332467164, 24751.25746227616, 24774.464946120483, 24878.253652390456], "value": 15918.641594952129, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.8985074030012, 377.18716166660846, 378.594903453305, 381.75376881911166, 387.3241194116267, 15497.457588984387, 15771.0537367758, 16999.49001529956, 17174.656506869855, 17184.398546050907, 15621.84378156218, 16315.184240787972, 16926.576835579086, 17019.40432084877, 17049.147542622883, 5128.333316668837, 5292.708901010443, 5294.391145018334, 5337.866553336159, 5340.599455040868, 2701.5272327342736, 5186.403563590197, 5234.241035049916, 5239.030779305841, 5247.344081989751, 4979.427365852937, 5097.082525145473, 5105.821296254632, 5109.795608175668, 5130.07658621448, 5129.871753206163, 5132.384113906318, 5168.896622067557, 5171.7672704728375, 5175.0, 4489.910201795946, 4589.1510070636705, 4648.023914977859, 4651.534846515356, 4661.580457758818, 19946.70079948802, 20101.79898201014, 20563.897180514152, 20735.688964665544, 20744.792552074436, 1970.1429878003114, 2160.157538559963, 2438.2807071913826, 2577.6391305217285, 2608.373990242347, 12900.677483062904, 13222.206667599974, 13358.131721438172, 13449.462021519226, 13799.172049677052, 1816.1827177770056, 1873.400511836213, 2006.0772044859236, 2010.678291473372, 2038.9490262743402, 59880.700596497176, 61883.381166188214, 64805.02792458164, 68032.659836701, 73025.26974730291, 9585.568649410654, 10014.449205293633, 10128.088472037552, 10282.742931426774, 10314.226433017404, 14290.499832505813, 14328.641783955485, 14404.639884002774, 14415.63960900965, 14427.42290308376, 6904.13698287714, 7041.119860017498, 7123.857522849514, 7136.857262854817, 7142.4286057115305, 6338.968305158444, 6352.428281454691, 6432.2602900667025, 6528.60828350291, 6543.541952063405, 4429.424174857248, 4470.195364834296, 4493.370928070073, 4497.752623605733, 4559.224931761609, 1835.4952388093382, 1898.5760679490381, 1923.7499125113925, 1932.3043704266454, 1940.1172466527696, 954.737447202025, 956.6986399284203, 956.7129861041799, 992.0327680511443, 995.711243739322, 16293.348266069224, 16841.915790421215, 16974.0, 17026.404075857285, 17073.829261707226, 859.0, 882.8499155143512, 893.3523195683208, 954.7565370830532, 955.9753438025989, 9150.0, 9505.19205867509, 9577.377470464398, 9634.403878124647, 9676.12914837668, 407865.41380986804, 409289.0, 414811.0, 420200.0, 423240.0, 64631.0, 76023.23976760161, 78274.0, 79601.60199198966, 83431.58284208662, 944.0465130218391, 950.2113246005798, 955.8422860228123, 978.9853152202722, 980.7106903463496, 15348.769768453705, 15386.461473848361, 15432.305546250222, 15515.30181141874, 15900.204989750235, 25342.0, 32193.35613287768, 34855.128621783646, 35222.8238858804, 37072.81463592665, 50526.494735053646, 50534.241986370966, 50735.74632126963, 51008.97982040413, 51387.48612513827, 7254.927450725425, 7595.5442673439775, 7706.922930770621, 7809.3362064225175, 7815.101263354787, 9955.253355998184, 10140.594376224868, 10482.0, 11147.609833655782, 11768.646940591796, 9767.15618961064, 9842.212622990286, 9970.102690757867, 9998.400095994264, 10100.040496152853, 9765.951170244103, 9906.900930990598, 10014.3490673106, 10164.949175254076, 10360.533775979948, 9528.19010384125, 9808.362456440309, 10040.598376064876, 10194.694159175237, 10325.554422380723, 7324.63376831167, 7413.888791668021, 7905.367570594223, 7923.405744569065, 8023.157568455228, 8699.56502174876, 9634.759131021781, 9657.951710241405, 9805.215582753506, 9924.801503970024], "value": 8248.780108663512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.7532019556677, 1472.271225743257, 1629.8696104311657, 1754.482427683833, 1781.77727784027, 6825.761098361559, 7327.743528976487, 7381.151167615726, 7793.961030194848, 7801.687932482701, 7366.96316518418, 7396.4082873370135, 7441.702331906731, 7441.9255807441905, 7503.587302698349, 2152.5264441822774, 2217.079911836586, 2218.7781221877763, 2219.2343641443676, 2224.73303203615, 2157.385145233609, 2164.2208804830248, 2230.07451907459, 2247.045005872506, 2248.2243625949104, 2198.1866709317574, 2205.1179528188773, 2206.0, 2217.2018073493527, 2223.466368071667, 2135.9999999999923, 2163.8485306028583, 2167.0, 2174.4672555223915, 2176.270949232009, 2137.871727696343, 2155.5904378168098, 2171.8479706420558, 2185.0495034659975, 2200.3728937252968, 7629.2752188542, 7713.807154821175, 7714.575698336589, 7715.1899050600005, 7721.961390193013, 4274.807633656493, 4509.301058335963, 4534.59188673021, 4540.023894862587, 4547.86356409305, 2731.221601843465, 2815.9859200704072, 2833.951437967965, 2854.3863069439963, 2881.726236007576, 857.3998201259144, 865.5542395666174, 866.9219770220648, 882.6910581296495, 888.6312180445108, 10321.174306055498, 10323.432211228379, 10342.638007669695, 10365.63720269787, 10369.170466362748, 4118.299889018874, 4150.667946564267, 4215.78921053946, 4275.40144379787, 4276.31578947367, 8932.330075244383, 8981.910180898238, 8986.101389861093, 8989.325800564853, 9030.729078127666, 4618.30725391194, 4694.647901407408, 4700.435947686299, 4712.81148754046, 4718.05638872227, 3651.6713495785507, 4096.09885825118, 4197.3284274516545, 4203.936940945889, 4322.200392927319, 3609.8917032489067, 3651.379265524867, 3695.316366472211, 3702.1114932416026, 3752.2870654575545, 1206.6922934651607, 1251.5056552661829, 1252.5616034387892, 1255.8492980842175, 1259.1437822280755, 759.3507551043889, 867.5835598912557, 892.4377642085444, 905.2215095018279, 935.219092058139, 5000.474950130257, 5079.619028572872, 5159.484051594811, 5185.325907632059, 5275.287836142148, 857.5583574459158, 904.3488688144525, 906.7687739626354, 915.4232833315102, 924.6024209589941, 3549.449835275485, 3567.7502574820032, 3640.9453858192146, 3650.324689932371, 3652.6712595866497, 9384.155426011692, 9684.56419461126, 9784.657536986171, 9785.706428807147, 9792.461414622121, 9563.61745530171, 9634.0, 9714.979927107694, 9720.07659272368, 9803.754906127404, 6732.259451460335, 7103.2541583133025, 7123.928760712327, 7179.533330333512, 7450.2549745026145, 5372.62391632582, 5458.263134476795, 5510.641808282448, 5516.282883225155, 5696.917585658712, 8494.193051660082, 8700.608472618875, 8808.91191088081, 8811.691590794291, 8896.911030889867, 8625.39622226438, 8936.0, 9109.04355042711, 9295.209907157698, 9326.0, 6159.692015399122, 6309.621422714652, 6483.902741458787, 6632.568883022588, 6787.389134977876, 6985.511014229159, 7004.579725216503, 7016.789496315118, 7068.11648543932, 7071.045408869737, 6222.657753823583, 6466.385693359123, 6516.250631177475, 6541.738330466728, 6596.043573681885, 6300.527460440577, 6417.422431981144, 6575.736970521126, 6789.830254243683, 6847.726090956306, 6196.659183744938, 6265.96867015662, 6270.341614130633, 6306.968465157828, 6316.368363163647, 4471.195184866625, 4557.453105627346, 4651.279051746985, 4660.743659098782, 4745.264484004984, 4534.229181039165, 4545.2954792007295, 4593.908121837611, 4610.492845786894, 4629.259318509023], "value": 4126.6189288757105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.75895645049286, 297.2420328163186, 303.7979743470592, 304.13170398512244, 312.2490410562597, 5011.198208286671, 5030.974845125774, 5040.571551418125, 5063.696178229309, 5070.540787717954, 4938.925916111261, 4939.28380384844, 4953.529414705597, 4958.950410495894, 4978.427480839705, 3697.7411581189394, 3790.9620903791024, 3922.8029156237717, 3928.469656596366, 3939.3106206413904, 3921.901952451183, 3930.2925473414916, 3944.644981951624, 3945.2109578084355, 3954.090559171392, 3919.8432062717457, 3934.5081864766903, 3937.7243592948507, 3941.3299739044432, 3948.802559872009, 3819.1788765415567, 3916.6096035907412, 3925.6466917977377, 3930.233604447134, 3932.252871954348, 3482.407990641597, 3485.9651403485896, 3488.529048578435, 3489.8778542750883, 3512.5082488451635, 4744.288356746481, 4752.500987396308, 4759.428868535798, 4764.904701905977, 4768.141734487791, 4316.740995540277, 4492.932606010912, 4510.075434535912, 4517.954820451786, 4531.56950089741, 5147.948520514784, 5170.922436163461, 5185.481451854822, 5208.583313334924, 5211.817586384458, 3781.5273090863643, 3799.67702745267, 3804.828782704757, 3816.46569480273, 3837.2517359114986, 5405.0, 5437.34751829779, 5439.592030597721, 5456.454354564551, 5476.863078423032, 3572.28554289138, 3775.6035616259896, 3799.810009499514, 3810.028442747137, 3812.0, 3824.388097904322, 3834.1373191031794, 3846.6922646188796, 3863.2273545291055, 3868.265029644415, 4369.519352871182, 4389.670774691911, 4403.119376124788, 4409.867703968886, 4416.602505774432, 5066.36670416198, 5203.531682148625, 5216.426193118754, 5261.921071183935, 5271.130263506555, 1400.6078298076352, 1403.8525954774807, 1408.2888141488688, 1412.1950488221821, 1414.6675531250148, 872.8777971084053, 909.4452384045727, 923.6951805904035, 941.9952900235455, 945.7588314979773, 4466.486354069324, 4598.632109431237, 4617.882929022896, 4622.375979242759, 4632.675712700146, 5336.866578335573, 5354.223637572531, 5360.381742323993, 5408.891822163535, 5417.024935511567, 4434.512203657595, 4591.609713174351, 4599.563041511051, 4599.942013336951, 4629.421322334708, 3065.7394121499924, 3088.6448058473115, 3104.301532155292, 3113.190570451699, 3122.7814053016073, 5452.91820622683, 5455.727213639302, 5475.890482190334, 5487.094629386186, 5490.396056433789, 5337.6797392156595, 5608.383077861432, 5626.015447296707, 5889.911651325234, 5925.170476133345, 5113.1052065888325, 5114.718690471986, 5129.615003948988, 5173.4221062575525, 5192.299039629753, 5485.286912701324, 5486.61593688438, 5500.1199808032125, 5507.044999025288, 5518.19986102021, 5178.275041494118, 5248.790048398021, 5328.200769884548, 5329.200619907045, 5339.279197308314, 5115.0, 5124.948750512447, 5142.717150556606, 5164.509371609691, 5172.19830926207, 3820.789856557916, 3871.787051712183, 3873.3415319396336, 3873.7094717896834, 3883.30100581898, 5332.0004998125705, 5400.837974860603, 5401.297831281908, 5418.539424148991, 5426.782928682808, 5170.819021334386, 5235.60732945023, 5239.9782042502875, 5246.239295302236, 5312.893742125213, 5083.593312535062, 5191.766370513412, 5200.6619569727845, 5269.78920843162, 5299.178627312773, 5092.618053645917, 5192.07893079563, 5215.956808638211, 5236.554892834151, 5248.317718696545, 5040.521150490697, 5064.366954130734, 5262.447443018428, 5264.473552644705, 5284.233786101071, 5091.261767043832, 5105.285260063668, 5122.129238029618, 5149.768260428365, 5157.381114266162], "value": 3980.7154376490917, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.513846492039, 668.3283300283215, 677.2888467109536, 698.9930100698991, 702.3573430311266, 11661.941690291558, 11723.179377443572, 11886.940565297173, 11892.64322070337, 12008.819867701981, 12068.637940861767, 12093.334866582334, 12098.0, 12138.453769580368, 12164.452599633016, 626.6866566716642, 782.12402109637, 794.1700922535935, 805.1465446626565, 815.7634286057037, 807.1041144329789, 807.8828569857396, 809.3767798794925, 811.809224832164, 813.3005615170948, 836.1513064239801, 837.4975014991018, 837.7193640130564, 843.4180415513307, 847.9618417171212, 832.2634468495364, 833.1793183714067, 838.0822998816348, 839.0686338164633, 842.3934766967774, 615.6029361062135, 618.1068356225256, 619.2970977940025, 619.9597026193283, 623.0498489803041, 10466.52900619474, 10500.317479363894, 10507.159427245879, 10510.632127875488, 10515.369077855354, 11662.825057624057, 11802.881971180264, 12108.21296615717, 12154.141355895199, 12312.384380780924, 9330.58012389444, 9403.341766076377, 9411.529423528797, 9454.43273403598, 9494.762630934281, 3156.447621666199, 3167.683231676814, 3189.4577921753357, 3231.709146176832, 3253.4469140246215, 44165.558344416786, 44368.55631443709, 44405.33391999122, 45821.08357832858, 46075.769621152016, 9276.814463710823, 9287.860682089775, 9355.95322023399, 9426.481543515172, 9727.07592778685, 16969.406070787463, 17028.0, 17033.148342582823, 17037.914810425867, 17109.486715398558, 6334.271558770708, 6457.1282876811965, 6486.254080780676, 6549.279579246279, 6678.532502724763, 3754.324221640131, 3766.9246615067545, 3772.5095737553943, 3820.4460353248624, 3823.923521529554, 2781.9443611127663, 2811.1566530041314, 2828.702986186462, 2839.559868220429, 2844.587534807483, 485.0807719371771, 505.1160469178937, 507.1530543991543, 514.3801718928682, 514.6860415146757, 559.6669981361084, 605.1950905295946, 610.8747706720112, 611.5443994224331, 644.1979735229669, 7408.370288525428, 7789.1042530108625, 7806.921930780733, 8072.596370181467, 8121.309688676529, 545.7544105152697, 575.4274496875552, 584.4360192414341, 591.9200907877467, 605.9394060593994, 3659.323025240339, 3745.606711295329, 3803.31540322739, 3822.6559609635265, 3830.8276127574327, 51175.0, 51734.0, 52173.47826521762, 53055.734721326146, 53137.468625314024, 45855.0, 46254.0, 46701.5329846704, 48205.75897120492, 48852.0, 41725.37411938823, 42183.578164218576, 43056.569434305886, 43406.565934340884, 44026.0, 7225.169105552718, 7230.819229519304, 7291.234420385783, 7334.156571994289, 7751.8837217442915, 26956.191314260603, 27854.16437506878, 28077.0, 28545.571816423184, 29415.0, 39230.41154382744, 39519.407208892466, 39579.80210098931, 39596.20807583775, 40511.797441012604, 10214.131798796889, 10232.897671023493, 10292.382457052301, 10407.427591482541, 10585.841212381974, 11708.941455292668, 11709.180357375242, 11843.23019003762, 11996.280223186637, 12003.579874704343, 10730.0, 10812.189085818753, 11381.601643942422, 11565.248258863146, 11617.419129043683, 10425.165986721197, 10707.839382409426, 10847.349159050482, 11152.665420037412, 11182.608608698656, 10631.8936810634, 10842.186835987175, 10923.508442119964, 11044.668659940215, 11188.272762270426, 8501.702440414803, 9094.363394562317, 9156.292538052221, 9972.152367048882, 10102.494875256061, 8849.823003540021, 8918.10818918129, 9006.09652667612, 9064.682736104205, 9144.58849351794], "value": 5805.508411912965, "unit": "score"}], "name": "dromaeo_css", "value": 6224.4698106350625, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 117.0, 113.0, 116.0, 125.0, 113.0, 113.0, 112.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 133.0, 166.0, 189.0, 134.0, 164.0, 157.0, 133.0, 196.0, 133.0], "value": 157.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 165.0, 172.0, 164.0, 160.0, 162.0, 162.0, 164.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 157.0, 78.0, 76.0, 74.0, 76.0, 156.0, 74.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 153.0, 95.0, 94.0, 94.0, 148.0, 94.0, 93.0, 140.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 65.0, 65.0, 65.0, 67.0, 82.0, 66.0, 65.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 68.0, 68.0, 66.0, 65.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 79.0, 79.0, 81.0, 80.0, 80.0, 80.0, 81.0, 81.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 129.0, 138.0, 133.0, 129.0, 134.0, 136.0, 180.0, 150.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 174.0, 182.0, 183.0, 173.0, 175.0, 179.0, 180.0, 174.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 71.0, 72.0, 76.0, 75.0, 72.0, 72.0, 74.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1602.5999999999997, "alertThreshold": 2.0}]} 11:32:48 INFO - Return code: 0 11:32:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:32:48 ERROR - # TBPL SUCCESS # 11:32:48 INFO - Running post-action listener: _resource_record_post_action 11:32:48 INFO - Running post-run listener: _resource_record_post_run 11:32:49 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 502104064; Read time: 12; Write time: 391880 11:32:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 102350848; Read time: 0; Write time: 105028 11:32:49 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284794880; Read time: 12; Write time: 179068 11:32:49 INFO - Running post-run listener: _upload_blobber_files 11:32:49 INFO - Blob upload gear active. 11:32:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:49 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 11:32:49 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'] 11:32:49 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 11:32:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:51 INFO - (blobuploader) - INFO - Done attempting. 11:32:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:32:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:51 INFO - (blobuploader) - INFO - Done attempting. 11:32:51 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:51 INFO - Return code: 0 11:32:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af3c2b32c6521cb017bde16df0b8c522fd91b834b20f800ad94e7e9ff814467c465a2802f9dbfabe299929b4aea4588d7116a7e20f1c9ceb5b61861399691977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05c576323e715cf2beba7bfbd6c8f6e18512504c15fa1ca3001d085d8fa1b6b4d8695af4a255e9a19a1fe5e5e106868978923fa048430af58a4e1e5afa768f7a"} 11:32:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:51 INFO - Contents: 11:32:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af3c2b32c6521cb017bde16df0b8c522fd91b834b20f800ad94e7e9ff814467c465a2802f9dbfabe299929b4aea4588d7116a7e20f1c9ceb5b61861399691977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05c576323e715cf2beba7bfbd6c8f6e18512504c15fa1ca3001d085d8fa1b6b4d8695af4a255e9a19a1fe5e5e106868978923fa048430af58a4e1e5afa768f7a"} 11:32:51 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:51 INFO - Copying logs to upload dir... 11:32:51 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.103735 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-29 11:32:51.195379) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 11:32:51.199101) ========= 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=0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843 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/af3c2b32c6521cb017bde16df0b8c522fd91b834b20f800ad94e7e9ff814467c465a2802f9dbfabe299929b4aea4588d7116a7e20f1c9ceb5b61861399691977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05c576323e715cf2beba7bfbd6c8f6e18512504c15fa1ca3001d085d8fa1b6b4d8695af4a255e9a19a1fe5e5e106868978923fa048430af58a4e1e5afa768f7a"} build_url:https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011057 build_url: 'https://queue.taskcluster.net/v1/task/Liqx010QSQyaX1Jm3b93-Q/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/af3c2b32c6521cb017bde16df0b8c522fd91b834b20f800ad94e7e9ff814467c465a2802f9dbfabe299929b4aea4588d7116a7e20f1c9ceb5b61861399691977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05c576323e715cf2beba7bfbd6c8f6e18512504c15fa1ca3001d085d8fa1b6b4d8695af4a255e9a19a1fe5e5e106868978923fa048430af58a4e1e5afa768f7a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 11:32:51.223566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:32:51.223910) ========= 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=0333a256a5e4f052382dd180000001b1-1461951478.497304-1275842843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:32:51.306541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 11:32:51.306862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 11:32:51.307180) ========= ========= Total master_lag: 0.53 =========