builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1461316806.71 results: success (0) buildid: 20160422014259 builduid: 56a85fe4813441aca3e137e3f2dba16f revision: b813b1e6e7e3288a865965bb9beefbf9d36b4a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.713611) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.714110) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.714393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.726037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.726392) ========= 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=523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 02:20:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-04-22 02:20:07 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145544 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.882982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.883314) ========= 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=523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019155 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.932965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:06.933344) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b813b1e6e7e3288a865965bb9beefbf9d36b4a67 --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 b813b1e6e7e3288a865965bb9beefbf9d36b4a67 --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=523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 02:20:07,585 truncating revision to first 12 chars 2016-04-22 02:20:07,585 Setting DEBUG logging. 2016-04-22 02:20:07,585 attempt 1/10 2016-04-22 02:20:07,585 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b813b1e6e7e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 02:20:07,868 unpacking tar archive at: fx-team-b813b1e6e7e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.595425 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:07.542039) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:07.542373) ========= script_repo_revision: b813b1e6e7e3288a865965bb9beefbf9d36b4a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:07.542758) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:07.543044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 02:20:07.551318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-22 02:20:07.551601) ========= /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=523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:08 INFO - MultiFileLogger online at 20160422 02:20:08 in /builds/slave/test 02:20:08 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 02:20:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:08 INFO - {'append_to_log': False, 02:20:08 INFO - 'base_work_dir': '/builds/slave/test', 02:20:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:20:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:08 INFO - 'branch': 'Fx-Team-Non-PGO', 02:20:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:08 INFO - 'config_files': ('talos/linux_config.py',), 02:20:08 INFO - 'default_actions': ('clobber', 02:20:08 INFO - 'read-buildbot-config', 02:20:08 INFO - 'download-and-extract', 02:20:08 INFO - 'populate-webroot', 02:20:08 INFO - 'create-virtualenv', 02:20:08 INFO - 'install', 02:20:08 INFO - 'run-tests'), 02:20:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:08 INFO - 'download_minidump_stackwalk': True, 02:20:08 INFO - 'download_symbols': 'ondemand', 02:20:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:08 INFO - 'installer_path': 'installer.exe', 02:20:08 INFO - 'log_level': 'info', 02:20:08 INFO - 'log_name': 'talos', 02:20:08 INFO - 'log_to_console': True, 02:20:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:08 INFO - 'opt_config_files': (), 02:20:08 INFO - 'pip_index': False, 02:20:08 INFO - 'sps_profile': False, 02:20:08 INFO - 'sps_profile_interval': 0, 02:20:08 INFO - 'suite': 'dromaeojs-e10s', 02:20:08 INFO - 'system_bits': '32', 02:20:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:08 INFO - 'title': 'talos-linux64-ix-065', 02:20:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:08 INFO - 'use_talos_json': True, 02:20:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:08 INFO - 'work_dir': 'build'} 02:20:08 INFO - ##### 02:20:08 INFO - ##### Running clobber step. 02:20:08 INFO - ##### 02:20:08 INFO - Running pre-action listener: _resource_record_pre_action 02:20:08 INFO - Running main action method: clobber 02:20:08 INFO - rmtree: /builds/slave/test/build 02:20:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:08 INFO - Running post-action listener: _resource_record_post_action 02:20:08 INFO - ##### 02:20:08 INFO - ##### Running read-buildbot-config step. 02:20:08 INFO - ##### 02:20:08 INFO - Running pre-action listener: _resource_record_pre_action 02:20:08 INFO - Running main action method: read_buildbot_config 02:20:08 INFO - Using buildbot properties: 02:20:08 INFO - { 02:20:08 INFO - "project": "", 02:20:08 INFO - "product": "firefox", 02:20:08 INFO - "script_repo_revision": "production", 02:20:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:20:08 INFO - "repository": "", 02:20:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:20:08 INFO - "buildid": "20160422014259", 02:20:08 INFO - "pgo_build": "False", 02:20:08 INFO - "basedir": "/builds/slave/test", 02:20:08 INFO - "buildnumber": 1430, 02:20:08 INFO - "slavename": "talos-linux64-ix-065", 02:20:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:20:08 INFO - "platform": "ubuntu64_hw", 02:20:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:20:08 INFO - "branch": "fx-team", 02:20:08 INFO - "repo_path": "integration/fx-team", 02:20:08 INFO - "revision": "b813b1e6e7e3288a865965bb9beefbf9d36b4a67", 02:20:08 INFO - "stage_platform": "linux64", 02:20:08 INFO - "builduid": "56a85fe4813441aca3e137e3f2dba16f", 02:20:08 INFO - "slavebuilddir": "test" 02:20:08 INFO - } 02:20:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:20:08 INFO - Running post-action listener: _resource_record_post_action 02:20:08 INFO - ##### 02:20:08 INFO - ##### Running download-and-extract step. 02:20:08 INFO - ##### 02:20:08 INFO - Running pre-action listener: _resource_record_pre_action 02:20:08 INFO - Running main action method: download_and_extract 02:20:08 INFO - mkdir: /builds/slave/test/build/tests 02:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:08 INFO - https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:20:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:20:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:20:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:20:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:20:09 INFO - Downloaded 1361 bytes. 02:20:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:20:09 INFO - Using the following test package requirements: 02:20:09 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:09 INFO - u'jsshell-linux-x86_64.zip'], 02:20:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:09 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:09 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')]} 02:20:09 INFO - https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:10 INFO - Downloaded 22281373 bytes. 02:20:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:11 INFO - Return code: 0 02:20:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:11 INFO - https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:12 INFO - Downloaded 22281373 bytes. 02:20:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:14 INFO - Return code: 0 02:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:14 INFO - https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:20:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:20:15 INFO - Downloaded 10845952 bytes. 02:20:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:20:15 INFO - Return code: 0 02:20: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')]} 02:20:15 INFO - https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:20:16 INFO - Downloaded 54630496 bytes. 02:20:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:16 INFO - mkdir: /builds/slave/test/properties 02:20:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:16 INFO - Contents: 02:20:16 INFO - build_url:https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:17 INFO - Running post-action listener: _resource_record_post_action 02:20:17 INFO - Running post-action listener: set_extra_try_arguments 02:20:17 INFO - ##### 02:20:17 INFO - ##### Running populate-webroot step. 02:20:17 INFO - ##### 02:20:17 INFO - Running pre-action listener: _resource_record_pre_action 02:20:17 INFO - Running main action method: populate_webroot 02:20:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:17 INFO - '--tppagecycles', 02:20:17 INFO - '7'], 02:20:17 INFO - 'tests': ['tsvgm']}}, 02:20:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:17 INFO - 'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:17 INFO - 'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['damp', 'tps']}, 02:20:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:17 INFO - 'tests': ['damp', 'tps']}, 02:20:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['dromaeo_dom']}, 02:20:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['a11yr', 02:20:17 INFO - 'ts_paint', 02:20:17 INFO - 'tpaint', 02:20:17 INFO - 'sessionrestore', 02:20:17 INFO - 'sessionrestore_no_auto_restore', 02:20:17 INFO - 'tabpaint']}, 02:20:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:17 INFO - 'ts_paint', 02:20:17 INFO - 'tpaint', 02:20:17 INFO - 'sessionrestore', 02:20:17 INFO - 'sessionrestore_no_auto_restore', 02:20:17 INFO - 'tabpaint']}, 02:20:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:17 INFO - 'ts_paint', 02:20:17 INFO - 'tpaint', 02:20:17 INFO - 'sessionrestore', 02:20:17 INFO - 'sessionrestore_no_auto_restore', 02:20:17 INFO - 'tabpaint']}, 02:20:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:17 INFO - 'ts_paint', 02:20:17 INFO - 'tpaint', 02:20:17 INFO - 'sessionrestore', 02:20:17 INFO - 'sessionrestore_no_auto_restore', 02:20:17 INFO - 'tabpaint']}, 02:20:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['a11yr', 02:20:17 INFO - 'ts_paint', 02:20:17 INFO - 'tpaint', 02:20:17 INFO - 'sessionrestore', 02:20:17 INFO - 'sessionrestore_no_auto_restore', 02:20:17 INFO - 'tabpaint']}, 02:20:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['a11yr', 02:20:17 INFO - 'ts_paint', 02:20:17 INFO - 'tpaint', 02:20:17 INFO - 'sessionrestore', 02:20:17 INFO - 'sessionrestore_no_auto_restore', 02:20:17 INFO - 'tabpaint']}, 02:20:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['tsvgx', 02:20:17 INFO - 'tsvgr_opacity', 02:20:17 INFO - 'tart', 02:20:17 INFO - 'tscrollx', 02:20:17 INFO - 'cart']}, 02:20:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:17 INFO - 'tsvgr_opacity', 02:20:17 INFO - 'tart', 02:20:17 INFO - 'tscrollx', 02:20:17 INFO - 'cart']}, 02:20:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:17 INFO - 'talos_options': ['--disable-e10s'], 02:20:17 INFO - 'tests': ['tp5o']}, 02:20:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:17 INFO - 'tests': ['tp5o']}, 02:20:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:17 INFO - 'talos_options': ['--disable-e10s', 02:20:17 INFO - '--xperf_path', 02:20:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:17 INFO - 'tests': ['tp5n']}, 02:20:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:17 INFO - 'talos_options': ['--xperf_path', 02:20:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:17 INFO - 'tests': ['tp5n']}}, 02:20:17 INFO - 'talos.zip': {'path': '', 02:20:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:17 INFO - Running post-action listener: _resource_record_post_action 02:20:17 INFO - ##### 02:20:17 INFO - ##### Running create-virtualenv step. 02:20:17 INFO - ##### 02:20:17 INFO - Running pre-action listener: _resource_record_pre_action 02:20:17 INFO - Running main action method: create_virtualenv 02:20:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:17 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 02:20:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:17 INFO - Using real prefix '/usr' 02:20:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:20 INFO - Installing pip.................done. 02:20:20 INFO - Return code: 0 02:20:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:20 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')]} 02:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:20 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')]} 02:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:20 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:20 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 02:20:20 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 02:20:20 INFO - Using env: {'DISPLAY': ':0', 02:20:20 INFO - 'HOME': '/home/cltbld', 02:20:20 INFO - 'LANG': 'en_US.UTF-8', 02:20:20 INFO - 'LANGUAGE': 'en_US:en', 02:20:20 INFO - 'LOGNAME': 'cltbld', 02:20:20 INFO - 'MAIL': '/var/mail/cltbld', 02:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:20 INFO - 'MOZ_NO_REMOTE': '1', 02:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:20 INFO - 'NO_EM_RESTART': '1', 02:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:20 INFO - 'PWD': '/builds/slave/test', 02:20:20 INFO - 'SHELL': '/bin/bash', 02:20:20 INFO - 'SHLVL': '1', 02:20:20 INFO - 'TERM': 'linux', 02:20:20 INFO - 'TMOUT': '86400', 02:20:20 INFO - 'USER': 'cltbld', 02:20:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:20 INFO - '_': '/tools/buildbot/bin/python'} 02:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:20 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 02:20:20 INFO - Cleaning up... 02:20:20 INFO - Return code: 0 02:20:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:20:20 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')]} 02:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:20 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')]} 02:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:20 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:20 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 02:20:20 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 02:20:20 INFO - Using env: {'DISPLAY': ':0', 02:20:20 INFO - 'HOME': '/home/cltbld', 02:20:20 INFO - 'LANG': 'en_US.UTF-8', 02:20:20 INFO - 'LANGUAGE': 'en_US:en', 02:20:20 INFO - 'LOGNAME': 'cltbld', 02:20:20 INFO - 'MAIL': '/var/mail/cltbld', 02:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:20 INFO - 'MOZ_NO_REMOTE': '1', 02:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:20 INFO - 'NO_EM_RESTART': '1', 02:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:20 INFO - 'PWD': '/builds/slave/test', 02:20:20 INFO - 'SHELL': '/bin/bash', 02:20:20 INFO - 'SHLVL': '1', 02:20:20 INFO - 'TERM': 'linux', 02:20:20 INFO - 'TMOUT': '86400', 02:20:20 INFO - 'USER': 'cltbld', 02:20:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:20 INFO - '_': '/tools/buildbot/bin/python'} 02:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:20 INFO - Downloading/unpacking psutil>=0.7.1 02:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:22 INFO - Installing collected packages: psutil 02:20:22 INFO - Running setup.py install for psutil 02:20:22 INFO - building 'psutil._psutil_linux' extension 02:20:22 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 02:20:22 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 02:20:22 INFO - building 'psutil._psutil_posix' extension 02:20:22 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 02:20:22 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 02:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:23 INFO - Successfully installed psutil 02:20:23 INFO - Cleaning up... 02:20:23 INFO - Return code: 0 02:20:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:23 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 02:20:23 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 02:20:23 INFO - Using env: {'DISPLAY': ':0', 02:20:23 INFO - 'HOME': '/home/cltbld', 02:20:23 INFO - 'LANG': 'en_US.UTF-8', 02:20:23 INFO - 'LANGUAGE': 'en_US:en', 02:20:23 INFO - 'LOGNAME': 'cltbld', 02:20:23 INFO - 'MAIL': '/var/mail/cltbld', 02:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:23 INFO - 'MOZ_NO_REMOTE': '1', 02:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:23 INFO - 'NO_EM_RESTART': '1', 02:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:23 INFO - 'PWD': '/builds/slave/test', 02:20:23 INFO - 'SHELL': '/bin/bash', 02:20:23 INFO - 'SHLVL': '1', 02:20:23 INFO - 'TERM': 'linux', 02:20:23 INFO - 'TMOUT': '86400', 02:20:23 INFO - 'USER': 'cltbld', 02:20:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:23 INFO - '_': '/tools/buildbot/bin/python'} 02:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:20:23 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 02:20:23 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 02:20:23 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 02:20:23 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 02:20:23 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 02:20:23 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 02:20:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:20:25 INFO - Installing collected packages: mozsystemmonitor 02:20:25 INFO - Running setup.py install for mozsystemmonitor 02:20:25 INFO - Successfully installed mozsystemmonitor 02:20:25 INFO - Cleaning up... 02:20:25 INFO - Return code: 0 02:20:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:25 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')]} 02:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:25 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')]} 02:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:25 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:25 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 02:20:25 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 02:20:25 INFO - Using env: {'DISPLAY': ':0', 02:20:25 INFO - 'HOME': '/home/cltbld', 02:20:25 INFO - 'LANG': 'en_US.UTF-8', 02:20:25 INFO - 'LANGUAGE': 'en_US:en', 02:20:25 INFO - 'LOGNAME': 'cltbld', 02:20:25 INFO - 'MAIL': '/var/mail/cltbld', 02:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:25 INFO - 'MOZ_NO_REMOTE': '1', 02:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:25 INFO - 'NO_EM_RESTART': '1', 02:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:25 INFO - 'PWD': '/builds/slave/test', 02:20:25 INFO - 'SHELL': '/bin/bash', 02:20:25 INFO - 'SHLVL': '1', 02:20:25 INFO - 'TERM': 'linux', 02:20:25 INFO - 'TMOUT': '86400', 02:20:25 INFO - 'USER': 'cltbld', 02:20:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:25 INFO - '_': '/tools/buildbot/bin/python'} 02:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:25 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:25 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 02:20:25 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 02:20:25 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 02:20:25 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 02:20:25 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 02:20:25 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 02:20:27 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:28 INFO - Downloading docopt-0.6.1.tar.gz 02:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:28 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:28 INFO - Running setup.py install for blobuploader 02:20:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:28 INFO - Running setup.py install for requests 02:20:28 INFO - Running setup.py install for docopt 02:20:28 INFO - Successfully installed blobuploader requests docopt 02:20:28 INFO - Cleaning up... 02:20:28 INFO - Return code: 0 02:20:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:28 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')]} 02:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:28 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')]} 02:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:28 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:28 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 02:20:28 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 02:20:28 INFO - Using env: {'DISPLAY': ':0', 02:20:28 INFO - 'HOME': '/home/cltbld', 02:20:28 INFO - 'LANG': 'en_US.UTF-8', 02:20:28 INFO - 'LANGUAGE': 'en_US:en', 02:20:28 INFO - 'LOGNAME': 'cltbld', 02:20:28 INFO - 'MAIL': '/var/mail/cltbld', 02:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:28 INFO - 'MOZ_NO_REMOTE': '1', 02:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:28 INFO - 'NO_EM_RESTART': '1', 02:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:28 INFO - 'PWD': '/builds/slave/test', 02:20:28 INFO - 'SHELL': '/bin/bash', 02:20:28 INFO - 'SHLVL': '1', 02:20:28 INFO - 'TERM': 'linux', 02:20:28 INFO - 'TMOUT': '86400', 02:20:28 INFO - 'USER': 'cltbld', 02:20:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:28 INFO - '_': '/tools/buildbot/bin/python'} 02:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:29 INFO - Running setup.py (path:/tmp/pip-EbK7_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:29 INFO - Running setup.py (path:/tmp/pip-X0xgBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:29 INFO - Running setup.py (path:/tmp/pip-1ht9r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:29 INFO - Running setup.py (path:/tmp/pip-Uk9SkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:29 INFO - Running setup.py (path:/tmp/pip-AxN5RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:29 INFO - Running setup.py (path:/tmp/pip-q1kdhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:29 INFO - Running setup.py (path:/tmp/pip-3HijSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:29 INFO - Running setup.py (path:/tmp/pip-sLnDJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:29 INFO - Running setup.py (path:/tmp/pip-NB5tu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:29 INFO - Running setup.py (path:/tmp/pip-MF_U5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:29 INFO - Running setup.py (path:/tmp/pip-HCe3yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:29 INFO - Running setup.py (path:/tmp/pip-86vP8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:29 INFO - Running setup.py (path:/tmp/pip-D0xsPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:29 INFO - Running setup.py (path:/tmp/pip-xaZcU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:30 INFO - Running setup.py (path:/tmp/pip-40JPu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:30 INFO - Running setup.py (path:/tmp/pip-Z7KrW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:30 INFO - Running setup.py (path:/tmp/pip-C1Nz45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:30 INFO - Running setup.py install for manifestparser 02:20:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:30 INFO - Running setup.py install for mozcrash 02:20:30 INFO - Running setup.py install for mozdebug 02:20:30 INFO - Running setup.py install for mozdevice 02:20:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:30 INFO - Running setup.py install for mozfile 02:20:30 INFO - Running setup.py install for mozhttpd 02:20:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:30 INFO - Running setup.py install for mozinfo 02:20:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Running setup.py install for mozInstall 02:20:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Running setup.py install for mozleak 02:20:31 INFO - Running setup.py install for mozlog 02:20:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Running setup.py install for moznetwork 02:20:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Running setup.py install for mozprocess 02:20:31 INFO - Running setup.py install for mozprofile 02:20:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Running setup.py install for mozrunner 02:20:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:31 INFO - Running setup.py install for mozscreenshot 02:20:31 INFO - Running setup.py install for moztest 02:20:31 INFO - Running setup.py install for mozversion 02:20:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:32 INFO - Cleaning up... 02:20:32 INFO - Return code: 0 02:20:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:32 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:32 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 02:20:32 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 02:20:32 INFO - Using env: {'DISPLAY': ':0', 02:20:32 INFO - 'HOME': '/home/cltbld', 02:20:32 INFO - 'LANG': 'en_US.UTF-8', 02:20:32 INFO - 'LANGUAGE': 'en_US:en', 02:20:32 INFO - 'LOGNAME': 'cltbld', 02:20:32 INFO - 'MAIL': '/var/mail/cltbld', 02:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:32 INFO - 'MOZ_NO_REMOTE': '1', 02:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:32 INFO - 'NO_EM_RESTART': '1', 02:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:32 INFO - 'PWD': '/builds/slave/test', 02:20:32 INFO - 'SHELL': '/bin/bash', 02:20:32 INFO - 'SHLVL': '1', 02:20:32 INFO - 'TERM': 'linux', 02:20:32 INFO - 'TMOUT': '86400', 02:20:32 INFO - 'USER': 'cltbld', 02:20:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:32 INFO - '_': '/tools/buildbot/bin/python'} 02:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:32 INFO - Running setup.py (path:/tmp/pip-w3h2fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:32 INFO - Running setup.py (path:/tmp/pip-zsD0V1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:32 INFO - Running setup.py (path:/tmp/pip-Mb4XJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:32 INFO - Running setup.py (path:/tmp/pip-yMQSCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:32 INFO - Running setup.py (path:/tmp/pip-50MY_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:32 INFO - Running setup.py (path:/tmp/pip-Xyvjg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:32 INFO - Running setup.py (path:/tmp/pip-MZPANL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:32 INFO - Running setup.py (path:/tmp/pip-nmx1N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:32 INFO - Running setup.py (path:/tmp/pip-7Nysox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:32 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)) 02:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:32 INFO - Running setup.py (path:/tmp/pip-GElOS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:33 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)) 02:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:33 INFO - Running setup.py (path:/tmp/pip-XEbc_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:33 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)) 02:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:33 INFO - Running setup.py (path:/tmp/pip-Q08b0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:33 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)) 02:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:33 INFO - Running setup.py (path:/tmp/pip-6xZSYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:33 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)) 02:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:33 INFO - Running setup.py (path:/tmp/pip-x3oQFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:33 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)) 02:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:33 INFO - Running setup.py (path:/tmp/pip-p1vwOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:33 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)) 02:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:33 INFO - Running setup.py (path:/tmp/pip-XdKTa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:33 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)) 02:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:33 INFO - Running setup.py (path:/tmp/pip-4gFDZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:33 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)) 02:20:33 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)) 02:20:33 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)) 02:20:33 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)) 02:20:33 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)) 02:20:33 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)) 02:20:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:35 INFO - Downloading blessings-1.6.tar.gz 02:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:35 INFO - Installing collected packages: blessings 02:20:35 INFO - Running setup.py install for blessings 02:20:35 INFO - Successfully installed blessings 02:20:35 INFO - Cleaning up... 02:20:35 INFO - Return code: 0 02:20:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:35 INFO - Reading from file tmpfile_stdout 02:20:35 INFO - Current package versions: 02:20:35 INFO - argparse == 1.2.1 02:20:35 INFO - blessings == 1.6 02:20:35 INFO - blobuploader == 1.2.4 02:20:35 INFO - docopt == 0.6.1 02:20:35 INFO - manifestparser == 1.1 02:20:35 INFO - mozInstall == 1.12 02:20:35 INFO - mozcrash == 0.17 02:20:35 INFO - mozdebug == 0.1 02:20:35 INFO - mozdevice == 0.48 02:20:35 INFO - mozfile == 1.2 02:20:35 INFO - mozhttpd == 0.7 02:20:35 INFO - mozinfo == 0.9 02:20:35 INFO - mozleak == 0.1 02:20:35 INFO - mozlog == 3.1 02:20:35 INFO - moznetwork == 0.27 02:20:35 INFO - mozprocess == 0.22 02:20:35 INFO - mozprofile == 0.28 02:20:35 INFO - mozrunner == 6.11 02:20:35 INFO - mozscreenshot == 0.1 02:20:35 INFO - mozsystemmonitor == 0.0 02:20:35 INFO - moztest == 0.7 02:20:35 INFO - mozversion == 1.4 02:20:35 INFO - psutil == 3.1.1 02:20:35 INFO - requests == 1.2.3 02:20:35 INFO - wsgiref == 0.1.2 02:20:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:35 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:35 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 02:20:35 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 02:20:35 INFO - Using env: {'DISPLAY': ':0', 02:20:35 INFO - 'HOME': '/home/cltbld', 02:20:35 INFO - 'LANG': 'en_US.UTF-8', 02:20:35 INFO - 'LANGUAGE': 'en_US:en', 02:20:35 INFO - 'LOGNAME': 'cltbld', 02:20:35 INFO - 'MAIL': '/var/mail/cltbld', 02:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:35 INFO - 'MOZ_NO_REMOTE': '1', 02:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:35 INFO - 'NO_EM_RESTART': '1', 02:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:35 INFO - 'PWD': '/builds/slave/test', 02:20:35 INFO - 'SHELL': '/bin/bash', 02:20:35 INFO - 'SHLVL': '1', 02:20:35 INFO - 'TERM': 'linux', 02:20:35 INFO - 'TMOUT': '86400', 02:20:35 INFO - 'USER': 'cltbld', 02:20:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:35 INFO - '_': '/tools/buildbot/bin/python'} 02:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 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)) 02:20:36 INFO - Cleaning up... 02:20:36 INFO - Return code: 0 02:20:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:36 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:36 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 02:20:36 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 02:20:36 INFO - Using env: {'DISPLAY': ':0', 02:20:36 INFO - 'HOME': '/home/cltbld', 02:20:36 INFO - 'LANG': 'en_US.UTF-8', 02:20:36 INFO - 'LANGUAGE': 'en_US:en', 02:20:36 INFO - 'LOGNAME': 'cltbld', 02:20:36 INFO - 'MAIL': '/var/mail/cltbld', 02:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:36 INFO - 'MOZ_NO_REMOTE': '1', 02:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:36 INFO - 'NO_EM_RESTART': '1', 02:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:36 INFO - 'PWD': '/builds/slave/test', 02:20:36 INFO - 'SHELL': '/bin/bash', 02:20:36 INFO - 'SHLVL': '1', 02:20:36 INFO - 'TERM': 'linux', 02:20:36 INFO - 'TMOUT': '86400', 02:20:36 INFO - 'USER': 'cltbld', 02:20:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:36 INFO - '_': '/tools/buildbot/bin/python'} 02:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:36 INFO - Downloading/unpacking jsonschema 02:20:36 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 02:20:36 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 02:20:36 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 02:20:36 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 02:20:36 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 02:20:36 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 02:20:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:38 INFO - Downloading/unpacking functools32 (from jsonschema) 02:20:38 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 02:20:38 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 02:20:38 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 02:20:38 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 02:20:38 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 02:20:38 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 02:20:38 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:38 INFO - warning: no files found matching '*.txt' 02:20:38 INFO - no previously-included directories found matching 'build' 02:20:38 INFO - no previously-included directories found matching 'dist' 02:20:38 INFO - no previously-included directories found matching '.git*' 02:20:38 INFO - Installing collected packages: jsonschema, functools32 02:20:38 INFO - Running setup.py install for functools32 02:20:38 INFO - warning: no files found matching '*.txt' 02:20:38 INFO - no previously-included directories found matching 'build' 02:20:38 INFO - no previously-included directories found matching 'dist' 02:20:38 INFO - no previously-included directories found matching '.git*' 02:20:38 INFO - Successfully installed jsonschema functools32 02:20:38 INFO - Cleaning up... 02:20:38 INFO - Return code: 0 02:20:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:38 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 0x7f07e5978f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', '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 02:20:38 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 02:20:38 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 02:20:38 INFO - Using env: {'DISPLAY': ':0', 02:20:38 INFO - 'HOME': '/home/cltbld', 02:20:38 INFO - 'LANG': 'en_US.UTF-8', 02:20:38 INFO - 'LANGUAGE': 'en_US:en', 02:20:38 INFO - 'LOGNAME': 'cltbld', 02:20:38 INFO - 'MAIL': '/var/mail/cltbld', 02:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:38 INFO - 'MOZ_NO_REMOTE': '1', 02:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:38 INFO - 'NO_EM_RESTART': '1', 02:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:38 INFO - 'PWD': '/builds/slave/test', 02:20:38 INFO - 'SHELL': '/bin/bash', 02:20:38 INFO - 'SHLVL': '1', 02:20:38 INFO - 'TERM': 'linux', 02:20:38 INFO - 'TMOUT': '86400', 02:20:38 INFO - 'USER': 'cltbld', 02:20:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:38 INFO - '_': '/tools/buildbot/bin/python'} 02:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:38 INFO - Downloading/unpacking flake8 02:20:38 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 02:20:38 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 02:20:38 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 02:20:38 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 02:20:38 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 02:20:38 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 02:20:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:20:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:20:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:20:41 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 02:20:41 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 02:20:41 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 02:20:41 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 02:20:41 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 02:20:41 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 02:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:20:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:41 INFO - no previously-included directories found matching 'docs/_build' 02:20:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:20:41 INFO - Running setup.py install for pep8 02:20:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:41 INFO - no previously-included directories found matching 'docs/_build' 02:20:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:20:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:20:41 INFO - Cleaning up... 02:20:41 INFO - Return code: 0 02:20:41 INFO - Running post-action listener: _resource_record_post_action 02:20:41 INFO - Running post-action listener: _start_resource_monitoring 02:20:41 INFO - Starting resource monitoring. 02:20:41 INFO - ##### 02:20:41 INFO - ##### Running install step. 02:20:41 INFO - ##### 02:20:41 INFO - Running pre-action listener: _resource_record_pre_action 02:20:41 INFO - Running main action method: install 02:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:41 INFO - Reading from file tmpfile_stdout 02:20:41 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:42 INFO - Reading from file tmpfile_stdout 02:20:42 INFO - Output received: 02:20:42 INFO - Usage: mozinstall [options] installer 02:20:42 INFO - Options: 02:20:42 INFO - -h, --help show this help message and exit 02:20:42 INFO - -d DEST, --destination=DEST 02:20:42 INFO - Directory to install application into. [default: 02:20:42 INFO - "/builds/slave/test"] 02:20:42 INFO - --app=APP Application being installed. [default: firefox] 02:20:42 INFO - mkdir: /builds/slave/test/build/application 02:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:20:57 INFO - Reading from file tmpfile_stdout 02:20:57 INFO - Output received: 02:20:57 INFO - /builds/slave/test/build/application/firefox/firefox 02:20:57 INFO - Running post-action listener: _resource_record_post_action 02:20:57 INFO - ##### 02:20:57 INFO - ##### Running run-tests step. 02:20:57 INFO - ##### 02:20:57 INFO - Running pre-action listener: _resource_record_pre_action 02:20:57 INFO - Running main action method: run_tests 02:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:57 INFO - Python 2.7.3 02:20:57 INFO - Return code: 0 02:20:57 INFO - grabbing minidump binary from tooltool 02:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:57 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 0x13da410>, '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 0x13db310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13db7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:57 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 02:20:57 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 02:20:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:57 INFO - Return code: 0 02:20:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:20:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:20:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:20:58 INFO - Return code: 0 02:20:58 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/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 02:20:58 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/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 02:20:58 INFO - Using env: {'DISPLAY': ':0', 02:20:58 INFO - 'HOME': '/home/cltbld', 02:20:58 INFO - 'LANG': 'en_US.UTF-8', 02:20:58 INFO - 'LANGUAGE': 'en_US:en', 02:20:58 INFO - 'LOGNAME': 'cltbld', 02:20:58 INFO - 'MAIL': '/var/mail/cltbld', 02:20:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:58 INFO - 'MOZ_NO_REMOTE': '1', 02:20:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:58 INFO - 'NO_EM_RESTART': '1', 02:20:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:58 INFO - 'PWD': '/builds/slave/test', 02:20:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:20:58 INFO - 'SHELL': '/bin/bash', 02:20:58 INFO - 'SHLVL': '1', 02:20:58 INFO - 'TERM': 'linux', 02:20:58 INFO - 'TMOUT': '86400', 02:20:58 INFO - 'USER': 'cltbld', 02:20:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711', 02:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:58 INFO - '_': '/tools/buildbot/bin/python'} 02:20:58 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/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 02:20:59 INFO - mozversion application_buildid: 20160422014259 02:20:59 INFO - mozversion application_changeset: b813b1e6e7e3288a865965bb9beefbf9d36b4a67 02:20:59 INFO - mozversion application_display_name: Nightly 02:20:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:59 INFO - mozversion application_name: Firefox 02:20:59 INFO - mozversion application_remotingname: firefox 02:20:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:20:59 INFO - mozversion application_vendor: Mozilla 02:20:59 INFO - mozversion application_version: 48.0a1 02:20:59 INFO - mozversion platform_buildid: 20160422014259 02:20:59 INFO - mozversion platform_changeset: b813b1e6e7e3288a865965bb9beefbf9d36b4a67 02:20:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:20:59 INFO - mozversion platform_version: 48.0a1 02:20:59 INFO - using testdate: 1461316859 02:20:59 INFO - actual date: 1461316859 02:20:59 INFO - starting webserver on 'localhost:47437' 02:20:59 INFO - SUITE-START | Running 2 tests 02:20:59 INFO - TEST-START | dromaeo_css 02:20:59 INFO - operating with platform_type : linux_ 02:20:59 INFO - Initialising browser for dromaeo_css test... 02:20:59 INFO - TEST-INFO | started process 6402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGWEuRu/profile http://localhost:47437/getInfo.html) 02:21:03 INFO - PROCESS | 6402 | 02:21:03 INFO - PROCESS | 6402 | (process:6470): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:21:04 INFO - PROCESS | 6402 | __metrics Screen width/height:1600/1200 02:21:04 INFO - PROCESS | 6402 | colorDepth:24 02:21:04 INFO - PROCESS | 6402 | Browser inner width/height: 1024/697 02:21:04 INFO - PROCESS | 6402 | __metrics 02:21:04 ERROR - PROCESS | 6402 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:21:05 INFO - TEST-INFO | 6402: exit 0 02:21:05 INFO - Browser initialized. 02:21:05 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:05 INFO - TEST-INFO | started process 6521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGWEuRu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:07 INFO - PROCESS | 6521 | 02:21:07 INFO - PROCESS | 6521 | (process:6582): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:21:17 INFO - PROCESS | 6521 | RSS: Main: 165007360 02:21:17 INFO - PROCESS | 6521 | 02:22:07 INFO - PROCESS | 6521 | 1461316927223 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] 02:24:18 INFO - PROCESS | 6521 | Cycle 1(1): loaded http://localhost:47437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47437/tests/dromaeo/cssquery-ext.html) 02:24:20 INFO - PROCESS | 6521 | RSS: Main: 169414656 02:24:20 INFO - PROCESS | 6521 | 02:27:22 INFO - PROCESS | 6521 | Cycle 1(1): loaded http://localhost:47437/tests/dromaeo/cssquery-ext.html (next: http://localhost:47437/tests/dromaeo/cssquery-jquery.html) 02:27:22 INFO - PROCESS | 6521 | RSS: Main: 166420480 02:27:22 INFO - PROCESS | 6521 | 02:30:24 INFO - PROCESS | 6521 | Cycle 1(1): loaded http://localhost:47437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47437/tests/dromaeo/cssquery-mootools.html) 02:30:25 INFO - PROCESS | 6521 | RSS: Main: 167305216 02:30:25 INFO - PROCESS | 6521 | 02:33:27 INFO - PROCESS | 6521 | Cycle 1(1): loaded http://localhost:47437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47437/tests/dromaeo/cssquery-prototype.html) 02:33:27 INFO - PROCESS | 6521 | RSS: Main: 164888576 02:33:27 INFO - PROCESS | 6521 | 02:36:30 INFO - PROCESS | 6521 | Cycle 1(1): loaded http://localhost:47437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47437/tests/dromaeo/cssquery-yui.html) 02:36:31 INFO - PROCESS | 6521 | RSS: Main: 166436864 02:36:31 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | Cycle 1(1): loaded http://localhost:47437/tests/dromaeo/cssquery-yui.html (next: http://localhost:47437/tests/dromaeo/cssquery-dojo.html) 02:39:33 INFO - PROCESS | 6521 | RSS: Main: 168321024 02:39:33 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | __start_tp_report 02:39:33 INFO - PROCESS | 6521 | _x_x_mozilla_page_load 02:39:33 INFO - PROCESS | 6521 | _x_x_mozilla_page_load_details 02:39:33 INFO - PROCESS | 6521 | |i|pagename|runs| 02:39:33 INFO - PROCESS | 6521 | |0;dojo.html;2643.312738687941;2690.6098615700726;2731.8087733858624;2737.1788463460957;2742.9177124686266;4726.574608285258;4736.810527578893;4772.928406073907;4790.80836766529;4792.897633544287;4690.202665546857;4808.062427826567;4827.324174615556;4835.395575553056;4852.199387101133;4364.519902810696;4372.934405983913;4379.167958087969;4418.580234877698;4475.3063275192235;4386.385905973167;4460.464744230697;4520.389747384111;4549.818007279721;4553.749543775091;4261.76560289184;4342.565743425664;4389.692721509496;4438.733675979435;4499.302608095751;4323.2434323993175;4334.068175342285;4379.540148284416;4391.978040109779;4426.380306757057;4382.233109205877;4385.649148068147;4405.581469760367;4409.669274804371;4463.062756821039;4670.392848929618;4675.462321832999;4747.976260118678;4770.928436073462;4800.423949126127;5088.516590923893;5106.693598384071;5120.846374608767;5125.564327032207;5140.665856719302;4965.801367945278;5124.128898087297;5158.767855446514;5159.638825282232;5170.819021334273;4822.590079843182;4829.734364609945;4838.685485443435;4839.128956787777;4878.390201224847;5154.046501397253;5206.323177986837;5217.191335343028;5247.344081989751;5265.921011184835;4967.205247160509;5016.272640467112;5021.171506701427;5027.497250274943;5081.2632168335385;5255.054090263713;5279.762410691528;5287.603429742785;5291.576673866081;5335.33308336458;5021.648484606116;5128.179491281452;5128.615353848476;5130.615203859726;5132.743362831843;5052.065367906949;5060.873478163002;5098.617603679739;5116.130257856174;5129.717865517432;4254.085371645111;4273.807678654468;4297.613214810682;4306.74159550428;4360.4331436913;3768.8680896168503;3773.6792372648083;3782.149016471272;3814.8474061037246;3818.4081467372603;4442.178197033559;4452.955470445254;4457.064016556495;4463.598276155161;4473.1277400907165;5057.190849464068;5142.665726727751;5178.042062218502;5218.08683480397;5237.397699264633;4390.517043125254;4401.405810215644;4410.713303635253;4452.220861349316;4459.063596644676;4513.368128462018;4533.252013417749;4540.205464043779;4542;4581.862544123682;4756.21522448799;4793.520647935248;4838.419389673261;4930;4941.308216849716;5145.511176438233;5166.225066240094;5171.405288391733;5185.481451854785;5194.662346947436;4852.902941941212;4869.952960113593;4892.8532144035735;4899.951000489949;4925.852224433273;4958.45456999737;4962.131626965339;4994.225894986283;5035.546800787946;5037.345145131109;5205.06308864408;5214.765335559833;5257.447967963309;5261.684298942076;5289.100852855101;4915.336429581961;5098.2352647103235;5099.872503187302;5108.489151084862;5124.846254612367;4909.26361045846;4996.6002719783055;5001.149804533311;5051.6716413433005;5084.593232541314;4907.435644900882;4934.605231581537;4965.280034395065;4995.925061124013;5009.398872135367;5041.521055499722;5067.797288108434;5078.390593128701;5081.568066714371;5136.332276803992;4776.689515181502;4883.6093112551625;4926.655134140576;4962.602991760723;4980.775865086008 02:39:33 INFO - PROCESS | 6521 | |1;ext.html;569.4959960435013;602.6233603997501;617.2438762515918;621.4624349937304;635.8251480842771;34048;35271.11822204446;35308.47037294439;35319;35367;35123.648763512356;35552.64447355526;35566.822165889134;35676.286474270564;35710.46434303487;7657.885131723015;7818.804529886742;7820.374370050411;7825.37397008238;7827.373810095207;7702.037245344332;7784.80537986552;7806.180351063142;7822.843543129134;7841.176676448977;7705.4220933430215;7744.109427415835;7746.38028957682;7763.495372800779;7790.415718821111;7710.498817576839;7717.614119294041;7739.303462688329;7747.341475974549;7791.493552919071;7660.080790305144;7782.533048017137;7794.2205779422175;7825.217478252186;7842.058952925629;30536.38927221443;35858.46212306817;36341.454878176846;36394.63605363939;36487.27025459502;2771.1547977866744;2782.3600571868583;2905.6513218413716;2968.1095671298526;2983.254186453387;27315.590266146024;27628.861855690593;27942;28014.859925700446;28029.719702802915;3475.1138459692615;3523.312953973976;3600.369935261319;3604.116991337113;3678.5769636491877;181429.0928545362;185720;185754;186135;237873.81063094747;33434.832825835714;34609.826950865085;55487.445125549035;55988.720056399456;56491;35356.823215883756;35446.82276588652;35602.82198589042;35642.64357356393;35832.64167358345;12276.754464910831;12424.56514022023;12437.315947622968;12448;12544.435500402504;9703.902960970441;9704.223662107015;9710.077542633438;9712;9736.610535578639;8221.917780822236;8262.256396924306;8320.625571849161;8362.916370836336;8365.790855228546;3314.718248948818;3320.468725003988;3369.359821633882;3374.54443650109;3389.4068538006245;883.5052370672315;885.623609965762;900.4237288135598;964.7395203295071;973.493783232715;27103.864480677472;28058.85970570175;28348.574771378448;28440.146795596163;28908.710912891023;982.759223990127;988.9653862114935;999.1357475783395;1095.9287646302964;1101.130107215291;14840.777388339184;15139.470118545798;15267.389304427921;15472.92263538675;15565.688686226213;354671;361044;361671;363600;364158;48048.759756201;48752.75623621859;49094.509054908995;49110.26334604984;49148.262776058385;1183.5480926818243;1207.6316723399273;1207.6377086873902;1221.3648902570615;1235.4872727818035;26513.60229596519;27785.166445006682;27978;28012.85993570019;28147;42046.57953420427;42370;42472.78763606162;42657.78671106625;42723.7863810679;250886;250986;251932;252668;252829;25160.874195628905;25404.364890877874;26111.477770444864;26131.73868261293;26239;42822.78588607037;43170.35244471273;43531.56468435275;43607.34588981231;44741.32888006748;30399.240018999702;30517.23706907345;31166.532502012033;31369.52945705862;31743.682563174072;34234.82882585571;34352.82823585866;34359.656403436646;34599.82700086483;35202.29595408026;34863.825680871436;35233.82383088171;35660.821695891354;37047.8147609271;37152.44271335878;27868.30329241704;29456.507671016745;31508.527372089895;31787.410629467973;32030.19924501906;24032.39919002039;24287.75712242855;24404.389890252885;24655.753442466063;24694.876525617256 02:39:33 INFO - PROCESS | 6521 | |2;jquery.html;372.992540149197;376.6421899195765;383.6029709250924;383.77932688704004;395.9683225341973;15847.286872090755;16199.757003644954;17149.056801875893;17189.484315470523;17214.56963575911;14896.329665165094;15089.698206035873;15553.533393998197;15603.84396156038;15625.453109141183;4572.954270457294;4697.318888761128;4735.266033764772;4747.976260118695;4751.809927602892;3433.7253019758487;5133.82031628893;5435.918461223065;5444.50999410053;5450.31871016123;5411.296531450906;5424.240606315119;5426.782928682848;5427.972860135694;5428.294321738169;4914.950850491503;5178.870528236786;5184.222366644995;5189.532942035235;5200.401953775307;5023.372078490189;5047.974760126176;5063.54428101469;5063.620228482879;5186.299849520305;11721.355325457096;11900.583479578174;11909.166358354918;12011.399430028463;17069;1819.9181036853374;1929.3825975687785;1977.1597071244807;1992.0537744571213;2100.5588826346484;8546.444481108709;8865.689700860503;9298.488583127924;9456.290778191664;9507.4295542267;1726.3353608860552;1829.3231504343346;1890.905454727258;1892.630936967292;1901.895395753233;68303.65848170727;70957;72601;72884.63557682178;72931;10139;10222.488875556193;10260.846087308697;10491.213159013105;10543.261971662063;14468.565943021726;14494.710105798036;14506;14573.562793116223;14592.562223133324;7190.352868241884;7200.351968322876;7245.347918687344;7249.093863267091;7316.743913962986;6633.2703402625675;6696.531242812956;6862.897056544056;6874.621895795679;6904.4131248844415;4336.479622445327;4418.823247070145;4419.602235798729;4476.753778542146;4533.5013148553635;1735.710827980969;1819.4814477873742;1828.3783513605438;1832.4841333690858;1852.8054554271607;840.13885767088;871.020102384817;880.801819590587;957.5547370472764;969.6945462179391;15540.222988850512;16676.91661541709;16766.739762101566;16807.243674034453;16940.2731399092;878.767126711422;878.9384743068051;892.9330300227509;903.0969030969031;946.8390373636498;8956.955215223883;9373.671921482715;9448.196903263299;9571.521423928914;9572.9042709572;417211;417510;423392;424491;448615;47800.7609961948;82156;85142;85240.57379713062;87799.56100219458;948.3693343926212;970.8543718442149;972.781124247053;982.3860087445347;986.8717066781272;14935.477258296341;14941;14975.026623269452;15112.09327440357;15274.236288185768;36637;36689.24830637766;37203.25593488061;37222.81388593148;38131.618683812805;45866.541334587564;51942.22086668627;54094;55190;56415.71792141013;4759.571638552547;4872.220444728827;5045.722485263345;7546.20764819708;7721.150673426031;11683.357415341898;11703.76592468129;11748.70628234301;11849.585264515701;12119.81820272679;10324.690259292232;10422.478876056015;10501.842472362769;10517.21120915919;10712.196585256293;10267.897321026694;10393.792124157626;10426.374417534973;10604.151667866397;10729.624463143753;10505.68482945513;10524.526396312338;10533.36799792015;10822.512986915764;10882.945585272022;7696.076470823313;7710.460267781202;7715.884261736191;7916.327112195528;7968.243016913384;7721.498102623312;10290.485475726333;10328.122109620766;10490;10646.414447205478 02:39:33 INFO - PROCESS | 6521 | |3;mootools.html;1418.2695911605522;1448.23967417106;1571.9921400392996;1687.983120168797;1701.7872765904262;6893.862122757542;7715.112762032368;7782.143964163937;8042.557659328734;8054.073781515128;7736.419768517356;7798.610069496531;7841.451098423098;7858.607069646509;7869.527828330304;2279.452931296489;2317.582835089683;2317.6639387288833;2319.6288593824993;2323.5236776460783;2239.697640818485;2265.2524666859895;2288.8168946484243;2303.37808791627;2311.0871205873755;2302.4474126209675;2310.607196776544;2336.836421450499;2357.210334537932;2360.1621424394352;2272.2728726807427;2283.7830406111393;2288.0504590594883;2289.828262880291;2302.6776251324827;2251.0658076898067;2255.988720056406;2256.131389415087;2271.5797577448225;2271.7505372045307;8003.5197888126895;8088.71689490865;8122.147174546706;8129.349652027823;8137.633806478663;4625.306204069383;4772.904541909177;4785.473597904228;4786.401699787527;4787.880302992418;2971.450281697893;3052.6031615890015;3077.1537827097727;3092.396982588396;3118.1736839737487;979.2410881566772;1016.0702956794524;1022.3846322810017;1023.687775228555;1045.4929359260752;10923.126149907988;10973.83539246912;10976.176786741027;10988.505517251742;10992.450377481095;4334.21984042869;4414.801333939916;4568.200564901129;4589.426321709786;4601.217792975135;9291.488968106683;9298.90701092994;9312.975572686999;9314.161725444743;9334.159925606727;4878.268259761065;4901.387326584177;4922.310876477296;4941.802327906844;4947.851564453;3909.5113110861143;4251.957480425218;4363.759993200341;4409.382686423904;4501.909961800746;3771.6039815819495;3789.204267103939;3831.750936189139;3858.440526123696;3906.7851268180525;1235.2835355493792;1263.2925561685486;1271.5994461744522;1281.7564662714055;1288.1498211180576;738.5347231244282;789.8696715042068;803.935685145187;817.0889458254004;824.826786374868;5138.203578445347;5203.115470370046;5359.330083739533;5379.865503362369;5394.838154855361;833.4041160570222;843.0852525010309;919.6551293265026;925.9351845370759;939.8496240601471;3602.225521512887;3613.94579081314;3653.1415117447377;3657.65252301031;3675.5956844747056;9791.706248812547;10025.849612255823;10134.189264858793;10210.234232432596;10228.437435941094;9949.054839790208;10013.148882345082;10048.79902401948;10130.746731331776;10133.847992280122;7560.206178351304;7705.30652241301;7745.225477452323;7750.263724946121;7775.1447340792465;5172.275881376686;5213.322268105122;5299.5230429261555;5437.13005919051;5455.645383050089;8649.8702519461;9088.681896133603;9211.124943130391;9303.116203960613;9397.718068457958;9408.294377921546;9492.95253523728;9530.903946046294;9555.713328600154;9673.1294183521;6278.968605156945;6617.305182955913;6801.829954251183;6871.347222013901;6998.405135563534;7395.482316237812;7451.850962980819;7455.850882982201;7487.026686530716;7528.849423011399;6503.544751867513;6730.394264516217;6734.663266836541;6801.319868013357;6810.421114205348;6686.966565167143;6701.497387695845;6722.260551339251;6754.493412994143;6765.188177418544;6385.074164246251;6398.520110991787;6446.355364463704;6460.289368169404;6487.3836985486305;4626.699264547794;4667.883302917318;4707.388039554836;4722.48052714208;4744.7390393528685;4418.8453404130705;4509.774511274489;4601.28680054592;4626.190416677001;4640.257558790578 02:39:33 INFO - PROCESS | 6521 | |4;prototype.html;310.37769272608415;316.52047148569915;324.13456072286994;325.96903294187047;327.22774252763475;5177.4045984711765;5317.494837990384;5391.649542779716;5392.433794451585;5406.8377948661555;5410.8917821643545;5411.404745477994;5419.864503387417;5438.53772429343;5456.781728730846;4222.134462435209;4224.176285624305;4236.724612900151;4250.893727656802;4253.8723838284905;4128.277551428488;4224.260754367989;4250.553691862357;4255.893602659943;4274.380214868842;4167.312393455076;4195.832166713328;4197.916041679165;4201.117765269297;4217.219814334358;4196.664266858659;4223.577642235782;4236.830526778926;4237.809298581556;4249.128928569636;3451.9654803451895;3586.7668601540818;3587.7442894986807;3593.245418462126;3605.5312809334882;5157.246536177718;5167;5168.9224661630105;5175.896482070375;5182.870428239286;4733.83431579893;4734.2425211966265;4757.857264282077;4763.190257656207;4764.904701905943;5497.189958786063;5642.238297829782;5644.238027866268;5664.4618761218035;5669.40471250521;3888.766673999569;3901.746386484898;3913.549941756706;3914.471546341236;3925.960740392588;5913.349531551526;5925.4074592541265;5946.137810017523;5950.2264705587995;5998.97000514999;3919.275518771731;4038.7172897897453;4040.7979601019833;4041.2927737645796;4049.0484736086996;4079.5104587449105;4107.466029416157;4114.691398145151;4125.628693417607;4129.070959034253;4738.5547408040875;4745.620350372031;4749.382580264543;4761.452432970253;4773.11697335994;5419.566434685215;5592.524635406036;5699.715014249271;5709.286339207599;5721.056025755704;1433.5985923941314;1464.692414592926;1471.9043262187924;1474.6829431672243;1478.689475210218;977.7257883706139;987.3335498538457;1004.1966426858484;1006.3609607899036;1007.7732510185297;4829.348038014893;4847.515248475124;4851.466338702739;4866.46468888422;4901.803927842846;5766.711664416763;5800.187973683687;5802.404338806862;5839.970800146057;5845.09401042839;4715.669903106818;4866.878328041827;4876.609871210295;4909.68087074339;4921.975390123026;3091.9536206956464;3098.752099832008;3124.7500199983947;3127.640321363027;3130.7025832545874;5373.623846330797;5398.217258497574;5407.459254074561;5415.404305526389;5443.156310771837;5757.769689212469;5925.970370148121;5958.344582095966;5965.612235204784;5980.43185897339;5367.490088441592;5369.919451208235;5385.515303622693;5414.133738601883;5415.4313797050745;5582.302212223472;5775.653460792366;5806.535477161901;5830.2420685310635;5849.561282903885;5639.351474580476;5682.204491371294;5684.147377893349;5697.686627235376;5704;5380.892382152413;5395.4604539545735;5418.106012507892;5439.918401224064;5441.83674489766;3812.237552489458;4040.807961651261;4055.7160998729805;4170.436991006175;4178.247915375262;5643.049865094368;5675.8864822704145;5847.38602446737;5858.179854820414;5867.765289388547;5682.943170568242;5711.914321285267;5729;5736.741846616829;5736.942630573641;5639.830805075854;5680.602357834912;5682.687452190169;5705.486506214461;5713.571482138939;5342.65272757285;5626.1560765883805;5631.211630371833;5650.85872853182;5657.15142728594;5749.425057494384;5751.683657398883;5756.0502517084215;5793.855153621024;5833.854153646193;5397.433269506802;5541.307336582927;5585.804496842754;5593;5610.607257491936 02:39:33 INFO - PROCESS | 6521 | |5;yui.html;668.9998452313791;699.1784653032686;726.4152357352331;749.4903465643367;760.5398733766069;12166.209196402227;12316.568920087799;12448.190867593612;12476.37618119095;12495.562655307067;12339.753204935896;12379.257244565333;12386.442610082546;12395.938020309908;12397;761.1399118995541;800.3997002248313;805.0379796143611;807.9515229086244;811.975640730779;797.9521228726265;804.1194891593725;804.1837534902079;805.138501803068;805.6777289084384;831.846108469932;832.9250367466926;834.253343257784;836.4145098431092;837.4221786966973;829.3323874281232;830.7632324787437;834.9540775257359;836.5190015740973;838.1325328285257;607.4472230270477;607.8936186167404;609.3358239518901;609.402785270433;609.4058293164173;12456.377181140906;12482.50069997199;12497.56258530956;12508.937455312756;12509.687257818536;11507.309561426342;11590.362530060844;11691.532338706442;11791.587294444738;12168.57409990655;9652.420854748667;9839.950800246024;9949.377915245323;9999.25005624581;10111.544980475895;3283.129970557804;3301.504774283853;3357.278185190196;3373.477111047767;3389.8305084745666;48273;48798.756006219744;48858;48928.755356223344;50075.99848003056;8845.336599755045;8891.377603567818;8938.240249578728;8952.104789521127;8961;15079.849201508065;15141.545753627188;15141.545753627408;15143.924280378747;15179.089254644756;6929.237783843773;6930.757423490154;6948.235694073648;6987.89518157228;7060.152781666233;3750.1374683822874;3765.9435108473394;3798.582155962842;3840.347140986039;3840.4431357453013;2859.7998140130408;2929.5312749959903;2940.382519670893;2942.073246927211;2944.4699954008056;492.4681344148311;495.0816235882458;500.75713279059624;509.2895410901771;511.04689753609995;442.60165850733955;530.2152813835545;553.7757208330632;569.2912324156451;575.1545228514077;7220.963895180491;7255.274472552808;7449.025375143348;7670.386369090571;7888.132305446511;481.3694060780389;522.6237109281311;539.9433059528772;560.5093022796012;565.0845630079298;3176.2059485128716;3445.1214940190093;3445.620981692012;3459.325431540876;3464.6881780639865;52180.73909630428;53734.73132634312;53797;53897.1915421269;53917.1912421314;41173.38239926403;42445;43243.567564324585;48423.273650895266;49431;41464.58535414668;41540;42032.36951445731;42330.9417264577;43051.35422968658;7030.086088808423;7101.786946391617;7108.573485590881;7139.678714457758;7244.275572442713;27355.863220684565;29150.12549623515;29164.56253156162;29497;29868.551971720008;36491.452628211126;37199.628003720696;39614.40578391269;39973.60026399699;40390.39414408727;8903.627477222912;9218.861717074384;9494.810103798023;9701.466419346722;9789.776277965255;10111.241656875616;10196;10670.786584268426;10764.300320479144;11202.43987800623;9948.154406875497;10064.547095380873;10165.593376265162;10233.692989210336;10608.416537090225;10464.11055060298;10626;10662.360258384522;10736.51685674131;11028.503717332578;9342.766430839283;9604.66383676568;9649.855252171083;9868.358556693793;10163.272243718438;8073.152319006655;8132.878006829784;8204.425690201628;8278.668853246043;8411.53736544496;8502.404831661725;8555.914440855511;8604.48373097616;8634.870476942726;8697.21725044749 02:39:33 INFO - PROCESS | 6521 | __end_tp_report 02:39:33 INFO - PROCESS | 6521 | __start_cc_report 02:39:33 INFO - PROCESS | 6521 | _x_x_mozilla_cycle_collect,364 02:39:33 INFO - PROCESS | 6521 | __end_cc_report 02:39:33 INFO - PROCESS | 6521 | __startTimestamp1461317973877__endTimestamp 02:39:33 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | ------- Summary: start ------- 02:39:33 INFO - PROCESS | 6521 | Number of tests: 6 02:39:33 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | [#0] dojo.html Cycles:165 Average:4749.68 Median:4892.85 stddev:503.54 (10.3%) stddev-sans-first:477.20 02:39:33 INFO - PROCESS | 6521 | Values: 2643.3 2690.6 2731.8 2737.2 2742.9 4726.6 4736.8 4772.9 4790.8 4792.9 4690.2 4808.1 4827.3 4835.4 4852.2 4364.5 4372.9 4379.2 4418.6 4475.3 4386.4 4460.5 4520.4 4549.8 4553.7 4261.8 4342.6 4389.7 4438.7 4499.3 4323.2 4334.1 4379.5 4392.0 4426.4 4382.2 4385.6 4405.6 4409.7 4463.1 4670.4 4675.5 4748.0 4770.9 4800.4 5088.5 5106.7 5120.8 5125.6 5140.7 4965.8 5124.1 5158.8 5159.6 5170.8 4822.6 4829.7 4838.7 4839.1 4878.4 5154.0 5206.3 5217.2 5247.3 5265.9 4967.2 5016.3 5021.2 5027.5 5081.3 5255.1 5279.8 5287.6 5291.6 5335.3 5021.6 5128.2 5128.6 5130.6 5132.7 5052.1 5060.9 5098.6 5116.1 5129.7 4254.1 4273.8 4297.6 4306.7 4360.4 3768.9 3773.7 3782.1 3814.8 3818.4 4442.2 4453.0 4457.1 4463.6 4473.1 5057.2 5142.7 5178.0 5218.1 5237.4 4390.5 4401.4 4410.7 4452.2 4459.1 4513.4 4533.3 4540.2 4542.0 4581.9 4756.2 4793.5 4838.4 4930.0 4941.3 5145.5 5166.2 5171.4 5185.5 5194.7 4852.9 4870.0 4892.9 4900.0 4925.9 4958.5 4962.1 4994.2 5035.5 5037.3 5205.1 5214.8 5257.4 5261.7 5289.1 4915.3 5098.2 5099.9 5108.5 5124.8 4909.3 4996.6 5001.1 5051.7 5084.6 4907.4 4934.6 4965.3 4995.9 5009.4 5041.5 5067.8 5078.4 5081.6 5136.3 4776.7 4883.6 4926.7 4962.6 4980.8 02:39:33 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | [#1] ext.html Cycles:180 Average:41548.56 Median:35406.91 stddev:73341.91 (207.1%) stddev-sans-first:73483.12 02:39:33 INFO - PROCESS | 6521 | Values: 569.5 602.6 617.2 621.5 635.8 34048.0 35271.1 35308.5 35319.0 35367.0 35123.6 35552.6 35566.8 35676.3 35710.5 7657.9 7818.8 7820.4 7825.4 7827.4 7702.0 7784.8 7806.2 7822.8 7841.2 7705.4 7744.1 7746.4 7763.5 7790.4 7710.5 7717.6 7739.3 7747.3 7791.5 7660.1 7782.5 7794.2 7825.2 7842.1 30536.4 35858.5 36341.5 36394.6 36487.3 2771.2 2782.4 2905.7 2968.1 2983.3 27315.6 27628.9 27942.0 28014.9 28029.7 3475.1 3523.3 3600.4 3604.1 3678.6 181429.1 185720.0 185754.0 186135.0 237873.8 33434.8 34609.8 55487.4 55988.7 56491.0 35356.8 35446.8 35602.8 35642.6 35832.6 12276.8 12424.6 12437.3 12448.0 12544.4 9703.9 9704.2 9710.1 9712.0 9736.6 8221.9 8262.3 8320.6 8362.9 8365.8 3314.7 3320.5 3369.4 3374.5 3389.4 883.5 885.6 900.4 964.7 973.5 27103.9 28058.9 28348.6 28440.1 28908.7 982.8 989.0 999.1 1095.9 1101.1 14840.8 15139.5 15267.4 15472.9 15565.7 354671.0 361044.0 361671.0 363600.0 364158.0 48048.8 48752.8 49094.5 49110.3 49148.3 1183.5 1207.6 1207.6 1221.4 1235.5 26513.6 27785.2 27978.0 28012.9 28147.0 42046.6 42370.0 42472.8 42657.8 42723.8 250886.0 250986.0 251932.0 252668.0 252829.0 25160.9 25404.4 26111.5 26131.7 26239.0 42822.8 43170.4 43531.6 43607.3 44741.3 30399.2 30517.2 31166.5 31369.5 31743.7 34234.8 34352.8 34359.7 34599.8 35202.3 34863.8 35233.8 35660.8 37047.8 37152.4 27868.3 29456.5 31508.5 31787.4 32030.2 24032.4 24287.8 24404.4 24655.8 24694.9 02:39:33 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | [#2] jquery.html Cycles:180 Average:25137.93 Median:4419.21 stddev:70358.89 (1592.1%) stddev-sans-first:70531.69 02:39:33 INFO - PROCESS | 6521 | Values: 373.0 376.6 383.6 383.8 396.0 15847.3 16199.8 17149.1 17189.5 17214.6 14896.3 15089.7 15553.5 15603.8 15625.5 4573.0 4697.3 4735.3 4748.0 4751.8 3433.7 5133.8 5435.9 5444.5 5450.3 5411.3 5424.2 5426.8 5428.0 5428.3 4915.0 5178.9 5184.2 5189.5 5200.4 5023.4 5048.0 5063.5 5063.6 5186.3 11721.4 11900.6 11909.2 12011.4 17069.0 1819.9 1929.4 1977.2 1992.1 2100.6 8546.4 8865.7 9298.5 9456.3 9507.4 1726.3 1829.3 1890.9 1892.6 1901.9 68303.7 70957.0 72601.0 72884.6 72931.0 10139.0 10222.5 10260.8 10491.2 10543.3 14468.6 14494.7 14506.0 14573.6 14592.6 7190.4 7200.4 7245.3 7249.1 7316.7 6633.3 6696.5 6862.9 6874.6 6904.4 4336.5 4418.8 4419.6 4476.8 4533.5 1735.7 1819.5 1828.4 1832.5 1852.8 840.1 871.0 880.8 957.6 969.7 15540.2 16676.9 16766.7 16807.2 16940.3 878.8 878.9 892.9 903.1 946.8 8957.0 9373.7 9448.2 9571.5 9572.9 417211.0 417510.0 423392.0 424491.0 448615.0 47800.8 82156.0 85142.0 85240.6 87799.6 948.4 970.9 972.8 982.4 986.9 14935.5 14941.0 14975.0 15112.1 15274.2 36637.0 36689.2 37203.3 37222.8 38131.6 45866.5 51942.2 54094.0 55190.0 56415.7 4759.6 4872.2 5045.7 7546.2 7721.2 11683.4 11703.8 11748.7 11849.6 12119.8 10324.7 10422.5 10501.8 10517.2 10712.2 10267.9 10393.8 10426.4 10604.2 10729.6 10505.7 10524.5 10533.4 10822.5 10882.9 7696.1 7710.5 7715.9 7916.3 7968.2 7721.5 10290.5 10328.1 10490.0 10646.4 02:39:33 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | [#3] mootools.html Cycles:180 Average:5286.78 Median:4787.14 stddev:2946.62 (61.6%) stddev-sans-first:2940.55 02:39:33 INFO - PROCESS | 6521 | Values: 1418.3 1448.2 1572.0 1688.0 1701.8 6893.9 7715.1 7782.1 8042.6 8054.1 7736.4 7798.6 7841.5 7858.6 7869.5 2279.5 2317.6 2317.7 2319.6 2323.5 2239.7 2265.3 2288.8 2303.4 2311.1 2302.4 2310.6 2336.8 2357.2 2360.2 2272.3 2283.8 2288.1 2289.8 2302.7 2251.1 2256.0 2256.1 2271.6 2271.8 8003.5 8088.7 8122.1 8129.3 8137.6 4625.3 4772.9 4785.5 4786.4 4787.9 2971.5 3052.6 3077.2 3092.4 3118.2 979.2 1016.1 1022.4 1023.7 1045.5 10923.1 10973.8 10976.2 10988.5 10992.5 4334.2 4414.8 4568.2 4589.4 4601.2 9291.5 9298.9 9313.0 9314.2 9334.2 4878.3 4901.4 4922.3 4941.8 4947.9 3909.5 4252.0 4363.8 4409.4 4501.9 3771.6 3789.2 3831.8 3858.4 3906.8 1235.3 1263.3 1271.6 1281.8 1288.1 738.5 789.9 803.9 817.1 824.8 5138.2 5203.1 5359.3 5379.9 5394.8 833.4 843.1 919.7 925.9 939.8 3602.2 3613.9 3653.1 3657.7 3675.6 9791.7 10025.8 10134.2 10210.2 10228.4 9949.1 10013.1 10048.8 10130.7 10133.8 7560.2 7705.3 7745.2 7750.3 7775.1 5172.3 5213.3 5299.5 5437.1 5455.6 8649.9 9088.7 9211.1 9303.1 9397.7 9408.3 9493.0 9530.9 9555.7 9673.1 6279.0 6617.3 6801.8 6871.3 6998.4 7395.5 7451.9 7455.9 7487.0 7528.8 6503.5 6730.4 6734.7 6801.3 6810.4 6687.0 6701.5 6722.3 6754.5 6765.2 6385.1 6398.5 6446.4 6460.3 6487.4 4626.7 4667.9 4707.4 4722.5 4744.7 4418.8 4509.8 4601.3 4626.2 4640.3 02:39:33 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | [#4] prototype.html Cycles:180 Average:4674.30 Median:5355.07 stddev:1364.31 (25.5%) stddev-sans-first:1328.24 02:39:33 INFO - PROCESS | 6521 | Values: 310.4 316.5 324.1 326.0 327.2 5177.4 5317.5 5391.6 5392.4 5406.8 5410.9 5411.4 5419.9 5438.5 5456.8 4222.1 4224.2 4236.7 4250.9 4253.9 4128.3 4224.3 4250.6 4255.9 4274.4 4167.3 4195.8 4197.9 4201.1 4217.2 4196.7 4223.6 4236.8 4237.8 4249.1 3452.0 3586.8 3587.7 3593.2 3605.5 5157.2 5167.0 5168.9 5175.9 5182.9 4733.8 4734.2 4757.9 4763.2 4764.9 5497.2 5642.2 5644.2 5664.5 5669.4 3888.8 3901.7 3913.5 3914.5 3926.0 5913.3 5925.4 5946.1 5950.2 5999.0 3919.3 4038.7 4040.8 4041.3 4049.0 4079.5 4107.5 4114.7 4125.6 4129.1 4738.6 4745.6 4749.4 4761.5 4773.1 5419.6 5592.5 5699.7 5709.3 5721.1 1433.6 1464.7 1471.9 1474.7 1478.7 977.7 987.3 1004.2 1006.4 1007.8 4829.3 4847.5 4851.5 4866.5 4901.8 5766.7 5800.2 5802.4 5840.0 5845.1 4715.7 4866.9 4876.6 4909.7 4922.0 3092.0 3098.8 3124.8 3127.6 3130.7 5373.6 5398.2 5407.5 5415.4 5443.2 5757.8 5926.0 5958.3 5965.6 5980.4 5367.5 5369.9 5385.5 5414.1 5415.4 5582.3 5775.7 5806.5 5830.2 5849.6 5639.4 5682.2 5684.1 5697.7 5704.0 5380.9 5395.5 5418.1 5439.9 5441.8 3812.2 4040.8 4055.7 4170.4 4178.2 5643.0 5675.9 5847.4 5858.2 5867.8 5682.9 5711.9 5729.0 5736.7 5736.9 5639.8 5680.6 5682.7 5705.5 5713.6 5342.7 5626.2 5631.2 5650.9 5657.2 5749.4 5751.7 5756.1 5793.9 5833.9 5397.4 5541.3 5585.8 5593.0 5610.6 02:39:33 INFO - PROCESS | 6521 | 02:39:33 INFO - PROCESS | 6521 | [#5] yui.html Cycles:180 Average:12469.81 Median:25292.64 stddev:14648.87 (57.9%) stddev-sans-first:14663.16 02:39:33 INFO - PROCESS | 6521 | Values: 669.0 699.2 726.4 749.5 760.5 12166.2 12316.6 12448.2 12476.4 12495.6 12339.8 12379.3 12386.4 12395.9 12397.0 761.1 800.4 805.0 808.0 812.0 798.0 804.1 804.2 805.1 805.7 831.8 832.9 834.3 836.4 837.4 829.3 830.8 835.0 836.5 838.1 607.4 607.9 609.3 609.4 609.4 12456.4 12482.5 12497.6 12508.9 12509.7 11507.3 11590.4 11691.5 11791.6 12168.6 9652.4 9840.0 9949.4 9999.3 10111.5 3283.1 3301.5 3357.3 3373.5 3389.8 48273.0 48798.8 48858.0 48928.8 50076.0 8845.3 8891.4 8938.2 8952.1 8961.0 15079.8 15141.5 15141.5 15143.9 15179.1 6929.2 6930.8 6948.2 6987.9 7060.2 3750.1 3765.9 3798.6 3840.3 3840.4 2859.8 2929.5 2940.4 2942.1 2944.5 492.5 495.1 500.8 509.3 511.0 442.6 530.2 553.8 569.3 575.2 7221.0 7255.3 7449.0 7670.4 7888.1 481.4 522.6 539.9 560.5 565.1 3176.2 3445.1 3445.6 3459.3 3464.7 52180.7 53734.7 53797.0 53897.2 53917.2 41173.4 42445.0 43243.6 48423.3 49431.0 41464.6 41540.0 42032.4 42330.9 43051.4 7030.1 7101.8 7108.6 7139.7 7244.3 27355.9 29150.1 29164.6 29497.0 29868.6 36491.5 37199.6 39614.4 39973.6 40390.4 8903.6 9218.9 9494.8 9701.5 9789.8 10111.2 10196.0 10670.8 10764.3 11202.4 9948.2 10064.5 10165.6 10233.7 10608.4 10464.1 10626.0 10662.4 10736.5 11028.5 9342.8 9604.7 9649.9 9868.4 10163.3 8073.2 8132.9 8204.4 8278.7 8411.5 8502.4 8555.9 8604.5 8634.9 8697.2 02:39:33 INFO - PROCESS | 6521 | -------- Summary: end -------- 02:39:33 INFO - PROCESS | 6521 | 02:39:34 INFO - TEST-INFO | 6521: exit 0 02:39:34 INFO - TEST-OK | dromaeo_css | took 1115606ms 02:39:34 INFO - TEST-START | kraken 02:39:34 INFO - operating with platform_type : linux_ 02:39:34 INFO - Initialising browser for kraken test... 02:39:34 INFO - TEST-INFO | started process 6752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD7xU5z/profile http://localhost:47437/getInfo.html) 02:39:38 INFO - PROCESS | 6752 | 02:39:38 INFO - PROCESS | 6752 | (process:6821): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:39:39 INFO - PROCESS | 6752 | __metrics Screen width/height:1600/1200 02:39:39 INFO - PROCESS | 6752 | colorDepth:24 02:39:39 INFO - PROCESS | 6752 | Browser inner width/height: 1024/697 02:39:39 INFO - PROCESS | 6752 | __metrics 02:39:39 ERROR - PROCESS | 6752 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:39:40 INFO - TEST-INFO | 6752: exit 0 02:39:40 INFO - Browser initialized. 02:39:40 INFO - Running cycle 1/1 for kraken test... 02:39:40 INFO - TEST-INFO | started process 6872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD7xU5z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:42 INFO - PROCESS | 6872 | 02:39:42 INFO - PROCESS | 6872 | (process:6934): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:39:52 INFO - PROCESS | 6872 | RSS: Main: 165126144 02:39:52 INFO - PROCESS | 6872 | 02:39:55 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47437/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:56 INFO - PROCESS | 6872 | RSS: Main: 168583168 02:39:56 INFO - PROCESS | 6872 | 02:39:59 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47437/tests/kraken/driver.html?testName=audio-dft) 02:39:59 INFO - PROCESS | 6872 | RSS: Main: 171933696 02:39:59 INFO - PROCESS | 6872 | 02:40:02 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47437/tests/kraken/driver.html?testName=audio-fft) 02:40:03 INFO - PROCESS | 6872 | RSS: Main: 164302848 02:40:03 INFO - PROCESS | 6872 | 02:40:05 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47437/tests/kraken/driver.html?testName=audio-oscillator) 02:40:06 INFO - PROCESS | 6872 | RSS: Main: 164745216 02:40:06 INFO - PROCESS | 6872 | 02:40:08 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:09 INFO - PROCESS | 6872 | RSS: Main: 165027840 02:40:09 INFO - PROCESS | 6872 | 02:40:12 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47437/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:13 INFO - PROCESS | 6872 | RSS: Main: 165355520 02:40:13 INFO - PROCESS | 6872 | 02:40:16 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47437/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:17 INFO - PROCESS | 6872 | RSS: Main: 164855808 02:40:17 INFO - PROCESS | 6872 | 02:40:20 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47437/tests/kraken/driver.html?testName=json-parse-financial) 02:40:20 INFO - PROCESS | 6872 | RSS: Main: 165670912 02:40:20 INFO - PROCESS | 6872 | 02:40:22 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:23 INFO - PROCESS | 6872 | RSS: Main: 165609472 02:40:23 INFO - PROCESS | 6872 | 02:40:24 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47437/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:25 INFO - PROCESS | 6872 | RSS: Main: 166121472 02:40:25 INFO - PROCESS | 6872 | 02:40:27 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:28 INFO - PROCESS | 6872 | RSS: Main: 166436864 02:40:28 INFO - PROCESS | 6872 | 02:40:31 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:32 INFO - PROCESS | 6872 | RSS: Main: 166109184 02:40:32 INFO - PROCESS | 6872 | 02:40:34 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:35 INFO - PROCESS | 6872 | RSS: Main: 166301696 02:40:35 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:47437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47437/tests/kraken/driver.html?testName=ai-astar) 02:40:37 INFO - PROCESS | 6872 | RSS: Main: 167845888 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | __start_tp_report 02:40:37 INFO - PROCESS | 6872 | _x_x_mozilla_page_load 02:40:37 INFO - PROCESS | 6872 | _x_x_mozilla_page_load_details 02:40:37 INFO - PROCESS | 6872 | |i|pagename|runs| 02:40:37 INFO - PROCESS | 6872 | |0;ai-astar;114;110;112;114;115;125;113;123;114;116 02:40:37 INFO - PROCESS | 6872 | |1;audio-beat-detection;160;136;152;193;138;163;157;139;193;133 02:40:37 INFO - PROCESS | 6872 | |2;audio-dft;163;163;164;175;165;163;164;165;165;163 02:40:37 INFO - PROCESS | 6872 | |3;audio-fft;77;78;74;172;78;73;75;80;157;79 02:40:37 INFO - PROCESS | 6872 | |4;audio-oscillator;94;95;151;94;94;94;148;93;93;152 02:40:37 INFO - PROCESS | 6872 | |5;imaging-gaussian-blur;118;117;118;118;118;117;120;118;118;118 02:40:37 INFO - PROCESS | 6872 | |6;imaging-darkroom;149;149;147;151;149;149;150;148;148;148 02:40:37 INFO - PROCESS | 6872 | |7;imaging-desaturate;105;101;100;95;95;95;95;100;96;96 02:40:37 INFO - PROCESS | 6872 | |8;json-parse-financial;66;67;64;67;65;66;74;82;62;76 02:40:37 INFO - PROCESS | 6872 | |9;json-stringify-tinderbox;65;65;65;65;65;64;65;65;64;66 02:40:37 INFO - PROCESS | 6872 | |10;stanford-crypto-aes;88;81;79;82;81;89;82;82;90;82 02:40:37 INFO - PROCESS | 6872 | |11;stanford-crypto-ccm;150;144;132;142;131;141;134;136;168;136 02:40:37 INFO - PROCESS | 6872 | |12;stanford-crypto-pbkdf2;177;175;183;183;181;177;179;179;186;181 02:40:37 INFO - PROCESS | 6872 | |13;stanford-crypto-sha256-iterative;75;78;74;76;75;74;73;72;76;74 02:40:37 INFO - PROCESS | 6872 | __end_tp_report 02:40:37 INFO - PROCESS | 6872 | __start_cc_report 02:40:37 INFO - PROCESS | 6872 | _x_x_mozilla_cycle_collect,927 02:40:37 INFO - PROCESS | 6872 | __end_cc_report 02:40:37 INFO - PROCESS | 6872 | __startTimestamp1461318037727__endTimestamp 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | ------- Summary: start ------- 02:40:37 INFO - PROCESS | 6872 | Number of tests: 14 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#0] ai-astar Cycles:10 Average:115.60 Median:114.50 stddev:4.74 (4.1%) stddev-sans-first:4.99 02:40:37 INFO - PROCESS | 6872 | Values: 114.0 110.0 112.0 114.0 115.0 125.0 113.0 123.0 114.0 116.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:158.50 stddev:22.01 (13.9%) stddev-sans-first:23.31 02:40:37 INFO - PROCESS | 6872 | Values: 160.0 136.0 152.0 193.0 138.0 163.0 157.0 139.0 193.0 133.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:3.62 (2.2%) stddev-sans-first:3.77 02:40:37 INFO - PROCESS | 6872 | Values: 163.0 163.0 164.0 175.0 165.0 163.0 164.0 165.0 165.0 163.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#3] audio-fft Cycles:10 Average:94.30 Median:77.50 stddev:37.23 (48.0%) stddev-sans-first:38.96 02:40:37 INFO - PROCESS | 6872 | Values: 77.0 78.0 74.0 172.0 78.0 73.0 75.0 80.0 157.0 79.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:94.00 stddev:27.30 (29.0%) stddev-sans-first:28.28 02:40:37 INFO - PROCESS | 6872 | Values: 94.0 95.0 151.0 94.0 94.0 94.0 148.0 93.0 93.0 152.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 02:40:37 INFO - PROCESS | 6872 | Values: 118.0 117.0 118.0 118.0 118.0 117.0 120.0 118.0 118.0 118.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 02:40:37 INFO - PROCESS | 6872 | Values: 149.0 149.0 147.0 151.0 149.0 149.0 150.0 148.0 148.0 148.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#7] imaging-desaturate Cycles:10 Average:97.80 Median:95.00 stddev:3.49 (3.7%) stddev-sans-first:2.55 02:40:37 INFO - PROCESS | 6872 | Values: 105.0 101.0 100.0 95.0 95.0 95.0 95.0 100.0 96.0 96.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:67.00 stddev:6.31 (9.4%) stddev-sans-first:6.61 02:40:37 INFO - PROCESS | 6872 | Values: 66.0 67.0 64.0 67.0 65.0 66.0 74.0 82.0 62.0 76.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 02:40:37 INFO - PROCESS | 6872 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 64.0 66.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.00 stddev:3.86 (4.7%) stddev-sans-first:3.76 02:40:37 INFO - PROCESS | 6872 | Values: 88.0 81.0 79.0 82.0 81.0 89.0 82.0 82.0 90.0 82.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:141.50 stddev:11.05 (7.8%) stddev-sans-first:11.27 02:40:37 INFO - PROCESS | 6872 | Values: 150.0 144.0 132.0 142.0 131.0 141.0 134.0 136.0 168.0 136.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:181.00 stddev:3.35 (1.8%) stddev-sans-first:3.36 02:40:37 INFO - PROCESS | 6872 | Values: 177.0 175.0 183.0 183.0 181.0 177.0 179.0 179.0 186.0 181.0 02:40:37 INFO - PROCESS | 6872 | 02:40:37 INFO - PROCESS | 6872 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:75.00 stddev:1.70 (2.3%) stddev-sans-first:1.80 02:40:37 INFO - PROCESS | 6872 | Values: 75.0 78.0 74.0 76.0 75.0 74.0 73.0 72.0 76.0 74.0 02:40:37 INFO - PROCESS | 6872 | -------- Summary: end -------- 02:40:37 INFO - PROCESS | 6872 | 02:40:38 INFO - TEST-INFO | 6872: exit 0 02:40:38 INFO - TEST-OK | kraken | took 64125ms 02:40:38 INFO - SUITE-END | took 1179s 02:40:38 INFO - Completed test suite (00:19:39) 02:40:38 INFO - javascript benchmark 02:40:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.312738687941, 2690.6098615700726, 2731.8087733858624, 2737.1788463460957, 2742.9177124686266, 4726.574608285258, 4736.810527578893, 4772.928406073907, 4790.80836766529, 4792.897633544287, 4690.202665546857, 4808.062427826567, 4827.324174615556, 4835.395575553056, 4852.199387101133, 4364.519902810696, 4372.934405983913, 4379.167958087969, 4418.580234877698, 4475.3063275192235, 4386.385905973167, 4460.464744230697, 4520.389747384111, 4549.818007279721, 4553.749543775091, 4261.76560289184, 4342.565743425664, 4389.692721509496, 4438.733675979435, 4499.302608095751, 4323.2434323993175, 4334.068175342285, 4379.540148284416, 4391.978040109779, 4426.380306757057, 4382.233109205877, 4385.649148068147, 4405.581469760367, 4409.669274804371, 4463.062756821039, 4670.392848929618, 4675.462321832999, 4747.976260118678, 4770.928436073462, 4800.423949126127, 5088.516590923893, 5106.693598384071, 5120.846374608767, 5125.564327032207, 5140.665856719302, 4965.801367945278, 5124.128898087297, 5158.767855446514, 5159.638825282232, 5170.819021334273, 4822.590079843182, 4829.734364609945, 4838.685485443435, 4839.128956787777, 4878.390201224847, 5154.046501397253, 5206.323177986837, 5217.191335343028, 5247.344081989751, 5265.921011184835, 4967.205247160509, 5016.272640467112, 5021.171506701427, 5027.497250274943, 5081.2632168335385, 5255.054090263713, 5279.762410691528, 5287.603429742785, 5291.576673866081, 5335.33308336458, 5021.648484606116, 5128.179491281452, 5128.615353848476, 5130.615203859726, 5132.743362831843, 5052.065367906949, 5060.873478163002, 5098.617603679739, 5116.130257856174, 5129.717865517432, 4254.085371645111, 4273.807678654468, 4297.613214810682, 4306.74159550428, 4360.4331436913, 3768.8680896168503, 3773.6792372648083, 3782.149016471272, 3814.8474061037246, 3818.4081467372603, 4442.178197033559, 4452.955470445254, 4457.064016556495, 4463.598276155161, 4473.1277400907165, 5057.190849464068, 5142.665726727751, 5178.042062218502, 5218.08683480397, 5237.397699264633, 4390.517043125254, 4401.405810215644, 4410.713303635253, 4452.220861349316, 4459.063596644676, 4513.368128462018, 4533.252013417749, 4540.205464043779, 4542.0, 4581.862544123682, 4756.21522448799, 4793.520647935248, 4838.419389673261, 4930.0, 4941.308216849716, 5145.511176438233, 5166.225066240094, 5171.405288391733, 5185.481451854785, 5194.662346947436, 4852.902941941212, 4869.952960113593, 4892.8532144035735, 4899.951000489949, 4925.852224433273, 4958.45456999737, 4962.131626965339, 4994.225894986283, 5035.546800787946, 5037.345145131109, 5205.06308864408, 5214.765335559833, 5257.447967963309, 5261.684298942076, 5289.100852855101, 4915.336429581961, 5098.2352647103235, 5099.872503187302, 5108.489151084862, 5124.846254612367, 4909.26361045846, 4996.6002719783055, 5001.149804533311, 5051.6716413433005, 5084.593232541314, 4907.435644900882, 4934.605231581537, 4965.280034395065, 4995.925061124013, 5009.398872135367, 5041.521055499722, 5067.797288108434, 5078.390593128701, 5081.568066714371, 5136.332276803992, 4776.689515181502, 4883.6093112551625, 4926.655134140576, 4962.602991760723, 4980.775865086008], "value": 4717.522718754633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4959960435013, 602.6233603997501, 617.2438762515918, 621.4624349937304, 635.8251480842771, 34048.0, 35271.11822204446, 35308.47037294439, 35319.0, 35367.0, 35123.648763512356, 35552.64447355526, 35566.822165889134, 35676.286474270564, 35710.46434303487, 7657.885131723015, 7818.804529886742, 7820.374370050411, 7825.37397008238, 7827.373810095207, 7702.037245344332, 7784.80537986552, 7806.180351063142, 7822.843543129134, 7841.176676448977, 7705.4220933430215, 7744.109427415835, 7746.38028957682, 7763.495372800779, 7790.415718821111, 7710.498817576839, 7717.614119294041, 7739.303462688329, 7747.341475974549, 7791.493552919071, 7660.080790305144, 7782.533048017137, 7794.2205779422175, 7825.217478252186, 7842.058952925629, 30536.38927221443, 35858.46212306817, 36341.454878176846, 36394.63605363939, 36487.27025459502, 2771.1547977866744, 2782.3600571868583, 2905.6513218413716, 2968.1095671298526, 2983.254186453387, 27315.590266146024, 27628.861855690593, 27942.0, 28014.859925700446, 28029.719702802915, 3475.1138459692615, 3523.312953973976, 3600.369935261319, 3604.116991337113, 3678.5769636491877, 181429.0928545362, 185720.0, 185754.0, 186135.0, 237873.81063094747, 33434.832825835714, 34609.826950865085, 55487.445125549035, 55988.720056399456, 56491.0, 35356.823215883756, 35446.82276588652, 35602.82198589042, 35642.64357356393, 35832.64167358345, 12276.754464910831, 12424.56514022023, 12437.315947622968, 12448.0, 12544.435500402504, 9703.902960970441, 9704.223662107015, 9710.077542633438, 9712.0, 9736.610535578639, 8221.917780822236, 8262.256396924306, 8320.625571849161, 8362.916370836336, 8365.790855228546, 3314.718248948818, 3320.468725003988, 3369.359821633882, 3374.54443650109, 3389.4068538006245, 883.5052370672315, 885.623609965762, 900.4237288135598, 964.7395203295071, 973.493783232715, 27103.864480677472, 28058.85970570175, 28348.574771378448, 28440.146795596163, 28908.710912891023, 982.759223990127, 988.9653862114935, 999.1357475783395, 1095.9287646302964, 1101.130107215291, 14840.777388339184, 15139.470118545798, 15267.389304427921, 15472.92263538675, 15565.688686226213, 354671.0, 361044.0, 361671.0, 363600.0, 364158.0, 48048.759756201, 48752.75623621859, 49094.509054908995, 49110.26334604984, 49148.262776058385, 1183.5480926818243, 1207.6316723399273, 1207.6377086873902, 1221.3648902570615, 1235.4872727818035, 26513.60229596519, 27785.166445006682, 27978.0, 28012.85993570019, 28147.0, 42046.57953420427, 42370.0, 42472.78763606162, 42657.78671106625, 42723.7863810679, 250886.0, 250986.0, 251932.0, 252668.0, 252829.0, 25160.874195628905, 25404.364890877874, 26111.477770444864, 26131.73868261293, 26239.0, 42822.78588607037, 43170.35244471273, 43531.56468435275, 43607.34588981231, 44741.32888006748, 30399.240018999702, 30517.23706907345, 31166.532502012033, 31369.52945705862, 31743.682563174072, 34234.82882585571, 34352.82823585866, 34359.656403436646, 34599.82700086483, 35202.29595408026, 34863.825680871436, 35233.82383088171, 35660.821695891354, 37047.8147609271, 37152.44271335878, 27868.30329241704, 29456.507671016745, 31508.527372089895, 31787.410629467973, 32030.19924501906, 24032.39919002039, 24287.75712242855, 24404.389890252885, 24655.753442466063, 24694.876525617256], "value": 15953.422718252576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.992540149197, 376.6421899195765, 383.6029709250924, 383.77932688704004, 395.9683225341973, 15847.286872090755, 16199.757003644954, 17149.056801875893, 17189.484315470523, 17214.56963575911, 14896.329665165094, 15089.698206035873, 15553.533393998197, 15603.84396156038, 15625.453109141183, 4572.954270457294, 4697.318888761128, 4735.266033764772, 4747.976260118695, 4751.809927602892, 3433.7253019758487, 5133.82031628893, 5435.918461223065, 5444.50999410053, 5450.31871016123, 5411.296531450906, 5424.240606315119, 5426.782928682848, 5427.972860135694, 5428.294321738169, 4914.950850491503, 5178.870528236786, 5184.222366644995, 5189.532942035235, 5200.401953775307, 5023.372078490189, 5047.974760126176, 5063.54428101469, 5063.620228482879, 5186.299849520305, 11721.355325457096, 11900.583479578174, 11909.166358354918, 12011.399430028463, 17069.0, 1819.9181036853374, 1929.3825975687785, 1977.1597071244807, 1992.0537744571213, 2100.5588826346484, 8546.444481108709, 8865.689700860503, 9298.488583127924, 9456.290778191664, 9507.4295542267, 1726.3353608860552, 1829.3231504343346, 1890.905454727258, 1892.630936967292, 1901.895395753233, 68303.65848170727, 70957.0, 72601.0, 72884.63557682178, 72931.0, 10139.0, 10222.488875556193, 10260.846087308697, 10491.213159013105, 10543.261971662063, 14468.565943021726, 14494.710105798036, 14506.0, 14573.562793116223, 14592.562223133324, 7190.352868241884, 7200.351968322876, 7245.347918687344, 7249.093863267091, 7316.743913962986, 6633.2703402625675, 6696.531242812956, 6862.897056544056, 6874.621895795679, 6904.4131248844415, 4336.479622445327, 4418.823247070145, 4419.602235798729, 4476.753778542146, 4533.5013148553635, 1735.710827980969, 1819.4814477873742, 1828.3783513605438, 1832.4841333690858, 1852.8054554271607, 840.13885767088, 871.020102384817, 880.801819590587, 957.5547370472764, 969.6945462179391, 15540.222988850512, 16676.91661541709, 16766.739762101566, 16807.243674034453, 16940.2731399092, 878.767126711422, 878.9384743068051, 892.9330300227509, 903.0969030969031, 946.8390373636498, 8956.955215223883, 9373.671921482715, 9448.196903263299, 9571.521423928914, 9572.9042709572, 417211.0, 417510.0, 423392.0, 424491.0, 448615.0, 47800.7609961948, 82156.0, 85142.0, 85240.57379713062, 87799.56100219458, 948.3693343926212, 970.8543718442149, 972.781124247053, 982.3860087445347, 986.8717066781272, 14935.477258296341, 14941.0, 14975.026623269452, 15112.09327440357, 15274.236288185768, 36637.0, 36689.24830637766, 37203.25593488061, 37222.81388593148, 38131.618683812805, 45866.541334587564, 51942.22086668627, 54094.0, 55190.0, 56415.71792141013, 4759.571638552547, 4872.220444728827, 5045.722485263345, 7546.20764819708, 7721.150673426031, 11683.357415341898, 11703.76592468129, 11748.70628234301, 11849.585264515701, 12119.81820272679, 10324.690259292232, 10422.478876056015, 10501.842472362769, 10517.21120915919, 10712.196585256293, 10267.897321026694, 10393.792124157626, 10426.374417534973, 10604.151667866397, 10729.624463143753, 10505.68482945513, 10524.526396312338, 10533.36799792015, 10822.512986915764, 10882.945585272022, 7696.076470823313, 7710.460267781202, 7715.884261736191, 7916.327112195528, 7968.243016913384, 7721.498102623312, 10290.485475726333, 10328.122109620766, 10490.0, 10646.414447205478], "value": 8076.5184752160285, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.2695911605522, 1448.23967417106, 1571.9921400392996, 1687.983120168797, 1701.7872765904262, 6893.862122757542, 7715.112762032368, 7782.143964163937, 8042.557659328734, 8054.073781515128, 7736.419768517356, 7798.610069496531, 7841.451098423098, 7858.607069646509, 7869.527828330304, 2279.452931296489, 2317.582835089683, 2317.6639387288833, 2319.6288593824993, 2323.5236776460783, 2239.697640818485, 2265.2524666859895, 2288.8168946484243, 2303.37808791627, 2311.0871205873755, 2302.4474126209675, 2310.607196776544, 2336.836421450499, 2357.210334537932, 2360.1621424394352, 2272.2728726807427, 2283.7830406111393, 2288.0504590594883, 2289.828262880291, 2302.6776251324827, 2251.0658076898067, 2255.988720056406, 2256.131389415087, 2271.5797577448225, 2271.7505372045307, 8003.5197888126895, 8088.71689490865, 8122.147174546706, 8129.349652027823, 8137.633806478663, 4625.306204069383, 4772.904541909177, 4785.473597904228, 4786.401699787527, 4787.880302992418, 2971.450281697893, 3052.6031615890015, 3077.1537827097727, 3092.396982588396, 3118.1736839737487, 979.2410881566772, 1016.0702956794524, 1022.3846322810017, 1023.687775228555, 1045.4929359260752, 10923.126149907988, 10973.83539246912, 10976.176786741027, 10988.505517251742, 10992.450377481095, 4334.21984042869, 4414.801333939916, 4568.200564901129, 4589.426321709786, 4601.217792975135, 9291.488968106683, 9298.90701092994, 9312.975572686999, 9314.161725444743, 9334.159925606727, 4878.268259761065, 4901.387326584177, 4922.310876477296, 4941.802327906844, 4947.851564453, 3909.5113110861143, 4251.957480425218, 4363.759993200341, 4409.382686423904, 4501.909961800746, 3771.6039815819495, 3789.204267103939, 3831.750936189139, 3858.440526123696, 3906.7851268180525, 1235.2835355493792, 1263.2925561685486, 1271.5994461744522, 1281.7564662714055, 1288.1498211180576, 738.5347231244282, 789.8696715042068, 803.935685145187, 817.0889458254004, 824.826786374868, 5138.203578445347, 5203.115470370046, 5359.330083739533, 5379.865503362369, 5394.838154855361, 833.4041160570222, 843.0852525010309, 919.6551293265026, 925.9351845370759, 939.8496240601471, 3602.225521512887, 3613.94579081314, 3653.1415117447377, 3657.65252301031, 3675.5956844747056, 9791.706248812547, 10025.849612255823, 10134.189264858793, 10210.234232432596, 10228.437435941094, 9949.054839790208, 10013.148882345082, 10048.79902401948, 10130.746731331776, 10133.847992280122, 7560.206178351304, 7705.30652241301, 7745.225477452323, 7750.263724946121, 7775.1447340792465, 5172.275881376686, 5213.322268105122, 5299.5230429261555, 5437.13005919051, 5455.645383050089, 8649.8702519461, 9088.681896133603, 9211.124943130391, 9303.116203960613, 9397.718068457958, 9408.294377921546, 9492.95253523728, 9530.903946046294, 9555.713328600154, 9673.1294183521, 6278.968605156945, 6617.305182955913, 6801.829954251183, 6871.347222013901, 6998.405135563534, 7395.482316237812, 7451.850962980819, 7455.850882982201, 7487.026686530716, 7528.849423011399, 6503.544751867513, 6730.394264516217, 6734.663266836541, 6801.319868013357, 6810.421114205348, 6686.966565167143, 6701.497387695845, 6722.260551339251, 6754.493412994143, 6765.188177418544, 6385.074164246251, 6398.520110991787, 6446.355364463704, 6460.289368169404, 6487.3836985486305, 4626.699264547794, 4667.883302917318, 4707.388039554836, 4722.48052714208, 4744.7390393528685, 4418.8453404130705, 4509.774511274489, 4601.28680054592, 4626.190416677001, 4640.257558790578], "value": 4276.370842674298, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.37769272608415, 316.52047148569915, 324.13456072286994, 325.96903294187047, 327.22774252763475, 5177.4045984711765, 5317.494837990384, 5391.649542779716, 5392.433794451585, 5406.8377948661555, 5410.8917821643545, 5411.404745477994, 5419.864503387417, 5438.53772429343, 5456.781728730846, 4222.134462435209, 4224.176285624305, 4236.724612900151, 4250.893727656802, 4253.8723838284905, 4128.277551428488, 4224.260754367989, 4250.553691862357, 4255.893602659943, 4274.380214868842, 4167.312393455076, 4195.832166713328, 4197.916041679165, 4201.117765269297, 4217.219814334358, 4196.664266858659, 4223.577642235782, 4236.830526778926, 4237.809298581556, 4249.128928569636, 3451.9654803451895, 3586.7668601540818, 3587.7442894986807, 3593.245418462126, 3605.5312809334882, 5157.246536177718, 5167.0, 5168.9224661630105, 5175.896482070375, 5182.870428239286, 4733.83431579893, 4734.2425211966265, 4757.857264282077, 4763.190257656207, 4764.904701905943, 5497.189958786063, 5642.238297829782, 5644.238027866268, 5664.4618761218035, 5669.40471250521, 3888.766673999569, 3901.746386484898, 3913.549941756706, 3914.471546341236, 3925.960740392588, 5913.349531551526, 5925.4074592541265, 5946.137810017523, 5950.2264705587995, 5998.97000514999, 3919.275518771731, 4038.7172897897453, 4040.7979601019833, 4041.2927737645796, 4049.0484736086996, 4079.5104587449105, 4107.466029416157, 4114.691398145151, 4125.628693417607, 4129.070959034253, 4738.5547408040875, 4745.620350372031, 4749.382580264543, 4761.452432970253, 4773.11697335994, 5419.566434685215, 5592.524635406036, 5699.715014249271, 5709.286339207599, 5721.056025755704, 1433.5985923941314, 1464.692414592926, 1471.9043262187924, 1474.6829431672243, 1478.689475210218, 977.7257883706139, 987.3335498538457, 1004.1966426858484, 1006.3609607899036, 1007.7732510185297, 4829.348038014893, 4847.515248475124, 4851.466338702739, 4866.46468888422, 4901.803927842846, 5766.711664416763, 5800.187973683687, 5802.404338806862, 5839.970800146057, 5845.09401042839, 4715.669903106818, 4866.878328041827, 4876.609871210295, 4909.68087074339, 4921.975390123026, 3091.9536206956464, 3098.752099832008, 3124.7500199983947, 3127.640321363027, 3130.7025832545874, 5373.623846330797, 5398.217258497574, 5407.459254074561, 5415.404305526389, 5443.156310771837, 5757.769689212469, 5925.970370148121, 5958.344582095966, 5965.612235204784, 5980.43185897339, 5367.490088441592, 5369.919451208235, 5385.515303622693, 5414.133738601883, 5415.4313797050745, 5582.302212223472, 5775.653460792366, 5806.535477161901, 5830.2420685310635, 5849.561282903885, 5639.351474580476, 5682.204491371294, 5684.147377893349, 5697.686627235376, 5704.0, 5380.892382152413, 5395.4604539545735, 5418.106012507892, 5439.918401224064, 5441.83674489766, 3812.237552489458, 4040.807961651261, 4055.7160998729805, 4170.436991006175, 4178.247915375262, 5643.049865094368, 5675.8864822704145, 5847.38602446737, 5858.179854820414, 5867.765289388547, 5682.943170568242, 5711.914321285267, 5729.0, 5736.741846616829, 5736.942630573641, 5639.830805075854, 5680.602357834912, 5682.687452190169, 5705.486506214461, 5713.571482138939, 5342.65272757285, 5626.1560765883805, 5631.211630371833, 5650.85872853182, 5657.15142728594, 5749.425057494384, 5751.683657398883, 5756.0502517084215, 5793.855153621024, 5833.854153646193, 5397.433269506802, 5541.307336582927, 5585.804496842754, 5593.0, 5610.607257491936], "value": 4241.481215586893, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.9998452313791, 699.1784653032686, 726.4152357352331, 749.4903465643367, 760.5398733766069, 12166.209196402227, 12316.568920087799, 12448.190867593612, 12476.37618119095, 12495.562655307067, 12339.753204935896, 12379.257244565333, 12386.442610082546, 12395.938020309908, 12397.0, 761.1399118995541, 800.3997002248313, 805.0379796143611, 807.9515229086244, 811.975640730779, 797.9521228726265, 804.1194891593725, 804.1837534902079, 805.138501803068, 805.6777289084384, 831.846108469932, 832.9250367466926, 834.253343257784, 836.4145098431092, 837.4221786966973, 829.3323874281232, 830.7632324787437, 834.9540775257359, 836.5190015740973, 838.1325328285257, 607.4472230270477, 607.8936186167404, 609.3358239518901, 609.402785270433, 609.4058293164173, 12456.377181140906, 12482.50069997199, 12497.56258530956, 12508.937455312756, 12509.687257818536, 11507.309561426342, 11590.362530060844, 11691.532338706442, 11791.587294444738, 12168.57409990655, 9652.420854748667, 9839.950800246024, 9949.377915245323, 9999.25005624581, 10111.544980475895, 3283.129970557804, 3301.504774283853, 3357.278185190196, 3373.477111047767, 3389.8305084745666, 48273.0, 48798.756006219744, 48858.0, 48928.755356223344, 50075.99848003056, 8845.336599755045, 8891.377603567818, 8938.240249578728, 8952.104789521127, 8961.0, 15079.849201508065, 15141.545753627188, 15141.545753627408, 15143.924280378747, 15179.089254644756, 6929.237783843773, 6930.757423490154, 6948.235694073648, 6987.89518157228, 7060.152781666233, 3750.1374683822874, 3765.9435108473394, 3798.582155962842, 3840.347140986039, 3840.4431357453013, 2859.7998140130408, 2929.5312749959903, 2940.382519670893, 2942.073246927211, 2944.4699954008056, 492.4681344148311, 495.0816235882458, 500.75713279059624, 509.2895410901771, 511.04689753609995, 442.60165850733955, 530.2152813835545, 553.7757208330632, 569.2912324156451, 575.1545228514077, 7220.963895180491, 7255.274472552808, 7449.025375143348, 7670.386369090571, 7888.132305446511, 481.3694060780389, 522.6237109281311, 539.9433059528772, 560.5093022796012, 565.0845630079298, 3176.2059485128716, 3445.1214940190093, 3445.620981692012, 3459.325431540876, 3464.6881780639865, 52180.73909630428, 53734.73132634312, 53797.0, 53897.1915421269, 53917.1912421314, 41173.38239926403, 42445.0, 43243.567564324585, 48423.273650895266, 49431.0, 41464.58535414668, 41540.0, 42032.36951445731, 42330.9417264577, 43051.35422968658, 7030.086088808423, 7101.786946391617, 7108.573485590881, 7139.678714457758, 7244.275572442713, 27355.863220684565, 29150.12549623515, 29164.56253156162, 29497.0, 29868.551971720008, 36491.452628211126, 37199.628003720696, 39614.40578391269, 39973.60026399699, 40390.39414408727, 8903.627477222912, 9218.861717074384, 9494.810103798023, 9701.466419346722, 9789.776277965255, 10111.241656875616, 10196.0, 10670.786584268426, 10764.300320479144, 11202.43987800623, 9948.154406875497, 10064.547095380873, 10165.593376265162, 10233.692989210336, 10608.416537090225, 10464.11055060298, 10626.0, 10662.360258384522, 10736.51685674131, 11028.503717332578, 9342.766430839283, 9604.66383676568, 9649.855252171083, 9868.358556693793, 10163.272243718438, 8073.152319006655, 8132.878006829784, 8204.425690201628, 8278.668853246043, 8411.53736544496, 8502.404831661725, 8555.914440855511, 8604.48373097616, 8634.870476942726, 8697.21725044749], "value": 5703.877544565107, "unit": "score"}], "name": "dromaeo_css", "value": 6306.172525148703, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 112.0, 114.0, 115.0, 125.0, 113.0, 123.0, 114.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 136.0, 152.0, 193.0, 138.0, 163.0, 157.0, 139.0, 193.0, 133.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 175.0, 165.0, 163.0, 164.0, 165.0, 165.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 74.0, 172.0, 78.0, 73.0, 75.0, 80.0, 157.0, 79.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 151.0, 94.0, 94.0, 94.0, 148.0, 93.0, 93.0, 152.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 120.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 151.0, 149.0, 149.0, 150.0, 148.0, 148.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 101.0, 100.0, 95.0, 95.0, 95.0, 95.0, 100.0, 96.0, 96.0], "value": 97.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 64.0, 67.0, 65.0, 66.0, 74.0, 82.0, 62.0, 76.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 79.0, 82.0, 81.0, 89.0, 82.0, 82.0, 90.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 144.0, 132.0, 142.0, 131.0, 141.0, 134.0, 136.0, 168.0, 136.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 183.0, 183.0, 181.0, 177.0, 179.0, 179.0, 186.0, 181.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 76.0, 75.0, 74.0, 73.0, 72.0, 76.0, 74.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1620.3, "alertThreshold": 2.0}]} 02:40:38 INFO - Return code: 0 02:40:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:40:39 ERROR - # TBPL SUCCESS # 02:40:39 INFO - Running post-action listener: _resource_record_post_action 02:40:39 INFO - Running post-run listener: _resource_record_post_run 02:40:40 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 531324928; Read time: 0; Write time: 535884 02:40:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234663936; Read time: 0; Write time: 300624 02:40:40 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 296660992; Read time: 0; Write time: 235260 02:40:40 INFO - Running post-run listener: _upload_blobber_files 02:40:40 INFO - Blob upload gear active. 02:40:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:40 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 02:40:40 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'] 02:40:40 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 02:40:40 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:40:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:41 INFO - (blobuploader) - INFO - Done attempting. 02:40:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:40:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:42 INFO - (blobuploader) - INFO - Done attempting. 02:40:42 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:42 INFO - Return code: 0 02:40:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/643120200eb197a7d554fc6a89c7d25293d2bd16a4d9d6614e21d736c4f976cccccc16c415120e8a60267b62655fac05bd4acf05f3363723a29e17da33c24a0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a279469b123ede6cecd4d97d3b02a14d50b1dcabecf758d174e92dd88942f3d51a30e8a36ee8c4ac5be850aab94e40e972873b4cf05042557405222ba2f489e"} 02:40:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:42 INFO - Contents: 02:40:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/643120200eb197a7d554fc6a89c7d25293d2bd16a4d9d6614e21d736c4f976cccccc16c415120e8a60267b62655fac05bd4acf05f3363723a29e17da33c24a0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a279469b123ede6cecd4d97d3b02a14d50b1dcabecf758d174e92dd88942f3d51a30e8a36ee8c4ac5be850aab94e40e972873b4cf05042557405222ba2f489e"} 02:40:42 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:42 INFO - Copying logs to upload dir... 02:40:42 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.005551 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-22 02:40:41.563507) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 02:40:41.567594) ========= 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=523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711 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/643120200eb197a7d554fc6a89c7d25293d2bd16a4d9d6614e21d736c4f976cccccc16c415120e8a60267b62655fac05bd4acf05f3363723a29e17da33c24a0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a279469b123ede6cecd4d97d3b02a14d50b1dcabecf758d174e92dd88942f3d51a30e8a36ee8c4ac5be850aab94e40e972873b4cf05042557405222ba2f489e"} build_url:https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/eKpNnqJgQiGVCSrcB7PboA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/643120200eb197a7d554fc6a89c7d25293d2bd16a4d9d6614e21d736c4f976cccccc16c415120e8a60267b62655fac05bd4acf05f3363723a29e17da33c24a0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a279469b123ede6cecd4d97d3b02a14d50b1dcabecf758d174e92dd88942f3d51a30e8a36ee8c4ac5be850aab94e40e972873b4cf05042557405222ba2f489e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 02:40:41.593217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:40:41.593631) ========= 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=523ca41ca1e0623de333ad52000001bf-1461316803.59235-1370708711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004360 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 02:40:41.679300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 02:40:41.679684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 02:40:41.679994) ========= ========= Total master_lag: 0.16 =========