builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1464242896.85 results: success (0) buildid: 20160525203033 builduid: 94abec3d545b40a39d51e94f4cf96f6f revision: 8dfd7c9d86397ed898d84933a3c39834f1db886f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:16.853428) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:16.854698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:16.855133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:16.921884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:16.922148) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 23:08:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-25 23:08:17 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.066920 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.019395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.019696) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019462 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.093068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.093389) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8dfd7c9d86397ed898d84933a3c39834f1db886f --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 8dfd7c9d86397ed898d84933a3c39834f1db886f --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=5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 23:08:17,603 truncating revision to first 12 chars 2016-05-25 23:08:17,603 Setting DEBUG logging. 2016-05-25 23:08:17,603 attempt 1/10 2016-05-25 23:08:17,603 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8dfd7c9d8639?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 23:08:17,904 unpacking tar archive at: fx-team-8dfd7c9d8639/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618749 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.726711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.727020) ========= script_repo_revision: 8dfd7c9d86397ed898d84933a3c39834f1db886f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.727433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.728312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 23:08:17.740647) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-25 23:08:17.741020) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:08:18 INFO - MultiFileLogger online at 20160525 23:08:18 in /builds/slave/test 23:08:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:08:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:08:18 INFO - {'append_to_log': False, 23:08:18 INFO - 'base_work_dir': '/builds/slave/test', 23:08:18 INFO - 'blob_upload_branch': 'Fx-Team', 23:08:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:08:18 INFO - 'branch': 'Fx-Team', 23:08:18 INFO - 'buildbot_json_path': 'buildprops.json', 23:08:18 INFO - 'config_files': ('talos/linux_config.py',), 23:08:18 INFO - 'default_actions': ('clobber', 23:08:18 INFO - 'read-buildbot-config', 23:08:18 INFO - 'download-and-extract', 23:08:18 INFO - 'populate-webroot', 23:08:18 INFO - 'create-virtualenv', 23:08:18 INFO - 'install', 23:08:18 INFO - 'run-tests'), 23:08:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:08:18 INFO - 'download_minidump_stackwalk': True, 23:08:18 INFO - 'download_symbols': 'ondemand', 23:08:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:08:18 INFO - 'tooltool.py': '/tools/tooltool.py', 23:08:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:08:18 INFO - '/tools/misc-python/virtualenv.py')}, 23:08:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:08:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:08:18 INFO - 'installer_path': 'installer.exe', 23:08:18 INFO - 'log_level': 'info', 23:08:18 INFO - 'log_name': 'talos', 23:08:18 INFO - 'log_to_console': True, 23:08:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:08:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:08:18 INFO - 'opt_config_files': (), 23:08:18 INFO - 'pip_index': False, 23:08:18 INFO - 'sps_profile': False, 23:08:18 INFO - 'sps_profile_interval': 0, 23:08:18 INFO - 'suite': 'dromaeojs-e10s', 23:08:18 INFO - 'system_bits': '32', 23:08:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:08:18 INFO - 'title': 'talos-linux64-ix-039', 23:08:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:08:18 INFO - 'use_talos_json': True, 23:08:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:08:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:08:18 INFO - 'work_dir': 'build'} 23:08:18 INFO - ##### 23:08:18 INFO - ##### Running clobber step. 23:08:18 INFO - ##### 23:08:18 INFO - Running pre-action listener: _resource_record_pre_action 23:08:18 INFO - Running main action method: clobber 23:08:18 INFO - rmtree: /builds/slave/test/build 23:08:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:08:18 INFO - Running post-action listener: _resource_record_post_action 23:08:18 INFO - ##### 23:08:18 INFO - ##### Finished clobber step (success) 23:08:18 INFO - ##### 23:08:18 INFO - ##### 23:08:18 INFO - ##### Running read-buildbot-config step. 23:08:18 INFO - ##### 23:08:18 INFO - Running pre-action listener: _resource_record_pre_action 23:08:18 INFO - Running main action method: read_buildbot_config 23:08:18 INFO - Using buildbot properties: 23:08:18 INFO - { 23:08:18 INFO - "project": "", 23:08:18 INFO - "product": "firefox", 23:08:18 INFO - "script_repo_revision": "production", 23:08:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:08:18 INFO - "repository": "", 23:08:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:08:18 INFO - "buildid": "20160525203033", 23:08:18 INFO - "pgo_build": "True", 23:08:18 INFO - "basedir": "/builds/slave/test", 23:08:18 INFO - "buildnumber": 492, 23:08:18 INFO - "slavename": "talos-linux64-ix-039", 23:08:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:08:18 INFO - "platform": "ubuntu64_hw", 23:08:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:08:18 INFO - "branch": "fx-team", 23:08:18 INFO - "repo_path": "integration/fx-team", 23:08:18 INFO - "revision": "8dfd7c9d86397ed898d84933a3c39834f1db886f", 23:08:18 INFO - "stage_platform": "linux64-pgo", 23:08:18 INFO - "builduid": "94abec3d545b40a39d51e94f4cf96f6f", 23:08:18 INFO - "slavebuilddir": "test" 23:08:18 INFO - } 23:08:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:08:18 INFO - Running post-action listener: _resource_record_post_action 23:08:18 INFO - ##### 23:08:18 INFO - ##### Finished read-buildbot-config step (success) 23:08:18 INFO - ##### 23:08:18 INFO - ##### 23:08:18 INFO - ##### Running download-and-extract step. 23:08:18 INFO - ##### 23:08:18 INFO - Running pre-action listener: _resource_record_pre_action 23:08:18 INFO - Running main action method: download_and_extract 23:08:18 INFO - mkdir: /builds/slave/test/build/tests 23:08:18 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')]} 23:08:18 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:08:27 INFO - Downloaded 1361 bytes. 23:08:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:28 INFO - Using the following test package requirements: 23:08:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:08:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:08:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:08:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:28 INFO - u'jsshell-linux-x86_64.zip'], 23:08:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:08:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:08:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:08:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:08:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:08:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:08:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:08: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')]} 23:08:28 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:08:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:08:30 INFO - Downloaded 24408799 bytes. 23:08:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:08:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:08:31 INFO - Return code: 0 23:08:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:08:31 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')]} 23:08:31 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:08:38 INFO - Downloaded 24408799 bytes. 23:08:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:08:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:08:40 INFO - Return code: 0 23:08:40 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')]} 23:08:40 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:08:41 INFO - Downloaded 10834034 bytes. 23:08:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:08:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:08:41 INFO - Return code: 0 23:08: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')]} 23:08:41 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:08:43 INFO - Downloaded 58658390 bytes. 23:08:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:43 INFO - mkdir: /builds/slave/test/properties 23:08:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:08:43 INFO - Writing to file /builds/slave/test/properties/build_url 23:08:43 INFO - Contents: 23:08:43 INFO - build_url:https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:44 INFO - Running post-action listener: _resource_record_post_action 23:08:44 INFO - Running post-action listener: set_extra_try_arguments 23:08:44 INFO - ##### 23:08:44 INFO - ##### Finished download-and-extract step (success) 23:08:44 INFO - ##### 23:08:44 INFO - ##### 23:08:44 INFO - ##### Running populate-webroot step. 23:08:44 INFO - ##### 23:08:44 INFO - Running pre-action listener: _resource_record_pre_action 23:08:44 INFO - Running main action method: populate_webroot 23:08:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:08:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:08:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:08:44 INFO - '--tppagecycles', 23:08:44 INFO - '7'], 23:08:44 INFO - 'tests': ['tsvgm']}}, 23:08:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:08:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:08:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:08:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:08:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:44 INFO - 'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:08:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:08:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:44 INFO - 'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['damp', 'tps']}, 23:08:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:44 INFO - 'tests': ['damp', 'tps']}, 23:08:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['dromaeo_dom']}, 23:08:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:08:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['a11yr', 23:08:44 INFO - 'ts_paint', 23:08:44 INFO - 'tpaint', 23:08:44 INFO - 'sessionrestore', 23:08:44 INFO - 'sessionrestore_no_auto_restore', 23:08:44 INFO - 'tabpaint']}, 23:08:44 INFO - 'other-e10s': {'tests': ['a11yr', 23:08:44 INFO - 'ts_paint', 23:08:44 INFO - 'tpaint', 23:08:44 INFO - 'sessionrestore', 23:08:44 INFO - 'sessionrestore_no_auto_restore', 23:08:44 INFO - 'tabpaint']}, 23:08:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:08:44 INFO - 'ts_paint', 23:08:44 INFO - 'tpaint', 23:08:44 INFO - 'sessionrestore', 23:08:44 INFO - 'sessionrestore_no_auto_restore', 23:08:44 INFO - 'tabpaint']}, 23:08:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:08:44 INFO - 'ts_paint', 23:08:44 INFO - 'tpaint', 23:08:44 INFO - 'sessionrestore', 23:08:44 INFO - 'sessionrestore_no_auto_restore', 23:08:44 INFO - 'tabpaint']}, 23:08:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['a11yr', 23:08:44 INFO - 'ts_paint', 23:08:44 INFO - 'tpaint', 23:08:44 INFO - 'sessionrestore', 23:08:44 INFO - 'sessionrestore_no_auto_restore', 23:08:44 INFO - 'tabpaint']}, 23:08:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['a11yr', 23:08:44 INFO - 'ts_paint', 23:08:44 INFO - 'tpaint', 23:08:44 INFO - 'sessionrestore', 23:08:44 INFO - 'sessionrestore_no_auto_restore', 23:08:44 INFO - 'tabpaint']}, 23:08:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['tsvgx', 23:08:44 INFO - 'tsvgr_opacity', 23:08:44 INFO - 'tart', 23:08:44 INFO - 'tscrollx', 23:08:44 INFO - 'cart']}, 23:08:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:08:44 INFO - 'tsvgr_opacity', 23:08:44 INFO - 'tart', 23:08:44 INFO - 'tscrollx', 23:08:44 INFO - 'cart']}, 23:08:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:44 INFO - 'talos_options': ['--disable-e10s'], 23:08:44 INFO - 'tests': ['tp5o']}, 23:08:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:44 INFO - 'tests': ['tp5o']}, 23:08:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:44 INFO - 'talos_options': ['--disable-e10s', 23:08:44 INFO - '--xperf_path', 23:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:08:44 INFO - 'tests': ['tp5n']}, 23:08:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:44 INFO - 'talos_options': ['--xperf_path', 23:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:08:44 INFO - 'tests': ['tp5n']}}, 23:08:44 INFO - 'talos.zip': {'path': '', 23:08:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:08:44 INFO - Running post-action listener: _resource_record_post_action 23:08:44 INFO - ##### 23:08:44 INFO - ##### Finished populate-webroot step (success) 23:08:44 INFO - ##### 23:08:44 INFO - ##### 23:08:44 INFO - ##### Running create-virtualenv step. 23:08:44 INFO - ##### 23:08:44 INFO - Running pre-action listener: _resource_record_pre_action 23:08:44 INFO - Running main action method: create_virtualenv 23:08:44 INFO - Creating virtualenv /builds/slave/test/build/venv 23:08:44 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 23:08:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:08:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:08:44 INFO - Using real prefix '/usr' 23:08:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:08:44 INFO - Installing distribute.............................................................................................................................................................................................done. 23:08:46 INFO - Installing pip.................done. 23:08:46 INFO - Return code: 0 23:08:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:46 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 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:08:46 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 23:08:46 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 23:08:46 INFO - Using env: {'DISPLAY': ':0', 23:08:46 INFO - 'HOME': '/home/cltbld', 23:08:46 INFO - 'LANG': 'en_US.UTF-8', 23:08:46 INFO - 'LANGUAGE': 'en_US:en', 23:08:46 INFO - 'LOGNAME': 'cltbld', 23:08:46 INFO - 'MAIL': '/var/mail/cltbld', 23:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:46 INFO - 'MOZ_NO_REMOTE': '1', 23:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:46 INFO - 'NO_EM_RESTART': '1', 23:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:46 INFO - 'PWD': '/builds/slave/test', 23:08:46 INFO - 'SHELL': '/bin/bash', 23:08:46 INFO - 'SHLVL': '1', 23:08:46 INFO - 'TERM': 'linux', 23:08:46 INFO - 'TMOUT': '86400', 23:08:46 INFO - 'USER': 'cltbld', 23:08:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:46 INFO - '_': '/tools/buildbot/bin/python'} 23:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:46 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 23:08:46 INFO - Cleaning up... 23:08:46 INFO - Return code: 0 23:08:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:46 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:08:46 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>=3.1.1'] in /builds/slave/test/build 23:08:46 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>=3.1.1 23:08:46 INFO - Using env: {'DISPLAY': ':0', 23:08:46 INFO - 'HOME': '/home/cltbld', 23:08:46 INFO - 'LANG': 'en_US.UTF-8', 23:08:46 INFO - 'LANGUAGE': 'en_US:en', 23:08:46 INFO - 'LOGNAME': 'cltbld', 23:08:46 INFO - 'MAIL': '/var/mail/cltbld', 23:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:46 INFO - 'MOZ_NO_REMOTE': '1', 23:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:46 INFO - 'NO_EM_RESTART': '1', 23:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:46 INFO - 'PWD': '/builds/slave/test', 23:08:46 INFO - 'SHELL': '/bin/bash', 23:08:46 INFO - 'SHLVL': '1', 23:08:46 INFO - 'TERM': 'linux', 23:08:46 INFO - 'TMOUT': '86400', 23:08:46 INFO - 'USER': 'cltbld', 23:08:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:46 INFO - '_': '/tools/buildbot/bin/python'} 23:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:47 INFO - Downloading/unpacking psutil>=3.1.1 23:08:47 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 23:08:47 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 23:08:47 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 23:08:47 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 23:08:47 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 23:08:47 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 23:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:08:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:08:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:08:49 INFO - Installing collected packages: psutil 23:08:49 INFO - Running setup.py install for psutil 23:08:49 INFO - building 'psutil._psutil_linux' extension 23:08:49 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 23:08:49 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 23:08:49 INFO - building 'psutil._psutil_posix' extension 23:08:49 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 23:08:49 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 23:08:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:08:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:08:49 INFO - Successfully installed psutil 23:08:49 INFO - Cleaning up... 23:08:49 INFO - Return code: 0 23:08:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:08:49 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')]} 23:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:49 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')]} 23:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:49 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:08:49 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.3'] in /builds/slave/test/build 23:08:49 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.3 23:08:49 INFO - Using env: {'DISPLAY': ':0', 23:08:49 INFO - 'HOME': '/home/cltbld', 23:08:49 INFO - 'LANG': 'en_US.UTF-8', 23:08:49 INFO - 'LANGUAGE': 'en_US:en', 23:08:49 INFO - 'LOGNAME': 'cltbld', 23:08:49 INFO - 'MAIL': '/var/mail/cltbld', 23:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:49 INFO - 'MOZ_NO_REMOTE': '1', 23:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:49 INFO - 'NO_EM_RESTART': '1', 23:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:49 INFO - 'PWD': '/builds/slave/test', 23:08:49 INFO - 'SHELL': '/bin/bash', 23:08:49 INFO - 'SHLVL': '1', 23:08:49 INFO - 'TERM': 'linux', 23:08:49 INFO - 'TMOUT': '86400', 23:08:49 INFO - 'USER': 'cltbld', 23:08:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:49 INFO - '_': '/tools/buildbot/bin/python'} 23:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:08:49 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 23:08:49 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 23:08:49 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 23:08:49 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 23:08:49 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 23:08:49 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 23:08:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:08:51 INFO - Installing collected packages: mozsystemmonitor 23:08:51 INFO - Running setup.py install for mozsystemmonitor 23:08:51 INFO - Successfully installed mozsystemmonitor 23:08:51 INFO - Cleaning up... 23:08:51 INFO - Return code: 0 23:08:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:51 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 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:08:51 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 23:08:51 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 23:08:51 INFO - Using env: {'DISPLAY': ':0', 23:08:51 INFO - 'HOME': '/home/cltbld', 23:08:51 INFO - 'LANG': 'en_US.UTF-8', 23:08:51 INFO - 'LANGUAGE': 'en_US:en', 23:08:51 INFO - 'LOGNAME': 'cltbld', 23:08:51 INFO - 'MAIL': '/var/mail/cltbld', 23:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:51 INFO - 'MOZ_NO_REMOTE': '1', 23:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:51 INFO - 'NO_EM_RESTART': '1', 23:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:51 INFO - 'PWD': '/builds/slave/test', 23:08:51 INFO - 'SHELL': '/bin/bash', 23:08:51 INFO - 'SHLVL': '1', 23:08:51 INFO - 'TERM': 'linux', 23:08:51 INFO - 'TMOUT': '86400', 23:08:51 INFO - 'USER': 'cltbld', 23:08:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:51 INFO - '_': '/tools/buildbot/bin/python'} 23:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:52 INFO - Downloading/unpacking blobuploader==1.2.4 23:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:53 INFO - Downloading blobuploader-1.2.4.tar.gz 23:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:08:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:08: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 23:08: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 23:08: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 23:08: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 23:08: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 23:08: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 23:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:08:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:08: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 23:08: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 23:08: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 23:08: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 23:08: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 23:08: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 23:08:54 INFO - Downloading docopt-0.6.1.tar.gz 23:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:08:54 INFO - Installing collected packages: blobuploader, requests, docopt 23:08:54 INFO - Running setup.py install for blobuploader 23:08:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:08:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:08:54 INFO - Running setup.py install for requests 23:08:55 INFO - Running setup.py install for docopt 23:08:55 INFO - Successfully installed blobuploader requests docopt 23:08:55 INFO - Cleaning up... 23:08:55 INFO - Return code: 0 23:08:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:08:55 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')]} 23:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:55 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')]} 23:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:55 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 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:08:55 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 23:08:55 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 23:08:55 INFO - Using env: {'DISPLAY': ':0', 23:08:55 INFO - 'HOME': '/home/cltbld', 23:08:55 INFO - 'LANG': 'en_US.UTF-8', 23:08:55 INFO - 'LANGUAGE': 'en_US:en', 23:08:55 INFO - 'LOGNAME': 'cltbld', 23:08:55 INFO - 'MAIL': '/var/mail/cltbld', 23:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:55 INFO - 'MOZ_NO_REMOTE': '1', 23:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:55 INFO - 'NO_EM_RESTART': '1', 23:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:55 INFO - 'PWD': '/builds/slave/test', 23:08:55 INFO - 'SHELL': '/bin/bash', 23:08:55 INFO - 'SHLVL': '1', 23:08:55 INFO - 'TERM': 'linux', 23:08:55 INFO - 'TMOUT': '86400', 23:08:55 INFO - 'USER': 'cltbld', 23:08:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:55 INFO - '_': '/tools/buildbot/bin/python'} 23:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:08:55 INFO - Running setup.py (path:/tmp/pip-gE6kpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:08:55 INFO - Running setup.py (path:/tmp/pip-Z6XBuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:08:55 INFO - Running setup.py (path:/tmp/pip-GNnNiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:08:55 INFO - Running setup.py (path:/tmp/pip-luZkoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:08:55 INFO - Running setup.py (path:/tmp/pip-m2Zq5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:08:55 INFO - Running setup.py (path:/tmp/pip-79JQZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:08:55 INFO - Running setup.py (path:/tmp/pip-aynoF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:08:56 INFO - Running setup.py (path:/tmp/pip-OZ9GCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:08:56 INFO - Running setup.py (path:/tmp/pip-BURcJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:08:56 INFO - Running setup.py (path:/tmp/pip-GvCCAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:08:56 INFO - Running setup.py (path:/tmp/pip-iMv4d7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:08:56 INFO - Running setup.py (path:/tmp/pip-3kyJBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:08:56 INFO - Running setup.py (path:/tmp/pip-VYW4a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:08:56 INFO - Running setup.py (path:/tmp/pip-YudKem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:08:56 INFO - Running setup.py (path:/tmp/pip-HIGiZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:08:56 INFO - Running setup.py (path:/tmp/pip-L3PX_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:08:56 INFO - Running setup.py (path:/tmp/pip-uJ3aqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:08:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:08:56 INFO - Running setup.py install for manifestparser 23:08:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:08:56 INFO - Running setup.py install for mozcrash 23:08:56 INFO - Running setup.py install for mozdebug 23:08:57 INFO - Running setup.py install for mozdevice 23:08:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Running setup.py install for mozfile 23:08:57 INFO - Running setup.py install for mozhttpd 23:08:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Running setup.py install for mozinfo 23:08:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Running setup.py install for mozInstall 23:08:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Running setup.py install for mozleak 23:08:57 INFO - Running setup.py install for mozlog 23:08:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Running setup.py install for moznetwork 23:08:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:08:57 INFO - Running setup.py install for mozprocess 23:08:57 INFO - Running setup.py install for mozprofile 23:08:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:08:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:08:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:08:58 INFO - Running setup.py install for mozrunner 23:08:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:08:58 INFO - Running setup.py install for mozscreenshot 23:08:58 INFO - Running setup.py install for moztest 23:08:58 INFO - Running setup.py install for mozversion 23:08:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:08:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:08:58 INFO - Cleaning up... 23:08:58 INFO - Return code: 0 23:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:58 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 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:08:58 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 23:08:58 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 23:08:58 INFO - Using env: {'DISPLAY': ':0', 23:08:58 INFO - 'HOME': '/home/cltbld', 23:08:58 INFO - 'LANG': 'en_US.UTF-8', 23:08:58 INFO - 'LANGUAGE': 'en_US:en', 23:08:58 INFO - 'LOGNAME': 'cltbld', 23:08:58 INFO - 'MAIL': '/var/mail/cltbld', 23:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:58 INFO - 'MOZ_NO_REMOTE': '1', 23:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:58 INFO - 'NO_EM_RESTART': '1', 23:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:58 INFO - 'PWD': '/builds/slave/test', 23:08:58 INFO - 'SHELL': '/bin/bash', 23:08:58 INFO - 'SHLVL': '1', 23:08:58 INFO - 'TERM': 'linux', 23:08:58 INFO - 'TMOUT': '86400', 23:08:58 INFO - 'USER': 'cltbld', 23:08:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:58 INFO - '_': '/tools/buildbot/bin/python'} 23:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:08:58 INFO - Running setup.py (path:/tmp/pip-DoQ_VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:08:58 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)) 23:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:08:58 INFO - Running setup.py (path:/tmp/pip-8Y5W6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:08:58 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)) 23:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:08:58 INFO - Running setup.py (path:/tmp/pip-veYYqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:08:59 INFO - Running setup.py (path:/tmp/pip-dCTNHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:08:59 INFO - Running setup.py (path:/tmp/pip-M8CaEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:08:59 INFO - Running setup.py (path:/tmp/pip-XGJXVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:08:59 INFO - Running setup.py (path:/tmp/pip-2OFeJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:08:59 INFO - Running setup.py (path:/tmp/pip-dr7H7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:08:59 INFO - Running setup.py (path:/tmp/pip-XaZ8c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:08:59 INFO - Running setup.py (path:/tmp/pip-SSKpaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:08:59 INFO - Running setup.py (path:/tmp/pip-wJGtFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:08:59 INFO - Running setup.py (path:/tmp/pip-iVGO8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:08:59 INFO - Running setup.py (path:/tmp/pip-WS9hrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:08:59 INFO - Running setup.py (path:/tmp/pip-VytReV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:08:59 INFO - Running setup.py (path:/tmp/pip-vySr9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:08:59 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)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:08:59 INFO - Running setup.py (path:/tmp/pip-qsq8BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:08:59 INFO - Running setup.py (path:/tmp/pip-OrQBQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:00 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)) 23:09:00 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)) 23:09:00 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)) 23:09:00 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)) 23:09:00 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)) 23:09:00 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)) 23:09:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:00 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 23:09:00 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 23:09:00 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 23:09:00 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 23:09:00 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 23:09:00 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 23:09:01 INFO - Downloading blessings-1.6.tar.gz 23:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:09:01 INFO - Installing collected packages: blessings 23:09:01 INFO - Running setup.py install for blessings 23:09:02 INFO - Successfully installed blessings 23:09:02 INFO - Cleaning up... 23:09:02 INFO - Return code: 0 23:09:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:09:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:02 INFO - Reading from file tmpfile_stdout 23:09:02 INFO - Current package versions: 23:09:02 INFO - argparse == 1.2.1 23:09:02 INFO - blessings == 1.6 23:09:02 INFO - blobuploader == 1.2.4 23:09:02 INFO - docopt == 0.6.1 23:09:02 INFO - manifestparser == 1.1 23:09:02 INFO - mozInstall == 1.12 23:09:02 INFO - mozcrash == 0.17 23:09:02 INFO - mozdebug == 0.1 23:09:02 INFO - mozdevice == 0.48 23:09:02 INFO - mozfile == 1.2 23:09:02 INFO - mozhttpd == 0.7 23:09:02 INFO - mozinfo == 0.9 23:09:02 INFO - mozleak == 0.1 23:09:02 INFO - mozlog == 3.2 23:09:02 INFO - moznetwork == 0.27 23:09:02 INFO - mozprocess == 0.22 23:09:02 INFO - mozprofile == 0.28 23:09:02 INFO - mozrunner == 6.11 23:09:02 INFO - mozscreenshot == 0.1 23:09:02 INFO - mozsystemmonitor == 0.3 23:09:02 INFO - moztest == 0.7 23:09:02 INFO - mozversion == 1.4 23:09:02 INFO - psutil == 3.1.1 23:09:02 INFO - requests == 1.2.3 23:09:02 INFO - wsgiref == 0.1.2 23:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:02 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 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:09:02 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 23:09:02 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 23:09:02 INFO - Using env: {'DISPLAY': ':0', 23:09:02 INFO - 'HOME': '/home/cltbld', 23:09:02 INFO - 'LANG': 'en_US.UTF-8', 23:09:02 INFO - 'LANGUAGE': 'en_US:en', 23:09:02 INFO - 'LOGNAME': 'cltbld', 23:09:02 INFO - 'MAIL': '/var/mail/cltbld', 23:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:02 INFO - 'MOZ_NO_REMOTE': '1', 23:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:02 INFO - 'NO_EM_RESTART': '1', 23:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:02 INFO - 'PWD': '/builds/slave/test', 23:09:02 INFO - 'SHELL': '/bin/bash', 23:09:02 INFO - 'SHLVL': '1', 23:09:02 INFO - 'TERM': 'linux', 23:09:02 INFO - 'TMOUT': '86400', 23:09:02 INFO - 'USER': 'cltbld', 23:09:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:02 INFO - '_': '/tools/buildbot/bin/python'} 23:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 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)) 23:09:02 INFO - Cleaning up... 23:09:02 INFO - Return code: 0 23:09:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:02 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 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:09:02 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 23:09:02 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 23:09:02 INFO - Using env: {'DISPLAY': ':0', 23:09:02 INFO - 'HOME': '/home/cltbld', 23:09:02 INFO - 'LANG': 'en_US.UTF-8', 23:09:02 INFO - 'LANGUAGE': 'en_US:en', 23:09:02 INFO - 'LOGNAME': 'cltbld', 23:09:02 INFO - 'MAIL': '/var/mail/cltbld', 23:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:02 INFO - 'MOZ_NO_REMOTE': '1', 23:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:02 INFO - 'NO_EM_RESTART': '1', 23:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:02 INFO - 'PWD': '/builds/slave/test', 23:09:02 INFO - 'SHELL': '/bin/bash', 23:09:02 INFO - 'SHLVL': '1', 23:09:02 INFO - 'TERM': 'linux', 23:09:02 INFO - 'TMOUT': '86400', 23:09:02 INFO - 'USER': 'cltbld', 23:09:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:02 INFO - '_': '/tools/buildbot/bin/python'} 23:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:02 INFO - Downloading/unpacking jsonschema 23:09:02 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 23:09:02 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 23:09:02 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 23:09:02 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 23:09:02 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 23:09:02 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 23:09:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:09:04 INFO - Downloading/unpacking functools32 (from jsonschema) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:04 INFO - Downloading functools32-3.2.3-2.tar.gz 23:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:09:04 INFO - warning: no files found matching '*.txt' 23:09:04 INFO - no previously-included directories found matching 'build' 23:09:04 INFO - no previously-included directories found matching 'dist' 23:09:04 INFO - no previously-included directories found matching '.git*' 23:09:04 INFO - Installing collected packages: jsonschema, functools32 23:09:04 INFO - Running setup.py install for functools32 23:09:05 INFO - warning: no files found matching '*.txt' 23:09:05 INFO - no previously-included directories found matching 'build' 23:09:05 INFO - no previously-included directories found matching 'dist' 23:09:05 INFO - no previously-included directories found matching '.git*' 23:09:05 INFO - Successfully installed jsonschema functools32 23:09:05 INFO - Cleaning up... 23:09:05 INFO - Return code: 0 23:09:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:05 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 0x7fa385409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', '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 23:09:05 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 23:09:05 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 23:09:05 INFO - Using env: {'DISPLAY': ':0', 23:09:05 INFO - 'HOME': '/home/cltbld', 23:09:05 INFO - 'LANG': 'en_US.UTF-8', 23:09:05 INFO - 'LANGUAGE': 'en_US:en', 23:09:05 INFO - 'LOGNAME': 'cltbld', 23:09:05 INFO - 'MAIL': '/var/mail/cltbld', 23:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:05 INFO - 'MOZ_NO_REMOTE': '1', 23:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:05 INFO - 'NO_EM_RESTART': '1', 23:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:05 INFO - 'PWD': '/builds/slave/test', 23:09:05 INFO - 'SHELL': '/bin/bash', 23:09:05 INFO - 'SHLVL': '1', 23:09:05 INFO - 'TERM': 'linux', 23:09:05 INFO - 'TMOUT': '86400', 23:09:05 INFO - 'USER': 'cltbld', 23:09:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:05 INFO - '_': '/tools/buildbot/bin/python'} 23:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:05 INFO - Downloading/unpacking flake8 23:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:09:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:09:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:09:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:09:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:09:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:09:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:09:07 INFO - no previously-included directories found matching 'docs/_build' 23:09:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:09:08 INFO - Running setup.py install for pep8 23:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:09:08 INFO - no previously-included directories found matching 'docs/_build' 23:09:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:09:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:09:08 INFO - Cleaning up... 23:09:08 INFO - Return code: 0 23:09:08 INFO - Running post-action listener: _resource_record_post_action 23:09:08 INFO - Running post-action listener: _start_resource_monitoring 23:09:08 INFO - Starting resource monitoring. 23:09:08 INFO - ##### 23:09:08 INFO - ##### Finished create-virtualenv step (success) 23:09:08 INFO - ##### 23:09:08 INFO - ##### 23:09:08 INFO - ##### Running install step. 23:09:08 INFO - ##### 23:09:08 INFO - Running pre-action listener: _resource_record_pre_action 23:09:08 INFO - Running main action method: install 23:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:08 INFO - Reading from file tmpfile_stdout 23:09:08 INFO - Detecting whether we're running mozinstall >=1.0... 23:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:09:08 INFO - Reading from file tmpfile_stdout 23:09:08 INFO - Output received: 23:09:08 INFO - Usage: mozinstall [options] installer 23:09:08 INFO - Options: 23:09:08 INFO - -h, --help show this help message and exit 23:09:08 INFO - -d DEST, --destination=DEST 23:09:08 INFO - Directory to install application into. [default: 23:09:08 INFO - "/builds/slave/test"] 23:09:08 INFO - --app=APP Application being installed. [default: firefox] 23:09:08 INFO - mkdir: /builds/slave/test/build/application 23:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:09:25 INFO - Reading from file tmpfile_stdout 23:09:25 INFO - Output received: 23:09:25 INFO - /builds/slave/test/build/application/firefox/firefox 23:09:25 INFO - Running post-action listener: _resource_record_post_action 23:09:25 INFO - ##### 23:09:25 INFO - ##### Finished install step (success) 23:09:25 INFO - ##### 23:09:25 INFO - ##### 23:09:25 INFO - ##### Running run-tests step. 23:09:25 INFO - ##### 23:09:25 INFO - Running pre-action listener: _resource_record_pre_action 23:09:25 INFO - Running main action method: run_tests 23:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:09:25 INFO - Python 2.7.3 23:09:25 INFO - Return code: 0 23:09:25 INFO - grabbing minidump binary from tooltool 23:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:25 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19949c0>, '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 0x19958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:09:25 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 23:09:25 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 23:09:25 INFO - Calling ['/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'] with output_timeout 600 23:09:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:09:25 INFO - Return code: 0 23:09:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:09:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:09:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:09:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:09:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:09:26 INFO - Return code: 0 23:09:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 23:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 23:09:26 INFO - Using env: {'DISPLAY': ':0', 23:09:26 INFO - 'HOME': '/home/cltbld', 23:09:26 INFO - 'LANG': 'en_US.UTF-8', 23:09:26 INFO - 'LANGUAGE': 'en_US:en', 23:09:26 INFO - 'LOGNAME': 'cltbld', 23:09:26 INFO - 'MAIL': '/var/mail/cltbld', 23:09:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:09:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:26 INFO - 'MOZ_NO_REMOTE': '1', 23:09:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:26 INFO - 'NO_EM_RESTART': '1', 23:09:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:26 INFO - 'PWD': '/builds/slave/test', 23:09:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:09:26 INFO - 'SHELL': '/bin/bash', 23:09:26 INFO - 'SHLVL': '1', 23:09:26 INFO - 'TERM': 'linux', 23:09:26 INFO - 'TMOUT': '86400', 23:09:26 INFO - 'USER': 'cltbld', 23:09:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958', 23:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:26 INFO - '_': '/tools/buildbot/bin/python'} 23:09:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 23:09:26 INFO - mozversion application_buildid: 20160525203033 23:09:26 INFO - mozversion application_changeset: 8dfd7c9d86397ed898d84933a3c39834f1db886f 23:09:26 INFO - mozversion application_display_name: Nightly 23:09:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:09:26 INFO - mozversion application_name: Firefox 23:09:26 INFO - mozversion application_remotingname: firefox 23:09:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:09:26 INFO - mozversion application_vendor: Mozilla 23:09:26 INFO - mozversion application_version: 49.0a1 23:09:26 INFO - mozversion platform_buildid: 20160525203033 23:09:26 INFO - mozversion platform_changeset: 8dfd7c9d86397ed898d84933a3c39834f1db886f 23:09:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:09:26 INFO - mozversion platform_version: 49.0a1 23:09:26 INFO - using testdate: 1464242966 23:09:26 INFO - actual date: 1464242966 23:09:26 INFO - starting webserver on 'localhost:44633' 23:09:26 INFO - SUITE-START | Running 2 tests 23:09:26 INFO - TEST-START | dromaeo_css 23:09:26 INFO - operating with platform_type : linux_ 23:09:26 INFO - Initialising browser for dromaeo_css test... 23:09:26 INFO - TEST-INFO | started process 16578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFgZ546/profile http://localhost:44633/getInfo.html) 23:09:30 INFO - PROCESS | 16578 | 23:09:30 INFO - PROCESS | 16578 | (process:16649): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:09:30 INFO - PROCESS | 16578 | __metrics Screen width/height:1600/1200 23:09:30 INFO - PROCESS | 16578 | colorDepth:24 23:09:30 INFO - PROCESS | 16578 | Browser inner width/height: 1024/697 23:09:30 INFO - PROCESS | 16578 | __metrics 23:09:31 ERROR - PROCESS | 16578 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:09:32 INFO - TEST-INFO | 16578: exit 0 23:09:32 INFO - Browser initialized. 23:09:32 INFO - Running cycle 1/1 for dromaeo_css test... 23:09:32 INFO - TEST-INFO | started process 16700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFgZ546/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:09:34 INFO - PROCESS | 16700 | 23:09:34 INFO - PROCESS | 16700 | (process:16760): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:09:44 INFO - PROCESS | 16700 | RSS: Main: 165945344 23:09:44 INFO - PROCESS | 16700 | 23:10:33 INFO - PROCESS | 16700 | 1464243033828 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] 23:12:41 INFO - PROCESS | 16700 | Cycle 1(1): loaded http://localhost:44633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44633/tests/dromaeo/cssquery-ext.html) 23:12:42 INFO - PROCESS | 16700 | RSS: Main: 169410560 23:12:42 INFO - PROCESS | 16700 | 23:15:44 INFO - PROCESS | 16700 | Cycle 1(1): loaded http://localhost:44633/tests/dromaeo/cssquery-ext.html (next: http://localhost:44633/tests/dromaeo/cssquery-jquery.html) 23:15:44 INFO - PROCESS | 16700 | RSS: Main: 168931328 23:15:44 INFO - PROCESS | 16700 | 23:18:46 INFO - PROCESS | 16700 | Cycle 1(1): loaded http://localhost:44633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44633/tests/dromaeo/cssquery-mootools.html) 23:18:47 INFO - PROCESS | 16700 | RSS: Main: 170369024 23:18:47 INFO - PROCESS | 16700 | 23:21:49 INFO - PROCESS | 16700 | Cycle 1(1): loaded http://localhost:44633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44633/tests/dromaeo/cssquery-prototype.html) 23:21:49 INFO - PROCESS | 16700 | RSS: Main: 168120320 23:21:49 INFO - PROCESS | 16700 | 23:24:52 INFO - PROCESS | 16700 | Cycle 1(1): loaded http://localhost:44633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44633/tests/dromaeo/cssquery-yui.html) 23:24:52 INFO - PROCESS | 16700 | RSS: Main: 169742336 23:24:52 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | Cycle 1(1): loaded http://localhost:44633/tests/dromaeo/cssquery-yui.html (next: http://localhost:44633/tests/dromaeo/cssquery-dojo.html) 23:27:55 INFO - PROCESS | 16700 | RSS: Main: 171610112 23:27:55 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | __start_tp_report 23:27:55 INFO - PROCESS | 16700 | _x_x_mozilla_page_load 23:27:55 INFO - PROCESS | 16700 | _x_x_mozilla_page_load_details 23:27:55 INFO - PROCESS | 16700 | |i|pagename|runs| 23:27:55 INFO - PROCESS | 16700 | |0;dojo.html;3092.304231547902;3105.146084826671;3134.4671405861;3137.858796354164;3156.589643346366;5340.385855626604;5394.973025134878;5426.968875913583;5429.511343979046;5443.918341224885;5365.195220716894;5411.377691565471;5440.4287549807295;5473.562115030788;5520.861978450541;4871.65898387114;4894.363732714742;4987.476314986929;5022.191772660923;5064.746762661871;820.0361839711527;4812.422509298889;4843.321934929113;4948.183549714293;4997.50024997501;4846.442659094214;4895.36360273164;4902.779374928119;4921;4923.556879880792;4890.633202509791;4901.950980490185;4903.2645103234445;4903.289023091667;4949.851504454872;4784.473707892129;4856.878578035542;4889.6088312935235;4911.140550403665;4939.185034469308;5335.653182543122;5348.705821179834;5351.277577527023;5368.8389348319615;5386.515213630752;5688.146777983295;5895.086261629454;5907.793227237069;5909.2022576951995;5917.970410147922;5818.854528636775;5846.766129354821;5892.175095486636;5909.025010873243;5921.763129474816;5524.254225679562;5539.14143307788;5545.085060964936;5553.805616803433;5555.749991250444;5738.942610573841;5958.85102872423;5975.611585246945;6024.216851809324;6043.8489037773525;5795.681237531892;5825.88348233033;5828.94171058284;5830.41695830422;5881.7647294107755;5868.941310586925;5905.320888097924;5918.082697181943;5927.73325200367;5931.822045338647;5603.691796951125;5737.053386191315;5744.138379243147;5796.739146738407;5812.418758124239;5784.797532086357;5818.650880947157;5819.5053420459735;5820.35976042635;5862.091375836752;4413.668974826901;4426.535213802569;4435.578620031157;4435.733855968652;4442.289233722653;3856.5564960029396;3893.4354518594646;3902.1220225449615;3947.1908258806875;3980.8208630611693;5463.125899856083;5550.86122846924;5593.832185034374;5595.888082238333;5649.293838270216;5918.141869428909;5951.613145145639;5953.315368732651;5955.79154729591;5965.880682386328;5508.91736623943;5535.972320138373;5563.082091454865;5606.962711898312;5686.630369026;5042.193249080129;5048.949510504922;5053.545180933734;5063.594912406998;5068.746562671851;6038.849028774228;6083.387902205919;6092.7562897484495;6092.969535152296;6108.75564977396;5787.305523337226;5848.561357898175;5874.089516125007;5884.440978107073;5948.434898684618;6087;6098.969505152446;6100.847478812888;6101.7559297627595;6107.633541987495;5635.154726791015;5790.536757059509;5792.768289268382;5798.913016304843;5811.79658711943;5788.0739081746715;5823.970880145572;5857.736401861841;5866.178734977021;5890.352061273171;5687.77248910039;5712.143178523254;5739.512141467855;5739.827805165852;5739.8565035874435;5587.7485513152815;5588.748506317144;5708.229389032427;5720.513756330759;5725.2843394575675;5508.44915508446;5562.721863906708;5567.025770490067;5590.077637189818;5624.212610234652;5639.464250896158;5667.886642267049;5671.347795003628;5702.657840529581;5708.4862362387585;5375.650582712111;5540.972295138498;5544.528715059104;5544.805931792529;5557.083081291542 23:27:55 INFO - PROCESS | 16700 | |1;ext.html;570.7631332996807;628.0641843652959;635.5138319185822;648.6400047973378;653.8823011857866;41942;43415.78292108535;43449.34825977613;43465.7826710866;47979;44940;44962.325565116465;45603.31595026069;45621.54378456214;45646;8778.692745753915;9004.954975225115;9005.594748236312;9036.328279268324;9037.231835294007;8825.95587022064;8910.33172512061;8915.821683566357;8943.373963822534;8948.64205431782;8901.332400069989;8937.597808098619;8956.507392093432;8970.551472426385;8983.685571005017;8887.111288871125;8890.244329231991;8936.597853096626;8940.374173807835;8943.195112439911;8776.21014108727;8832.11678832118;8835.558222088934;8847.823043539092;8904.376693631448;43140.35289470661;43158.56841431577;43196.3520547192;43413;43719.344209836876;3077.4460597092516;3382.5433566468705;3557.7509574329806;3626.5648122225502;3899.298126337258;30762.852404643574;30892.382152356826;31331.216719582193;31546.684533154832;31781.52327715086;3987.342088555385;4019.4573732546023;4066.8576599818866;4090.3455447128613;4175.603317684845;298697;302102;302502;305429.9999999978;305748;33910.83044584761;34191.31617367639;34515.482267766005;34687.306253875286;35727.82136089303;36438.27123457516;36812.63187368092;37091.25817483635;37180.07049823776;37214.813925930735;15426.382944682087;15486.690266194613;15508.069515829086;15509.612259693373;15615.765763513557;12717.982561395067;12734.299613521345;12869.163504372373;12906.548270810665;12917.095803293867;8269.09040005599;8279.50322980623;8286.254237118688;8293.33653307734;8404.243618074403;3223.4197844388236;3229.289556297611;3233.3210025894828;3237.271613886857;3249.4638384666737;1081.1891081688734;1097.259349938788;1097.8572785537829;1101.5483651702764;1144.725265936186;31560.938005122815;32520.674793252238;32926;32938.83530582332;33071.834640826644;1091.9890801091888;1132.65454036518;1137.7724455109012;1141.6917432293235;1301.7461594988886;17303.56741081483;17345.47963561095;17370;17398;17452.47642570725;587564;587701;597155;597485;598226;57674;58221;58325.70837145872;58347.70826145927;58466;1368.3773882883265;1378.5726424808342;1379.6755115089427;1397.7274431485966;1420.7087547053036;30534.694653053186;31391.09395932891;32146.67853321437;32194;32336.67663323337;51160.48839511557;51187.488125118274;51188.232176518126;51510.74244628753;51551.742241290056;448239;454886;458913;459330;459699;27644.723552764215;27909.720902790712;28042.43915121727;28135.155945321672;28168.29579260535;47867;48323.75838120928;48598;49472.25791613057;49862.50137498724;41738;42172.789136054125;42234.1553168941;42302.788486057376;42437.15125697407;40962.59037409707;41248.1750364985;41354.829753901344;41620.791896040326;42092.15815683731;40528.59471405248;41740;41787.1642567153;41983.370249445674;42431.151376972906;33591;36583.45124823183;36733.26533469369;37259.627403725615;37320.62679373172;27597.31006724848;28588.857055714587;28930.566041509814;29925.700742993162;30727.2318192047 23:27:55 INFO - PROCESS | 16700 | |2;jquery.html;381.18997131096427;386.23525419669056;389.4508742672832;397.6361629109365;409.82582402478937;18183.636327273463;19301;20092.995350232504;20112.195512179514;20193.293234736786;17805.198766055528;18005.90997045016;18063.548411289725;18793.154308056135;19131.139098740554;5494;5499.50504454599;5578.470045345685;5687.7156142192935;5702.344230413514;5502.944970550283;5546.833594992137;5570.777168913239;5571.387147413781;5575.721213939287;5377.623566350357;5535.723213839292;5557.694326812024;5646.322441307049;5654.9151762723595;5558.110702287615;5561.165825126223;5578.3584887737825;5604.495595396434;5644.7459864306;4859.562639362474;4874.512548745097;4879.463259041502;4883.8779030524165;5034.597232221414;22494.77505224943;22509;22528.43678908024;22788.772112278995;22951.7704822953;2424.696912885889;2471.332740160147;2476.3809047738064;2484.3664865459373;2644.2728249731285;14212.147271163763;14250.572482825532;14293.78559321611;14413.279336033262;14529.564113076625;1932.7100934859743;1981.8216360527479;2001.9899900500404;2002.4493264352275;2020.8787472751535;73691;73813;73883.26116738818;74328.62835685787;74441;9493.857592136124;9537.189338906132;9812.116909478182;10422.322549034288;10590.311629744043;12761.61715148547;12805.743885122432;12831.230126192459;13005.414756335987;13024.869751302365;7981.72063977758;8171.264586187272;8204.179582041748;8331.33349332052;8481.56496618858;8076.959615202004;8259.21537453941;8295.8340833183;8401.83196336082;8434.114417986146;6346.9682651586445;6358.026233603998;6437.774677886251;6460.515461340325;6487.837804054842;1776.7030068050396;1851.5000949743494;1853.2123847364817;1857.9163937622839;1870.2892900697648;939.4410325856105;1043.8695163104612;1083.5286650307141;1132.5526417065214;1137.0903277378065;19179.136938837786;19546.70679939802;19974.201031958848;20065.29771458021;20070.39788806338;1064.6646306413454;1077.3374374759467;1086.4187659602076;1094.8631421072366;1132.750794825137;11006.504707288192;11412.258203216765;11518.193726439236;11548.422578871023;11586.76826463483;378186;380316;383921;500469;511391;94002.529987351;99956;102881;103393.48303258435;103939;1054.7626783973699;1071.2233630617895;1086.0442810326863;1090.4787820989675;1093.1145771924926;17733.46799596014;17912.552186195448;18043;18226.817731822513;18394.26422943121;43050;43274.567254328314;43375.566244337155;44787.328190077824;44897.775511122236;61296.38703612907;63097;63808;63907.36092639014;64158.679206603665;7970.9202907970175;8077.798055048671;8222.342212622856;8265;8349.457285276681;9227.3079519035;12816.935915320364;13298.468061277441;13323.533676321282;13663.453461861414;11489.597864074718;11751.529938802352;11794.705132371759;11860.525578977089;11932.58235961772;11318.151138664798;11526.711832204262;11535.36555489456;11702.648920532398;11889.346085965355;11971.10216733731;12000.879991199976;12278.386080696107;12310.753784924073;12472.251664900135;8211.876821847796;8223.95888020556;8314;8320.334373250005;8351.95824020876;10975.890241097806;12059.939700301442;12067.215630983957;12151.331676757864;12361.320127393079 23:27:55 INFO - PROCESS | 16700 | |3;mootools.html;1507.306638946085;1519.642883922278;1701.8893771904825;1798.343604584327;1823.4073925974062;7855.332296754783;8512.787180320494;8602.569871506415;9186.173244408003;9244.722658320245;8683.088275731052;8768.649254029831;8863.512506812123;8875.644974201025;8993.415427997175;2267.535155293165;2286.931392058241;2291;2301.551197516485;2302.1021801497345;2262.8981695823645;2296.5751336002895;2306.642470417088;2326.0463210083867;2327.697399338092;2248.325502349297;2253.86476811391;2263.6265016272296;2308.053697983827;2311.0293676655847;2225.1766846266823;2254.0645632062838;2257.1535674122206;2264.1509433962265;2265.694131292279;2248.5952528544854;2249.6288112461425;2261.796438320559;2262.423082114067;2272.5114100468477;8814.074522175208;8911.509866957314;8933.330000250007;8957.462552246821;9003;5137.229415587654;5267.315249017642;5288.338957630296;5289.047971365153;5293.86765330866;3137.372525494887;3229.450993331139;3459.377312083824;3462.255615042778;3478.7564870459078;1073.320253802804;1079.169039839327;1093.338530189232;1104.4312179227704;1134.8581427321585;12517.499300027988;12572.622821315375;12624.116311858174;12645.05162112836;12676.366181690972;4270.252705776476;4348.826046958086;4412.823487060482;4425.955740442554;4457.108578284357;10523.368597884151;10551.788964220827;10570;10574;10581.100606448384;4999.375078115236;5056.84829455117;5074.314967479417;5080.77136528857;5180.119379705459;4222.619964203236;4611.423572053493;4651.86044418668;4674.298855171752;4703.85888423341;3859.1316953685196;3884.747491413049;3952.9802350988634;3957.1294315250598;4028.295048366524;1187.7802606517648;1208.6917835951776;1214.9392530373623;1222.1567118688076;1224.0697070226693;941.9623215071457;948.4451595816524;959.2469911119738;970.7912798748162;999.8450240212778;5702.857428564236;5879.882402351929;5904.3210030847;5904.793332233351;5915.40845915405;434.114406610511;445.9509453960062;451.58003057157157;455.20112203083374;458.73851904414164;3989.7007724420782;4062.939055914164;4072.1448495815616;4090.8568200112854;4093.3450647896193;10665.253432259668;11081.058110060574;11159.888401116048;11160.776784464266;11173.888261117447;10987.230893837515;11048.834267485994;11053.613123540637;11056.557737690564;11066.39134847591;8242.546659933641;8295.917040829636;8343.707970221014;8363.623636936352;8425.07324194338;5699.458551437607;5703.173039909273;5773.711314434346;5782.5663075268685;5874.03078492044;9630.181434578139;10175.949120254352;10196.59213631476;10200;10362.792744145225;10180.389176649425;10315.587376504856;10473.057424831803;10485.423301718478;10588.4705764713;7603.429742769204;8362.289205417608;8399.076101628694;8401.663933442594;8574.528400938008;8688.26149777276;8717.782055448664;8746.212840844355;8788.03331633507;8804.295656347605;7665.808354791175;7931.524108553505;7985.2014798522005;8009.639566219417;8020.518768873886;7786.143524212445;7814.609269536614;7883.960580197062;7931.946200712652;7949.7217597383815;7029.5430796998035;7119.537230080028;7225.5664660120565;7244.89132663;7290.781276561712;4918.532739389752;4949.430815456269;4983.5763960063805;4992.775325110451;5004;5087.847364579068;5163.0706472833745;5198.792048318025;5226.608004399762;5307.310049693515 23:27:55 INFO - PROCESS | 16700 | |4;prototype.html;329.1786991456317;329.4448853681547;333.5413806016727;335.3695053299796;336.8496584165078;5658.8019419320335;5686.2039314496005;5711.7715291388295;5730.828075157752;5752.5685573581995;5581.748821303041;5592.5805564582615;5616.943830561693;5631.971840140804;5633.15502674599;4119.299719047762;4194.07072746537;4268.890088576977;4298.935515967263;4319.611234988851;4299.4195783569285;4300.548442413548;4319.913601727963;4346.174226896896;4359.585839345257;4293.849715259967;4342.630876375511;4350.499692535367;4353.825846966118;4363.956360436387;4042.2521833460905;4224.8732538023905;4239;4284.507281662586;4362;3703;3752.418375151856;3756.8121593920196;3759.8496060157563;3777.5655799583124;5380.650257733235;5448.237246785453;5462.344518657746;5462.863428414282;5532.419095994903;4789.2816077588295;4890.657653964224;4924.645722426361;4949.356583644139;4996.4503904570465;5852.531797456236;5854.76580936762;5865.912011319833;5874.853128671774;5883.52931765462;4131.29767939448;4132.8140233689555;4143.875683729493;4154.439150714676;4155.771432571208;5912.467877890967;6156.999999999955;6170.7223174957235;6174.84562885927;6187.226596675416;4209.536950935395;4215.114825886537;4228.894277643083;4248.787560621957;4268.807903644343;4262.936055959163;4289.721168124062;4310.5344182977315;4320.287152619782;4340.717853339523;4818.879528011757;4872.519563829319;4913.410390753061;4939.925901111486;4969.378827646544;5859.363286521083;5862.589618726648;5903;5962.791302304486;6004.279486461653;1461.5822652027516;1465.6335916020994;1468.7796830475513;1489.9942538786277;1496.1920562895914;956.4357029352715;963.5856581669949;975.6243846119295;1004.2969921055291;1009.1775203209361;5638.577106717013;5659.292588426447;5701.486866182064;5731;5761.827145185651;5979.312379076375;5993.643559606547;6028.457438830526;6062.333143354227;6075;5544.69504177266;5680.261565996477;5787.739551720183;5808.244928159397;5842.503387212135;3244.2538216210405;3244.383567122239;3267.8889177679703;3321.853960383664;3326.3181047885128;6147.200863887755;6243.843903902348;6308.810735677937;6428.19647544057;6441.484681225491;6139.649277159018;6142.692865356715;6213.539818142733;6232.719527621268;6233.1273621693;6054.757809687563;6223.319703679981;6309.842253943596;6323.146375239376;6355.775478582459;6062.757489700362;6067.666278354733;6080.422359875804;6103.05402662588;6139.662318572343;6112.694365281629;6114.327423983269;6117.1036978536795;6129.938700612936;6141.324454309933;6011.166594188814;6310.49516038725;6356.696877140268;6356.809295721136;6358.650274234961;4241.97879010603;4252.447856532405;4303.268444364403;4313.762743049162;4317.417148685013;5934.376890426615;6008.459238668541;6130.7241174146375;6225.62646241227;6235.191794379579;5855.189509035602;5900.64596124234;5903.586748927534;5922;5999.100134979613;5939.643621382731;5949.137375080676;5955.40445955401;5964.850878728066;5976.9103463448955;5655.632383895034;5780.710964451845;5815.534757219328;5833.358330583547;5848.853778655568;5962.344142144274;5979.701014949323;6001;6008.8798224036145;6020.849478763066;5688.519596730286;5858.794942177174;5860.531157507304;5863.794767183128;5897.646141231368 23:27:55 INFO - PROCESS | 16700 | |5;yui.html;738.3539403022355;750.9098908131025;780.9808200298615;812.6221307092201;817.235884448041;14621.853781462181;15137.924310378461;15235.466758663435;15680.215989200522;15746.685066298667;14440.061396009252;14468.855311446883;14533.92733036336;14581;14599.343029563668;676.3777324861115;814.9225823546753;820.6881385073664;824.3405275779382;824.7031068815222;803.0724513187278;837.2548431895618;837.2841220756258;838.2497664590188;838.8867502887124;872.3936863879607;875.1423604867234;876.7457437343163;878.0517041595062;881.8015946412038;857.4041041476146;858.9441686290403;859.5745106172453;864.8616221404608;866.6230189867427;630.5869655375736;630.854903372227;631.1416473595906;631.974721011159;632.2223664892163;13431;13575.592732218049;13587.796183057262;13592.66018349549;13594.11638243511;14614.342354593962;14628.561143165616;14752;14758.557243282612;14798.260086995715;11249.493772780244;11368.488418021208;11609.129315301301;11609.780972997798;11617.361045142514;3862.111714305697;3906.335922893115;3922.7254092213557;4006.3790112532606;4070.5318888327924;61110;61292.0806187912;61492;61652;61931.690341548005;11090.778184436427;11360;11464.223045427972;11484.19610627248;11886;20844.687329690067;20957.161713531594;20971.685424718642;20978.475538111365;21000.264990725253;8410.32717382608;8469.491830490191;8640.395172338001;8648.048714641385;8754.387192896436;4745.501722319176;4816.710997340171;4836;4868.172410690191;5015.097282489114;3329.433996220648;3391.9993601887504;3397.6772206640826;3401.8129002904584;3419.401604719164;585.2450339062647;604.1119554255238;610.4018062298971;614.3733391940285;616.211249600512;649.2857856357969;693.6462404173807;755.4598462099625;764.2739397572328;788.9132195458495;9392.765180870532;9680;9812.705618831304;9884.41849304108;9943.950280248553;575.3211210771246;718.5939943931662;757.2805834457288;774.3302043732243;791.6833266693253;4438.423005009328;4522.163399771053;4581.450225972838;4583.495815460296;4608.372889114432;33407.16482087919;33593.496097558556;33657.15857103592;70099.2990070103;70171;54006.18990715143;56796.71601642048;62981.37018629847;63310.0503492448;64169.679151604876;57044;58673.119903201485;59833.70083149643;60321.396786031575;60588.39411605916;9935.552900119657;9956.751081222737;10076.69769906904;10107.241956853119;10243.07812296897;38770.41844372393;39191.41212881866;39225.6077439222;39583.40624890687;39588.2082358357;47767.04465910593;50181.24728129008;50703.23945140752;51267.2309915359;51514.74242628763;12011.039116870805;12112.576059837864;12466.626001219978;12521.812172817597;12680.048996325497;13503.797443038558;13546.59360219195;13783.655408614464;13814.792778108136;14248.71502569922;11624.593139240085;12102.213356131822;12853.228806271654;12950.740985180431;13474.46102155942;12112.939435302767;12520.87479125197;12615.36923153857;12661.683457913627;12666.620001399973;12331.50673973031;12864.22814631125;13360.398782054637;13552.79670804919;13736.725265494435;10531.315464494783;10707.839382409426;11519.712007199887;11584.744034264508;11621.302721836717;11707.88292117068;11708.180427370002;11817.286493458572;11998.460069297078;12055.21641093326 23:27:55 INFO - PROCESS | 16700 | __end_tp_report 23:27:55 INFO - PROCESS | 16700 | __start_cc_report 23:27:55 INFO - PROCESS | 16700 | _x_x_mozilla_cycle_collect,338 23:27:55 INFO - PROCESS | 16700 | __end_cc_report 23:27:55 INFO - PROCESS | 16700 | __startTimestamp1464244075693__endTimestamp 23:27:55 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | ------- Summary: start ------- 23:27:55 INFO - PROCESS | 16700 | Number of tests: 6 23:27:55 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | [#0] dojo.html Cycles:165 Average:5391.53 Median:5603.69 stddev:731.09 (13.0%) stddev-sans-first:710.74 23:27:55 INFO - PROCESS | 16700 | Values: 3092.3 3105.1 3134.5 3137.9 3156.6 5340.4 5395.0 5427.0 5429.5 5443.9 5365.2 5411.4 5440.4 5473.6 5520.9 4871.7 4894.4 4987.5 5022.2 5064.7 820.0 4812.4 4843.3 4948.2 4997.5 4846.4 4895.4 4902.8 4921.0 4923.6 4890.6 4902.0 4903.3 4903.3 4949.9 4784.5 4856.9 4889.6 4911.1 4939.2 5335.7 5348.7 5351.3 5368.8 5386.5 5688.1 5895.1 5907.8 5909.2 5918.0 5818.9 5846.8 5892.2 5909.0 5921.8 5524.3 5539.1 5545.1 5553.8 5555.7 5738.9 5958.9 5975.6 6024.2 6043.8 5795.7 5825.9 5828.9 5830.4 5881.8 5868.9 5905.3 5918.1 5927.7 5931.8 5603.7 5737.1 5744.1 5796.7 5812.4 5784.8 5818.7 5819.5 5820.4 5862.1 4413.7 4426.5 4435.6 4435.7 4442.3 3856.6 3893.4 3902.1 3947.2 3980.8 5463.1 5550.9 5593.8 5595.9 5649.3 5918.1 5951.6 5953.3 5955.8 5965.9 5508.9 5536.0 5563.1 5607.0 5686.6 5042.2 5048.9 5053.5 5063.6 5068.7 6038.8 6083.4 6092.8 6093.0 6108.8 5787.3 5848.6 5874.1 5884.4 5948.4 6087.0 6099.0 6100.8 6101.8 6107.6 5635.2 5790.5 5792.8 5798.9 5811.8 5788.1 5824.0 5857.7 5866.2 5890.4 5687.8 5712.1 5739.5 5739.8 5739.9 5587.7 5588.7 5708.2 5720.5 5725.3 5508.4 5562.7 5567.0 5590.1 5624.2 5639.5 5667.9 5671.3 5702.7 5708.5 5375.7 5541.0 5544.5 5544.8 5557.1 23:27:55 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | [#1] ext.html Cycles:180 Average:59539.41 Median:41105.38 stddev:124398.45 (302.6%) stddev-sans-first:124668.63 23:27:55 INFO - PROCESS | 16700 | Values: 570.8 628.1 635.5 648.6 653.9 41942.0 43415.8 43449.3 43465.8 47979.0 44940.0 44962.3 45603.3 45621.5 45646.0 8778.7 9005.0 9005.6 9036.3 9037.2 8826.0 8910.3 8915.8 8943.4 8948.6 8901.3 8937.6 8956.5 8970.6 8983.7 8887.1 8890.2 8936.6 8940.4 8943.2 8776.2 8832.1 8835.6 8847.8 8904.4 43140.4 43158.6 43196.4 43413.0 43719.3 3077.4 3382.5 3557.8 3626.6 3899.3 30762.9 30892.4 31331.2 31546.7 31781.5 3987.3 4019.5 4066.9 4090.3 4175.6 298697.0 302102.0 302502.0 305430.0 305748.0 33910.8 34191.3 34515.5 34687.3 35727.8 36438.3 36812.6 37091.3 37180.1 37214.8 15426.4 15486.7 15508.1 15509.6 15615.8 12718.0 12734.3 12869.2 12906.5 12917.1 8269.1 8279.5 8286.3 8293.3 8404.2 3223.4 3229.3 3233.3 3237.3 3249.5 1081.2 1097.3 1097.9 1101.5 1144.7 31560.9 32520.7 32926.0 32938.8 33071.8 1092.0 1132.7 1137.8 1141.7 1301.7 17303.6 17345.5 17370.0 17398.0 17452.5 587564.0 587701.0 597155.0 597485.0 598226.0 57674.0 58221.0 58325.7 58347.7 58466.0 1368.4 1378.6 1379.7 1397.7 1420.7 30534.7 31391.1 32146.7 32194.0 32336.7 51160.5 51187.5 51188.2 51510.7 51551.7 448239.0 454886.0 458913.0 459330.0 459699.0 27644.7 27909.7 28042.4 28135.2 28168.3 47867.0 48323.8 48598.0 49472.3 49862.5 41738.0 42172.8 42234.2 42302.8 42437.2 40962.6 41248.2 41354.8 41620.8 42092.2 40528.6 41740.0 41787.2 41983.4 42431.2 33591.0 36583.5 36733.3 37259.6 37320.6 27597.3 28588.9 28930.6 29925.7 30727.2 23:27:55 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | [#2] jquery.html Cycles:180 Average:27677.90 Median:22658.60 stddev:72307.55 (319.1%) stddev-sans-first:72481.35 23:27:55 INFO - PROCESS | 16700 | Values: 381.2 386.2 389.5 397.6 409.8 18183.6 19301.0 20093.0 20112.2 20193.3 17805.2 18005.9 18063.5 18793.2 19131.1 5494.0 5499.5 5578.5 5687.7 5702.3 5502.9 5546.8 5570.8 5571.4 5575.7 5377.6 5535.7 5557.7 5646.3 5654.9 5558.1 5561.2 5578.4 5604.5 5644.7 4859.6 4874.5 4879.5 4883.9 5034.6 22494.8 22509.0 22528.4 22788.8 22951.8 2424.7 2471.3 2476.4 2484.4 2644.3 14212.1 14250.6 14293.8 14413.3 14529.6 1932.7 1981.8 2002.0 2002.4 2020.9 73691.0 73813.0 73883.3 74328.6 74441.0 9493.9 9537.2 9812.1 10422.3 10590.3 12761.6 12805.7 12831.2 13005.4 13024.9 7981.7 8171.3 8204.2 8331.3 8481.6 8077.0 8259.2 8295.8 8401.8 8434.1 6347.0 6358.0 6437.8 6460.5 6487.8 1776.7 1851.5 1853.2 1857.9 1870.3 939.4 1043.9 1083.5 1132.6 1137.1 19179.1 19546.7 19974.2 20065.3 20070.4 1064.7 1077.3 1086.4 1094.9 1132.8 11006.5 11412.3 11518.2 11548.4 11586.8 378186.0 380316.0 383921.0 500469.0 511391.0 94002.5 99956.0 102881.0 103393.5 103939.0 1054.8 1071.2 1086.0 1090.5 1093.1 17733.5 17912.6 18043.0 18226.8 18394.3 43050.0 43274.6 43375.6 44787.3 44897.8 61296.4 63097.0 63808.0 63907.4 64158.7 7970.9 8077.8 8222.3 8265.0 8349.5 9227.3 12816.9 13298.5 13323.5 13663.5 11489.6 11751.5 11794.7 11860.5 11932.6 11318.2 11526.7 11535.4 11702.6 11889.3 11971.1 12000.9 12278.4 12310.8 12472.3 8211.9 8224.0 8314.0 8320.3 8352.0 10975.9 12059.9 12067.2 12151.3 12361.3 23:27:55 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | [#3] mootools.html Cycles:180 Average:5826.67 Median:2451.53 stddev:3408.36 (139.0%) stddev-sans-first:3402.47 23:27:55 INFO - PROCESS | 16700 | Values: 1507.3 1519.6 1701.9 1798.3 1823.4 7855.3 8512.8 8602.6 9186.2 9244.7 8683.1 8768.6 8863.5 8875.6 8993.4 2267.5 2286.9 2291.0 2301.6 2302.1 2262.9 2296.6 2306.6 2326.0 2327.7 2248.3 2253.9 2263.6 2308.1 2311.0 2225.2 2254.1 2257.2 2264.2 2265.7 2248.6 2249.6 2261.8 2262.4 2272.5 8814.1 8911.5 8933.3 8957.5 9003.0 5137.2 5267.3 5288.3 5289.0 5293.9 3137.4 3229.5 3459.4 3462.3 3478.8 1073.3 1079.2 1093.3 1104.4 1134.9 12517.5 12572.6 12624.1 12645.1 12676.4 4270.3 4348.8 4412.8 4426.0 4457.1 10523.4 10551.8 10570.0 10574.0 10581.1 4999.4 5056.8 5074.3 5080.8 5180.1 4222.6 4611.4 4651.9 4674.3 4703.9 3859.1 3884.7 3953.0 3957.1 4028.3 1187.8 1208.7 1214.9 1222.2 1224.1 942.0 948.4 959.2 970.8 999.8 5702.9 5879.9 5904.3 5904.8 5915.4 434.1 446.0 451.6 455.2 458.7 3989.7 4062.9 4072.1 4090.9 4093.3 10665.3 11081.1 11159.9 11160.8 11173.9 10987.2 11048.8 11053.6 11056.6 11066.4 8242.5 8295.9 8343.7 8363.6 8425.1 5699.5 5703.2 5773.7 5782.6 5874.0 9630.2 10175.9 10196.6 10200.0 10362.8 10180.4 10315.6 10473.1 10485.4 10588.5 7603.4 8362.3 8399.1 8401.7 8574.5 8688.3 8717.8 8746.2 8788.0 8804.3 7665.8 7931.5 7985.2 8009.6 8020.5 7786.1 7814.6 7884.0 7931.9 7949.7 7029.5 7119.5 7225.6 7244.9 7290.8 4918.5 4949.4 4983.6 4992.8 5004.0 5087.8 5163.1 5198.8 5226.6 5307.3 23:27:55 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | [#4] prototype.html Cycles:180 Average:4964.68 Median:5706.63 stddev:1489.68 (26.1%) stddev-sans-first:1452.66 23:27:55 INFO - PROCESS | 16700 | Values: 329.2 329.4 333.5 335.4 336.8 5658.8 5686.2 5711.8 5730.8 5752.6 5581.7 5592.6 5616.9 5632.0 5633.2 4119.3 4194.1 4268.9 4298.9 4319.6 4299.4 4300.5 4319.9 4346.2 4359.6 4293.8 4342.6 4350.5 4353.8 4364.0 4042.3 4224.9 4239.0 4284.5 4362.0 3703.0 3752.4 3756.8 3759.8 3777.6 5380.7 5448.2 5462.3 5462.9 5532.4 4789.3 4890.7 4924.6 4949.4 4996.5 5852.5 5854.8 5865.9 5874.9 5883.5 4131.3 4132.8 4143.9 4154.4 4155.8 5912.5 6157.0 6170.7 6174.8 6187.2 4209.5 4215.1 4228.9 4248.8 4268.8 4262.9 4289.7 4310.5 4320.3 4340.7 4818.9 4872.5 4913.4 4939.9 4969.4 5859.4 5862.6 5903.0 5962.8 6004.3 1461.6 1465.6 1468.8 1490.0 1496.2 956.4 963.6 975.6 1004.3 1009.2 5638.6 5659.3 5701.5 5731.0 5761.8 5979.3 5993.6 6028.5 6062.3 6075.0 5544.7 5680.3 5787.7 5808.2 5842.5 3244.3 3244.4 3267.9 3321.9 3326.3 6147.2 6243.8 6308.8 6428.2 6441.5 6139.6 6142.7 6213.5 6232.7 6233.1 6054.8 6223.3 6309.8 6323.1 6355.8 6062.8 6067.7 6080.4 6103.1 6139.7 6112.7 6114.3 6117.1 6129.9 6141.3 6011.2 6310.5 6356.7 6356.8 6358.7 4242.0 4252.4 4303.3 4313.8 4317.4 5934.4 6008.5 6130.7 6225.6 6235.2 5855.2 5900.6 5903.6 5922.0 5999.1 5939.6 5949.1 5955.4 5964.9 5976.9 5655.6 5780.7 5815.5 5833.4 5848.9 5962.3 5979.7 6001.0 6008.9 6020.8 5688.5 5858.8 5860.5 5863.8 5897.6 23:27:55 INFO - PROCESS | 16700 | 23:27:55 INFO - PROCESS | 16700 | [#5] yui.html Cycles:180 Average:15561.14 Median:4254.48 stddev:18260.20 (429.2%) stddev-sans-first:18277.49 23:27:55 INFO - PROCESS | 16700 | Values: 738.4 750.9 781.0 812.6 817.2 14621.9 15137.9 15235.5 15680.2 15746.7 14440.1 14468.9 14533.9 14581.0 14599.3 676.4 814.9 820.7 824.3 824.7 803.1 837.3 837.3 838.2 838.9 872.4 875.1 876.7 878.1 881.8 857.4 858.9 859.6 864.9 866.6 630.6 630.9 631.1 632.0 632.2 13431.0 13575.6 13587.8 13592.7 13594.1 14614.3 14628.6 14752.0 14758.6 14798.3 11249.5 11368.5 11609.1 11609.8 11617.4 3862.1 3906.3 3922.7 4006.4 4070.5 61110.0 61292.1 61492.0 61652.0 61931.7 11090.8 11360.0 11464.2 11484.2 11886.0 20844.7 20957.2 20971.7 20978.5 21000.3 8410.3 8469.5 8640.4 8648.0 8754.4 4745.5 4816.7 4836.0 4868.2 5015.1 3329.4 3392.0 3397.7 3401.8 3419.4 585.2 604.1 610.4 614.4 616.2 649.3 693.6 755.5 764.3 788.9 9392.8 9680.0 9812.7 9884.4 9944.0 575.3 718.6 757.3 774.3 791.7 4438.4 4522.2 4581.5 4583.5 4608.4 33407.2 33593.5 33657.2 70099.3 70171.0 54006.2 56796.7 62981.4 63310.1 64169.7 57044.0 58673.1 59833.7 60321.4 60588.4 9935.6 9956.8 10076.7 10107.2 10243.1 38770.4 39191.4 39225.6 39583.4 39588.2 47767.0 50181.2 50703.2 51267.2 51514.7 12011.0 12112.6 12466.6 12521.8 12680.0 13503.8 13546.6 13783.7 13814.8 14248.7 11624.6 12102.2 12853.2 12950.7 13474.5 12112.9 12520.9 12615.4 12661.7 12666.6 12331.5 12864.2 13360.4 13552.8 13736.7 10531.3 10707.8 11519.7 11584.7 11621.3 11707.9 11708.2 11817.3 11998.5 12055.2 23:27:55 INFO - PROCESS | 16700 | -------- Summary: end -------- 23:27:55 INFO - PROCESS | 16700 | 23:27:56 INFO - TEST-INFO | 16700: exit 0 23:27:56 INFO - TEST-OK | dromaeo_css | took 1109990ms 23:27:56 INFO - TEST-START | kraken 23:27:56 INFO - operating with platform_type : linux_ 23:27:56 INFO - Initialising browser for kraken test... 23:27:56 INFO - TEST-INFO | started process 16938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBXVeFA/profile http://localhost:44633/getInfo.html) 23:28:00 INFO - PROCESS | 16938 | 23:28:00 INFO - PROCESS | 16938 | (process:17006): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:00 INFO - PROCESS | 16938 | __metrics Screen width/height:1600/1200 23:28:00 INFO - PROCESS | 16938 | colorDepth:24 23:28:00 INFO - PROCESS | 16938 | Browser inner width/height: 1024/697 23:28:00 INFO - PROCESS | 16938 | __metrics 23:28:01 ERROR - PROCESS | 16938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:28:02 INFO - TEST-INFO | 16938: exit 0 23:28:02 INFO - Browser initialized. 23:28:02 INFO - Running cycle 1/1 for kraken test... 23:28:02 INFO - TEST-INFO | started process 17058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBXVeFA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:04 INFO - PROCESS | 17058 | 23:28:04 INFO - PROCESS | 17058 | (process:17122): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:14 INFO - PROCESS | 17058 | RSS: Main: 166121472 23:28:14 INFO - PROCESS | 17058 | 23:28:16 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44633/tests/kraken/driver.html?testName=audio-beat-detection) 23:28:17 INFO - PROCESS | 17058 | RSS: Main: 171249664 23:28:17 INFO - PROCESS | 17058 | 23:28:20 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44633/tests/kraken/driver.html?testName=audio-dft) 23:28:20 INFO - PROCESS | 17058 | RSS: Main: 171630592 23:28:20 INFO - PROCESS | 17058 | 23:28:23 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44633/tests/kraken/driver.html?testName=audio-fft) 23:28:24 INFO - PROCESS | 17058 | RSS: Main: 165781504 23:28:24 INFO - PROCESS | 17058 | 23:28:26 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44633/tests/kraken/driver.html?testName=audio-oscillator) 23:28:27 INFO - PROCESS | 17058 | RSS: Main: 165863424 23:28:27 INFO - PROCESS | 17058 | 23:28:29 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:28:29 INFO - PROCESS | 17058 | RSS: Main: 166223872 23:28:29 INFO - PROCESS | 17058 | 23:28:32 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44633/tests/kraken/driver.html?testName=imaging-darkroom) 23:28:33 INFO - PROCESS | 17058 | RSS: Main: 166412288 23:28:33 INFO - PROCESS | 17058 | 23:28:36 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44633/tests/kraken/driver.html?testName=imaging-desaturate) 23:28:37 INFO - PROCESS | 17058 | RSS: Main: 166387712 23:28:37 INFO - PROCESS | 17058 | 23:28:40 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44633/tests/kraken/driver.html?testName=json-parse-financial) 23:28:41 INFO - PROCESS | 17058 | RSS: Main: 166449152 23:28:41 INFO - PROCESS | 17058 | 23:28:42 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:28:43 INFO - PROCESS | 17058 | RSS: Main: 166875136 23:28:43 INFO - PROCESS | 17058 | 23:28:44 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44633/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:28:45 INFO - PROCESS | 17058 | RSS: Main: 167104512 23:28:45 INFO - PROCESS | 17058 | 23:28:47 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:28:48 INFO - PROCESS | 17058 | RSS: Main: 167464960 23:28:48 INFO - PROCESS | 17058 | 23:28:50 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:28:51 INFO - PROCESS | 17058 | RSS: Main: 167288832 23:28:51 INFO - PROCESS | 17058 | 23:28:54 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:28:54 INFO - PROCESS | 17058 | RSS: Main: 167002112 23:28:54 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | Cycle 1(1): loaded http://localhost:44633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44633/tests/kraken/driver.html?testName=ai-astar) 23:28:56 INFO - PROCESS | 17058 | RSS: Main: 168771584 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | __start_tp_report 23:28:56 INFO - PROCESS | 17058 | _x_x_mozilla_page_load 23:28:56 INFO - PROCESS | 17058 | _x_x_mozilla_page_load_details 23:28:56 INFO - PROCESS | 17058 | |i|pagename|runs| 23:28:56 INFO - PROCESS | 17058 | |0;ai-astar;114;104;111;110;111;111;111;112;111;111 23:28:56 INFO - PROCESS | 17058 | |1;audio-beat-detection;151;135;155;189;130;165;154;125;187;127 23:28:56 INFO - PROCESS | 17058 | |2;audio-dft;162;160;163;160;161;162;176;162;163;162 23:28:56 INFO - PROCESS | 17058 | |3;audio-fft;76;74;75;163;77;76;76;75;178;76 23:28:56 INFO - PROCESS | 17058 | |4;audio-oscillator;84;82;150;84;81;83;141;82;82;148 23:28:56 INFO - PROCESS | 17058 | |5;imaging-gaussian-blur;118;118;117;116;117;117;117;118;117;118 23:28:56 INFO - PROCESS | 17058 | |6;imaging-darkroom;147;147;147;147;147;148;148;147;148;146 23:28:56 INFO - PROCESS | 17058 | |7;imaging-desaturate;95;95;96;95;96;100;95;99;95;95 23:28:56 INFO - PROCESS | 17058 | |8;json-parse-financial;54;55;58;55;56;56;54;70;55;52 23:28:56 INFO - PROCESS | 17058 | |9;json-stringify-tinderbox;61;63;62;61;61;61;61;61;61;61 23:28:56 INFO - PROCESS | 17058 | |10;stanford-crypto-aes;78;80;83;81;79;98;83;80;81;81 23:28:56 INFO - PROCESS | 17058 | |11;stanford-crypto-ccm;127;122;122;129;128;135;121;130;166;127 23:28:56 INFO - PROCESS | 17058 | |12;stanford-crypto-pbkdf2;160;164;166;161;161;160;161;161;164;164 23:28:56 INFO - PROCESS | 17058 | |13;stanford-crypto-sha256-iterative;65;63;65;63;63;65;62;66;61;62 23:28:56 INFO - PROCESS | 17058 | __end_tp_report 23:28:56 INFO - PROCESS | 17058 | __start_cc_report 23:28:56 INFO - PROCESS | 17058 | _x_x_mozilla_cycle_collect,865 23:28:56 INFO - PROCESS | 17058 | __end_cc_report 23:28:56 INFO - PROCESS | 17058 | __startTimestamp1464244136804__endTimestamp 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | ------- Summary: start ------- 23:28:56 INFO - PROCESS | 17058 | Number of tests: 14 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.55 (2.3%) stddev-sans-first:2.39 23:28:56 INFO - PROCESS | 17058 | Values: 114.0 104.0 111.0 110.0 111.0 111.0 111.0 112.0 111.0 111.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:154.50 stddev:23.34 (15.1%) stddev-sans-first:24.76 23:28:56 INFO - PROCESS | 17058 | Values: 151.0 135.0 155.0 189.0 130.0 165.0 154.0 125.0 187.0 127.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.00 stddev:4.65 (2.9%) stddev-sans-first:4.92 23:28:56 INFO - PROCESS | 17058 | Values: 162.0 160.0 163.0 160.0 161.0 162.0 176.0 162.0 163.0 162.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:40.17 (52.9%) stddev-sans-first:42.04 23:28:56 INFO - PROCESS | 17058 | Values: 76.0 74.0 75.0 163.0 77.0 76.0 76.0 75.0 178.0 76.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:82.00 stddev:30.89 (37.7%) stddev-sans-first:32.10 23:28:56 INFO - PROCESS | 17058 | Values: 84.0 82.0 150.0 84.0 81.0 83.0 141.0 82.0 82.0 148.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 23:28:56 INFO - PROCESS | 17058 | Values: 118.0 118.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 118.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 23:28:56 INFO - PROCESS | 17058 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 148.0 146.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:1.85 (2.0%) stddev-sans-first:1.92 23:28:56 INFO - PROCESS | 17058 | Values: 95.0 95.0 96.0 95.0 96.0 100.0 95.0 99.0 95.0 95.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.50 stddev:4.99 (9.0%) stddev-sans-first:5.21 23:28:56 INFO - PROCESS | 17058 | Values: 54.0 55.0 58.0 55.0 56.0 56.0 54.0 70.0 55.0 52.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 23:28:56 INFO - PROCESS | 17058 | Values: 61.0 63.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.00 stddev:5.70 (7.0%) stddev-sans-first:5.82 23:28:56 INFO - PROCESS | 17058 | Values: 78.0 80.0 83.0 81.0 79.0 98.0 83.0 80.0 81.0 81.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:128.50 stddev:13.12 (10.2%) stddev-sans-first:13.84 23:28:56 INFO - PROCESS | 17058 | Values: 127.0 122.0 122.0 129.0 128.0 135.0 121.0 130.0 166.0 127.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.50 stddev:2.10 (1.3%) stddev-sans-first:2.07 23:28:56 INFO - PROCESS | 17058 | Values: 160.0 164.0 166.0 161.0 161.0 160.0 161.0 161.0 164.0 164.0 23:28:56 INFO - PROCESS | 17058 | 23:28:56 INFO - PROCESS | 17058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.65 (2.6%) stddev-sans-first:1.66 23:28:56 INFO - PROCESS | 17058 | Values: 65.0 63.0 65.0 63.0 63.0 65.0 62.0 66.0 61.0 62.0 23:28:56 INFO - PROCESS | 17058 | -------- Summary: end -------- 23:28:56 INFO - PROCESS | 17058 | 23:28:57 INFO - TEST-INFO | 17058: exit 0 23:28:57 INFO - TEST-OK | kraken | took 61354ms 23:28:57 INFO - SUITE-END | took 1171s 23:28:57 INFO - Completed test suite (00:19:31) 23:28:57 INFO - javascript benchmark 23:28:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7149.325528015585, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.304231547902, 3105.146084826671, 3134.4671405861, 3137.858796354164, 3156.589643346366, 5340.385855626604, 5394.973025134878, 5426.968875913583, 5429.511343979046, 5443.918341224885, 5365.195220716894, 5411.377691565471, 5440.4287549807295, 5473.562115030788, 5520.861978450541, 4871.65898387114, 4894.363732714742, 4987.476314986929, 5022.191772660923, 5064.746762661871, 820.0361839711527, 4812.422509298889, 4843.321934929113, 4948.183549714293, 4997.50024997501, 4846.442659094214, 4895.36360273164, 4902.779374928119, 4921.0, 4923.556879880792, 4890.633202509791, 4901.950980490185, 4903.2645103234445, 4903.289023091667, 4949.851504454872, 4784.473707892129, 4856.878578035542, 4889.6088312935235, 4911.140550403665, 4939.185034469308, 5335.653182543122, 5348.705821179834, 5351.277577527023, 5368.8389348319615, 5386.515213630752, 5688.146777983295, 5895.086261629454, 5907.793227237069, 5909.2022576951995, 5917.970410147922, 5818.854528636775, 5846.766129354821, 5892.175095486636, 5909.025010873243, 5921.763129474816, 5524.254225679562, 5539.14143307788, 5545.085060964936, 5553.805616803433, 5555.749991250444, 5738.942610573841, 5958.85102872423, 5975.611585246945, 6024.216851809324, 6043.8489037773525, 5795.681237531892, 5825.88348233033, 5828.94171058284, 5830.41695830422, 5881.7647294107755, 5868.941310586925, 5905.320888097924, 5918.082697181943, 5927.73325200367, 5931.822045338647, 5603.691796951125, 5737.053386191315, 5744.138379243147, 5796.739146738407, 5812.418758124239, 5784.797532086357, 5818.650880947157, 5819.5053420459735, 5820.35976042635, 5862.091375836752, 4413.668974826901, 4426.535213802569, 4435.578620031157, 4435.733855968652, 4442.289233722653, 3856.5564960029396, 3893.4354518594646, 3902.1220225449615, 3947.1908258806875, 3980.8208630611693, 5463.125899856083, 5550.86122846924, 5593.832185034374, 5595.888082238333, 5649.293838270216, 5918.141869428909, 5951.613145145639, 5953.315368732651, 5955.79154729591, 5965.880682386328, 5508.91736623943, 5535.972320138373, 5563.082091454865, 5606.962711898312, 5686.630369026, 5042.193249080129, 5048.949510504922, 5053.545180933734, 5063.594912406998, 5068.746562671851, 6038.849028774228, 6083.387902205919, 6092.7562897484495, 6092.969535152296, 6108.75564977396, 5787.305523337226, 5848.561357898175, 5874.089516125007, 5884.440978107073, 5948.434898684618, 6087.0, 6098.969505152446, 6100.847478812888, 6101.7559297627595, 6107.633541987495, 5635.154726791015, 5790.536757059509, 5792.768289268382, 5798.913016304843, 5811.79658711943, 5788.0739081746715, 5823.970880145572, 5857.736401861841, 5866.178734977021, 5890.352061273171, 5687.77248910039, 5712.143178523254, 5739.512141467855, 5739.827805165852, 5739.8565035874435, 5587.7485513152815, 5588.748506317144, 5708.229389032427, 5720.513756330759, 5725.2843394575675, 5508.44915508446, 5562.721863906708, 5567.025770490067, 5590.077637189818, 5624.212610234652, 5639.464250896158, 5667.886642267049, 5671.347795003628, 5702.657840529581, 5708.4862362387585, 5375.650582712111, 5540.972295138498, 5544.528715059104, 5544.805931792529, 5557.083081291542], "value": 5341.958846904381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7631332996807, 628.0641843652959, 635.5138319185822, 648.6400047973378, 653.8823011857866, 41942.0, 43415.78292108535, 43449.34825977613, 43465.7826710866, 47979.0, 44940.0, 44962.325565116465, 45603.31595026069, 45621.54378456214, 45646.0, 8778.692745753915, 9004.954975225115, 9005.594748236312, 9036.328279268324, 9037.231835294007, 8825.95587022064, 8910.33172512061, 8915.821683566357, 8943.373963822534, 8948.64205431782, 8901.332400069989, 8937.597808098619, 8956.507392093432, 8970.551472426385, 8983.685571005017, 8887.111288871125, 8890.244329231991, 8936.597853096626, 8940.374173807835, 8943.195112439911, 8776.21014108727, 8832.11678832118, 8835.558222088934, 8847.823043539092, 8904.376693631448, 43140.35289470661, 43158.56841431577, 43196.3520547192, 43413.0, 43719.344209836876, 3077.4460597092516, 3382.5433566468705, 3557.7509574329806, 3626.5648122225502, 3899.298126337258, 30762.852404643574, 30892.382152356826, 31331.216719582193, 31546.684533154832, 31781.52327715086, 3987.342088555385, 4019.4573732546023, 4066.8576599818866, 4090.3455447128613, 4175.603317684845, 298697.0, 302102.0, 302502.0, 305429.9999999978, 305748.0, 33910.83044584761, 34191.31617367639, 34515.482267766005, 34687.306253875286, 35727.82136089303, 36438.27123457516, 36812.63187368092, 37091.25817483635, 37180.07049823776, 37214.813925930735, 15426.382944682087, 15486.690266194613, 15508.069515829086, 15509.612259693373, 15615.765763513557, 12717.982561395067, 12734.299613521345, 12869.163504372373, 12906.548270810665, 12917.095803293867, 8269.09040005599, 8279.50322980623, 8286.254237118688, 8293.33653307734, 8404.243618074403, 3223.4197844388236, 3229.289556297611, 3233.3210025894828, 3237.271613886857, 3249.4638384666737, 1081.1891081688734, 1097.259349938788, 1097.8572785537829, 1101.5483651702764, 1144.725265936186, 31560.938005122815, 32520.674793252238, 32926.0, 32938.83530582332, 33071.834640826644, 1091.9890801091888, 1132.65454036518, 1137.7724455109012, 1141.6917432293235, 1301.7461594988886, 17303.56741081483, 17345.47963561095, 17370.0, 17398.0, 17452.47642570725, 587564.0, 587701.0, 597155.0, 597485.0, 598226.0, 57674.0, 58221.0, 58325.70837145872, 58347.70826145927, 58466.0, 1368.3773882883265, 1378.5726424808342, 1379.6755115089427, 1397.7274431485966, 1420.7087547053036, 30534.694653053186, 31391.09395932891, 32146.67853321437, 32194.0, 32336.67663323337, 51160.48839511557, 51187.488125118274, 51188.232176518126, 51510.74244628753, 51551.742241290056, 448239.0, 454886.0, 458913.0, 459330.0, 459699.0, 27644.723552764215, 27909.720902790712, 28042.43915121727, 28135.155945321672, 28168.29579260535, 47867.0, 48323.75838120928, 48598.0, 49472.25791613057, 49862.50137498724, 41738.0, 42172.789136054125, 42234.1553168941, 42302.788486057376, 42437.15125697407, 40962.59037409707, 41248.1750364985, 41354.829753901344, 41620.791896040326, 42092.15815683731, 40528.59471405248, 41740.0, 41787.1642567153, 41983.370249445674, 42431.151376972906, 33591.0, 36583.45124823183, 36733.26533469369, 37259.627403725615, 37320.62679373172, 27597.31006724848, 28588.857055714587, 28930.566041509814, 29925.700742993162, 30727.2318192047], "value": 18824.03378251839, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.18997131096427, 386.23525419669056, 389.4508742672832, 397.6361629109365, 409.82582402478937, 18183.636327273463, 19301.0, 20092.995350232504, 20112.195512179514, 20193.293234736786, 17805.198766055528, 18005.90997045016, 18063.548411289725, 18793.154308056135, 19131.139098740554, 5494.0, 5499.50504454599, 5578.470045345685, 5687.7156142192935, 5702.344230413514, 5502.944970550283, 5546.833594992137, 5570.777168913239, 5571.387147413781, 5575.721213939287, 5377.623566350357, 5535.723213839292, 5557.694326812024, 5646.322441307049, 5654.9151762723595, 5558.110702287615, 5561.165825126223, 5578.3584887737825, 5604.495595396434, 5644.7459864306, 4859.562639362474, 4874.512548745097, 4879.463259041502, 4883.8779030524165, 5034.597232221414, 22494.77505224943, 22509.0, 22528.43678908024, 22788.772112278995, 22951.7704822953, 2424.696912885889, 2471.332740160147, 2476.3809047738064, 2484.3664865459373, 2644.2728249731285, 14212.147271163763, 14250.572482825532, 14293.78559321611, 14413.279336033262, 14529.564113076625, 1932.7100934859743, 1981.8216360527479, 2001.9899900500404, 2002.4493264352275, 2020.8787472751535, 73691.0, 73813.0, 73883.26116738818, 74328.62835685787, 74441.0, 9493.857592136124, 9537.189338906132, 9812.116909478182, 10422.322549034288, 10590.311629744043, 12761.61715148547, 12805.743885122432, 12831.230126192459, 13005.414756335987, 13024.869751302365, 7981.72063977758, 8171.264586187272, 8204.179582041748, 8331.33349332052, 8481.56496618858, 8076.959615202004, 8259.21537453941, 8295.8340833183, 8401.83196336082, 8434.114417986146, 6346.9682651586445, 6358.026233603998, 6437.774677886251, 6460.515461340325, 6487.837804054842, 1776.7030068050396, 1851.5000949743494, 1853.2123847364817, 1857.9163937622839, 1870.2892900697648, 939.4410325856105, 1043.8695163104612, 1083.5286650307141, 1132.5526417065214, 1137.0903277378065, 19179.136938837786, 19546.70679939802, 19974.201031958848, 20065.29771458021, 20070.39788806338, 1064.6646306413454, 1077.3374374759467, 1086.4187659602076, 1094.8631421072366, 1132.750794825137, 11006.504707288192, 11412.258203216765, 11518.193726439236, 11548.422578871023, 11586.76826463483, 378186.0, 380316.0, 383921.0, 500469.0, 511391.0, 94002.529987351, 99956.0, 102881.0, 103393.48303258435, 103939.0, 1054.7626783973699, 1071.2233630617895, 1086.0442810326863, 1090.4787820989675, 1093.1145771924926, 17733.46799596014, 17912.552186195448, 18043.0, 18226.817731822513, 18394.26422943121, 43050.0, 43274.567254328314, 43375.566244337155, 44787.328190077824, 44897.775511122236, 61296.38703612907, 63097.0, 63808.0, 63907.36092639014, 64158.679206603665, 7970.9202907970175, 8077.798055048671, 8222.342212622856, 8265.0, 8349.457285276681, 9227.3079519035, 12816.935915320364, 13298.468061277441, 13323.533676321282, 13663.453461861414, 11489.597864074718, 11751.529938802352, 11794.705132371759, 11860.525578977089, 11932.58235961772, 11318.151138664798, 11526.711832204262, 11535.36555489456, 11702.648920532398, 11889.346085965355, 11971.10216733731, 12000.879991199976, 12278.386080696107, 12310.753784924073, 12472.251664900135, 8211.876821847796, 8223.95888020556, 8314.0, 8320.334373250005, 8351.95824020876, 10975.890241097806, 12059.939700301442, 12067.215630983957, 12151.331676757864, 12361.320127393079], "value": 9341.940025992179, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.306638946085, 1519.642883922278, 1701.8893771904825, 1798.343604584327, 1823.4073925974062, 7855.332296754783, 8512.787180320494, 8602.569871506415, 9186.173244408003, 9244.722658320245, 8683.088275731052, 8768.649254029831, 8863.512506812123, 8875.644974201025, 8993.415427997175, 2267.535155293165, 2286.931392058241, 2291.0, 2301.551197516485, 2302.1021801497345, 2262.8981695823645, 2296.5751336002895, 2306.642470417088, 2326.0463210083867, 2327.697399338092, 2248.325502349297, 2253.86476811391, 2263.6265016272296, 2308.053697983827, 2311.0293676655847, 2225.1766846266823, 2254.0645632062838, 2257.1535674122206, 2264.1509433962265, 2265.694131292279, 2248.5952528544854, 2249.6288112461425, 2261.796438320559, 2262.423082114067, 2272.5114100468477, 8814.074522175208, 8911.509866957314, 8933.330000250007, 8957.462552246821, 9003.0, 5137.229415587654, 5267.315249017642, 5288.338957630296, 5289.047971365153, 5293.86765330866, 3137.372525494887, 3229.450993331139, 3459.377312083824, 3462.255615042778, 3478.7564870459078, 1073.320253802804, 1079.169039839327, 1093.338530189232, 1104.4312179227704, 1134.8581427321585, 12517.499300027988, 12572.622821315375, 12624.116311858174, 12645.05162112836, 12676.366181690972, 4270.252705776476, 4348.826046958086, 4412.823487060482, 4425.955740442554, 4457.108578284357, 10523.368597884151, 10551.788964220827, 10570.0, 10574.0, 10581.100606448384, 4999.375078115236, 5056.84829455117, 5074.314967479417, 5080.77136528857, 5180.119379705459, 4222.619964203236, 4611.423572053493, 4651.86044418668, 4674.298855171752, 4703.85888423341, 3859.1316953685196, 3884.747491413049, 3952.9802350988634, 3957.1294315250598, 4028.295048366524, 1187.7802606517648, 1208.6917835951776, 1214.9392530373623, 1222.1567118688076, 1224.0697070226693, 941.9623215071457, 948.4451595816524, 959.2469911119738, 970.7912798748162, 999.8450240212778, 5702.857428564236, 5879.882402351929, 5904.3210030847, 5904.793332233351, 5915.40845915405, 434.114406610511, 445.9509453960062, 451.58003057157157, 455.20112203083374, 458.73851904414164, 3989.7007724420782, 4062.939055914164, 4072.1448495815616, 4090.8568200112854, 4093.3450647896193, 10665.253432259668, 11081.058110060574, 11159.888401116048, 11160.776784464266, 11173.888261117447, 10987.230893837515, 11048.834267485994, 11053.613123540637, 11056.557737690564, 11066.39134847591, 8242.546659933641, 8295.917040829636, 8343.707970221014, 8363.623636936352, 8425.07324194338, 5699.458551437607, 5703.173039909273, 5773.711314434346, 5782.5663075268685, 5874.03078492044, 9630.181434578139, 10175.949120254352, 10196.59213631476, 10200.0, 10362.792744145225, 10180.389176649425, 10315.587376504856, 10473.057424831803, 10485.423301718478, 10588.4705764713, 7603.429742769204, 8362.289205417608, 8399.076101628694, 8401.663933442594, 8574.528400938008, 8688.26149777276, 8717.782055448664, 8746.212840844355, 8788.03331633507, 8804.295656347605, 7665.808354791175, 7931.524108553505, 7985.2014798522005, 8009.639566219417, 8020.518768873886, 7786.143524212445, 7814.609269536614, 7883.960580197062, 7931.946200712652, 7949.7217597383815, 7029.5430796998035, 7119.537230080028, 7225.5664660120565, 7244.89132663, 7290.781276561712, 4918.532739389752, 4949.430815456269, 4983.5763960063805, 4992.775325110451, 5004.0, 5087.847364579068, 5163.0706472833745, 5198.792048318025, 5226.608004399762, 5307.310049693515], "value": 4544.40108702438, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1786991456317, 329.4448853681547, 333.5413806016727, 335.3695053299796, 336.8496584165078, 5658.8019419320335, 5686.2039314496005, 5711.7715291388295, 5730.828075157752, 5752.5685573581995, 5581.748821303041, 5592.5805564582615, 5616.943830561693, 5631.971840140804, 5633.15502674599, 4119.299719047762, 4194.07072746537, 4268.890088576977, 4298.935515967263, 4319.611234988851, 4299.4195783569285, 4300.548442413548, 4319.913601727963, 4346.174226896896, 4359.585839345257, 4293.849715259967, 4342.630876375511, 4350.499692535367, 4353.825846966118, 4363.956360436387, 4042.2521833460905, 4224.8732538023905, 4239.0, 4284.507281662586, 4362.0, 3703.0, 3752.418375151856, 3756.8121593920196, 3759.8496060157563, 3777.5655799583124, 5380.650257733235, 5448.237246785453, 5462.344518657746, 5462.863428414282, 5532.419095994903, 4789.2816077588295, 4890.657653964224, 4924.645722426361, 4949.356583644139, 4996.4503904570465, 5852.531797456236, 5854.76580936762, 5865.912011319833, 5874.853128671774, 5883.52931765462, 4131.29767939448, 4132.8140233689555, 4143.875683729493, 4154.439150714676, 4155.771432571208, 5912.467877890967, 6156.999999999955, 6170.7223174957235, 6174.84562885927, 6187.226596675416, 4209.536950935395, 4215.114825886537, 4228.894277643083, 4248.787560621957, 4268.807903644343, 4262.936055959163, 4289.721168124062, 4310.5344182977315, 4320.287152619782, 4340.717853339523, 4818.879528011757, 4872.519563829319, 4913.410390753061, 4939.925901111486, 4969.378827646544, 5859.363286521083, 5862.589618726648, 5903.0, 5962.791302304486, 6004.279486461653, 1461.5822652027516, 1465.6335916020994, 1468.7796830475513, 1489.9942538786277, 1496.1920562895914, 956.4357029352715, 963.5856581669949, 975.6243846119295, 1004.2969921055291, 1009.1775203209361, 5638.577106717013, 5659.292588426447, 5701.486866182064, 5731.0, 5761.827145185651, 5979.312379076375, 5993.643559606547, 6028.457438830526, 6062.333143354227, 6075.0, 5544.69504177266, 5680.261565996477, 5787.739551720183, 5808.244928159397, 5842.503387212135, 3244.2538216210405, 3244.383567122239, 3267.8889177679703, 3321.853960383664, 3326.3181047885128, 6147.200863887755, 6243.843903902348, 6308.810735677937, 6428.19647544057, 6441.484681225491, 6139.649277159018, 6142.692865356715, 6213.539818142733, 6232.719527621268, 6233.1273621693, 6054.757809687563, 6223.319703679981, 6309.842253943596, 6323.146375239376, 6355.775478582459, 6062.757489700362, 6067.666278354733, 6080.422359875804, 6103.05402662588, 6139.662318572343, 6112.694365281629, 6114.327423983269, 6117.1036978536795, 6129.938700612936, 6141.324454309933, 6011.166594188814, 6310.49516038725, 6356.696877140268, 6356.809295721136, 6358.650274234961, 4241.97879010603, 4252.447856532405, 4303.268444364403, 4313.762743049162, 4317.417148685013, 5934.376890426615, 6008.459238668541, 6130.7241174146375, 6225.62646241227, 6235.191794379579, 5855.189509035602, 5900.64596124234, 5903.586748927534, 5922.0, 5999.100134979613, 5939.643621382731, 5949.137375080676, 5955.40445955401, 5964.850878728066, 5976.9103463448955, 5655.632383895034, 5780.710964451845, 5815.534757219328, 5833.358330583547, 5848.853778655568, 5962.344142144274, 5979.701014949323, 6001.0, 6008.8798224036145, 6020.849478763066, 5688.519596730286, 5858.794942177174, 5860.531157507304, 5863.794767183128, 5897.646141231368], "value": 4482.547203743394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.3539403022355, 750.9098908131025, 780.9808200298615, 812.6221307092201, 817.235884448041, 14621.853781462181, 15137.924310378461, 15235.466758663435, 15680.215989200522, 15746.685066298667, 14440.061396009252, 14468.855311446883, 14533.92733036336, 14581.0, 14599.343029563668, 676.3777324861115, 814.9225823546753, 820.6881385073664, 824.3405275779382, 824.7031068815222, 803.0724513187278, 837.2548431895618, 837.2841220756258, 838.2497664590188, 838.8867502887124, 872.3936863879607, 875.1423604867234, 876.7457437343163, 878.0517041595062, 881.8015946412038, 857.4041041476146, 858.9441686290403, 859.5745106172453, 864.8616221404608, 866.6230189867427, 630.5869655375736, 630.854903372227, 631.1416473595906, 631.974721011159, 632.2223664892163, 13431.0, 13575.592732218049, 13587.796183057262, 13592.66018349549, 13594.11638243511, 14614.342354593962, 14628.561143165616, 14752.0, 14758.557243282612, 14798.260086995715, 11249.493772780244, 11368.488418021208, 11609.129315301301, 11609.780972997798, 11617.361045142514, 3862.111714305697, 3906.335922893115, 3922.7254092213557, 4006.3790112532606, 4070.5318888327924, 61110.0, 61292.0806187912, 61492.0, 61652.0, 61931.690341548005, 11090.778184436427, 11360.0, 11464.223045427972, 11484.19610627248, 11886.0, 20844.687329690067, 20957.161713531594, 20971.685424718642, 20978.475538111365, 21000.264990725253, 8410.32717382608, 8469.491830490191, 8640.395172338001, 8648.048714641385, 8754.387192896436, 4745.501722319176, 4816.710997340171, 4836.0, 4868.172410690191, 5015.097282489114, 3329.433996220648, 3391.9993601887504, 3397.6772206640826, 3401.8129002904584, 3419.401604719164, 585.2450339062647, 604.1119554255238, 610.4018062298971, 614.3733391940285, 616.211249600512, 649.2857856357969, 693.6462404173807, 755.4598462099625, 764.2739397572328, 788.9132195458495, 9392.765180870532, 9680.0, 9812.705618831304, 9884.41849304108, 9943.950280248553, 575.3211210771246, 718.5939943931662, 757.2805834457288, 774.3302043732243, 791.6833266693253, 4438.423005009328, 4522.163399771053, 4581.450225972838, 4583.495815460296, 4608.372889114432, 33407.16482087919, 33593.496097558556, 33657.15857103592, 70099.2990070103, 70171.0, 54006.18990715143, 56796.71601642048, 62981.37018629847, 63310.0503492448, 64169.679151604876, 57044.0, 58673.119903201485, 59833.70083149643, 60321.396786031575, 60588.39411605916, 9935.552900119657, 9956.751081222737, 10076.69769906904, 10107.241956853119, 10243.07812296897, 38770.41844372393, 39191.41212881866, 39225.6077439222, 39583.40624890687, 39588.2082358357, 47767.04465910593, 50181.24728129008, 50703.23945140752, 51267.2309915359, 51514.74242628763, 12011.039116870805, 12112.576059837864, 12466.626001219978, 12521.812172817597, 12680.048996325497, 13503.797443038558, 13546.59360219195, 13783.655408614464, 13814.792778108136, 14248.71502569922, 11624.593139240085, 12102.213356131822, 12853.228806271654, 12950.740985180431, 13474.46102155942, 12112.939435302767, 12520.87479125197, 12615.36923153857, 12661.683457913627, 12666.620001399973, 12331.50673973031, 12864.22814631125, 13360.398782054637, 13552.79670804919, 13736.725265494435, 10531.315464494783, 10707.839382409426, 11519.712007199887, 11584.744034264508, 11621.302721836717, 11707.88292117068, 11708.180427370002, 11817.286493458572, 11998.460069297078, 12055.21641093326], "value": 6977.4628705349705, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 104.0, 111.0, 110.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 135.0, 155.0, 189.0, 130.0, 165.0, 154.0, 125.0, 187.0, 127.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 160.0, 161.0, 162.0, 176.0, 162.0, 163.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 163.0, 77.0, 76.0, 76.0, 75.0, 178.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 150.0, 84.0, 81.0, 83.0, 141.0, 82.0, 82.0, 148.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 100.0, 95.0, 99.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 58.0, 55.0, 56.0, 56.0, 54.0, 70.0, 55.0, 52.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 83.0, 81.0, 79.0, 98.0, 83.0, 80.0, 81.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 122.0, 129.0, 128.0, 135.0, 121.0, 130.0, 166.0, 127.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 166.0, 161.0, 161.0, 160.0, 161.0, 161.0, 164.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 63.0, 63.0, 65.0, 62.0, 66.0, 61.0, 62.0], "value": 63.5, "unit": "score"}]}]} 23:28:58 INFO - Return code: 0 23:28:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:28:58 ERROR - # TBPL SUCCESS # 23:28:58 INFO - Running post-action listener: _resource_record_post_action 23:28:58 INFO - ##### 23:28:58 INFO - ##### Finished run-tests step (success) 23:28:58 INFO - ##### 23:28:58 INFO - Running post-run listener: _resource_record_post_run 23:28:58 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540160000; Read time: 8; Write time: 562104 23:28:58 INFO - TinderboxPrint: CPU usage
13.4% 23:28:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:28:58 INFO - TinderboxPrint: I/O write bytes / time
540,160,000 / 562,104 23:28:58 INFO - TinderboxPrint: CPU idle
8,211.1 (86.5%) 23:28:58 INFO - TinderboxPrint: CPU user
1,221.8 (12.9%) 23:28:58 INFO - TinderboxPrint: Swap in / out
0 / 0 23:28:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247267328; Read time: 0; Write time: 341680 23:28:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292892672; Read time: 8; Write time: 220424 23:28:58 INFO - Running post-run listener: _upload_blobber_files 23:28:58 INFO - Blob upload gear active. 23:28:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:28:58 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 23:28:58 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:28:58 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:28:59 INFO - (blobuploader) - INFO - Open directory for files ... 23:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:29:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:04 INFO - (blobuploader) - INFO - Done attempting. 23:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:29:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:05 INFO - (blobuploader) - INFO - Done attempting. 23:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:06 INFO - (blobuploader) - INFO - Done attempting. 23:29:06 INFO - (blobuploader) - INFO - Iteration through files over. 23:29:06 INFO - Return code: 0 23:29:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:29:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:29:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc5cf6675dfe48e3a5841fe3cfbb4c67ae72cbbf00d0a320862edd198bac6158a7663a9a6242c1d4345037919c8b623cb5871499742a1c2d25bf90e2c61d412c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c2f586c58a905e5827d7dc40599e88252322dbe37525e3c5e4473ce8d07665aec956c5eb8847d85c61d8bf7f5db98183a1f6d7ffd2bc913b4a3d64de20338b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b597b3b3774066f784638b77a8e5f400542cd3d1cb857f261bae1db99d996071fe6320b857250444962c1f6b5fed5d87c98dcd151a3b95a54cdedc86d36a4aef"} 23:29:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:29:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:29:06 INFO - Contents: 23:29:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc5cf6675dfe48e3a5841fe3cfbb4c67ae72cbbf00d0a320862edd198bac6158a7663a9a6242c1d4345037919c8b623cb5871499742a1c2d25bf90e2c61d412c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c2f586c58a905e5827d7dc40599e88252322dbe37525e3c5e4473ce8d07665aec956c5eb8847d85c61d8bf7f5db98183a1f6d7ffd2bc913b4a3d64de20338b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b597b3b3774066f784638b77a8e5f400542cd3d1cb857f261bae1db99d996071fe6320b857250444962c1f6b5fed5d87c98dcd151a3b95a54cdedc86d36a4aef"} 23:29:06 INFO - Running post-run listener: copy_logs_to_upload_dir 23:29:06 INFO - Copying logs to upload dir... 23:29:06 INFO - mkdir: /builds/slave/test/build/upload/logs 23:29:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.959212 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-25 23:29:05.714210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 23:29:05.718049) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958 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/sha512/bc5cf6675dfe48e3a5841fe3cfbb4c67ae72cbbf00d0a320862edd198bac6158a7663a9a6242c1d4345037919c8b623cb5871499742a1c2d25bf90e2c61d412c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c2f586c58a905e5827d7dc40599e88252322dbe37525e3c5e4473ce8d07665aec956c5eb8847d85c61d8bf7f5db98183a1f6d7ffd2bc913b4a3d64de20338b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b597b3b3774066f784638b77a8e5f400542cd3d1cb857f261bae1db99d996071fe6320b857250444962c1f6b5fed5d87c98dcd151a3b95a54cdedc86d36a4aef"} build_url:https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc5cf6675dfe48e3a5841fe3cfbb4c67ae72cbbf00d0a320862edd198bac6158a7663a9a6242c1d4345037919c8b623cb5871499742a1c2d25bf90e2c61d412c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c2f586c58a905e5827d7dc40599e88252322dbe37525e3c5e4473ce8d07665aec956c5eb8847d85c61d8bf7f5db98183a1f6d7ffd2bc913b4a3d64de20338b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b597b3b3774066f784638b77a8e5f400542cd3d1cb857f261bae1db99d996071fe6320b857250444962c1f6b5fed5d87c98dcd151a3b95a54cdedc86d36a4aef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 23:29:05.743040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:29:05.743383) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464242489.996064-791792958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:29:05.825407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 23:29:05.825746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 23:29:05.826044) ========= ========= Total master_lag: 0.20 =========