builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1461172336.16 results: success (0) buildid: 20160420094342 builduid: a1e895ebc7944c22b05b8dd4b95d21b5 revision: b29a652d68e85d25953a2bb371d35114cd8036a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.160210) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.160603) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.160875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.178748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.179085) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 10:12:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-04-20 10:12:16 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.296180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.296729) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019598 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.347488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:16.347942) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b29a652d68e85d25953a2bb371d35114cd8036a0 --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 b29a652d68e85d25953a2bb371d35114cd8036a0 --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=934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 10:12:16,475 truncating revision to first 12 chars 2016-04-20 10:12:16,475 Setting DEBUG logging. 2016-04-20 10:12:16,475 attempt 1/10 2016-04-20 10:12:16,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b29a652d68e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 10:12:17,002 unpacking tar archive at: fx-team-b29a652d68e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.855507 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:17.216450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:17.216766) ========= script_repo_revision: b29a652d68e85d25953a2bb371d35114cd8036a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:17.217177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:17.217444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:17.226575) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-20 10:12:17.226878) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:12:17 INFO - MultiFileLogger online at 20160420 10:12:17 in /builds/slave/test 10:12:17 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 10:12:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:17 INFO - {'append_to_log': False, 10:12:17 INFO - 'base_work_dir': '/builds/slave/test', 10:12:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:12:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:17 INFO - 'branch': 'Fx-Team-Non-PGO', 10:12:17 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:17 INFO - 'config_files': ('talos/linux_config.py',), 10:12:17 INFO - 'default_actions': ('clobber', 10:12:17 INFO - 'read-buildbot-config', 10:12:17 INFO - 'download-and-extract', 10:12:17 INFO - 'populate-webroot', 10:12:17 INFO - 'create-virtualenv', 10:12:17 INFO - 'install', 10:12:17 INFO - 'run-tests'), 10:12:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:17 INFO - 'download_minidump_stackwalk': True, 10:12:17 INFO - 'download_symbols': 'ondemand', 10:12:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:17 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:17 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:17 INFO - 'installer_path': 'installer.exe', 10:12:17 INFO - 'log_level': 'info', 10:12:17 INFO - 'log_name': 'talos', 10:12:17 INFO - 'log_to_console': True, 10:12:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:12:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:12:17 INFO - 'opt_config_files': (), 10:12:17 INFO - 'pip_index': False, 10:12:17 INFO - 'sps_profile': False, 10:12:17 INFO - 'sps_profile_interval': 0, 10:12:17 INFO - 'suite': 'dromaeojs-e10s', 10:12:17 INFO - 'system_bits': '32', 10:12:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:17 INFO - 'title': 'talos-linux64-ix-057', 10:12:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:17 INFO - 'use_talos_json': True, 10:12:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:17 INFO - 'work_dir': 'build'} 10:12:17 INFO - ##### 10:12:17 INFO - ##### Running clobber step. 10:12:17 INFO - ##### 10:12:17 INFO - Running pre-action listener: _resource_record_pre_action 10:12:17 INFO - Running main action method: clobber 10:12:17 INFO - rmtree: /builds/slave/test/build 10:12:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:17 INFO - Running post-action listener: _resource_record_post_action 10:12:17 INFO - ##### 10:12:17 INFO - ##### Running read-buildbot-config step. 10:12:17 INFO - ##### 10:12:17 INFO - Running pre-action listener: _resource_record_pre_action 10:12:17 INFO - Running main action method: read_buildbot_config 10:12:17 INFO - Using buildbot properties: 10:12:17 INFO - { 10:12:17 INFO - "project": "", 10:12:17 INFO - "product": "firefox", 10:12:17 INFO - "script_repo_revision": "production", 10:12:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:12:17 INFO - "repository": "", 10:12:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:12:17 INFO - "buildid": "20160420094342", 10:12:17 INFO - "pgo_build": "False", 10:12:17 INFO - "basedir": "/builds/slave/test", 10:12:17 INFO - "buildnumber": 1167, 10:12:17 INFO - "slavename": "talos-linux64-ix-057", 10:12:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:12:17 INFO - "platform": "ubuntu64_hw", 10:12:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:12:17 INFO - "branch": "fx-team", 10:12:17 INFO - "repo_path": "integration/fx-team", 10:12:17 INFO - "revision": "b29a652d68e85d25953a2bb371d35114cd8036a0", 10:12:17 INFO - "stage_platform": "linux64", 10:12:17 INFO - "builduid": "a1e895ebc7944c22b05b8dd4b95d21b5", 10:12:17 INFO - "slavebuilddir": "test" 10:12:17 INFO - } 10:12:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:12:17 INFO - Running post-action listener: _resource_record_post_action 10:12:17 INFO - ##### 10:12:17 INFO - ##### Running download-and-extract step. 10:12:17 INFO - ##### 10:12:17 INFO - Running pre-action listener: _resource_record_pre_action 10:12:17 INFO - Running main action method: download_and_extract 10:12:17 INFO - mkdir: /builds/slave/test/build/tests 10:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:17 INFO - https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:27 INFO - Downloaded 1361 bytes. 10:12:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:12:27 INFO - Using the following test package requirements: 10:12:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:12:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:12:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:12:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:27 INFO - u'jsshell-linux-x86_64.zip'], 10:12:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:12:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:12:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:12:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:12:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:12:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:12:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:12:27 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')]} 10:12:27 INFO - https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:12:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:12:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:40 INFO - Downloaded 22267803 bytes. 10:12:40 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'] 10:12:40 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 10:12:41 INFO - Return code: 0 10:12:41 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 10:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:41 INFO - https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:42 INFO - Downloaded 22267803 bytes. 10:12:42 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'] 10:12:42 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 10:12:43 INFO - Return code: 0 10:12:43 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')]} 10:12:43 INFO - https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:12:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:44 INFO - Downloaded 10845952 bytes. 10:12:44 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'] 10:12:44 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 10:12:45 INFO - Return code: 0 10:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:45 INFO - https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:12:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:12:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:12:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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 10:12:47 INFO - Downloaded 54615238 bytes. 10:12:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:12:47 INFO - mkdir: /builds/slave/test/properties 10:12:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:47 INFO - Contents: 10:12:47 INFO - build_url:https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:12:48 INFO - Running post-action listener: _resource_record_post_action 10:12:48 INFO - Running post-action listener: set_extra_try_arguments 10:12:48 INFO - ##### 10:12:48 INFO - ##### Running populate-webroot step. 10:12:48 INFO - ##### 10:12:48 INFO - Running pre-action listener: _resource_record_pre_action 10:12:48 INFO - Running main action method: populate_webroot 10:12:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:48 INFO - '--tppagecycles', 10:12:48 INFO - '7'], 10:12:48 INFO - 'tests': ['tsvgm']}}, 10:12:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:48 INFO - 'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:48 INFO - 'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['damp', 'tps']}, 10:12:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:48 INFO - 'tests': ['damp', 'tps']}, 10:12:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['dromaeo_dom']}, 10:12:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['a11yr', 10:12:48 INFO - 'ts_paint', 10:12:48 INFO - 'tpaint', 10:12:48 INFO - 'sessionrestore', 10:12:48 INFO - 'sessionrestore_no_auto_restore', 10:12:48 INFO - 'tabpaint']}, 10:12:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:48 INFO - 'ts_paint', 10:12:48 INFO - 'tpaint', 10:12:48 INFO - 'sessionrestore', 10:12:48 INFO - 'sessionrestore_no_auto_restore', 10:12:48 INFO - 'tabpaint']}, 10:12:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:48 INFO - 'ts_paint', 10:12:48 INFO - 'tpaint', 10:12:48 INFO - 'sessionrestore', 10:12:48 INFO - 'sessionrestore_no_auto_restore', 10:12:48 INFO - 'tabpaint']}, 10:12:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:48 INFO - 'ts_paint', 10:12:48 INFO - 'tpaint', 10:12:48 INFO - 'sessionrestore', 10:12:48 INFO - 'sessionrestore_no_auto_restore', 10:12:48 INFO - 'tabpaint']}, 10:12:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['a11yr', 10:12:48 INFO - 'ts_paint', 10:12:48 INFO - 'tpaint', 10:12:48 INFO - 'sessionrestore', 10:12:48 INFO - 'sessionrestore_no_auto_restore', 10:12:48 INFO - 'tabpaint']}, 10:12:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['a11yr', 10:12:48 INFO - 'ts_paint', 10:12:48 INFO - 'tpaint', 10:12:48 INFO - 'sessionrestore', 10:12:48 INFO - 'sessionrestore_no_auto_restore', 10:12:48 INFO - 'tabpaint']}, 10:12:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['tsvgx', 10:12:48 INFO - 'tsvgr_opacity', 10:12:48 INFO - 'tart', 10:12:48 INFO - 'tscrollx', 10:12:48 INFO - 'cart']}, 10:12:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:48 INFO - 'tsvgr_opacity', 10:12:48 INFO - 'tart', 10:12:48 INFO - 'tscrollx', 10:12:48 INFO - 'cart']}, 10:12:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:48 INFO - 'talos_options': ['--disable-e10s'], 10:12:48 INFO - 'tests': ['tp5o']}, 10:12:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:48 INFO - 'tests': ['tp5o']}, 10:12:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:48 INFO - 'talos_options': ['--disable-e10s', 10:12:48 INFO - '--xperf_path', 10:12:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:48 INFO - 'tests': ['tp5n']}, 10:12:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:48 INFO - 'talos_options': ['--xperf_path', 10:12:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:48 INFO - 'tests': ['tp5n']}}, 10:12:48 INFO - 'talos.zip': {'path': '', 10:12:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:48 INFO - Running post-action listener: _resource_record_post_action 10:12:48 INFO - ##### 10:12:48 INFO - ##### Running create-virtualenv step. 10:12:48 INFO - ##### 10:12:48 INFO - Running pre-action listener: _resource_record_pre_action 10:12:48 INFO - Running main action method: create_virtualenv 10:12:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:48 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 10:12:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:48 INFO - Using real prefix '/usr' 10:12:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:50 INFO - Installing pip.................done. 10:12:50 INFO - Return code: 0 10:12:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:12:50 INFO - Using env: {'DISPLAY': ':0', 10:12:50 INFO - 'HOME': '/home/cltbld', 10:12:50 INFO - 'LANG': 'en_US.UTF-8', 10:12:50 INFO - 'LANGUAGE': 'en_US:en', 10:12:50 INFO - 'LOGNAME': 'cltbld', 10:12:50 INFO - 'MAIL': '/var/mail/cltbld', 10:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:50 INFO - 'MOZ_NO_REMOTE': '1', 10:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:50 INFO - 'NO_EM_RESTART': '1', 10:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:50 INFO - 'PWD': '/builds/slave/test', 10:12:50 INFO - 'SHELL': '/bin/bash', 10:12:50 INFO - 'SHLVL': '1', 10:12:50 INFO - 'TERM': 'linux', 10:12:50 INFO - 'TMOUT': '86400', 10:12:50 INFO - 'USER': 'cltbld', 10:12:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:50 INFO - '_': '/tools/buildbot/bin/python'} 10:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:50 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 10:12:50 INFO - Cleaning up... 10:12:50 INFO - Return code: 0 10:12:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:12:50 INFO - Using env: {'DISPLAY': ':0', 10:12:50 INFO - 'HOME': '/home/cltbld', 10:12:50 INFO - 'LANG': 'en_US.UTF-8', 10:12:50 INFO - 'LANGUAGE': 'en_US:en', 10:12:50 INFO - 'LOGNAME': 'cltbld', 10:12:50 INFO - 'MAIL': '/var/mail/cltbld', 10:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:50 INFO - 'MOZ_NO_REMOTE': '1', 10:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:50 INFO - 'NO_EM_RESTART': '1', 10:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:50 INFO - 'PWD': '/builds/slave/test', 10:12:50 INFO - 'SHELL': '/bin/bash', 10:12:50 INFO - 'SHLVL': '1', 10:12:50 INFO - 'TERM': 'linux', 10:12:50 INFO - 'TMOUT': '86400', 10:12:50 INFO - 'USER': 'cltbld', 10:12:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:50 INFO - '_': '/tools/buildbot/bin/python'} 10:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:51 INFO - Downloading/unpacking psutil>=0.7.1 10:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:53 INFO - Installing collected packages: psutil 10:12:53 INFO - Running setup.py install for psutil 10:12:53 INFO - building 'psutil._psutil_linux' extension 10:12:53 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 10:12:53 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 10:12:53 INFO - building 'psutil._psutil_posix' extension 10:12:53 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 10:12:53 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 10:12:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:53 INFO - Successfully installed psutil 10:12:53 INFO - Cleaning up... 10:12:53 INFO - Return code: 0 10:12:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:53 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 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:12:53 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 10:12:53 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 10:12:53 INFO - Using env: {'DISPLAY': ':0', 10:12:53 INFO - 'HOME': '/home/cltbld', 10:12:53 INFO - 'LANG': 'en_US.UTF-8', 10:12:53 INFO - 'LANGUAGE': 'en_US:en', 10:12:53 INFO - 'LOGNAME': 'cltbld', 10:12:53 INFO - 'MAIL': '/var/mail/cltbld', 10:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:53 INFO - 'MOZ_NO_REMOTE': '1', 10:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:53 INFO - 'NO_EM_RESTART': '1', 10:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:53 INFO - 'PWD': '/builds/slave/test', 10:12:53 INFO - 'SHELL': '/bin/bash', 10:12:53 INFO - 'SHLVL': '1', 10:12:53 INFO - 'TERM': 'linux', 10:12:53 INFO - 'TMOUT': '86400', 10:12:53 INFO - 'USER': 'cltbld', 10:12:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:53 INFO - '_': '/tools/buildbot/bin/python'} 10:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:12:56 INFO - Installing collected packages: mozsystemmonitor 10:12:56 INFO - Running setup.py install for mozsystemmonitor 10:12:56 INFO - Successfully installed mozsystemmonitor 10:12:56 INFO - Cleaning up... 10:12:56 INFO - Return code: 0 10:12:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:56 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')]} 10:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:56 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')]} 10:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:56 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 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:12:56 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 10:12:56 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 10:12:56 INFO - Using env: {'DISPLAY': ':0', 10:12:56 INFO - 'HOME': '/home/cltbld', 10:12:56 INFO - 'LANG': 'en_US.UTF-8', 10:12:56 INFO - 'LANGUAGE': 'en_US:en', 10:12:56 INFO - 'LOGNAME': 'cltbld', 10:12:56 INFO - 'MAIL': '/var/mail/cltbld', 10:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:56 INFO - 'MOZ_NO_REMOTE': '1', 10:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:56 INFO - 'NO_EM_RESTART': '1', 10:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:56 INFO - 'PWD': '/builds/slave/test', 10:12:56 INFO - 'SHELL': '/bin/bash', 10:12:56 INFO - 'SHLVL': '1', 10:12:56 INFO - 'TERM': 'linux', 10:12:56 INFO - 'TMOUT': '86400', 10:12:56 INFO - 'USER': 'cltbld', 10:12:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:56 INFO - '_': '/tools/buildbot/bin/python'} 10:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:56 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 10:12:56 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 10:12:56 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 10:12:56 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 10:12:56 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 10:12:56 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 10:12:58 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:58 INFO - Downloading docopt-0.6.1.tar.gz 10:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:59 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:59 INFO - Running setup.py install for blobuploader 10:12:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:59 INFO - Running setup.py install for requests 10:12:59 INFO - Running setup.py install for docopt 10:12:59 INFO - Successfully installed blobuploader requests docopt 10:12:59 INFO - Cleaning up... 10:12:59 INFO - Return code: 0 10:12:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:59 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 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:12:59 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 10:12:59 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 10:12:59 INFO - Using env: {'DISPLAY': ':0', 10:12:59 INFO - 'HOME': '/home/cltbld', 10:12:59 INFO - 'LANG': 'en_US.UTF-8', 10:12:59 INFO - 'LANGUAGE': 'en_US:en', 10:12:59 INFO - 'LOGNAME': 'cltbld', 10:12:59 INFO - 'MAIL': '/var/mail/cltbld', 10:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:59 INFO - 'MOZ_NO_REMOTE': '1', 10:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:59 INFO - 'NO_EM_RESTART': '1', 10:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:59 INFO - 'PWD': '/builds/slave/test', 10:12:59 INFO - 'SHELL': '/bin/bash', 10:12:59 INFO - 'SHLVL': '1', 10:12:59 INFO - 'TERM': 'linux', 10:12:59 INFO - 'TMOUT': '86400', 10:12:59 INFO - 'USER': 'cltbld', 10:12:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:59 INFO - '_': '/tools/buildbot/bin/python'} 10:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:59 INFO - Running setup.py (path:/tmp/pip-GZ_VbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:59 INFO - Running setup.py (path:/tmp/pip-jU39Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:59 INFO - Running setup.py (path:/tmp/pip-3mV6jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:00 INFO - Running setup.py (path:/tmp/pip-xQN6Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:00 INFO - Running setup.py (path:/tmp/pip-ov1FM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:00 INFO - Running setup.py (path:/tmp/pip-DEReeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:00 INFO - Running setup.py (path:/tmp/pip-WsGVH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:00 INFO - Running setup.py (path:/tmp/pip-BPgEnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:00 INFO - Running setup.py (path:/tmp/pip-QVHSB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:00 INFO - Running setup.py (path:/tmp/pip-sYX5_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:00 INFO - Running setup.py (path:/tmp/pip-sg7OgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:00 INFO - Running setup.py (path:/tmp/pip-TEugLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:00 INFO - Running setup.py (path:/tmp/pip-aA3GvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:00 INFO - Running setup.py (path:/tmp/pip-uAskd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:00 INFO - Running setup.py (path:/tmp/pip-JAF_i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:00 INFO - Running setup.py (path:/tmp/pip-FT0l1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:00 INFO - Running setup.py (path:/tmp/pip-LD6Oqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:01 INFO - Running setup.py install for manifestparser 10:13:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Running setup.py install for mozcrash 10:13:01 INFO - Running setup.py install for mozdebug 10:13:01 INFO - Running setup.py install for mozdevice 10:13:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Running setup.py install for mozfile 10:13:01 INFO - Running setup.py install for mozhttpd 10:13:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Running setup.py install for mozinfo 10:13:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Running setup.py install for mozInstall 10:13:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:01 INFO - Running setup.py install for mozleak 10:13:01 INFO - Running setup.py install for mozlog 10:13:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:02 INFO - Running setup.py install for moznetwork 10:13:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:02 INFO - Running setup.py install for mozprocess 10:13:02 INFO - Running setup.py install for mozprofile 10:13:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:02 INFO - Running setup.py install for mozrunner 10:13:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:02 INFO - Running setup.py install for mozscreenshot 10:13:02 INFO - Running setup.py install for moztest 10:13:02 INFO - Running setup.py install for mozversion 10:13:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:02 INFO - Cleaning up... 10:13:02 INFO - Return code: 0 10:13:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:02 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 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:13:02 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 10:13:02 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 10:13:02 INFO - Using env: {'DISPLAY': ':0', 10:13:02 INFO - 'HOME': '/home/cltbld', 10:13:02 INFO - 'LANG': 'en_US.UTF-8', 10:13:02 INFO - 'LANGUAGE': 'en_US:en', 10:13:02 INFO - 'LOGNAME': 'cltbld', 10:13:02 INFO - 'MAIL': '/var/mail/cltbld', 10:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:02 INFO - 'MOZ_NO_REMOTE': '1', 10:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:02 INFO - 'NO_EM_RESTART': '1', 10:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:02 INFO - 'PWD': '/builds/slave/test', 10:13:02 INFO - 'SHELL': '/bin/bash', 10:13:02 INFO - 'SHLVL': '1', 10:13:02 INFO - 'TERM': 'linux', 10:13:02 INFO - 'TMOUT': '86400', 10:13:02 INFO - 'USER': 'cltbld', 10:13:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:02 INFO - '_': '/tools/buildbot/bin/python'} 10:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:03 INFO - Running setup.py (path:/tmp/pip-j_vDYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:03 INFO - Running setup.py (path:/tmp/pip-AFJDAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:03 INFO - Running setup.py (path:/tmp/pip-lSgHor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:03 INFO - Running setup.py (path:/tmp/pip-tAoivf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:03 INFO - Running setup.py (path:/tmp/pip-oIsNkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:03 INFO - Running setup.py (path:/tmp/pip-uz3xHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:03 INFO - Running setup.py (path:/tmp/pip-HtJP6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:03 INFO - Running setup.py (path:/tmp/pip-jhgYku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:03 INFO - Running setup.py (path:/tmp/pip-koC1Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:03 INFO - Running setup.py (path:/tmp/pip-ClpcdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:03 INFO - Running setup.py (path:/tmp/pip-YtU2nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:03 INFO - Running setup.py (path:/tmp/pip-DY10z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:03 INFO - Running setup.py (path:/tmp/pip-zAkUHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:03 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)) 10:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:03 INFO - Running setup.py (path:/tmp/pip-4OwJKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:04 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)) 10:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:04 INFO - Running setup.py (path:/tmp/pip-Y94Gp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:04 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)) 10:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:04 INFO - Running setup.py (path:/tmp/pip-tMwsSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:04 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)) 10:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:04 INFO - Running setup.py (path:/tmp/pip-jCD3ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:04 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)) 10:13:04 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)) 10:13:04 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)) 10:13:04 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)) 10:13:04 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)) 10:13:04 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)) 10:13:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:06 INFO - Downloading blessings-1.6.tar.gz 10:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:06 INFO - Installing collected packages: blessings 10:13:06 INFO - Running setup.py install for blessings 10:13:06 INFO - Successfully installed blessings 10:13:06 INFO - Cleaning up... 10:13:06 INFO - Return code: 0 10:13:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:06 INFO - Reading from file tmpfile_stdout 10:13:06 INFO - Current package versions: 10:13:06 INFO - argparse == 1.2.1 10:13:06 INFO - blessings == 1.6 10:13:06 INFO - blobuploader == 1.2.4 10:13:06 INFO - docopt == 0.6.1 10:13:06 INFO - manifestparser == 1.1 10:13:06 INFO - mozInstall == 1.12 10:13:06 INFO - mozcrash == 0.17 10:13:06 INFO - mozdebug == 0.1 10:13:06 INFO - mozdevice == 0.48 10:13:06 INFO - mozfile == 1.2 10:13:06 INFO - mozhttpd == 0.7 10:13:06 INFO - mozinfo == 0.9 10:13:06 INFO - mozleak == 0.1 10:13:06 INFO - mozlog == 3.1 10:13:06 INFO - moznetwork == 0.27 10:13:06 INFO - mozprocess == 0.22 10:13:06 INFO - mozprofile == 0.28 10:13:06 INFO - mozrunner == 6.11 10:13:06 INFO - mozscreenshot == 0.1 10:13:06 INFO - mozsystemmonitor == 0.0 10:13:06 INFO - moztest == 0.7 10:13:06 INFO - mozversion == 1.4 10:13:06 INFO - psutil == 3.1.1 10:13:06 INFO - requests == 1.2.3 10:13:06 INFO - wsgiref == 0.1.2 10:13:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:06 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 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:13:06 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 10:13:06 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 10:13:06 INFO - Using env: {'DISPLAY': ':0', 10:13:06 INFO - 'HOME': '/home/cltbld', 10:13:06 INFO - 'LANG': 'en_US.UTF-8', 10:13:06 INFO - 'LANGUAGE': 'en_US:en', 10:13:06 INFO - 'LOGNAME': 'cltbld', 10:13:06 INFO - 'MAIL': '/var/mail/cltbld', 10:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:06 INFO - 'MOZ_NO_REMOTE': '1', 10:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:06 INFO - 'NO_EM_RESTART': '1', 10:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:06 INFO - 'PWD': '/builds/slave/test', 10:13:06 INFO - 'SHELL': '/bin/bash', 10:13:06 INFO - 'SHLVL': '1', 10:13:06 INFO - 'TERM': 'linux', 10:13:06 INFO - 'TMOUT': '86400', 10:13:06 INFO - 'USER': 'cltbld', 10:13:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:06 INFO - '_': '/tools/buildbot/bin/python'} 10:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 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)) 10:13:06 INFO - Cleaning up... 10:13:06 INFO - Return code: 0 10:13:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:06 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 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:13:06 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 10:13:06 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 10:13:06 INFO - Using env: {'DISPLAY': ':0', 10:13:06 INFO - 'HOME': '/home/cltbld', 10:13:06 INFO - 'LANG': 'en_US.UTF-8', 10:13:06 INFO - 'LANGUAGE': 'en_US:en', 10:13:06 INFO - 'LOGNAME': 'cltbld', 10:13:06 INFO - 'MAIL': '/var/mail/cltbld', 10:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:06 INFO - 'MOZ_NO_REMOTE': '1', 10:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:06 INFO - 'NO_EM_RESTART': '1', 10:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:06 INFO - 'PWD': '/builds/slave/test', 10:13:06 INFO - 'SHELL': '/bin/bash', 10:13:06 INFO - 'SHLVL': '1', 10:13:06 INFO - 'TERM': 'linux', 10:13:06 INFO - 'TMOUT': '86400', 10:13:06 INFO - 'USER': 'cltbld', 10:13:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:06 INFO - '_': '/tools/buildbot/bin/python'} 10:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:07 INFO - Downloading/unpacking jsonschema 10:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:08 INFO - Downloading/unpacking functools32 (from jsonschema) 10:13:08 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 10:13:08 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 10:13:08 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 10:13:08 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 10:13:08 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 10:13:08 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 10:13:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:09 INFO - warning: no files found matching '*.txt' 10:13:09 INFO - no previously-included directories found matching 'build' 10:13:09 INFO - no previously-included directories found matching 'dist' 10:13:09 INFO - no previously-included directories found matching '.git*' 10:13:09 INFO - Installing collected packages: jsonschema, functools32 10:13:09 INFO - Running setup.py install for functools32 10:13:09 INFO - warning: no files found matching '*.txt' 10:13:09 INFO - no previously-included directories found matching 'build' 10:13:09 INFO - no previously-included directories found matching 'dist' 10:13:09 INFO - no previously-included directories found matching '.git*' 10:13:09 INFO - Successfully installed jsonschema functools32 10:13:09 INFO - Cleaning up... 10:13:09 INFO - Return code: 0 10:13:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:09 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 0x7f400aa7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', '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 10:13:09 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 10:13:09 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 10:13:09 INFO - Using env: {'DISPLAY': ':0', 10:13:09 INFO - 'HOME': '/home/cltbld', 10:13:09 INFO - 'LANG': 'en_US.UTF-8', 10:13:09 INFO - 'LANGUAGE': 'en_US:en', 10:13:09 INFO - 'LOGNAME': 'cltbld', 10:13:09 INFO - 'MAIL': '/var/mail/cltbld', 10:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:09 INFO - 'MOZ_NO_REMOTE': '1', 10:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:09 INFO - 'NO_EM_RESTART': '1', 10:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:09 INFO - 'PWD': '/builds/slave/test', 10:13:09 INFO - 'SHELL': '/bin/bash', 10:13:09 INFO - 'SHLVL': '1', 10:13:09 INFO - 'TERM': 'linux', 10:13:09 INFO - 'TMOUT': '86400', 10:13:09 INFO - 'USER': 'cltbld', 10:13:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:09 INFO - '_': '/tools/buildbot/bin/python'} 10:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:09 INFO - Downloading/unpacking flake8 10:13:09 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 10:13:09 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 10:13:09 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 10:13:09 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 10:13:09 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 10:13:09 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 10:13:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:13:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:13:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:13:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:12 INFO - no previously-included directories found matching 'docs/_build' 10:13:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:13:12 INFO - Running setup.py install for pep8 10:13:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:12 INFO - no previously-included directories found matching 'docs/_build' 10:13:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:13:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:13:12 INFO - Cleaning up... 10:13:12 INFO - Return code: 0 10:13:12 INFO - Running post-action listener: _resource_record_post_action 10:13:12 INFO - Running post-action listener: _start_resource_monitoring 10:13:12 INFO - Starting resource monitoring. 10:13:12 INFO - ##### 10:13:12 INFO - ##### Running install step. 10:13:12 INFO - ##### 10:13:12 INFO - Running pre-action listener: _resource_record_pre_action 10:13:12 INFO - Running main action method: install 10:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:12 INFO - Reading from file tmpfile_stdout 10:13:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:12 INFO - Reading from file tmpfile_stdout 10:13:12 INFO - Output received: 10:13:12 INFO - Usage: mozinstall [options] installer 10:13:12 INFO - Options: 10:13:12 INFO - -h, --help show this help message and exit 10:13:12 INFO - -d DEST, --destination=DEST 10:13:12 INFO - Directory to install application into. [default: 10:13:12 INFO - "/builds/slave/test"] 10:13:12 INFO - --app=APP Application being installed. [default: firefox] 10:13:12 INFO - mkdir: /builds/slave/test/build/application 10:13:12 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'] 10:13:12 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 10:13:28 INFO - Reading from file tmpfile_stdout 10:13:28 INFO - Output received: 10:13:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:13:28 INFO - Running post-action listener: _resource_record_post_action 10:13:28 INFO - ##### 10:13:28 INFO - ##### Running run-tests step. 10:13:28 INFO - ##### 10:13:28 INFO - Running pre-action listener: _resource_record_pre_action 10:13:28 INFO - Running main action method: run_tests 10:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:28 INFO - Python 2.7.3 10:13:28 INFO - Return code: 0 10:13:28 INFO - grabbing minidump binary from tooltool 10:13: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')]} 10:13:28 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 0x1bdb640>, '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 0x1bdc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdc9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:28 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 10:13:28 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 10:13:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:28 INFO - Return code: 0 10:13:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:13:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:13:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:13:29 INFO - Return code: 0 10:13:29 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/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 10:13:29 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/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 10:13:29 INFO - Using env: {'DISPLAY': ':0', 10:13:29 INFO - 'HOME': '/home/cltbld', 10:13:29 INFO - 'LANG': 'en_US.UTF-8', 10:13:29 INFO - 'LANGUAGE': 'en_US:en', 10:13:29 INFO - 'LOGNAME': 'cltbld', 10:13:29 INFO - 'MAIL': '/var/mail/cltbld', 10:13:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:29 INFO - 'MOZ_NO_REMOTE': '1', 10:13:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:29 INFO - 'NO_EM_RESTART': '1', 10:13:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:29 INFO - 'PWD': '/builds/slave/test', 10:13:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:29 INFO - 'SHELL': '/bin/bash', 10:13:29 INFO - 'SHLVL': '1', 10:13:29 INFO - 'TERM': 'linux', 10:13:29 INFO - 'TMOUT': '86400', 10:13:29 INFO - 'USER': 'cltbld', 10:13:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030', 10:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:29 INFO - '_': '/tools/buildbot/bin/python'} 10:13:29 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/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 10:13:29 INFO - mozversion application_buildid: 20160420094342 10:13:29 INFO - mozversion application_changeset: b29a652d68e85d25953a2bb371d35114cd8036a0 10:13:29 INFO - mozversion application_display_name: Nightly 10:13:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:29 INFO - mozversion application_name: Firefox 10:13:29 INFO - mozversion application_remotingname: firefox 10:13:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:13:29 INFO - mozversion application_vendor: Mozilla 10:13:29 INFO - mozversion application_version: 48.0a1 10:13:29 INFO - mozversion platform_buildid: 20160420094342 10:13:29 INFO - mozversion platform_changeset: b29a652d68e85d25953a2bb371d35114cd8036a0 10:13:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:13:29 INFO - mozversion platform_version: 48.0a1 10:13:29 INFO - using testdate: 1461172409 10:13:29 INFO - actual date: 1461172409 10:13:29 INFO - starting webserver on 'localhost:42186' 10:13:29 INFO - SUITE-START | Running 2 tests 10:13:29 INFO - TEST-START | dromaeo_css 10:13:29 INFO - operating with platform_type : linux_ 10:13:29 INFO - Initialising browser for dromaeo_css test... 10:13:29 INFO - TEST-INFO | started process 3985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiDw6ch/profile http://localhost:42186/getInfo.html) 10:13:33 INFO - PROCESS | 3985 | 10:13:33 INFO - PROCESS | 3985 | (process:4053): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:13:34 INFO - PROCESS | 3985 | __metrics Screen width/height:1600/1200 10:13:34 INFO - PROCESS | 3985 | colorDepth:24 10:13:34 INFO - PROCESS | 3985 | Browser inner width/height: 1024/697 10:13:34 INFO - PROCESS | 3985 | __metrics 10:13:35 ERROR - PROCESS | 3985 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:13:36 INFO - TEST-INFO | 3985: exit 0 10:13:36 INFO - Browser initialized. 10:13:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:36 INFO - TEST-INFO | started process 4104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiDw6ch/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:37 INFO - PROCESS | 4104 | 10:13:37 INFO - PROCESS | 4104 | (process:4164): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:13:47 INFO - PROCESS | 4104 | RSS: Main: 164884480 10:13:47 INFO - PROCESS | 4104 | 10:14:37 INFO - PROCESS | 4104 | 1461172477564 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] 10:16:49 INFO - PROCESS | 4104 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42186/tests/dromaeo/cssquery-ext.html) 10:16:50 INFO - PROCESS | 4104 | RSS: Main: 166756352 10:16:50 INFO - PROCESS | 4104 | 10:19:52 INFO - PROCESS | 4104 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-ext.html (next: http://localhost:42186/tests/dromaeo/cssquery-jquery.html) 10:19:53 INFO - PROCESS | 4104 | RSS: Main: 165711872 10:19:53 INFO - PROCESS | 4104 | 10:22:55 INFO - PROCESS | 4104 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42186/tests/dromaeo/cssquery-mootools.html) 10:22:55 INFO - PROCESS | 4104 | RSS: Main: 167051264 10:22:55 INFO - PROCESS | 4104 | 10:25:57 INFO - PROCESS | 4104 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42186/tests/dromaeo/cssquery-prototype.html) 10:25:58 INFO - PROCESS | 4104 | RSS: Main: 164491264 10:25:58 INFO - PROCESS | 4104 | 10:29:00 INFO - PROCESS | 4104 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42186/tests/dromaeo/cssquery-yui.html) 10:29:01 INFO - PROCESS | 4104 | RSS: Main: 165974016 10:29:01 INFO - PROCESS | 4104 | 10:32:03 INFO - PROCESS | 4104 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-yui.html (next: http://localhost:42186/tests/dromaeo/cssquery-dojo.html) 10:32:04 INFO - PROCESS | 4104 | RSS: Main: 168087552 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - PROCESS | 4104 | __start_tp_report 10:32:04 INFO - PROCESS | 4104 | _x_x_mozilla_page_load 10:32:04 INFO - PROCESS | 4104 | _x_x_mozilla_page_load_details 10:32:04 INFO - PROCESS | 4104 | |i|pagename|runs| 10:32:04 INFO - PROCESS | 4104 | |0;dojo.html;2609.2041927212204;2685.4360584277306;2702.1353166986573;2715.443334116505;2727.7954153438495;4818.180909245428;4819.590334821535;4840.515948405157;4845.273209018649;4914.655974081807;4753.7623118844;4838.612910967123;4866.051120031595;4944.5055494450535;4955.578775804061;4324.416203812484;4371.846985355513;4458.7324760514475;4470.843520476784;4486.080353527519;4417.249067658489;4545.886352841172;4563.064571762798;4585.105904348653;4597.632189424855;4297.8495752648505;4385.56144385562;4436.511983681792;4467.950031742538;4515.458145022585;4371.169477799208;4379.759113248802;4401.251787196153;4429.734215947054;4457.48738895028;4402.25161722508;4441.511433742286;4444.933326000112;4445.977770111129;4474.619657329131;4678.0410015946645;4756.7145971241835;4776.880577985544;4780.498047704976;4803;5158.509941555546;5200.869978250536;5202.895942081137;5208.609354298443;5224.451432599599;5056.84829455117;5219.347581552306;5237.73811309433;5245.26566280721;5246.108161612535;4887.266909963534;4903.166461701519;4913.287573301851;4960.107180707508;4970.577500912463;5340.30576025122;5386.48828361305;5387.353517577916;5408.459154084639;5412.539934105566;4966.180580204298;5094.083065048327;5119.078565858107;5145.9485405146215;5148.665336753099;5193.662411943212;5216.60875434344;5217;5229.738513074407;5273.578113750891;5016.573591244712;5110;5112.539871411591;5118.360204974379;5123.38519377677;5055.140626093573;5147.6654017488745;5192.350956130484;5219.16493361068;5238.97380513095;3983.4024896265214;4056.7971601419813;4059.65492933104;4068.532118806316;4102.50769907613;3575.4994300797907;3598.226381328027;3604.8377822998027;3642.4354225095153;3649.0147660131615;4437.445319335083;4502.549745025537;4514.841980530731;4524.16302983949;4559.726416415026;5021.924671129936;5130.384353877558;5201.375834899761;5215.374155101336;5271.024860400838;4503.504614492404;4509.481409637868;4512.075024619945;4544.2501987171745;4546.522615125365;4590.334401511829;4609.3086037094035;4616.561426664462;4629.421322334708;4667.903042784943;4733.952660473351;4858.295547145714;4876.634252431082;4889.339939108246;4912.606991440748;5150.459201783909;5173;5174.6119041072825;5174.9482505174465;5180.222966555047;4794.664373493822;4831.106245344622;4859.708417494961;4895.241237608177;4947.307376967299;5085.48794809017;5093.567046800915;5131.897362052663;5152.845414637567;5185.740712964262;5106.387233532;5141.53726164647;5159.17453207485;5172.172452407597;5216.713080780593;4935.654504184673;4992.151334273255;4994.450610432922;5000.849974500771;5011.298418221525;4920.5571498565305;5020.573251273682;5063.772130254221;5065.974670126626;5100.693958362362;4861.562459378673;4870.26945958095;4901.117798796108;4902.4607293197005;4945.4807245238735;4963.5780958618925;4988.700677959334;4998;5028.094942910311;5051.292819005415;4835.758212089452;4930.285108659296;5035.647504674637;5069.036882992367;5107.821226257063 10:32:04 INFO - PROCESS | 4104 | |1;ext.html;576.0840263980273;596.994065000474;604.579817027166;620.2061361457334;629.9464545513631;33305.66694333056;34528.65471345286;34534;34688.82655586725;34721.30557388851;34570;35187;35290.294194116104;35292.47061294083;35344.82327588359;7497.400207983348;7652.846943061136;7694.615269236544;7737.148913619498;7743.728969486069;7643.23567643234;7982.161873003309;7984.321332686729;7990.520568765864;7994.480358776661;7956.920430795705;7961.044674639052;7975.96012019942;8014.158513356101;8024.759257222293;7851.803704907395;7928.722494712657;7946.562939038351;7985.880211796828;7989.800254993672;7798.649060792278;7815.765527034198;7833.608319583998;7876.960615196887;7885.842283154305;29177.41645167106;34951.300973980375;35268.29463410743;35390;35452.64547354519;3084.8766049358;3168.904932851995;3228.1122691259857;3246.798614646015;3304.7025767680784;27296.89102149301;27586;28028.859855700794;28102;28672.863413374762;3446.773538760111;3468.4277094279414;3475.5481787367735;3509.526213961108;3557.324108419392;192857;197073;197308.01345993322;197489;197584;34675.30649386998;57895.71052144712;58027.4197258022;58713.706431468425;58733.70633146807;34579;34836;34938.47592286118;34958;34981.47527787085;12614.369281535886;12725.363731813371;12818.679533011562;12826.935865320615;12854.871451285368;10352.792944141074;10379.325343852626;10396.428196449117;10426.270161088803;10472;8359.540225287546;8427.199416055464;8453.704120355758;8457.23884850354;8472.364572657076;3291.1772056985756;3325.9833700831823;3350.7151892089446;3387.2886693794085;3387.3902697514686;811.8741595052776;935.7894473743489;956.7655924298452;994.8607194992707;1060.390275591538;28087.157385278475;28634.570481442795;28656.570151447744;29273.707262927524;29283;975.1223898491272;991.2912267728465;1020.2297265564451;1080.9459527023616;1120.2270433400927;14705.55883323502;15249.237538123049;15299.923500382427;15540.300686469136;15633.374665013273;352729;355367;356017;357029;358317;50063;50292;50699.18357756007;50905.490945090816;50944.490555094715;1186.8753780853058;1219.3476490077944;1278.7122897348208;1281.1238768963551;1284.8693150027916;27138.72861271441;28348.291292717848;28500.57249141223;28780.568291476062;29036.854815725786;44326;44509.33236001527;44653.77673111744;44786.104277914914;44799.328010079225;305053;306091;306461;306658;307175;26066.60900086538;26098.347541311618;26642.467150657267;26835.731642683324;26876.59685104764;42511;43283.35074973941;43539;43974.12051758883;44319.556804431544;32214;33237.667623323454;34521.482177766855;35011.12472188216;35073.473897892065;34737.65262347344;35263;35302.47046294256;35385.82307088448;35507.82246088753;30594;30655.386892262475;31789;36730.95951986739;38160.618393815705;29638.259043523223;31525.211869703442;31631.593658906644;31714;31920;24770.752292477566;24932;24949.50100998006;25347.366315842253;25404.872975635004 10:32:04 INFO - PROCESS | 4104 | |2;jquery.html;382.9425586162075;385.99807000965;394.3473551272643;395.41320680110687;398.3586425854374;13052.673683157926;15450.459233926815;16003.759943600855;16580.088095154777;16612;15708.528744137695;15711.292991815368;15992;17347;17353.652926941453;4388.188185185735;4462.12988467249;4481.686281960264;4508.323751437278;4539.228331183706;5127.435982041991;5214.374275086995;5258.710770907599;5274.81538146165;5285.312909321783;5194.27280180775;5222.503862133091;5230.73846307685;5236.842894713165;5249.081410753122;6075.939240607604;6430.678466076677;6441.645709485976;6459.870802583945;6477.157969463987;6145.9692701536205;6679.198496180489;6693.698783554752;6694.564853284521;6702.128723265993;22014;22410.88794556033;22593.77406225933;23991;24014.639780403308;1927.1231589626686;2003.6092961872441;2170.7395112586432;2176.253613797216;2221.2336743823357;13704.314784260747;14409.711805763825;14435.35040923161;14478.638034049127;14624.341904614212;1859.8047205043547;2016.3648450737971;2020.7979202079675;2022.6763717805081;2053.363457328233;87825;88236;88726;89697.55151224202;90469.99999999935;15381;16548.503544893672;17003.489895303162;17220.225089870986;17716.379926702502;12967.675808104872;13784.448622055206;29834.701652983193;29878;30152.396952060837;5559.6664200148125;5721;6081.2094427725;6934.410575101072;6945;6725.932740672629;6738.225104112992;6828.078209441761;6850.554713943578;6916.55042422241;4230.238557059697;4328.220920234388;4370.475542934868;4415.977920110379;4521.163584736834;1874.3983520457246;1875.606122714218;1875.728019437174;1888.4240306706586;1913.6172765446966;855.9400841941005;855.9529225892511;935.8923723771853;1011.110223003752;1019.5361110694616;15229.086254824746;16591.170441477876;16654.66690666204;16780.412685555948;17068.658626827393;850.7150104714866;896.5651658945407;904.3353135445442;950.7908260182749;950.9239260859115;9093.818123637622;9219.308551858503;9413.670521531714;9506.191973682176;9564.61741530331;385876;390537;401909;407171;414292;78177.60911195408;80122;82198.58900705459;82522;83183;906.3474298505066;926.3515539122641;934.2619330728784;937.8265020971143;947.0292949726586;14851.274120556713;14953.850461495245;14993.2503374833;14996.925015374853;15114;34125.65874341225;34182.82908585441;34888.825555872056;35398;35744.28511429809;48079.75960120177;49702.751486242334;50529.49470505248;51325.973480529436;51442;7744.49660772048;7772.106207785951;7790.493617914817;7817.921820781947;7947.602619868868;11091.72270693239;11708.648740537797;11901.880981190423;11940;12085.516579336729;10350.637727679496;10352.17182625373;10456.947715261374;10476.68569942903;10636.09593184557;10209.132223760766;10218.948905255425;10317.9484102579;10457.68626941193;10476.476176191312;10651.89348106509;10689.251752377259;10772.515236814519;10790.082842958123;10893.400862952296;7707.229277072248;7768.378529717496;7769.92230077692;7973.72091976778;8090.83818323642;8812.118788121137;10419.218558608287;10426.113780328757;10557.63048293306;10691.396290556479 10:32:04 INFO - PROCESS | 4104 | |3;mootools.html;1437.2669938331449;1478.2239324354712;1615.313491766;1738.3481194552044;1778.8754787164903;6749.392554670078;7396.112466504021;7486.139094004191;7557.962210188948;7660.540367577943;7426.220246874068;7464.664090115944;7533.209013053633;7565.848683026336;7578.166401695809;2172.6415141501634;2209.4034610655112;2222.611043067465;2223.7776222377715;2224.632935565638;2214.5017371091535;2232.9218477353215;2243.1588154442084;2243.3270018994317;2250.8424410291286;2221.833362497819;2238.2837492002564;2242.1816037146486;2252.256755270765;2276.681264622954;2194.3416974907545;2196.187410658059;2196.8905702620236;2199.714037175173;2204.305643722222;2200.3288996855954;2204.041242059709;2206.1837120265604;2208.1277895231456;2213.269621025058;7645.617719114078;7760.146383897767;7775.494592851446;7778.766637000843;7791.4935529190425;4582.243929751587;4721.811127554894;4730.124926888537;4751.14479393709;4764.666473346867;2763.557830747071;2978.8659510322086;3021.6374035115705;3045.6954304569585;3050.3899220155836;932.9953350233274;943.5376665433956;958.1137447860771;963.9566219520138;973.2603221551601;10288;10291.794164116676;10309;10338.948305258426;10351.844722329095;4155.252054630196;4247.980484683653;4253.63844073251;4425.513193548707;4438.289873620205;8953.686620968236;8963.014068452465;8968.372213944962;8970.102989700978;8973.551322433852;4566.383538222364;4588.931166032512;4592.908141837212;4600.6549508786975;4605.746683932416;3793.393057110849;4169.624733773975;4190.287651099259;4220.388043733641;4347.760873151944;3623.474596183539;3637.7089832813313;3736.1593641431004;3752.9437058444146;3753.6246375362243;1232.7164752107064;1233.9136260461862;1234.8086046662602;1238.9194702344319;1242.037420998715;910.7723069232692;913.7532866126109;922.9630814767335;931.9627214911328;935.8081593273363;5197.246399272084;5201.271821944931;5211.374635043743;5217.530422262014;5219.765110570033;420.13871563295123;422.8963903843578;432.9675274354436;436.6463164836493;439.3651174053526;3629.9637003629628;3756.5679946806467;3794.5636251830842;3817.7136714746507;3828.904277393032;9161.541922903829;9449.102335278138;9519.143277105093;9535.809283814286;9593.184579310697;9318;9389.436633801857;9437.433753974783;9441;9441.386309889835;6645.169353830771;6869.210040845267;6906.274841141708;6925.757598484029;6954.756583519553;5092.694438333712;5298.81454149103;5305.230741542532;5310.628256022042;5376;8445.831083378422;8547.188017138362;8601;8628.870566941627;8676.566171691517;8327.95836020816;8546.914530854861;8548.914510854811;8601.311895048506;8743.606537705691;6068.302145253352;6373.330800266091;6580.901286480803;6734.326567343226;6804.149481314836;6850.314968503109;6928.792136235921;6975.6163411012885;6977.406920411619;6994.265602111908;6298.181236439417;6308.873822523616;6358.078078678658;6394.296627371078;6474.093626892145;6197.287311959182;6221.097940798469;6295.055741638791;6313.779017734358;6440.194975628046;6037.335893051849;6059.242594675666;6059.848503787441;6094.512439004958;6095.329513753395;4364.781760911878;4506.369108324771;4513.345564893007;4547.886302842323;4600.4479462464715;4482.260427029503;4609.539046095364;4637.397138372125;4654.837080702159;4656.324832899279 10:32:04 INFO - PROCESS | 4104 | |4;prototype.html;309.71815647760536;313.7458658486626;316.9920751981202;317.982510961897;322.20254869198726;5263.86840328992;5345.1714984177415;5352.635078055096;5391.865203369918;5405.459454054602;5212.4266330703595;5226.2944502492155;5226.346706661668;5259.894802103965;5268.446813084628;3897.259520691067;3962.9801850990702;4127.62851343379;4146.253674338618;4153.231652144363;4120.402541631462;4147.854825081123;4148.543660197376;4156.085661154556;4162.771047592381;4102.323116685759;4145.979270103645;4147.822393243556;4148.958510414903;4157.605027522381;4046.696497762665;4107.466029416187;4134.586541345871;4144.233316836365;4153.916921661565;3621.4567814827724;3636.5454318210222;3640.890773276806;3646.6717995380545;3650.671439570451;5074.985002999378;5100.285959965608;5100.948990510122;5115.693058416507;5128.205128205097;4608.778673651485;4742.739149346785;4782.952170478286;4783.3497443381975;4826.758662066883;5598.2442370280305;5615.9157612635845;5638.323401191883;5639.802606908779;5647.802326918538;4043.9191216175514;4044.959550404488;4049.473568436114;4051.8784436466954;4061.3704875744306;5714.542836573064;5793.191016585975;5858.162903298304;5938.524918006592;5950.851228719273;4102.343625019982;4120.75275483472;4130.793460326971;4132.194222126716;4135.593898074609;4170.16596680665;4199.559046300155;4199.748015119103;4200.075983283673;4205.369194620831;4585.72485650862;4743.881402964885;4745.078243311395;4769.30845027476;4787.138315103315;5550.333959924835;5605.131204663284;5612.548282806045;5620.960122377373;5635.126555383922;1430.2920054573053;1449.2101804516565;1453.840077591464;1455.5997100797365;1458.7009663019055;929.3773171974793;969.2827307792184;974.8342781727123;993.2749093162032;1013.7871047080196;4821.373221481185;4833.73414462208;4838.95161048385;4842.806287748451;4848.733319667382;5687.8908612820105;5691.231683722727;5720.141978703228;5720.799772007959;5736.885262294814;4741.312509686145;4845.53967373099;4874.488178741181;4888.095702295087;4998.125328067574;3115.376924615086;3129.937401251962;3134.905952821419;3148.968510314913;3152.952705709416;5506.229127922094;5544.417836127229;5551;5552.972235138798;5553.278073850373;5922.378150294243;6092.603980741238;6093.451589356979;6111.480524155497;6127.5404344674325;5546;5560.110382338807;5564;5565.888682226414;5577.525910297589;5733.569982251432;5899.410058994238;5906.173135760911;5913.940860591511;5926.940730592639;5808.5353171747;5828.504577110993;5832.766689332379;5840.094785308284;5852.209951656472;5561.5272701820795;5569.470900264469;5570.888582228252;5575.2473416088305;5589.888202236014;3802.809859506958;4040.8585699500377;4058.5332686741403;4064.4309796629086;4069.8372065117064;5797.565182611237;5816.098504731774;5839.854003649943;5846.9183201107935;5879.617824841372;5536.889262214652;5629.057974998619;5679.148127780701;5685.431456854281;5693.263554615882;5579.46995035471;5650.717464126859;5654.293213348332;5657.236273103078;5688.345840228427;5301.25782390458;5536.557075434036;5539.58453116026;5546.4453554644215;5568.721563921707;5458.263134476795;5638.436156384329;5740.282464691913;5761.107028410603;5764.596478246483;5488.204210389551;5572.498475137257;5597.440255974533;5608.10270356741;5623.2127502148915 10:32:04 INFO - PROCESS | 4104 | |5;yui.html;661.1273119482286;679.3478260869565;732.406750532069;778.2412148155546;779.1701837543017;11990.16068875179;12405.193662411948;12457.065720070985;12703.491860325576;12707.809382859265;13923.955703322266;14021.43914243429;14061.859381406182;14118.64703382416;14131.728144466995;647.6891092275711;793.6626933553246;807.0275318241505;818.071488860145;821.9383546234027;805.8025783683006;807.5033854179667;809.6599428240124;811.3144392987916;811.4847072109224;853.0147679430237;857.7083791510885;858.2275951643509;858.3690987124489;859.5573279760928;845.9492430454193;846.8221673448584;847.3941132090554;850.7320194138888;852.2415050604967;624.7188765055697;627.1001113402236;627.1220291591808;627.8493161641219;631.3970158498623;11796.528138874435;11864.169508134433;11874.881251187464;11896.22674526153;11938.64184074479;12706.618801435972;12835.358232088358;12860.292683902382;13003;13121.803172952414;10225;10270.1783857292;10394.272400931937;10577.312474689197;10604.151667866552;3313.9005829825146;3341.8496167672515;3389.8983030509125;3406.0463070340343;3430.5025771263026;51857.74071129658;51950.740246298905;52429.47570524284;52539;52963.47036529624;10036.949815250877;10047.346922450017;10083.747906302402;10084.344517606332;10174.236932230113;16932.661346772995;17552.824471755375;17705.38031168903;17793.822061779476;17858.642827143645;6928.861422771516;6949.89575156373;7035.6833942471685;7094.219635840053;7101.2898710128575;3879.7866117363815;4004.759714417144;4008.7995600219874;4055.229506393776;4066.9796651017145;2892.5950366948646;3007.5338322560037;3010.6989301069716;3023.0779612218043;3024.107888172994;550.5320477594094;553.7425097329681;571.2259887851901;582.8222392170429;584.6024703201779;508.3061620887462;586.26131074846;615.0497481391261;635.4947816485904;644.559409719277;7230.710771569078;7612.8477430451085;7697.692092316244;7856.096548896836;7940.404469664798;612.8192183305936;635.3392471829338;636.7548493829817;639.7792761497276;645.0970632155302;3572.9464058039152;3615.1323682316056;3665.2119794244363;3680.15992003998;3680.1719613087375;58381;58561;58677.41322586805;58806.7059664699;59802;50842.74578627083;51107;51974.48025519772;52135.73932130391;52136.21795673068;45420.318695218935;46052;46066.539334606896;46699.76650116796;47024.294635580496;7016.36852683261;7094.503384763017;7110.43116550685;7129.714811407693;7188.4968052235845;27567;27702.44595108127;28312;28680.856595716887;29226;36932.81533592315;40102.59897400989;40550;40901;41252.79373603233;9647.372920760128;9737;9793.657221997197;9880.555375007998;9909.45497997617;10424.374537527772;10582.735431614272;10672.46637668129;10715.196360272856;10980.066694331072;10412.947935260578;10418.531166097393;10505.842412363667;10665.733356665834;10686.839697404701;10286.742831429274;10332.380057196593;10334.741631459274;10375.948120259653;10587.311824731369;9944.602215911282;10023.148032417035;10050.396976181453;10052;10212.897871021194;8397.370197235354;8419.747407577783;8423.11557286476;8724.869126963227;8743.34424918121;9052.54737263121;9182.862257066015;9218.400803947721;9251.306152038758;9283 10:32:04 INFO - PROCESS | 4104 | __end_tp_report 10:32:04 INFO - PROCESS | 4104 | __start_cc_report 10:32:04 INFO - PROCESS | 4104 | _x_x_mozilla_cycle_collect,373 10:32:04 INFO - PROCESS | 4104 | __end_cc_report 10:32:04 INFO - PROCESS | 4104 | __startTimestamp1461173524188__endTimestamp 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - PROCESS | 4104 | ------- Summary: start ------- 10:32:04 INFO - PROCESS | 4104 | Number of tests: 6 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - PROCESS | 4104 | [#0] dojo.html Cycles:165 Average:4766.40 Median:4912.61 stddev:528.98 (10.8%) stddev-sans-first:502.81 10:32:04 INFO - PROCESS | 4104 | Values: 2609.2 2685.4 2702.1 2715.4 2727.8 4818.2 4819.6 4840.5 4845.3 4914.7 4753.8 4838.6 4866.1 4944.5 4955.6 4324.4 4371.8 4458.7 4470.8 4486.1 4417.2 4545.9 4563.1 4585.1 4597.6 4297.8 4385.6 4436.5 4468.0 4515.5 4371.2 4379.8 4401.3 4429.7 4457.5 4402.3 4441.5 4444.9 4446.0 4474.6 4678.0 4756.7 4776.9 4780.5 4803.0 5158.5 5200.9 5202.9 5208.6 5224.5 5056.8 5219.3 5237.7 5245.3 5246.1 4887.3 4903.2 4913.3 4960.1 4970.6 5340.3 5386.5 5387.4 5408.5 5412.5 4966.2 5094.1 5119.1 5145.9 5148.7 5193.7 5216.6 5217.0 5229.7 5273.6 5016.6 5110.0 5112.5 5118.4 5123.4 5055.1 5147.7 5192.4 5219.2 5239.0 3983.4 4056.8 4059.7 4068.5 4102.5 3575.5 3598.2 3604.8 3642.4 3649.0 4437.4 4502.5 4514.8 4524.2 4559.7 5021.9 5130.4 5201.4 5215.4 5271.0 4503.5 4509.5 4512.1 4544.3 4546.5 4590.3 4609.3 4616.6 4629.4 4667.9 4734.0 4858.3 4876.6 4889.3 4912.6 5150.5 5173.0 5174.6 5174.9 5180.2 4794.7 4831.1 4859.7 4895.2 4947.3 5085.5 5093.6 5131.9 5152.8 5185.7 5106.4 5141.5 5159.2 5172.2 5216.7 4935.7 4992.2 4994.5 5000.8 5011.3 4920.6 5020.6 5063.8 5066.0 5100.7 4861.6 4870.3 4901.1 4902.5 4945.5 4963.6 4988.7 4998.0 5028.1 5051.3 4835.8 4930.3 5035.6 5069.0 5107.8 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - PROCESS | 4104 | [#1] ext.html Cycles:180 Average:43341.73 Median:34729.48 stddev:77466.92 (223.1%) stddev-sans-first:77617.69 10:32:04 INFO - PROCESS | 4104 | Values: 576.1 597.0 604.6 620.2 629.9 33305.7 34528.7 34534.0 34688.8 34721.3 34570.0 35187.0 35290.3 35292.5 35344.8 7497.4 7652.8 7694.6 7737.1 7743.7 7643.2 7982.2 7984.3 7990.5 7994.5 7956.9 7961.0 7976.0 8014.2 8024.8 7851.8 7928.7 7946.6 7985.9 7989.8 7798.6 7815.8 7833.6 7877.0 7885.8 29177.4 34951.3 35268.3 35390.0 35452.6 3084.9 3168.9 3228.1 3246.8 3304.7 27296.9 27586.0 28028.9 28102.0 28672.9 3446.8 3468.4 3475.5 3509.5 3557.3 192857.0 197073.0 197308.0 197489.0 197584.0 34675.3 57895.7 58027.4 58713.7 58733.7 34579.0 34836.0 34938.5 34958.0 34981.5 12614.4 12725.4 12818.7 12826.9 12854.9 10352.8 10379.3 10396.4 10426.3 10472.0 8359.5 8427.2 8453.7 8457.2 8472.4 3291.2 3326.0 3350.7 3387.3 3387.4 811.9 935.8 956.8 994.9 1060.4 28087.2 28634.6 28656.6 29273.7 29283.0 975.1 991.3 1020.2 1080.9 1120.2 14705.6 15249.2 15299.9 15540.3 15633.4 352729.0 355367.0 356017.0 357029.0 358317.0 50063.0 50292.0 50699.2 50905.5 50944.5 1186.9 1219.3 1278.7 1281.1 1284.9 27138.7 28348.3 28500.6 28780.6 29036.9 44326.0 44509.3 44653.8 44786.1 44799.3 305053.0 306091.0 306461.0 306658.0 307175.0 26066.6 26098.3 26642.5 26835.7 26876.6 42511.0 43283.4 43539.0 43974.1 44319.6 32214.0 33237.7 34521.5 35011.1 35073.5 34737.7 35263.0 35302.5 35385.8 35507.8 30594.0 30655.4 31789.0 36731.0 38160.6 29638.3 31525.2 31631.6 31714.0 31920.0 24770.8 24932.0 24949.5 25347.4 25404.9 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - PROCESS | 4104 | [#2] jquery.html Cycles:180 Average:25808.43 Median:394.88 stddev:66446.03 (16826.9%) stddev-sans-first:66605.00 10:32:04 INFO - PROCESS | 4104 | Values: 382.9 386.0 394.3 395.4 398.4 13052.7 15450.5 16003.8 16580.1 16612.0 15708.5 15711.3 15992.0 17347.0 17353.7 4388.2 4462.1 4481.7 4508.3 4539.2 5127.4 5214.4 5258.7 5274.8 5285.3 5194.3 5222.5 5230.7 5236.8 5249.1 6075.9 6430.7 6441.6 6459.9 6477.2 6146.0 6679.2 6693.7 6694.6 6702.1 22014.0 22410.9 22593.8 23991.0 24014.6 1927.1 2003.6 2170.7 2176.3 2221.2 13704.3 14409.7 14435.4 14478.6 14624.3 1859.8 2016.4 2020.8 2022.7 2053.4 87825.0 88236.0 88726.0 89697.6 90470.0 15381.0 16548.5 17003.5 17220.2 17716.4 12967.7 13784.4 29834.7 29878.0 30152.4 5559.7 5721.0 6081.2 6934.4 6945.0 6725.9 6738.2 6828.1 6850.6 6916.6 4230.2 4328.2 4370.5 4416.0 4521.2 1874.4 1875.6 1875.7 1888.4 1913.6 855.9 856.0 935.9 1011.1 1019.5 15229.1 16591.2 16654.7 16780.4 17068.7 850.7 896.6 904.3 950.8 950.9 9093.8 9219.3 9413.7 9506.2 9564.6 385876.0 390537.0 401909.0 407171.0 414292.0 78177.6 80122.0 82198.6 82522.0 83183.0 906.3 926.4 934.3 937.8 947.0 14851.3 14953.9 14993.3 14996.9 15114.0 34125.7 34182.8 34888.8 35398.0 35744.3 48079.8 49702.8 50529.5 51326.0 51442.0 7744.5 7772.1 7790.5 7817.9 7947.6 11091.7 11708.6 11901.9 11940.0 12085.5 10350.6 10352.2 10456.9 10476.7 10636.1 10209.1 10218.9 10317.9 10457.7 10476.5 10651.9 10689.3 10772.5 10790.1 10893.4 7707.2 7768.4 7769.9 7973.7 8090.8 8812.1 10419.2 10426.1 10557.6 10691.4 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - PROCESS | 4104 | [#3] mootools.html Cycles:180 Average:5027.62 Median:5144.97 stddev:2747.29 (53.4%) stddev-sans-first:2741.75 10:32:04 INFO - PROCESS | 4104 | Values: 1437.3 1478.2 1615.3 1738.3 1778.9 6749.4 7396.1 7486.1 7558.0 7660.5 7426.2 7464.7 7533.2 7565.8 7578.2 2172.6 2209.4 2222.6 2223.8 2224.6 2214.5 2232.9 2243.2 2243.3 2250.8 2221.8 2238.3 2242.2 2252.3 2276.7 2194.3 2196.2 2196.9 2199.7 2204.3 2200.3 2204.0 2206.2 2208.1 2213.3 7645.6 7760.1 7775.5 7778.8 7791.5 4582.2 4721.8 4730.1 4751.1 4764.7 2763.6 2978.9 3021.6 3045.7 3050.4 933.0 943.5 958.1 964.0 973.3 10288.0 10291.8 10309.0 10338.9 10351.8 4155.3 4248.0 4253.6 4425.5 4438.3 8953.7 8963.0 8968.4 8970.1 8973.6 4566.4 4588.9 4592.9 4600.7 4605.7 3793.4 4169.6 4190.3 4220.4 4347.8 3623.5 3637.7 3736.2 3752.9 3753.6 1232.7 1233.9 1234.8 1238.9 1242.0 910.8 913.8 923.0 932.0 935.8 5197.2 5201.3 5211.4 5217.5 5219.8 420.1 422.9 433.0 436.6 439.4 3630.0 3756.6 3794.6 3817.7 3828.9 9161.5 9449.1 9519.1 9535.8 9593.2 9318.0 9389.4 9437.4 9441.0 9441.4 6645.2 6869.2 6906.3 6925.8 6954.8 5092.7 5298.8 5305.2 5310.6 5376.0 8445.8 8547.2 8601.0 8628.9 8676.6 8328.0 8546.9 8548.9 8601.3 8743.6 6068.3 6373.3 6580.9 6734.3 6804.1 6850.3 6928.8 6975.6 6977.4 6994.3 6298.2 6308.9 6358.1 6394.3 6474.1 6197.3 6221.1 6295.1 6313.8 6440.2 6037.3 6059.2 6059.8 6094.5 6095.3 4364.8 4506.4 4513.3 4547.9 4600.4 4482.3 4609.5 4637.4 4654.8 4656.3 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - PROCESS | 4104 | [#4] prototype.html Cycles:180 Average:4676.66 Median:5266.16 stddev:1371.14 (26.0%) stddev-sans-first:1335.23 10:32:04 INFO - PROCESS | 4104 | Values: 309.7 313.7 317.0 318.0 322.2 5263.9 5345.2 5352.6 5391.9 5405.5 5212.4 5226.3 5226.3 5259.9 5268.4 3897.3 3963.0 4127.6 4146.3 4153.2 4120.4 4147.9 4148.5 4156.1 4162.8 4102.3 4146.0 4147.8 4149.0 4157.6 4046.7 4107.5 4134.6 4144.2 4153.9 3621.5 3636.5 3640.9 3646.7 3650.7 5075.0 5100.3 5100.9 5115.7 5128.2 4608.8 4742.7 4783.0 4783.3 4826.8 5598.2 5615.9 5638.3 5639.8 5647.8 4043.9 4045.0 4049.5 4051.9 4061.4 5714.5 5793.2 5858.2 5938.5 5950.9 4102.3 4120.8 4130.8 4132.2 4135.6 4170.2 4199.6 4199.7 4200.1 4205.4 4585.7 4743.9 4745.1 4769.3 4787.1 5550.3 5605.1 5612.5 5621.0 5635.1 1430.3 1449.2 1453.8 1455.6 1458.7 929.4 969.3 974.8 993.3 1013.8 4821.4 4833.7 4839.0 4842.8 4848.7 5687.9 5691.2 5720.1 5720.8 5736.9 4741.3 4845.5 4874.5 4888.1 4998.1 3115.4 3129.9 3134.9 3149.0 3153.0 5506.2 5544.4 5551.0 5553.0 5553.3 5922.4 6092.6 6093.5 6111.5 6127.5 5546.0 5560.1 5564.0 5565.9 5577.5 5733.6 5899.4 5906.2 5913.9 5926.9 5808.5 5828.5 5832.8 5840.1 5852.2 5561.5 5569.5 5570.9 5575.2 5589.9 3802.8 4040.9 4058.5 4064.4 4069.8 5797.6 5816.1 5839.9 5846.9 5879.6 5536.9 5629.1 5679.1 5685.4 5693.3 5579.5 5650.7 5654.3 5657.2 5688.3 5301.3 5536.6 5539.6 5546.4 5568.7 5458.3 5638.4 5740.3 5761.1 5764.6 5488.2 5572.5 5597.4 5608.1 5623.2 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - PROCESS | 4104 | [#5] yui.html Cycles:180 Average:13281.31 Median:50974.87 stddev:15977.49 (31.3%) stddev-sans-first:15994.20 10:32:04 INFO - PROCESS | 4104 | Values: 661.1 679.3 732.4 778.2 779.2 11990.2 12405.2 12457.1 12703.5 12707.8 13924.0 14021.4 14061.9 14118.6 14131.7 647.7 793.7 807.0 818.1 821.9 805.8 807.5 809.7 811.3 811.5 853.0 857.7 858.2 858.4 859.6 845.9 846.8 847.4 850.7 852.2 624.7 627.1 627.1 627.8 631.4 11796.5 11864.2 11874.9 11896.2 11938.6 12706.6 12835.4 12860.3 13003.0 13121.8 10225.0 10270.2 10394.3 10577.3 10604.2 3313.9 3341.8 3389.9 3406.0 3430.5 51857.7 51950.7 52429.5 52539.0 52963.5 10036.9 10047.3 10083.7 10084.3 10174.2 16932.7 17552.8 17705.4 17793.8 17858.6 6928.9 6949.9 7035.7 7094.2 7101.3 3879.8 4004.8 4008.8 4055.2 4067.0 2892.6 3007.5 3010.7 3023.1 3024.1 550.5 553.7 571.2 582.8 584.6 508.3 586.3 615.0 635.5 644.6 7230.7 7612.8 7697.7 7856.1 7940.4 612.8 635.3 636.8 639.8 645.1 3572.9 3615.1 3665.2 3680.2 3680.2 58381.0 58561.0 58677.4 58806.7 59802.0 50842.7 51107.0 51974.5 52135.7 52136.2 45420.3 46052.0 46066.5 46699.8 47024.3 7016.4 7094.5 7110.4 7129.7 7188.5 27567.0 27702.4 28312.0 28680.9 29226.0 36932.8 40102.6 40550.0 40901.0 41252.8 9647.4 9737.0 9793.7 9880.6 9909.5 10424.4 10582.7 10672.5 10715.2 10980.1 10412.9 10418.5 10505.8 10665.7 10686.8 10286.7 10332.4 10334.7 10375.9 10587.3 9944.6 10023.1 10050.4 10052.0 10212.9 8397.4 8419.7 8423.1 8724.9 8743.3 9052.5 9182.9 9218.4 9251.3 9283.0 10:32:04 INFO - PROCESS | 4104 | -------- Summary: end -------- 10:32:04 INFO - PROCESS | 4104 | 10:32:04 INFO - TEST-INFO | 4104: exit 0 10:32:04 INFO - TEST-OK | dromaeo_css | took 1115236ms 10:32:04 INFO - TEST-START | kraken 10:32:04 INFO - operating with platform_type : linux_ 10:32:04 INFO - Initialising browser for kraken test... 10:32:04 INFO - TEST-INFO | started process 4340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi7Vz5w/profile http://localhost:42186/getInfo.html) 10:32:09 INFO - PROCESS | 4340 | 10:32:09 INFO - PROCESS | 4340 | (process:4408): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:32:10 INFO - PROCESS | 4340 | __metrics Screen width/height:1600/1200 10:32:10 INFO - PROCESS | 4340 | colorDepth:24 10:32:10 INFO - PROCESS | 4340 | Browser inner width/height: 1024/697 10:32:10 INFO - PROCESS | 4340 | __metrics 10:32:10 ERROR - PROCESS | 4340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:32:11 INFO - TEST-INFO | 4340: exit 0 10:32:11 INFO - Browser initialized. 10:32:11 INFO - Running cycle 1/1 for kraken test... 10:32:11 INFO - TEST-INFO | started process 4459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi7Vz5w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:13 INFO - PROCESS | 4459 | 10:32:13 INFO - PROCESS | 4459 | (process:4519): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:32:23 INFO - PROCESS | 4459 | RSS: Main: 165167104 10:32:23 INFO - PROCESS | 4459 | 10:32:26 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42186/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:27 INFO - PROCESS | 4459 | RSS: Main: 169771008 10:32:27 INFO - PROCESS | 4459 | 10:32:29 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42186/tests/kraken/driver.html?testName=audio-dft) 10:32:30 INFO - PROCESS | 4459 | RSS: Main: 172933120 10:32:30 INFO - PROCESS | 4459 | 10:32:33 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42186/tests/kraken/driver.html?testName=audio-fft) 10:32:34 INFO - PROCESS | 4459 | RSS: Main: 163946496 10:32:34 INFO - PROCESS | 4459 | 10:32:36 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42186/tests/kraken/driver.html?testName=audio-oscillator) 10:32:36 INFO - PROCESS | 4459 | RSS: Main: 165765120 10:32:36 INFO - PROCESS | 4459 | 10:32:39 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42186/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:39 INFO - PROCESS | 4459 | RSS: Main: 166137856 10:32:39 INFO - PROCESS | 4459 | 10:32:42 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42186/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:43 INFO - PROCESS | 4459 | RSS: Main: 165568512 10:32:43 INFO - PROCESS | 4459 | 10:32:47 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42186/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:47 INFO - PROCESS | 4459 | RSS: Main: 164536320 10:32:47 INFO - PROCESS | 4459 | 10:32:50 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42186/tests/kraken/driver.html?testName=json-parse-financial) 10:32:51 INFO - PROCESS | 4459 | RSS: Main: 165199872 10:32:51 INFO - PROCESS | 4459 | 10:32:52 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42186/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:53 INFO - PROCESS | 4459 | RSS: Main: 165576704 10:32:53 INFO - PROCESS | 4459 | 10:32:55 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:56 INFO - PROCESS | 4459 | RSS: Main: 165724160 10:32:56 INFO - PROCESS | 4459 | 10:32:58 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:59 INFO - PROCESS | 4459 | RSS: Main: 166064128 10:32:59 INFO - PROCESS | 4459 | 10:33:01 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:02 INFO - PROCESS | 4459 | RSS: Main: 166207488 10:33:02 INFO - PROCESS | 4459 | 10:33:05 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:05 INFO - PROCESS | 4459 | RSS: Main: 166211584 10:33:05 INFO - PROCESS | 4459 | 10:33:07 INFO - PROCESS | 4459 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42186/tests/kraken/driver.html?testName=ai-astar) 10:33:08 INFO - PROCESS | 4459 | RSS: Main: 167788544 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | __start_tp_report 10:33:08 INFO - PROCESS | 4459 | _x_x_mozilla_page_load 10:33:08 INFO - PROCESS | 4459 | _x_x_mozilla_page_load_details 10:33:08 INFO - PROCESS | 4459 | |i|pagename|runs| 10:33:08 INFO - PROCESS | 4459 | |0;ai-astar;117;108;115;113;115;127;114;114;114;114 10:33:08 INFO - PROCESS | 4459 | |1;audio-beat-detection;175;142;158;188;133;156;159;134;187;133 10:33:08 INFO - PROCESS | 4459 | |2;audio-dft;163;171;164;172;165;162;162;164;165;160 10:33:08 INFO - PROCESS | 4459 | |3;audio-fft;73;77;75;166;73;75;74;74;151;73 10:33:08 INFO - PROCESS | 4459 | |4;audio-oscillator;96;94;154;95;95;94;153;93;95;136 10:33:08 INFO - PROCESS | 4459 | |5;imaging-gaussian-blur;117;118;118;118;117;118;117;118;126;118 10:33:08 INFO - PROCESS | 4459 | |6;imaging-darkroom;147;147;146;148;148;147;148;147;148;147 10:33:08 INFO - PROCESS | 4459 | |7;imaging-desaturate;96;96;95;95;95;96;95;96;95;95 10:33:08 INFO - PROCESS | 4459 | |8;json-parse-financial;64;65;67;65;65;65;64;85;64;66 10:33:08 INFO - PROCESS | 4459 | |9;json-stringify-tinderbox;64;66;65;65;65;66;64;66;65;65 10:33:08 INFO - PROCESS | 4459 | |10;stanford-crypto-aes;82;79;79;80;83;80;83;80;83;82 10:33:08 INFO - PROCESS | 4459 | |11;stanford-crypto-ccm;143;137;132;134;134;140;146;132;171;138 10:33:08 INFO - PROCESS | 4459 | |12;stanford-crypto-pbkdf2;180;171;174;172;183;174;178;172;174;181 10:33:08 INFO - PROCESS | 4459 | |13;stanford-crypto-sha256-iterative;74;71;75;74;74;75;79;73;73;73 10:33:08 INFO - PROCESS | 4459 | __end_tp_report 10:33:08 INFO - PROCESS | 4459 | __start_cc_report 10:33:08 INFO - PROCESS | 4459 | _x_x_mozilla_cycle_collect,945 10:33:08 INFO - PROCESS | 4459 | __end_cc_report 10:33:08 INFO - PROCESS | 4459 | __startTimestamp1461173588016__endTimestamp 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | ------- Summary: start ------- 10:33:08 INFO - PROCESS | 4459 | Number of tests: 14 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#0] ai-astar Cycles:10 Average:115.10 Median:114.50 stddev:4.77 (4.2%) stddev-sans-first:5.01 10:33:08 INFO - PROCESS | 4459 | Values: 117.0 108.0 115.0 113.0 115.0 127.0 114.0 114.0 114.0 114.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#1] audio-beat-detection Cycles:10 Average:156.50 Median:158.50 stddev:21.33 (13.5%) stddev-sans-first:21.55 10:33:08 INFO - PROCESS | 4459 | Values: 175.0 142.0 158.0 188.0 133.0 156.0 159.0 134.0 187.0 133.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.85 (2.3%) stddev-sans-first:4.03 10:33:08 INFO - PROCESS | 4459 | Values: 163.0 171.0 164.0 172.0 165.0 162.0 162.0 164.0 165.0 160.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#3] audio-fft Cycles:10 Average:91.10 Median:74.00 stddev:35.72 (48.3%) stddev-sans-first:37.28 10:33:08 INFO - PROCESS | 4459 | Values: 73.0 77.0 75.0 166.0 73.0 75.0 74.0 74.0 151.0 73.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:94.50 stddev:26.10 (27.6%) stddev-sans-first:27.15 10:33:08 INFO - PROCESS | 4459 | Values: 96.0 94.0 154.0 95.0 95.0 94.0 153.0 93.0 95.0 136.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:2.68 (2.3%) stddev-sans-first:2.78 10:33:08 INFO - PROCESS | 4459 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 126.0 118.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:33:08 INFO - PROCESS | 4459 | Values: 147.0 147.0 146.0 148.0 148.0 147.0 148.0 147.0 148.0 147.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:33:08 INFO - PROCESS | 4459 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:65.00 stddev:6.39 (9.8%) stddev-sans-first:6.69 10:33:08 INFO - PROCESS | 4459 | Values: 64.0 65.0 67.0 65.0 65.0 65.0 64.0 85.0 64.0 66.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 10:33:08 INFO - PROCESS | 4459 | Values: 64.0 66.0 65.0 65.0 65.0 66.0 64.0 66.0 65.0 65.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:82.00 stddev:1.66 (2.0%) stddev-sans-first:1.73 10:33:08 INFO - PROCESS | 4459 | Values: 82.0 79.0 79.0 80.0 83.0 80.0 83.0 80.0 83.0 82.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:139.00 stddev:11.61 (8.4%) stddev-sans-first:12.29 10:33:08 INFO - PROCESS | 4459 | Values: 143.0 137.0 132.0 134.0 134.0 140.0 146.0 132.0 171.0 138.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:176.00 stddev:4.25 (2.4%) stddev-sans-first:4.25 10:33:08 INFO - PROCESS | 4459 | Values: 180.0 171.0 174.0 172.0 183.0 174.0 178.0 172.0 174.0 181.0 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - PROCESS | 4459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.00 stddev:2.08 (2.8%) stddev-sans-first:2.20 10:33:08 INFO - PROCESS | 4459 | Values: 74.0 71.0 75.0 74.0 74.0 75.0 79.0 73.0 73.0 73.0 10:33:08 INFO - PROCESS | 4459 | -------- Summary: end -------- 10:33:08 INFO - PROCESS | 4459 | 10:33:08 INFO - TEST-INFO | 4459: exit 0 10:33:09 INFO - TEST-OK | kraken | took 64123ms 10:33:09 INFO - SUITE-END | took 1179s 10:33:09 INFO - Completed test suite (00:19:39) 10:33:09 INFO - javascript benchmark 10:33:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.2041927212204, 2685.4360584277306, 2702.1353166986573, 2715.443334116505, 2727.7954153438495, 4818.180909245428, 4819.590334821535, 4840.515948405157, 4845.273209018649, 4914.655974081807, 4753.7623118844, 4838.612910967123, 4866.051120031595, 4944.5055494450535, 4955.578775804061, 4324.416203812484, 4371.846985355513, 4458.7324760514475, 4470.843520476784, 4486.080353527519, 4417.249067658489, 4545.886352841172, 4563.064571762798, 4585.105904348653, 4597.632189424855, 4297.8495752648505, 4385.56144385562, 4436.511983681792, 4467.950031742538, 4515.458145022585, 4371.169477799208, 4379.759113248802, 4401.251787196153, 4429.734215947054, 4457.48738895028, 4402.25161722508, 4441.511433742286, 4444.933326000112, 4445.977770111129, 4474.619657329131, 4678.0410015946645, 4756.7145971241835, 4776.880577985544, 4780.498047704976, 4803.0, 5158.509941555546, 5200.869978250536, 5202.895942081137, 5208.609354298443, 5224.451432599599, 5056.84829455117, 5219.347581552306, 5237.73811309433, 5245.26566280721, 5246.108161612535, 4887.266909963534, 4903.166461701519, 4913.287573301851, 4960.107180707508, 4970.577500912463, 5340.30576025122, 5386.48828361305, 5387.353517577916, 5408.459154084639, 5412.539934105566, 4966.180580204298, 5094.083065048327, 5119.078565858107, 5145.9485405146215, 5148.665336753099, 5193.662411943212, 5216.60875434344, 5217.0, 5229.738513074407, 5273.578113750891, 5016.573591244712, 5110.0, 5112.539871411591, 5118.360204974379, 5123.38519377677, 5055.140626093573, 5147.6654017488745, 5192.350956130484, 5219.16493361068, 5238.97380513095, 3983.4024896265214, 4056.7971601419813, 4059.65492933104, 4068.532118806316, 4102.50769907613, 3575.4994300797907, 3598.226381328027, 3604.8377822998027, 3642.4354225095153, 3649.0147660131615, 4437.445319335083, 4502.549745025537, 4514.841980530731, 4524.16302983949, 4559.726416415026, 5021.924671129936, 5130.384353877558, 5201.375834899761, 5215.374155101336, 5271.024860400838, 4503.504614492404, 4509.481409637868, 4512.075024619945, 4544.2501987171745, 4546.522615125365, 4590.334401511829, 4609.3086037094035, 4616.561426664462, 4629.421322334708, 4667.903042784943, 4733.952660473351, 4858.295547145714, 4876.634252431082, 4889.339939108246, 4912.606991440748, 5150.459201783909, 5173.0, 5174.6119041072825, 5174.9482505174465, 5180.222966555047, 4794.664373493822, 4831.106245344622, 4859.708417494961, 4895.241237608177, 4947.307376967299, 5085.48794809017, 5093.567046800915, 5131.897362052663, 5152.845414637567, 5185.740712964262, 5106.387233532, 5141.53726164647, 5159.17453207485, 5172.172452407597, 5216.713080780593, 4935.654504184673, 4992.151334273255, 4994.450610432922, 5000.849974500771, 5011.298418221525, 4920.5571498565305, 5020.573251273682, 5063.772130254221, 5065.974670126626, 5100.693958362362, 4861.562459378673, 4870.26945958095, 4901.117798796108, 4902.4607293197005, 4945.4807245238735, 4963.5780958618925, 4988.700677959334, 4998.0, 5028.094942910311, 5051.292819005415, 4835.758212089452, 4930.285108659296, 5035.647504674637, 5069.036882992367, 5107.821226257063], "value": 4730.884866056758, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.0840263980273, 596.994065000474, 604.579817027166, 620.2061361457334, 629.9464545513631, 33305.66694333056, 34528.65471345286, 34534.0, 34688.82655586725, 34721.30557388851, 34570.0, 35187.0, 35290.294194116104, 35292.47061294083, 35344.82327588359, 7497.400207983348, 7652.846943061136, 7694.615269236544, 7737.148913619498, 7743.728969486069, 7643.23567643234, 7982.161873003309, 7984.321332686729, 7990.520568765864, 7994.480358776661, 7956.920430795705, 7961.044674639052, 7975.96012019942, 8014.158513356101, 8024.759257222293, 7851.803704907395, 7928.722494712657, 7946.562939038351, 7985.880211796828, 7989.800254993672, 7798.649060792278, 7815.765527034198, 7833.608319583998, 7876.960615196887, 7885.842283154305, 29177.41645167106, 34951.300973980375, 35268.29463410743, 35390.0, 35452.64547354519, 3084.8766049358, 3168.904932851995, 3228.1122691259857, 3246.798614646015, 3304.7025767680784, 27296.89102149301, 27586.0, 28028.859855700794, 28102.0, 28672.863413374762, 3446.773538760111, 3468.4277094279414, 3475.5481787367735, 3509.526213961108, 3557.324108419392, 192857.0, 197073.0, 197308.01345993322, 197489.0, 197584.0, 34675.30649386998, 57895.71052144712, 58027.4197258022, 58713.706431468425, 58733.70633146807, 34579.0, 34836.0, 34938.47592286118, 34958.0, 34981.47527787085, 12614.369281535886, 12725.363731813371, 12818.679533011562, 12826.935865320615, 12854.871451285368, 10352.792944141074, 10379.325343852626, 10396.428196449117, 10426.270161088803, 10472.0, 8359.540225287546, 8427.199416055464, 8453.704120355758, 8457.23884850354, 8472.364572657076, 3291.1772056985756, 3325.9833700831823, 3350.7151892089446, 3387.2886693794085, 3387.3902697514686, 811.8741595052776, 935.7894473743489, 956.7655924298452, 994.8607194992707, 1060.390275591538, 28087.157385278475, 28634.570481442795, 28656.570151447744, 29273.707262927524, 29283.0, 975.1223898491272, 991.2912267728465, 1020.2297265564451, 1080.9459527023616, 1120.2270433400927, 14705.55883323502, 15249.237538123049, 15299.923500382427, 15540.300686469136, 15633.374665013273, 352729.0, 355367.0, 356017.0, 357029.0, 358317.0, 50063.0, 50292.0, 50699.18357756007, 50905.490945090816, 50944.490555094715, 1186.8753780853058, 1219.3476490077944, 1278.7122897348208, 1281.1238768963551, 1284.8693150027916, 27138.72861271441, 28348.291292717848, 28500.57249141223, 28780.568291476062, 29036.854815725786, 44326.0, 44509.33236001527, 44653.77673111744, 44786.104277914914, 44799.328010079225, 305053.0, 306091.0, 306461.0, 306658.0, 307175.0, 26066.60900086538, 26098.347541311618, 26642.467150657267, 26835.731642683324, 26876.59685104764, 42511.0, 43283.35074973941, 43539.0, 43974.12051758883, 44319.556804431544, 32214.0, 33237.667623323454, 34521.482177766855, 35011.12472188216, 35073.473897892065, 34737.65262347344, 35263.0, 35302.47046294256, 35385.82307088448, 35507.82246088753, 30594.0, 30655.386892262475, 31789.0, 36730.95951986739, 38160.618393815705, 29638.259043523223, 31525.211869703442, 31631.593658906644, 31714.0, 31920.0, 24770.752292477566, 24932.0, 24949.50100998006, 25347.366315842253, 25404.872975635004], "value": 16314.32733997325, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.9425586162075, 385.99807000965, 394.3473551272643, 395.41320680110687, 398.3586425854374, 13052.673683157926, 15450.459233926815, 16003.759943600855, 16580.088095154777, 16612.0, 15708.528744137695, 15711.292991815368, 15992.0, 17347.0, 17353.652926941453, 4388.188185185735, 4462.12988467249, 4481.686281960264, 4508.323751437278, 4539.228331183706, 5127.435982041991, 5214.374275086995, 5258.710770907599, 5274.81538146165, 5285.312909321783, 5194.27280180775, 5222.503862133091, 5230.73846307685, 5236.842894713165, 5249.081410753122, 6075.939240607604, 6430.678466076677, 6441.645709485976, 6459.870802583945, 6477.157969463987, 6145.9692701536205, 6679.198496180489, 6693.698783554752, 6694.564853284521, 6702.128723265993, 22014.0, 22410.88794556033, 22593.77406225933, 23991.0, 24014.639780403308, 1927.1231589626686, 2003.6092961872441, 2170.7395112586432, 2176.253613797216, 2221.2336743823357, 13704.314784260747, 14409.711805763825, 14435.35040923161, 14478.638034049127, 14624.341904614212, 1859.8047205043547, 2016.3648450737971, 2020.7979202079675, 2022.6763717805081, 2053.363457328233, 87825.0, 88236.0, 88726.0, 89697.55151224202, 90469.99999999935, 15381.0, 16548.503544893672, 17003.489895303162, 17220.225089870986, 17716.379926702502, 12967.675808104872, 13784.448622055206, 29834.701652983193, 29878.0, 30152.396952060837, 5559.6664200148125, 5721.0, 6081.2094427725, 6934.410575101072, 6945.0, 6725.932740672629, 6738.225104112992, 6828.078209441761, 6850.554713943578, 6916.55042422241, 4230.238557059697, 4328.220920234388, 4370.475542934868, 4415.977920110379, 4521.163584736834, 1874.3983520457246, 1875.606122714218, 1875.728019437174, 1888.4240306706586, 1913.6172765446966, 855.9400841941005, 855.9529225892511, 935.8923723771853, 1011.110223003752, 1019.5361110694616, 15229.086254824746, 16591.170441477876, 16654.66690666204, 16780.412685555948, 17068.658626827393, 850.7150104714866, 896.5651658945407, 904.3353135445442, 950.7908260182749, 950.9239260859115, 9093.818123637622, 9219.308551858503, 9413.670521531714, 9506.191973682176, 9564.61741530331, 385876.0, 390537.0, 401909.0, 407171.0, 414292.0, 78177.60911195408, 80122.0, 82198.58900705459, 82522.0, 83183.0, 906.3474298505066, 926.3515539122641, 934.2619330728784, 937.8265020971143, 947.0292949726586, 14851.274120556713, 14953.850461495245, 14993.2503374833, 14996.925015374853, 15114.0, 34125.65874341225, 34182.82908585441, 34888.825555872056, 35398.0, 35744.28511429809, 48079.75960120177, 49702.751486242334, 50529.49470505248, 51325.973480529436, 51442.0, 7744.49660772048, 7772.106207785951, 7790.493617914817, 7817.921820781947, 7947.602619868868, 11091.72270693239, 11708.648740537797, 11901.880981190423, 11940.0, 12085.516579336729, 10350.637727679496, 10352.17182625373, 10456.947715261374, 10476.68569942903, 10636.09593184557, 10209.132223760766, 10218.948905255425, 10317.9484102579, 10457.68626941193, 10476.476176191312, 10651.89348106509, 10689.251752377259, 10772.515236814519, 10790.082842958123, 10893.400862952296, 7707.229277072248, 7768.378529717496, 7769.92230077692, 7973.72091976778, 8090.83818323642, 8812.118788121137, 10419.218558608287, 10426.113780328757, 10557.63048293306, 10691.396290556479], "value": 8737.113284880843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.2669938331449, 1478.2239324354712, 1615.313491766, 1738.3481194552044, 1778.8754787164903, 6749.392554670078, 7396.112466504021, 7486.139094004191, 7557.962210188948, 7660.540367577943, 7426.220246874068, 7464.664090115944, 7533.209013053633, 7565.848683026336, 7578.166401695809, 2172.6415141501634, 2209.4034610655112, 2222.611043067465, 2223.7776222377715, 2224.632935565638, 2214.5017371091535, 2232.9218477353215, 2243.1588154442084, 2243.3270018994317, 2250.8424410291286, 2221.833362497819, 2238.2837492002564, 2242.1816037146486, 2252.256755270765, 2276.681264622954, 2194.3416974907545, 2196.187410658059, 2196.8905702620236, 2199.714037175173, 2204.305643722222, 2200.3288996855954, 2204.041242059709, 2206.1837120265604, 2208.1277895231456, 2213.269621025058, 7645.617719114078, 7760.146383897767, 7775.494592851446, 7778.766637000843, 7791.4935529190425, 4582.243929751587, 4721.811127554894, 4730.124926888537, 4751.14479393709, 4764.666473346867, 2763.557830747071, 2978.8659510322086, 3021.6374035115705, 3045.6954304569585, 3050.3899220155836, 932.9953350233274, 943.5376665433956, 958.1137447860771, 963.9566219520138, 973.2603221551601, 10288.0, 10291.794164116676, 10309.0, 10338.948305258426, 10351.844722329095, 4155.252054630196, 4247.980484683653, 4253.63844073251, 4425.513193548707, 4438.289873620205, 8953.686620968236, 8963.014068452465, 8968.372213944962, 8970.102989700978, 8973.551322433852, 4566.383538222364, 4588.931166032512, 4592.908141837212, 4600.6549508786975, 4605.746683932416, 3793.393057110849, 4169.624733773975, 4190.287651099259, 4220.388043733641, 4347.760873151944, 3623.474596183539, 3637.7089832813313, 3736.1593641431004, 3752.9437058444146, 3753.6246375362243, 1232.7164752107064, 1233.9136260461862, 1234.8086046662602, 1238.9194702344319, 1242.037420998715, 910.7723069232692, 913.7532866126109, 922.9630814767335, 931.9627214911328, 935.8081593273363, 5197.246399272084, 5201.271821944931, 5211.374635043743, 5217.530422262014, 5219.765110570033, 420.13871563295123, 422.8963903843578, 432.9675274354436, 436.6463164836493, 439.3651174053526, 3629.9637003629628, 3756.5679946806467, 3794.5636251830842, 3817.7136714746507, 3828.904277393032, 9161.541922903829, 9449.102335278138, 9519.143277105093, 9535.809283814286, 9593.184579310697, 9318.0, 9389.436633801857, 9437.433753974783, 9441.0, 9441.386309889835, 6645.169353830771, 6869.210040845267, 6906.274841141708, 6925.757598484029, 6954.756583519553, 5092.694438333712, 5298.81454149103, 5305.230741542532, 5310.628256022042, 5376.0, 8445.831083378422, 8547.188017138362, 8601.0, 8628.870566941627, 8676.566171691517, 8327.95836020816, 8546.914530854861, 8548.914510854811, 8601.311895048506, 8743.606537705691, 6068.302145253352, 6373.330800266091, 6580.901286480803, 6734.326567343226, 6804.149481314836, 6850.314968503109, 6928.792136235921, 6975.6163411012885, 6977.406920411619, 6994.265602111908, 6298.181236439417, 6308.873822523616, 6358.078078678658, 6394.296627371078, 6474.093626892145, 6197.287311959182, 6221.097940798469, 6295.055741638791, 6313.779017734358, 6440.194975628046, 6037.335893051849, 6059.242594675666, 6059.848503787441, 6094.512439004958, 6095.329513753395, 4364.781760911878, 4506.369108324771, 4513.345564893007, 4547.886302842323, 4600.4479462464715, 4482.260427029503, 4609.539046095364, 4637.397138372125, 4654.837080702159, 4656.324832899279], "value": 4048.264929536731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.71815647760536, 313.7458658486626, 316.9920751981202, 317.982510961897, 322.20254869198726, 5263.86840328992, 5345.1714984177415, 5352.635078055096, 5391.865203369918, 5405.459454054602, 5212.4266330703595, 5226.2944502492155, 5226.346706661668, 5259.894802103965, 5268.446813084628, 3897.259520691067, 3962.9801850990702, 4127.62851343379, 4146.253674338618, 4153.231652144363, 4120.402541631462, 4147.854825081123, 4148.543660197376, 4156.085661154556, 4162.771047592381, 4102.323116685759, 4145.979270103645, 4147.822393243556, 4148.958510414903, 4157.605027522381, 4046.696497762665, 4107.466029416187, 4134.586541345871, 4144.233316836365, 4153.916921661565, 3621.4567814827724, 3636.5454318210222, 3640.890773276806, 3646.6717995380545, 3650.671439570451, 5074.985002999378, 5100.285959965608, 5100.948990510122, 5115.693058416507, 5128.205128205097, 4608.778673651485, 4742.739149346785, 4782.952170478286, 4783.3497443381975, 4826.758662066883, 5598.2442370280305, 5615.9157612635845, 5638.323401191883, 5639.802606908779, 5647.802326918538, 4043.9191216175514, 4044.959550404488, 4049.473568436114, 4051.8784436466954, 4061.3704875744306, 5714.542836573064, 5793.191016585975, 5858.162903298304, 5938.524918006592, 5950.851228719273, 4102.343625019982, 4120.75275483472, 4130.793460326971, 4132.194222126716, 4135.593898074609, 4170.16596680665, 4199.559046300155, 4199.748015119103, 4200.075983283673, 4205.369194620831, 4585.72485650862, 4743.881402964885, 4745.078243311395, 4769.30845027476, 4787.138315103315, 5550.333959924835, 5605.131204663284, 5612.548282806045, 5620.960122377373, 5635.126555383922, 1430.2920054573053, 1449.2101804516565, 1453.840077591464, 1455.5997100797365, 1458.7009663019055, 929.3773171974793, 969.2827307792184, 974.8342781727123, 993.2749093162032, 1013.7871047080196, 4821.373221481185, 4833.73414462208, 4838.95161048385, 4842.806287748451, 4848.733319667382, 5687.8908612820105, 5691.231683722727, 5720.141978703228, 5720.799772007959, 5736.885262294814, 4741.312509686145, 4845.53967373099, 4874.488178741181, 4888.095702295087, 4998.125328067574, 3115.376924615086, 3129.937401251962, 3134.905952821419, 3148.968510314913, 3152.952705709416, 5506.229127922094, 5544.417836127229, 5551.0, 5552.972235138798, 5553.278073850373, 5922.378150294243, 6092.603980741238, 6093.451589356979, 6111.480524155497, 6127.5404344674325, 5546.0, 5560.110382338807, 5564.0, 5565.888682226414, 5577.525910297589, 5733.569982251432, 5899.410058994238, 5906.173135760911, 5913.940860591511, 5926.940730592639, 5808.5353171747, 5828.504577110993, 5832.766689332379, 5840.094785308284, 5852.209951656472, 5561.5272701820795, 5569.470900264469, 5570.888582228252, 5575.2473416088305, 5589.888202236014, 3802.809859506958, 4040.8585699500377, 4058.5332686741403, 4064.4309796629086, 4069.8372065117064, 5797.565182611237, 5816.098504731774, 5839.854003649943, 5846.9183201107935, 5879.617824841372, 5536.889262214652, 5629.057974998619, 5679.148127780701, 5685.431456854281, 5693.263554615882, 5579.46995035471, 5650.717464126859, 5654.293213348332, 5657.236273103078, 5688.345840228427, 5301.25782390458, 5536.557075434036, 5539.58453116026, 5546.4453554644215, 5568.721563921707, 5458.263134476795, 5638.436156384329, 5740.282464691913, 5761.107028410603, 5764.596478246483, 5488.204210389551, 5572.498475137257, 5597.440255974533, 5608.10270356741, 5623.2127502148915], "value": 4238.688671481934, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.1273119482286, 679.3478260869565, 732.406750532069, 778.2412148155546, 779.1701837543017, 11990.16068875179, 12405.193662411948, 12457.065720070985, 12703.491860325576, 12707.809382859265, 13923.955703322266, 14021.43914243429, 14061.859381406182, 14118.64703382416, 14131.728144466995, 647.6891092275711, 793.6626933553246, 807.0275318241505, 818.071488860145, 821.9383546234027, 805.8025783683006, 807.5033854179667, 809.6599428240124, 811.3144392987916, 811.4847072109224, 853.0147679430237, 857.7083791510885, 858.2275951643509, 858.3690987124489, 859.5573279760928, 845.9492430454193, 846.8221673448584, 847.3941132090554, 850.7320194138888, 852.2415050604967, 624.7188765055697, 627.1001113402236, 627.1220291591808, 627.8493161641219, 631.3970158498623, 11796.528138874435, 11864.169508134433, 11874.881251187464, 11896.22674526153, 11938.64184074479, 12706.618801435972, 12835.358232088358, 12860.292683902382, 13003.0, 13121.803172952414, 10225.0, 10270.1783857292, 10394.272400931937, 10577.312474689197, 10604.151667866552, 3313.9005829825146, 3341.8496167672515, 3389.8983030509125, 3406.0463070340343, 3430.5025771263026, 51857.74071129658, 51950.740246298905, 52429.47570524284, 52539.0, 52963.47036529624, 10036.949815250877, 10047.346922450017, 10083.747906302402, 10084.344517606332, 10174.236932230113, 16932.661346772995, 17552.824471755375, 17705.38031168903, 17793.822061779476, 17858.642827143645, 6928.861422771516, 6949.89575156373, 7035.6833942471685, 7094.219635840053, 7101.2898710128575, 3879.7866117363815, 4004.759714417144, 4008.7995600219874, 4055.229506393776, 4066.9796651017145, 2892.5950366948646, 3007.5338322560037, 3010.6989301069716, 3023.0779612218043, 3024.107888172994, 550.5320477594094, 553.7425097329681, 571.2259887851901, 582.8222392170429, 584.6024703201779, 508.3061620887462, 586.26131074846, 615.0497481391261, 635.4947816485904, 644.559409719277, 7230.710771569078, 7612.8477430451085, 7697.692092316244, 7856.096548896836, 7940.404469664798, 612.8192183305936, 635.3392471829338, 636.7548493829817, 639.7792761497276, 645.0970632155302, 3572.9464058039152, 3615.1323682316056, 3665.2119794244363, 3680.15992003998, 3680.1719613087375, 58381.0, 58561.0, 58677.41322586805, 58806.7059664699, 59802.0, 50842.74578627083, 51107.0, 51974.48025519772, 52135.73932130391, 52136.21795673068, 45420.318695218935, 46052.0, 46066.539334606896, 46699.76650116796, 47024.294635580496, 7016.36852683261, 7094.503384763017, 7110.43116550685, 7129.714811407693, 7188.4968052235845, 27567.0, 27702.44595108127, 28312.0, 28680.856595716887, 29226.0, 36932.81533592315, 40102.59897400989, 40550.0, 40901.0, 41252.79373603233, 9647.372920760128, 9737.0, 9793.657221997197, 9880.555375007998, 9909.45497997617, 10424.374537527772, 10582.735431614272, 10672.46637668129, 10715.196360272856, 10980.066694331072, 10412.947935260578, 10418.531166097393, 10505.842412363667, 10665.733356665834, 10686.839697404701, 10286.742831429274, 10332.380057196593, 10334.741631459274, 10375.948120259653, 10587.311824731369, 9944.602215911282, 10023.148032417035, 10050.396976181453, 10052.0, 10212.897871021194, 8397.370197235354, 8419.747407577783, 8423.11557286476, 8724.869126963227, 8743.34424918121, 9052.54737263121, 9182.862257066015, 9218.400803947721, 9251.306152038758, 9283.0], "value": 5986.673326667028, "unit": "score"}], "name": "dromaeo_css", "value": 6408.674587661569, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 108.0, 115.0, 113.0, 115.0, 127.0, 114.0, 114.0, 114.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 142.0, 158.0, 188.0, 133.0, 156.0, 159.0, 134.0, 187.0, 133.0], "value": 156.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 164.0, 172.0, 165.0, 162.0, 162.0, 164.0, 165.0, 160.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 75.0, 166.0, 73.0, 75.0, 74.0, 74.0, 151.0, 73.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 154.0, 95.0, 95.0, 94.0, 153.0, 93.0, 95.0, 136.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 126.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 65.0, 65.0, 65.0, 64.0, 85.0, 64.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 66.0, 64.0, 66.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 80.0, 83.0, 80.0, 83.0, 80.0, 83.0, 82.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 137.0, 132.0, 134.0, 134.0, 140.0, 146.0, 132.0, 171.0, 138.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 171.0, 174.0, 172.0, 183.0, 174.0, 178.0, 172.0, 174.0, 181.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 75.0, 74.0, 74.0, 75.0, 79.0, 73.0, 73.0, 73.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1603.0999999999997, "alertThreshold": 2.0}]} 10:33:09 INFO - Return code: 0 10:33:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:33:09 ERROR - # TBPL SUCCESS # 10:33:09 INFO - Running post-action listener: _resource_record_post_action 10:33:09 INFO - Running post-run listener: _resource_record_post_run 10:33:10 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 430080; Write bytes: 295583744; Read time: 52; Write time: 255936 10:33:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13254656; Read time: 0; Write time: 24236 10:33:10 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 430080; Write bytes: 278433792; Read time: 52; Write time: 219568 10:33:10 INFO - Running post-run listener: _upload_blobber_files 10:33:10 INFO - Blob upload gear active. 10:33:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:10 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 10:33:10 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'] 10:33:10 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 10:33:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:33:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:11 INFO - (blobuploader) - INFO - Done attempting. 10:33:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:33:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:12 INFO - (blobuploader) - INFO - Done attempting. 10:33:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:12 INFO - Return code: 0 10:33:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10e0a9729da28e116ff0175f5bb2c11feea2e89e4e5a5504034f462f38aca1d2df9fefdd8bc72f3c00b58802b7ae431c5550ac6f34ba4155d9a9e0df0a3485e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/855d4c53f09d6c71f83d89ba24b1b8949d87c93e47e954a70a2558fb8e0695fff8498dbabc1621287c6d62f9f5774d633415410a03ab61c8e8108dffdc6cd4a6"} 10:33:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:12 INFO - Contents: 10:33:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10e0a9729da28e116ff0175f5bb2c11feea2e89e4e5a5504034f462f38aca1d2df9fefdd8bc72f3c00b58802b7ae431c5550ac6f34ba4155d9a9e0df0a3485e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/855d4c53f09d6c71f83d89ba24b1b8949d87c93e47e954a70a2558fb8e0695fff8498dbabc1621287c6d62f9f5774d633415410a03ab61c8e8108dffdc6cd4a6"} 10:33:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:12 INFO - Copying logs to upload dir... 10:33:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.260722 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-20 10:33:12.500251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:33:12.503355) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030 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/10e0a9729da28e116ff0175f5bb2c11feea2e89e4e5a5504034f462f38aca1d2df9fefdd8bc72f3c00b58802b7ae431c5550ac6f34ba4155d9a9e0df0a3485e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/855d4c53f09d6c71f83d89ba24b1b8949d87c93e47e954a70a2558fb8e0695fff8498dbabc1621287c6d62f9f5774d633415410a03ab61c8e8108dffdc6cd4a6"} build_url:https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/NzkgDpL7QdKMqfy8dZCCBA/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/10e0a9729da28e116ff0175f5bb2c11feea2e89e4e5a5504034f462f38aca1d2df9fefdd8bc72f3c00b58802b7ae431c5550ac6f34ba4155d9a9e0df0a3485e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/855d4c53f09d6c71f83d89ba24b1b8949d87c93e47e954a70a2558fb8e0695fff8498dbabc1621287c6d62f9f5774d633415410a03ab61c8e8108dffdc6cd4a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:33:12.528621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:33:12.528940) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461170425.82720-59824030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:33:12.610389) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:33:12.610676) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:33:12.610936) ========= ========= Total master_lag: 0.16 =========