builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1469751420.36 results: success (0) buildid: 20160728143020 builduid: be206c7c388d4ff2a6b2b44f6c624b62 revision: 527045290210d4c117dac3c558019a9169cc4b18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.359169) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.359699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.360047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.381409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.381673) ========= 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=52faae308a556c440401f8e5000001e8-1469749840.753002-418951562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 17:17:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.2M=0s 2016-07-28 17:17:01 (44.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.461378 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.857042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.857402) ========= 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=52faae308a556c440401f8e5000001e8-1469749840.753002-418951562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.907219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:00.907596) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 527045290210d4c117dac3c558019a9169cc4b18 --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 527045290210d4c117dac3c558019a9169cc4b18 --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=52faae308a556c440401f8e5000001e8-1469749840.753002-418951562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 17:17:01,203 truncating revision to first 12 chars 2016-07-28 17:17:01,203 Setting DEBUG logging. 2016-07-28 17:17:01,203 attempt 1/10 2016-07-28 17:17:01,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/527045290210?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 17:17:01,507 unpacking tar archive at: fx-team-527045290210/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:01.545145) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:01.545475) ========= script_repo_revision: 527045290210d4c117dac3c558019a9169cc4b18 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:01.545914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:01.546191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 17:17:01.556228) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-28 17:17:01.556570) ========= /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=52faae308a556c440401f8e5000001e8-1469749840.753002-418951562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:01 INFO - MultiFileLogger online at 20160728 17:17:01 in /builds/slave/test 17:17:01 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 17:17:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:01 INFO - {'append_to_log': False, 17:17:01 INFO - 'base_work_dir': '/builds/slave/test', 17:17:01 INFO - 'blob_upload_branch': 'Fx-Team', 17:17:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:01 INFO - 'branch': 'Fx-Team', 17:17:01 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:01 INFO - 'config_files': ('talos/linux_config.py',), 17:17:01 INFO - 'default_actions': ('clobber', 17:17:01 INFO - 'read-buildbot-config', 17:17:01 INFO - 'download-and-extract', 17:17:01 INFO - 'populate-webroot', 17:17:01 INFO - 'create-virtualenv', 17:17:01 INFO - 'install', 17:17:01 INFO - 'run-tests'), 17:17:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:01 INFO - 'download_minidump_stackwalk': True, 17:17:01 INFO - 'download_symbols': 'ondemand', 17:17:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:01 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:01 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:01 INFO - 'installer_path': 'installer.exe', 17:17:01 INFO - 'log_level': 'info', 17:17:01 INFO - 'log_name': 'talos', 17:17:01 INFO - 'log_to_console': True, 17:17:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:01 INFO - 'opt_config_files': (), 17:17:01 INFO - 'pip_index': False, 17:17:01 INFO - 'sps_profile': False, 17:17:01 INFO - 'sps_profile_interval': 0, 17:17:01 INFO - 'suite': 'dromaeojs-e10s', 17:17:01 INFO - 'system_bits': '32', 17:17:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:01 INFO - 'title': 'talos-linux64-ix-056', 17:17:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:01 INFO - 'use_talos_json': True, 17:17:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:01 INFO - 'work_dir': 'build'} 17:17:01 INFO - [mozharness: 2016-07-29 00:17:01.949154Z] Running clobber step. 17:17:01 INFO - Running pre-action listener: _resource_record_pre_action 17:17:01 INFO - Running main action method: clobber 17:17:01 INFO - rmtree: /builds/slave/test/build 17:17:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:02 INFO - Running post-action listener: _resource_record_post_action 17:17:02 INFO - [mozharness: 2016-07-29 00:17:02.430333Z] Finished clobber step (success) 17:17:02 INFO - [mozharness: 2016-07-29 00:17:02.430436Z] Running read-buildbot-config step. 17:17:02 INFO - Running pre-action listener: _resource_record_pre_action 17:17:02 INFO - Running main action method: read_buildbot_config 17:17:02 INFO - Using buildbot properties: 17:17:02 INFO - { 17:17:02 INFO - "project": "", 17:17:02 INFO - "product": "firefox", 17:17:02 INFO - "script_repo_revision": "production", 17:17:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:17:02 INFO - "repository": "", 17:17:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:17:02 INFO - "buildid": "20160728143020", 17:17:02 INFO - "pgo_build": "True", 17:17:02 INFO - "basedir": "/builds/slave/test", 17:17:02 INFO - "buildnumber": 619, 17:17:02 INFO - "slavename": "talos-linux64-ix-056", 17:17:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:17:02 INFO - "platform": "ubuntu64_hw", 17:17:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:17:02 INFO - "branch": "fx-team", 17:17:02 INFO - "repo_path": "integration/fx-team", 17:17:02 INFO - "revision": "527045290210d4c117dac3c558019a9169cc4b18", 17:17:02 INFO - "stage_platform": "linux64-pgo", 17:17:02 INFO - "builduid": "be206c7c388d4ff2a6b2b44f6c624b62", 17:17:02 INFO - "slavebuilddir": "test" 17:17:02 INFO - } 17:17:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:17:02 INFO - Running post-action listener: _resource_record_post_action 17:17:02 INFO - [mozharness: 2016-07-29 00:17:02.432894Z] Finished read-buildbot-config step (success) 17:17:02 INFO - [mozharness: 2016-07-29 00:17:02.432983Z] Running download-and-extract step. 17:17:02 INFO - Running pre-action listener: _resource_record_pre_action 17:17:02 INFO - Running main action method: download_and_extract 17:17:02 INFO - mkdir: /builds/slave/test/build/tests 17:17: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')]} 17:17:02 INFO - https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:17:05 INFO - Downloaded 1361 bytes. 17:17:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:17:05 INFO - Using the following test package requirements: 17:17:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:17:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:17:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:05 INFO - u'jsshell-linux-x86_64.zip'], 17:17:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:17:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:17:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:17:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:17:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:17:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:17: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')]} 17:17:05 INFO - https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:08 INFO - Downloaded 24321040 bytes. 17:17:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:17:09 INFO - Return code: 0 17:17:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:09 INFO - https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:12 INFO - Downloaded 24321040 bytes. 17:17:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:17:13 INFO - Return code: 0 17:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:13 INFO - https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:17:16 INFO - Downloaded 14413725 bytes. 17:17:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:17:16 INFO - Return code: 0 17:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:16 INFO - https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:17:17 INFO - Downloaded 60982570 bytes. 17:17:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:17:17 INFO - mkdir: /builds/slave/test/properties 17:17:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:17 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:17 INFO - Contents: 17:17:17 INFO - build_url:https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:17:18 INFO - Running post-action listener: _resource_record_post_action 17:17:18 INFO - Running post-action listener: set_extra_try_arguments 17:17:18 INFO - [mozharness: 2016-07-29 00:17:18.408783Z] Finished download-and-extract step (success) 17:17:18 INFO - [mozharness: 2016-07-29 00:17:18.409016Z] Running populate-webroot step. 17:17:18 INFO - Running pre-action listener: _resource_record_pre_action 17:17:18 INFO - Running main action method: populate_webroot 17:17:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:18 INFO - '--tppagecycles', 17:17:18 INFO - '7'], 17:17:18 INFO - 'tests': ['tsvgm']}}, 17:17:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:18 INFO - 'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:18 INFO - 'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['damp', 'tps']}, 17:17:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:18 INFO - 'tests': ['damp', 'tps']}, 17:17:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['dromaeo_dom']}, 17:17:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['basic_compositor_video']}, 17:17:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:17:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['a11yr', 17:17:18 INFO - 'ts_paint', 17:17:18 INFO - 'tpaint', 17:17:18 INFO - 'sessionrestore', 17:17:18 INFO - 'sessionrestore_no_auto_restore', 17:17:18 INFO - 'tabpaint']}, 17:17:18 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:18 INFO - 'ts_paint', 17:17:18 INFO - 'tpaint', 17:17:18 INFO - 'sessionrestore', 17:17:18 INFO - 'sessionrestore_no_auto_restore', 17:17:18 INFO - 'tabpaint']}, 17:17:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:18 INFO - 'ts_paint', 17:17:18 INFO - 'tpaint', 17:17:18 INFO - 'sessionrestore', 17:17:18 INFO - 'sessionrestore_no_auto_restore', 17:17:18 INFO - 'tabpaint']}, 17:17:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:18 INFO - 'ts_paint', 17:17:18 INFO - 'tpaint', 17:17:18 INFO - 'sessionrestore', 17:17:18 INFO - 'sessionrestore_no_auto_restore', 17:17:18 INFO - 'tabpaint']}, 17:17:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['a11yr', 17:17:18 INFO - 'ts_paint', 17:17:18 INFO - 'tpaint', 17:17:18 INFO - 'sessionrestore', 17:17:18 INFO - 'sessionrestore_no_auto_restore', 17:17:18 INFO - 'tabpaint']}, 17:17:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['a11yr', 17:17:18 INFO - 'ts_paint', 17:17:18 INFO - 'tpaint', 17:17:18 INFO - 'sessionrestore', 17:17:18 INFO - 'sessionrestore_no_auto_restore', 17:17:18 INFO - 'tabpaint']}, 17:17:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['tsvgx', 17:17:18 INFO - 'tsvgr_opacity', 17:17:18 INFO - 'tart', 17:17:18 INFO - 'tscrollx', 17:17:18 INFO - 'cart']}, 17:17:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:18 INFO - 'tsvgr_opacity', 17:17:18 INFO - 'tart', 17:17:18 INFO - 'tscrollx', 17:17:18 INFO - 'cart']}, 17:17:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:18 INFO - 'talos_options': ['--disable-e10s'], 17:17:18 INFO - 'tests': ['tp5o']}, 17:17:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:18 INFO - 'tests': ['tp5o']}, 17:17:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:18 INFO - 'talos_options': ['--disable-e10s', 17:17:18 INFO - '--xperf_path', 17:17:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:18 INFO - 'tests': ['tp5n']}, 17:17:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:18 INFO - 'talos_options': ['--xperf_path', 17:17:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:18 INFO - 'tests': ['tp5n']}}, 17:17:18 INFO - 'talos.zip': {'path': '', 17:17:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:18 INFO - Running post-action listener: _resource_record_post_action 17:17:18 INFO - [mozharness: 2016-07-29 00:17:18.424652Z] Finished populate-webroot step (success) 17:17:18 INFO - [mozharness: 2016-07-29 00:17:18.424752Z] Running create-virtualenv step. 17:17:18 INFO - Running pre-action listener: _resource_record_pre_action 17:17:18 INFO - Running main action method: create_virtualenv 17:17:18 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:18 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 17:17:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:18 INFO - Using real prefix '/usr' 17:17:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:19 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:20 INFO - Installing pip.................done. 17:17:20 INFO - Return code: 0 17:17:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:17:20 INFO - Using env: {'DISPLAY': ':0', 17:17:20 INFO - 'HOME': '/home/cltbld', 17:17:20 INFO - 'LANG': 'en_US.UTF-8', 17:17:20 INFO - 'LANGUAGE': 'en_US:en', 17:17:20 INFO - 'LOGNAME': 'cltbld', 17:17:20 INFO - 'MAIL': '/var/mail/cltbld', 17:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:20 INFO - 'MOZ_NO_REMOTE': '1', 17:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:20 INFO - 'NO_EM_RESTART': '1', 17:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:20 INFO - 'PWD': '/builds/slave/test', 17:17:20 INFO - 'SHELL': '/bin/bash', 17:17:20 INFO - 'SHLVL': '1', 17:17:20 INFO - 'TERM': 'linux', 17:17:20 INFO - 'TMOUT': '86400', 17:17:20 INFO - 'USER': 'cltbld', 17:17:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:20 INFO - '_': '/tools/buildbot/bin/python'} 17:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:21 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 17:17:21 INFO - Cleaning up... 17:17:21 INFO - Return code: 0 17:17:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:21 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 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:21 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 17:17:21 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 17:17:21 INFO - Using env: {'DISPLAY': ':0', 17:17:21 INFO - 'HOME': '/home/cltbld', 17:17:21 INFO - 'LANG': 'en_US.UTF-8', 17:17:21 INFO - 'LANGUAGE': 'en_US:en', 17:17:21 INFO - 'LOGNAME': 'cltbld', 17:17:21 INFO - 'MAIL': '/var/mail/cltbld', 17:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:21 INFO - 'MOZ_NO_REMOTE': '1', 17:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:21 INFO - 'NO_EM_RESTART': '1', 17:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:21 INFO - 'PWD': '/builds/slave/test', 17:17:21 INFO - 'SHELL': '/bin/bash', 17:17:21 INFO - 'SHLVL': '1', 17:17:21 INFO - 'TERM': 'linux', 17:17:21 INFO - 'TMOUT': '86400', 17:17:21 INFO - 'USER': 'cltbld', 17:17:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:21 INFO - '_': '/tools/buildbot/bin/python'} 17:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:21 INFO - Downloading/unpacking psutil>=3.1.1 17:17:21 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 17:17:21 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 17:17:21 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 17:17:21 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 17:17:21 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 17:17:21 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 17:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:23 INFO - Installing collected packages: psutil 17:17:23 INFO - Running setup.py install for psutil 17:17:23 INFO - building 'psutil._psutil_linux' extension 17:17:23 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 17:17:23 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 17:17:23 INFO - building 'psutil._psutil_posix' extension 17:17:23 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 17:17:23 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 17:17:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:23 INFO - Successfully installed psutil 17:17:23 INFO - Cleaning up... 17:17:23 INFO - Return code: 0 17:17:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:17:23 INFO - Using env: {'DISPLAY': ':0', 17:17:23 INFO - 'HOME': '/home/cltbld', 17:17:23 INFO - 'LANG': 'en_US.UTF-8', 17:17:23 INFO - 'LANGUAGE': 'en_US:en', 17:17:23 INFO - 'LOGNAME': 'cltbld', 17:17:23 INFO - 'MAIL': '/var/mail/cltbld', 17:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:23 INFO - 'MOZ_NO_REMOTE': '1', 17:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:23 INFO - 'NO_EM_RESTART': '1', 17:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:23 INFO - 'PWD': '/builds/slave/test', 17:17:23 INFO - 'SHELL': '/bin/bash', 17:17:23 INFO - 'SHLVL': '1', 17:17:23 INFO - 'TERM': 'linux', 17:17:23 INFO - 'TMOUT': '86400', 17:17:23 INFO - 'USER': 'cltbld', 17:17:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:23 INFO - '_': '/tools/buildbot/bin/python'} 17:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:17:26 INFO - Installing collected packages: mozsystemmonitor 17:17:26 INFO - Running setup.py install for mozsystemmonitor 17:17:26 INFO - Successfully installed mozsystemmonitor 17:17:26 INFO - Cleaning up... 17:17:26 INFO - Return code: 0 17:17:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:17:26 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')]} 17:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:26 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')]} 17:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:26 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:26 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==2.5.1'] in /builds/slave/test/build 17:17:26 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==2.5.1 17:17:26 INFO - Using env: {'DISPLAY': ':0', 17:17:26 INFO - 'HOME': '/home/cltbld', 17:17:26 INFO - 'LANG': 'en_US.UTF-8', 17:17:26 INFO - 'LANGUAGE': 'en_US:en', 17:17:26 INFO - 'LOGNAME': 'cltbld', 17:17:26 INFO - 'MAIL': '/var/mail/cltbld', 17:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:26 INFO - 'MOZ_NO_REMOTE': '1', 17:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:26 INFO - 'NO_EM_RESTART': '1', 17:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:26 INFO - 'PWD': '/builds/slave/test', 17:17:26 INFO - 'SHELL': '/bin/bash', 17:17:26 INFO - 'SHLVL': '1', 17:17:26 INFO - 'TERM': 'linux', 17:17:26 INFO - 'TMOUT': '86400', 17:17:26 INFO - 'USER': 'cltbld', 17:17:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:26 INFO - '_': '/tools/buildbot/bin/python'} 17:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:26 INFO - Downloading/unpacking jsonschema==2.5.1 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:17:28 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 17:17:28 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 17:17:28 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 17:17:28 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 17:17:28 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 17:17:28 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 17:17:28 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:28 INFO - warning: no files found matching '*.txt' 17:17:28 INFO - no previously-included directories found matching 'build' 17:17:28 INFO - no previously-included directories found matching 'dist' 17:17:28 INFO - no previously-included directories found matching '.git*' 17:17:28 INFO - Installing collected packages: jsonschema, functools32 17:17:28 INFO - Running setup.py install for functools32 17:17:28 INFO - warning: no files found matching '*.txt' 17:17:28 INFO - no previously-included directories found matching 'build' 17:17:28 INFO - no previously-included directories found matching 'dist' 17:17:28 INFO - no previously-included directories found matching '.git*' 17:17:28 INFO - Successfully installed jsonschema functools32 17:17:28 INFO - Cleaning up... 17:17:28 INFO - Return code: 0 17:17:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:28 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:28 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:17:28 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 functools32==3.2.3-2 17:17:28 INFO - Using env: {'DISPLAY': ':0', 17:17:28 INFO - 'HOME': '/home/cltbld', 17:17:28 INFO - 'LANG': 'en_US.UTF-8', 17:17:28 INFO - 'LANGUAGE': 'en_US:en', 17:17:28 INFO - 'LOGNAME': 'cltbld', 17:17:28 INFO - 'MAIL': '/var/mail/cltbld', 17:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:28 INFO - 'MOZ_NO_REMOTE': '1', 17:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:28 INFO - 'NO_EM_RESTART': '1', 17:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:28 INFO - 'PWD': '/builds/slave/test', 17:17:28 INFO - 'SHELL': '/bin/bash', 17:17:28 INFO - 'SHLVL': '1', 17:17:28 INFO - 'TERM': 'linux', 17:17:28 INFO - 'TMOUT': '86400', 17:17:28 INFO - 'USER': 'cltbld', 17:17:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:28 INFO - '_': '/tools/buildbot/bin/python'} 17:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:17:29 INFO - Cleaning up... 17:17:29 INFO - Return code: 0 17:17:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:17:29 INFO - Using env: {'DISPLAY': ':0', 17:17:29 INFO - 'HOME': '/home/cltbld', 17:17:29 INFO - 'LANG': 'en_US.UTF-8', 17:17:29 INFO - 'LANGUAGE': 'en_US:en', 17:17:29 INFO - 'LOGNAME': 'cltbld', 17:17:29 INFO - 'MAIL': '/var/mail/cltbld', 17:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:29 INFO - 'MOZ_NO_REMOTE': '1', 17:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:29 INFO - 'NO_EM_RESTART': '1', 17:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:29 INFO - 'PWD': '/builds/slave/test', 17:17:29 INFO - 'SHELL': '/bin/bash', 17:17:29 INFO - 'SHLVL': '1', 17:17:29 INFO - 'TERM': 'linux', 17:17:29 INFO - 'TMOUT': '86400', 17:17:29 INFO - 'USER': 'cltbld', 17:17:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:29 INFO - '_': '/tools/buildbot/bin/python'} 17:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:29 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:29 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 17:17:29 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 17:17:29 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 17:17:29 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 17:17:29 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 17:17:29 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 17:17:31 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:31 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 17:17:31 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 17:17:31 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 17:17:31 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 17:17:31 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 17:17:31 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 17:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:31 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 17:17:31 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 17:17:31 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 17:17:31 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 17:17:31 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 17:17:31 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 17:17:31 INFO - Downloading docopt-0.6.1.tar.gz 17:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:31 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:31 INFO - Running setup.py install for blobuploader 17:17:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:32 INFO - Running setup.py install for requests 17:17:32 INFO - Running setup.py install for docopt 17:17:32 INFO - Successfully installed blobuploader requests docopt 17:17:32 INFO - Cleaning up... 17:17:32 INFO - Return code: 0 17:17:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:32 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 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:32 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 17:17:32 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 17:17:32 INFO - Using env: {'DISPLAY': ':0', 17:17:32 INFO - 'HOME': '/home/cltbld', 17:17:32 INFO - 'LANG': 'en_US.UTF-8', 17:17:32 INFO - 'LANGUAGE': 'en_US:en', 17:17:32 INFO - 'LOGNAME': 'cltbld', 17:17:32 INFO - 'MAIL': '/var/mail/cltbld', 17:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:32 INFO - 'MOZ_NO_REMOTE': '1', 17:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:32 INFO - 'NO_EM_RESTART': '1', 17:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:32 INFO - 'PWD': '/builds/slave/test', 17:17:32 INFO - 'SHELL': '/bin/bash', 17:17:32 INFO - 'SHLVL': '1', 17:17:32 INFO - 'TERM': 'linux', 17:17:32 INFO - 'TMOUT': '86400', 17:17:32 INFO - 'USER': 'cltbld', 17:17:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:32 INFO - '_': '/tools/buildbot/bin/python'} 17:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:32 INFO - Running setup.py (path:/tmp/pip-T0p5v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:32 INFO - Running setup.py (path:/tmp/pip-JosAr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:32 INFO - Running setup.py (path:/tmp/pip-tWv7jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:32 INFO - Running setup.py (path:/tmp/pip-jIXqT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:33 INFO - Running setup.py (path:/tmp/pip-_GI_pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:33 INFO - Running setup.py (path:/tmp/pip-RmGgeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:33 INFO - Running setup.py (path:/tmp/pip-CX4my2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:33 INFO - Running setup.py (path:/tmp/pip-U17j6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:33 INFO - Running setup.py (path:/tmp/pip-EfaCTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:33 INFO - Running setup.py (path:/tmp/pip-bVZN6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:33 INFO - Running setup.py (path:/tmp/pip-Xau1UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:33 INFO - Running setup.py (path:/tmp/pip-tOjZFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:33 INFO - Running setup.py (path:/tmp/pip-aGzHzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:33 INFO - Running setup.py (path:/tmp/pip-0tiQkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:33 INFO - Running setup.py (path:/tmp/pip-wZFvvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:33 INFO - Running setup.py (path:/tmp/pip-AfTVDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:33 INFO - Running setup.py (path:/tmp/pip-F8grow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:33 INFO - Running setup.py install for manifestparser 17:17:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozcrash 17:17:34 INFO - Running setup.py install for mozdebug 17:17:34 INFO - Running setup.py install for mozdevice 17:17:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozfile 17:17:34 INFO - Running setup.py install for mozhttpd 17:17:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozinfo 17:17:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozInstall 17:17:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozleak 17:17:34 INFO - Running setup.py install for mozlog 17:17:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Running setup.py install for moznetwork 17:17:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Running setup.py install for mozprocess 17:17:35 INFO - Running setup.py install for mozprofile 17:17:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Running setup.py install for mozrunner 17:17:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Running setup.py install for mozscreenshot 17:17:35 INFO - Running setup.py install for moztest 17:17:35 INFO - Running setup.py install for mozversion 17:17:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:35 INFO - Cleaning up... 17:17:35 INFO - Return code: 0 17:17:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:35 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 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:35 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 17:17:35 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 17:17:35 INFO - Using env: {'DISPLAY': ':0', 17:17:35 INFO - 'HOME': '/home/cltbld', 17:17:35 INFO - 'LANG': 'en_US.UTF-8', 17:17:35 INFO - 'LANGUAGE': 'en_US:en', 17:17:35 INFO - 'LOGNAME': 'cltbld', 17:17:35 INFO - 'MAIL': '/var/mail/cltbld', 17:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:35 INFO - 'MOZ_NO_REMOTE': '1', 17:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:35 INFO - 'NO_EM_RESTART': '1', 17:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:35 INFO - 'PWD': '/builds/slave/test', 17:17:35 INFO - 'SHELL': '/bin/bash', 17:17:35 INFO - 'SHLVL': '1', 17:17:35 INFO - 'TERM': 'linux', 17:17:35 INFO - 'TMOUT': '86400', 17:17:35 INFO - 'USER': 'cltbld', 17:17:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:35 INFO - '_': '/tools/buildbot/bin/python'} 17:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:36 INFO - Running setup.py (path:/tmp/pip-AOa8xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:36 INFO - Running setup.py (path:/tmp/pip-4boTWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:36 INFO - Running setup.py (path:/tmp/pip-z0eLk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:36 INFO - Running setup.py (path:/tmp/pip-BCqGGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:36 INFO - Running setup.py (path:/tmp/pip-XkzXlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:36 INFO - Running setup.py (path:/tmp/pip-vnPYVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:36 INFO - Running setup.py (path:/tmp/pip-uWcPzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:36 INFO - Running setup.py (path:/tmp/pip-8sVudZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:36 INFO - Running setup.py (path:/tmp/pip-wL1xeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:36 INFO - Running setup.py (path:/tmp/pip-qzfIew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:36 INFO - Running setup.py (path:/tmp/pip-a3jUHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:36 INFO - Running setup.py (path:/tmp/pip-BCuUrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:36 INFO - Running setup.py (path:/tmp/pip-qxKUEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:36 INFO - Running setup.py (path:/tmp/pip-K8fJeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:37 INFO - Running setup.py (path:/tmp/pip-f1SaAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:37 INFO - Running setup.py (path:/tmp/pip-ge2aBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:37 INFO - Running setup.py (path:/tmp/pip-0fAPeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:37 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)) 17:17:37 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)) 17:17:37 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)) 17:17:37 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)) 17:17:37 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)) 17:17:37 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)) 17:17:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:39 INFO - Downloading blessings-1.6.tar.gz 17:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:39 INFO - Installing collected packages: blessings 17:17:39 INFO - Running setup.py install for blessings 17:17:39 INFO - Successfully installed blessings 17:17:39 INFO - Cleaning up... 17:17:39 INFO - Return code: 0 17:17:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:39 INFO - Reading from file tmpfile_stdout 17:17:39 INFO - Current package versions: 17:17:39 INFO - argparse == 1.2.1 17:17:39 INFO - blessings == 1.6 17:17:39 INFO - blobuploader == 1.2.4 17:17:39 INFO - docopt == 0.6.1 17:17:39 INFO - functools32 == 3.2.3-2 17:17:39 INFO - jsonschema == 2.5.1 17:17:39 INFO - manifestparser == 1.1 17:17:39 INFO - mozInstall == 1.12 17:17:39 INFO - mozcrash == 0.17 17:17:39 INFO - mozdebug == 0.1 17:17:39 INFO - mozdevice == 0.48 17:17:39 INFO - mozfile == 1.2 17:17:39 INFO - mozhttpd == 0.7 17:17:39 INFO - mozinfo == 0.9 17:17:39 INFO - mozleak == 0.1 17:17:39 INFO - mozlog == 3.3 17:17:39 INFO - moznetwork == 0.27 17:17:39 INFO - mozprocess == 0.23 17:17:39 INFO - mozprofile == 0.28 17:17:39 INFO - mozrunner == 6.12 17:17:39 INFO - mozscreenshot == 0.1 17:17:39 INFO - mozsystemmonitor == 0.3 17:17:39 INFO - moztest == 0.7 17:17:39 INFO - mozversion == 1.4 17:17:39 INFO - psutil == 3.1.1 17:17:39 INFO - requests == 1.2.3 17:17:39 INFO - wsgiref == 0.1.2 17:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:39 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')]} 17:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:39 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')]} 17:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:39 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 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:39 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 17:17:39 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 17:17:39 INFO - Using env: {'DISPLAY': ':0', 17:17:39 INFO - 'HOME': '/home/cltbld', 17:17:39 INFO - 'LANG': 'en_US.UTF-8', 17:17:39 INFO - 'LANGUAGE': 'en_US:en', 17:17:39 INFO - 'LOGNAME': 'cltbld', 17:17:39 INFO - 'MAIL': '/var/mail/cltbld', 17:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:39 INFO - 'MOZ_NO_REMOTE': '1', 17:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:39 INFO - 'NO_EM_RESTART': '1', 17:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:39 INFO - 'PWD': '/builds/slave/test', 17:17:39 INFO - 'SHELL': '/bin/bash', 17:17:39 INFO - 'SHLVL': '1', 17:17:39 INFO - 'TERM': 'linux', 17:17:39 INFO - 'TMOUT': '86400', 17:17:39 INFO - 'USER': 'cltbld', 17:17:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:39 INFO - '_': '/tools/buildbot/bin/python'} 17:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 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)) 17:17:39 INFO - Cleaning up... 17:17:39 INFO - Return code: 0 17:17:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17:39 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')]} 17:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:39 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')]} 17:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:39 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 0x1fb6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2277180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, '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': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', '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 17:17:39 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 17:17:39 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 17:17:39 INFO - Using env: {'DISPLAY': ':0', 17:17:39 INFO - 'HOME': '/home/cltbld', 17:17:39 INFO - 'LANG': 'en_US.UTF-8', 17:17:39 INFO - 'LANGUAGE': 'en_US:en', 17:17:39 INFO - 'LOGNAME': 'cltbld', 17:17:39 INFO - 'MAIL': '/var/mail/cltbld', 17:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:39 INFO - 'MOZ_NO_REMOTE': '1', 17:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:39 INFO - 'NO_EM_RESTART': '1', 17:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:39 INFO - 'PWD': '/builds/slave/test', 17:17:39 INFO - 'SHELL': '/bin/bash', 17:17:39 INFO - 'SHLVL': '1', 17:17:39 INFO - 'TERM': 'linux', 17:17:39 INFO - 'TMOUT': '86400', 17:17:39 INFO - 'USER': 'cltbld', 17:17:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:39 INFO - '_': '/tools/buildbot/bin/python'} 17:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:17:40 INFO - Cleaning up... 17:17:40 INFO - Return code: 0 17:17:40 INFO - Running post-action listener: _resource_record_post_action 17:17:40 INFO - Running post-action listener: _start_resource_monitoring 17:17:40 INFO - Starting resource monitoring. 17:17:40 INFO - [mozharness: 2016-07-29 00:17:40.100023Z] Finished create-virtualenv step (success) 17:17:40 INFO - [mozharness: 2016-07-29 00:17:40.100460Z] Running install step. 17:17:40 INFO - Running pre-action listener: _resource_record_pre_action 17:17:40 INFO - Running main action method: install 17:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:40 INFO - Reading from file tmpfile_stdout 17:17:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:40 INFO - Reading from file tmpfile_stdout 17:17:40 INFO - Output received: 17:17:40 INFO - Usage: mozinstall [options] installer 17:17:40 INFO - Options: 17:17:40 INFO - -h, --help show this help message and exit 17:17:40 INFO - -d DEST, --destination=DEST 17:17:40 INFO - Directory to install application into. [default: 17:17:40 INFO - "/builds/slave/test"] 17:17:40 INFO - --app=APP Application being installed. [default: firefox] 17:17:40 INFO - mkdir: /builds/slave/test/build/application 17:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:17:57 INFO - Reading from file tmpfile_stdout 17:17:57 INFO - Output received: 17:17:57 INFO - /builds/slave/test/build/application/firefox/firefox 17:17:57 INFO - Running post-action listener: _resource_record_post_action 17:17:57 INFO - [mozharness: 2016-07-29 00:17:57.664769Z] Finished install step (success) 17:17:57 INFO - [mozharness: 2016-07-29 00:17:57.665045Z] Running run-tests step. 17:17:57 INFO - Running pre-action listener: _resource_record_pre_action 17:17:57 INFO - Running main action method: run_tests 17:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:17:57 INFO - Python 2.7.3 17:17:57 INFO - Return code: 0 17:17:57 INFO - grabbing minidump binary from tooltool 17:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22753b0>, '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 0x22762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2276740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:17:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:17:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:17:57 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 17:17:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:17:57 INFO - Return code: 0 17:17:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:17:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:17:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:17:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:17:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:17:57 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/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 17:17:57 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/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 17:17:57 INFO - Using env: {'DISPLAY': ':0', 17:17:57 INFO - 'HOME': '/home/cltbld', 17:17:57 INFO - 'LANG': 'en_US.UTF-8', 17:17:57 INFO - 'LANGUAGE': 'en_US:en', 17:17:57 INFO - 'LOGNAME': 'cltbld', 17:17:57 INFO - 'MAIL': '/var/mail/cltbld', 17:17:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:57 INFO - 'MOZ_NO_REMOTE': '1', 17:17:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:57 INFO - 'NO_EM_RESTART': '1', 17:17:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:57 INFO - 'PWD': '/builds/slave/test', 17:17:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:57 INFO - 'SHELL': '/bin/bash', 17:17:57 INFO - 'SHLVL': '1', 17:17:57 INFO - 'TERM': 'linux', 17:17:57 INFO - 'TMOUT': '86400', 17:17:57 INFO - 'USER': 'cltbld', 17:17:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469749840.753002-418951562', 17:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:57 INFO - '_': '/tools/buildbot/bin/python'} 17:17:57 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/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 17:17:57 INFO - mozversion application_buildid: 20160728143020 17:17:57 INFO - mozversion application_changeset: 527045290210d4c117dac3c558019a9169cc4b18 17:17:57 INFO - mozversion application_display_name: Nightly 17:17:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:17:57 INFO - mozversion application_name: Firefox 17:17:57 INFO - mozversion application_remotingname: firefox 17:17:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:17:57 INFO - mozversion application_vendor: Mozilla 17:17:57 INFO - mozversion application_version: 50.0a1 17:17:57 INFO - mozversion platform_buildid: 20160728143020 17:17:57 INFO - mozversion platform_changeset: 527045290210d4c117dac3c558019a9169cc4b18 17:17:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:17:57 INFO - mozversion platform_version: 50.0a1 17:17:57 INFO - using testdate: 1469751477 17:17:57 INFO - actual date: 1469751477 17:17:57 INFO - starting webserver on 'localhost:47303' 17:17:57 INFO - SUITE-START | Running 2 tests 17:17:57 INFO - TEST-START | dromaeo_css 17:17:57 INFO - operating with platform_type : linux_ 17:17:57 INFO - Initialising browser for dromaeo_css test... 17:17:57 INFO - TEST-INFO | started process 24138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1Pdss/profile http://localhost:47303/getInfo.html) 17:18:01 INFO - PROCESS | 24138 | JavaScript error: , line 0: uncaught exception: undefined 17:18:02 INFO - PROCESS | 24138 | __metrics Screen width/height:1600/1200 17:18:02 INFO - PROCESS | 24138 | colorDepth:24 17:18:02 INFO - PROCESS | 24138 | Browser inner width/height: 1024/697 17:18:02 INFO - PROCESS | 24138 | __metrics 17:18:03 ERROR - PROCESS | 24138 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:18:04 INFO - TEST-INFO | 24138: exit 0 17:18:04 INFO - Browser initialized. 17:18:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:04 INFO - TEST-INFO | started process 24258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1Pdss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:16 INFO - PROCESS | 24258 | RSS: Main: 164995072 17:18:16 INFO - PROCESS | 24258 | 17:19:05 INFO - PROCESS | 24258 | 1469751545858 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] 17:21:14 INFO - PROCESS | 24258 | Cycle 1(1): loaded http://localhost:47303/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47303/tests/dromaeo/cssquery-ext.html) 17:21:15 INFO - PROCESS | 24258 | RSS: Main: 169893888 17:21:15 INFO - PROCESS | 24258 | 17:24:18 INFO - PROCESS | 24258 | Cycle 1(1): loaded http://localhost:47303/tests/dromaeo/cssquery-ext.html (next: http://localhost:47303/tests/dromaeo/cssquery-jquery.html) 17:24:18 INFO - PROCESS | 24258 | RSS: Main: 167325696 17:24:18 INFO - PROCESS | 24258 | 17:27:20 INFO - PROCESS | 24258 | Cycle 1(1): loaded http://localhost:47303/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47303/tests/dromaeo/cssquery-mootools.html) 17:27:21 INFO - PROCESS | 24258 | RSS: Main: 170708992 17:27:21 INFO - PROCESS | 24258 | 17:30:22 INFO - PROCESS | 24258 | Cycle 1(1): loaded http://localhost:47303/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47303/tests/dromaeo/cssquery-prototype.html) 17:30:23 INFO - PROCESS | 24258 | RSS: Main: 165437440 17:30:23 INFO - PROCESS | 24258 | 17:33:25 INFO - PROCESS | 24258 | Cycle 1(1): loaded http://localhost:47303/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47303/tests/dromaeo/cssquery-yui.html) 17:33:26 INFO - PROCESS | 24258 | RSS: Main: 167608320 17:33:26 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | Cycle 1(1): loaded http://localhost:47303/tests/dromaeo/cssquery-yui.html (next: http://localhost:47303/tests/dromaeo/cssquery-dojo.html) 17:36:29 INFO - PROCESS | 24258 | RSS: Main: 170397696 17:36:29 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | __start_tp_report 17:36:29 INFO - PROCESS | 24258 | _x_x_mozilla_page_load 17:36:29 INFO - PROCESS | 24258 | _x_x_mozilla_page_load_details 17:36:29 INFO - PROCESS | 24258 | |i|pagename|runs| 17:36:29 INFO - PROCESS | 24258 | |0;dojo.html;3043.1327071784544;3059.9847000764994;3085.4600444922135;3090.2583379988796;3093.505039193729;5261.6316857819875;5313.68117912925;5401.621886467954;5420.783168673253;5485.506304432601;5393.056215162341;5406.297181366427;5477.986572484093;5484.561235101192;5490.945090549093;4890.193118135503;4893.706377617345;4936;4952.826651067214;5038.269450929613;4932.482089380599;4989.301497790312;5000.299958005882;5039.6976181429045;5055.39335279767;4715.504871988461;4818.638602104821;4870.342503761982;4941.061198372297;4952.87617809554;4849.612031037544;4868.05073010763;4876.804927802919;4882.072406242838;4953.356063711731;4871.8294859679745;4877.6341774367065;4889.853304400874;4913.140200464904;4989.625778066623;5283.339582552181;5351;5387.1111266640955;5393.703346315951;5439.972800135974;5677;5700.173474846166;5724.771009159628;5728.828135155952;5801.506871915893;5677.943220567783;5719.428057194247;5751.281089863767;5781.768729250825;5784.2769653793275;5181.1969144782615;5209.817656382046;5249.081410753103;5317.1226747586215;5356.330458692663;5816.5928385013485;5835.299764028344;5864.9413505864395;5875.706214689249;5922.703864806743;5556.138798486241;5617.606767526316;5619.606627536115;5627.380988091307;5651.943480565142;5604.047311956977;5711.543076553866;5731.226284451629;5772.422757724278;5793;5490.258815059916;5673.5461163107675;5727.5131613812455;5736;5833.38749431312;5762.164486149485;5762.625429347079;5767.509761670305;5770.567207459458;5796.130580412888;4371.256886329332;4377.540358262337;4442.267025940683;4449.488308844459;4450.020995381075;3900.2004589059175;3942.5860284669698;3970.5235371754998;3978.244133614604;3985.0834308109297;5449.700266485382;5450.454954504517;5452.291202143696;5457.536109430743;5458.426865179099;5543.61194716374;5645.943540564542;5674.886502269931;5675.091985282335;5738.254026976467;5490.313710786152;5583.134614134816;5590.888182236414;5597.80407685729;5611.635243709227;5069.239614057847;5074.695518268915;5076.36545431821;5088.160453525201;5137.588992880561;5816.47651711348;5961.8211453655595;6059.575829691879;6087.421694938974;6104.053871649901;5778.422157784188;5841.50347220491;5876.94123058781;5881.029630110984;5881.470667639933;6053.182820319201;6086.1175129606845;6089.725962331617;6111.266648002268;6119.051547010221;5451.591130665137;5578.944210557843;5705.857353566028;5745.224394706661;5778.537716982715;5699.629524080921;5714.828555143353;5747.626404283708;5772;5811.331696854747;5601.943980560142;5607.915881261866;5620.803271885465;5621.550275977994;5626.465485778845;5480.671159730429;5527.170924361378;5590.7763689453595;5605.271314729059;5638.971805140948;5504.311961004874;5510.80712175088;5515.834524964257;5541.639793413416;5568.6658800472105;5592.440755924537;5619.80330688424;5634.014047541746;5649.350324712546;5665.065264231355;5416.51251387377;5519.475649813261;5531.8893622128135;5551.500364967173;5566.165075238747 17:36:29 INFO - PROCESS | 24258 | |1;ext.html;554.0139090771164;586.2173997713053;587.0138167877964;613.2089604410311;618.8421952402136;38052.23895522091;42069.78965105174;42214.788926055364;42367.78816105923;42431.57568424315;40767.98080047993;41433.17133657325;41441.58558414415;41771;41880.581194188046;8792.736217913473;8811.427257228292;8823.602937867812;8877.68928087517;8898.243649289818;8746.562671866413;8754.037055923875;8759.78100547485;8875.535536636447;8908.599113039929;8899.28805695546;8945.060768619267;8946.41848279863;8952.239059679934;8954.507502087383;8818.911810881906;8856.955715221415;8878.689245876363;8882.600282987249;8913.064128266567;8820.250278726251;8876.112388761072;8912.8663070054;8922.86615700765;8927.794747709042;40873;40877.795611022055;41225.1754964902;41287.793561032304;41290;2885.365219651694;3166.8733250669948;3391.9491207631904;3495.4756786481976;4093.9385909211387;29882.85058574715;29883.70116298831;30315.242118946982;31309.843450782828;31599;4065.79671016448;4066.125782956649;4106.096658735103;4170.562090980464;4191.161767646483;318124;319886;320464.39767801244;320676;321369;33547.329053419286;33672;33724.831375842965;33726.156846079044;33741.15647108842;31417.37165256682;31624.367512649616;31724.524132138038;31736;34883.4767478488;14972;15027;15080.095194288378;15106.54680359591;15150.848491515164;11429.771404571862;11573;11597.594084207012;11614.6515604532;11640.883591164149;18235.27058917655;18343.431919531275;18381.81618183828;18405.5398615033;18528.536786580444;6379.489640828722;6594.472442204708;6712.060311556386;6724.7646332378135;6772.796816095525;963.6579014449909;1000.1498726082917;1050.1598721023151;1127.1940562497853;1154.861416629993;32351.191220219684;32406;32472.35055298928;32639.836800815843;33121.668783311856;1093.9179561532917;1099.70308016835;1138.3113216504062;1172.6013155527162;1203.4644583160584;15704;17052.914735426242;17063.91468042652;17086.91456542734;17150.313987440364;555306;561742;563536;570596;570803.8977466451;59359.40640593625;59874.40125598775;60156.699216503635;60945.39054609486;61055.38944610497;1300.6033159886326;1315.2897435384975;1359.422245545639;1368.637311112536;1377.3526442571974;30257.546136808407;33076;33143.66856331406;33351.83324083364;35371;56668.433315667964;57093.714531427075;57385.13922291253;57492.71253643705;57737.13394299005;521932;522201;522680;526682;531413;42129.78935105305;43367.56632433762;43646.34530481982;43746;44295;47765.283520747915;48060.519394807;48067.27899081447;48984.75507622439;49099.75450122727;42463;43399;43545;44405.11189776251;44888.77555612331;42097.579024209364;42300.57699422966;42564.78717606516;42690.35964460474;43885.78057109694;42024.159516810105;44633.77683111564;45220.77389613031;45294;45938.081238375715;40660;42416.787916060224;43297.35053974256;45018;46306.30540541827;33143.502847456824;34180;34856.47715284323;34928.47607285842;36513.81743091268 17:36:29 INFO - PROCESS | 24258 | |2;jquery.html;372.8788143853247;381.99427008594876;384.01846472203425;399.4766855419399;409.2204350711893;18333.816661833378;19145.138468768888;19476.70784938227;19873.304434344802;20208.696869546933;18453.815461845377;18620.62758744824;18967.90516047418;19203.711944320847;19386.806131938676;5539.723013849311;5820.010598198316;5820.447057529528;5953.88092238155;5959.910601340984;5614;5766.423357664221;5805.303363596353;5807.128930660392;5812.564057695668;5674.546036317085;5692.060809966371;5710.257666503348;5753.424657534255;5780.277465316835;5641.971790141023;5730.914036289459;5740.368559458477;5744.856378590527;5766.481016708495;5171.844844654666;5178.818741344073;5204.9479505204845;5228.947710522884;5236.685798852043;23093.653595196087;23183.188588399324;23286.76713232863;23446.413839653975;23841.642375364383;2092.4978005278776;2198.1097655449566;2282.167009041704;2538.4796116796015;2770.224337185591;10320.638777642822;10382;10539.894601053968;10621.681349559525;10685.679429617125;1912.6174765046908;1919.827215550593;1989.3932350633052;1990.203918432624;2020.7474065741783;85972;86477;87910.56044719735;88059;90714.5464272681;10199.796004080024;10242;10337.9483102584;10348.327358721659;10508.894911050944;13810.033297669066;13922.651933701738;13971.58085257444;14002.22987735664;14216.64458388528;7828.491148075357;7934.365250779923;7957.124716281204;8118.675252989932;8145.8370832584205;7642.885356719654;7678.577678227751;7681;7811.80470488231;7980.640871160812;4347.239233134189;4376.6498680105515;4398.494173170063;4598.839040633628;4774.355462012653;1768.2838450427598;1880.2385034061226;1883.5950270691867;1893.651871679108;1926.2198809482181;940.741296143566;971.2715463402449;971.6744890461633;982.6757170133839;997.396575072071;19830.70253946192;19885;20287.18851245963;20291.8985405075;20372.89813550923;979.6522234606755;1008.4856723071287;1015.1422048369117;1029.629333439961;1045.414567842011;10385.480725963671;11243.381614011145;11258.155638327158;11310.717232069099;11365.431728413547;493930;503794;505363;507024;521974;51270;55226;90261.54869225612;96487.51756241314;99742.5012874931;914.4513292024732;936.9344145909721;957.2198658093631;959.203860795538;959.7120863740989;17057;17447.47657570275;17480.47558573245;18172;18190;40132.3980140304;41544.792276038424;42156.15687686291;42948.35577466278;43480.565194347655;51670.22494662508;59251.40748592459;61673.38326616676;62242.377576223655;64514.09686564022;7107.893381599383;7788.454808163374;7846.686132554634;7855.764327070197;8020.799480013046;12405.689857753629;13517.729645407233;13529.932350338186;13608.523701670394;13819;11487.425628718698;11554.537818487503;11830.881691182978;12085.75828483443;12501.062420318694;11829.645110646694;11917.52329906794;11966.760664786829;12001.699957500783;12026.639200823989;11685.357305348287;11734.413279335828;11797.941010294893;11919.225250358699;11965.880341196476;7469.439792015512;7640.958814512976;7678.385729141543;7814.72648457324;7874.645640946285;8723.69467068675;11424.371659558805;11927.642170734893;11962.940185299018;12000.15998880105 17:36:29 INFO - PROCESS | 24258 | |3;mootools.html;1525.1001908873761;1539.3842463014794;1644.7039532884085;1739.1565090930903;1777.0492786359293;7855.60721963901;8600.526971016592;8712.346574006942;9029.780979567764;9111.088891110894;8649.135086491347;8946.373753837233;8980.461172329664;8982;9006.774830629238;2320.4198950262394;2332.4985128197436;2340.8946597403155;2346.4133966508375;2354.929352119439;2234.5866014787234;2276.157821606008;2287.039443433762;2293.4037150340864;2302.3783578433813;2317.339558225906;2336.906523739048;2348.295511346589;2349.9765002350014;2361.8819059047064;2279.190887235041;2290.713660792401;2322.686437330964;2331.393837602227;2342.121704360865;2270.137347807839;2284.794368506826;2287.4395773035544;2288.39357570244;2290.358699564125;9007.909920900773;9065.048169942127;9085.13691199335;9101.408408453495;9108.362414630978;5124.718140502271;5168.173092305213;5218.6868787872845;5236.005159019774;5258.474152584711;3252.349530093991;3278.2951665392056;3316.3201543683485;3347.5648165738544;3365.0241429985276;1089.6131873184984;1114.7157474843943;1121.7195701074731;1144.3362849547325;1153.7634784869165;11436.542538298458;11507.597234096851;11598.072154227642;11633.185677002613;11667.06663466929;4456.710313829591;4483.14820184164;4631.560001799824;4640.141573808856;4668.159731248408;10354.068133867988;10361;10375.533101010473;10389.220808439397;10400.323978941344;5345.1447768356875;5387.515123638891;5389.892202155935;5396.568274538027;5432.972835135799;4372.540883207281;4634.745089020136;4698.671093023456;4702.553257440606;4922.655414121049;3905.433712111728;3923.725339226227;4051.4125451809323;4058.7158898877387;4101.364288535282;1223.8714934931882;1223.9020878329711;1227.0858210633135;1260.6596219020996;1271.6947932496319;950.4907045400149;959.4195511715451;966.5747071288611;995.1988649137369;995.1988649137514;5612.915806262909;5816.563757718188;5847.06446968483;5949.702514874239;5964.940350596526;423.36706623597917;428.9506706728704;429.6455424274986;433.20074462616424;1020.2756043209405;4180.602842729997;4277.379779931893;4277.914441711148;4309.07354918694;4322.610965013164;11021.118310535137;11073.50169242386;11146.386948717736;11155.776884462266;11167.72080697989;10299.073083422529;10754.516046777913;10778.19163562736;11079.058280046287;11138.721531961766;8255.25702686749;8457.830843383097;8526.957365213135;8537.445066070686;8538.743837684879;5982.222311099529;6010.609310394811;6048.969755151196;6114.0828875669;6211;10293.691189264335;10337.0696637303;10426.791464170827;10440.68677939663;10594.894051059391;9470.479123648265;9752.46361450127;9912.504374781376;10173.084422401724;10547.683569492927;7267.491275610657;7840.255175758294;7892.0529536456;7971.083325417651;8027.799305017421;8722.084181160886;8750.737477875675;8776.868346974928;8852.822943540965;8874.645014199617;7717.382609391348;7813.765587032398;7901.525908445512;8025.197480251928;8059.597020148852;7737.845243095219;7749.108852482037;7801.102873169431;7819.335356494534;7910.762677119696;7155.677994490156;7164.247753985965;7189;7196.244394338519;7221.855562888608;5271.525562699376;5286.841394758163;5319.335083114611;5352.143657014859;5456;5029.321041659329;5105.412877519133;5122.334096567572;5212.765425555935;5382.407935127211 17:36:29 INFO - PROCESS | 24258 | |4;prototype.html;320.5368242889026;324.790510120972;329.37418904082244;331.8523257150569;337.1133917796196;5281.947180528194;5391.757370918308;5461.535769459596;5513.365962914261;5548.250986116873;5413.945860541394;5433;5438.265834112393;5455;5463.2078348639425;4235.555266696999;4240.427542281784;4249.91754040521;4252.744835309892;4274.7862606869685;4183.247015537202;4251.319788833787;4274.615284624383;4284.60062365075;4309.784510774464;4263.63563659629;4264.466941632296;4276.230278549875;4280.250956082688;4281.743095414269;4246.129543443602;4277.957220427803;4302.612764851178;4318.5465526119615;4328.264195086843;3664.5785734640326;3788.204477059821;3796.8481260749536;3797.82267497074;3804.6766024887916;5310.176922577007;5345.812896548641;5357.678539287655;5411.918821217685;5412.3505179378335;4883.389576302962;4935.6051515879;4943.678660887031;4946.505349465061;4956.405231372259;5571.582131340125;5683.8010669626365;5703.657780533182;5721.971390143064;5722.599418040697;4106.260873042851;4107.8973025674295;4116.897077573085;4162.895927601804;4176.561461046576;5919.3488716240745;5984.162217289583;6045.848853778691;6047.244094488189;6049.820285044418;4086;4157.521884983205;4252.702310838212;4267.295896177158;4278.187144442546;4275.8075886585175;4276.401303817468;4280.636145927569;4284.9716068143425;4322.8703138905885;4906.730129842893;4921.4832442593015;4921.729304888266;4922.015596880567;4940.184869496493;5698.746275819313;5797.768089276382;5834.649921004669;5837.737301821428;5843.152742852262;1438.2233593859407;1439.8920080993967;1443.3721331220952;1457.3369117051716;1460.1312219229542;910.904355042711;932.7734029750856;953.6423841059602;963.8241345558407;974.6929717139078;4846.418429788448;4900.656954013256;4927.359443272423;4927.926081108786;4968.552830245295;5191.636585439059;5195.636305458582;5199.816077247489;5222.3472065991755;5227.947720522822;4645.907081858344;4838.661293709407;4859.246816743411;4915.681914707629;4978;2737.3293543081672;2757.869273597815;2761.9585706214425;2770.7644850187958;2780.235435255321;5261;5320.430473010394;5326.334208223972;5336.62643614951;5348.87673588543;5065.027357707665;5095.898082038412;5230.189320655304;5288.180332048539;5298.576113910878;5294.590961112684;5332.520073193431;5372.48961348679;5378.623496355218;5391.487808658171;5055.140626093499;5098.592112630907;5145.78388507183;5182.32629758129;5205;4936.259561065869;5079.5428411443145;5101.285819985279;5117.5650069743;5124.30821839047;5305.495977882095;5322.38792538863;5324.8136315228785;5327.254184414262;5352.143657014859;3846.6345697158727;4005.9799701001307;4116.485439320085;4211.284081706179;4234.470691163605;5826.242588463472;5833.812320379858;5846.970765146317;5870.152975806815;5904.704764761659;5527.535203171083;5739.684317362585;5751.252337196305;5760.366359700346;5767.3367562729145;5639.7180140993605;5673.290838645169;5694;5694.515966142924;5729.341125770589;5638.887222255614;5651.886962260814;5658.603897727119;5659.320881494247;5668.534187628395;5555.2500412445415;5698.373178950395;5727.51084717968;5730.226419433323;5813.273340832396;5596.3284405871555;5604.971975140098;5606.551475881838;5617.1914042978515;5620.494155526022 17:36:29 INFO - PROCESS | 24258 | |5;yui.html;728.8578727148201;743.9665215065321;761.200739223815;790.1466416270429;859.8409294280557;13514.189148651089;14255.501057462965;14471.059381140218;14479.710405791879;14493.855061449382;12623.810642840364;12691.238525688465;12763.425645845937;12845;12852.051959995399;645.6416688737748;772.1622040086485;785.3246208260891;799.8360336131079;801.3509057663282;786.5477350523472;793.5278509286965;794.0312818361618;796.8685166947447;797.401948538596;827.9917200828005;833.8790875323075;833.9124391938819;835.1189495082685;837.3217693668117;823.8887750153773;826.2563692676579;832.9754402085408;835.1564919431388;836.0719601242646;603.6378173096151;606.3451472409787;608.5892022884535;609;610.6122612141278;13193.076484646079;13275.137116087424;13335;13337.86662133376;13359.465621375231;15363.15502647354;15418.306176222097;15480.612984675361;15530.145841978687;15727.606809829731;12428.75142497145;12505.249685018836;12656.873431265754;12701.74596508074;13195.340232988312;3821.3885778275344;4034.7895631310785;4047.4535937648334;4076.266272071026;4090.468239128924;78316.60841695812;78818;79638.60180699118;80015;80169.19830801734;10444.895551044545;11096.445177741081;11453.885461145448;11466.656000320003;11666.88333116658;21140.577188456144;21304.680429793567;21324.253651122137;21441.249556265455;21563.892180539;8433.704820331259;8491.532965686947;8543.641145238971;8631.827363452696;8747.65009399617;4827.179379505493;4912.38595175603;4933.679310844784;4963.255511673206;4975.029869175476;3466.7053300469743;3511.631278715698;3542.4509201073874;3578.0697018775304;3591.730620203495;606.3269770554681;609.5367520684312;612.592625903778;623.8533944523033;624.8156793745856;598.5750117416683;666.0079051383399;685.2017399729259;707.3068392974914;744.3821628048706;9669.9033009669;10045.79908401828;10148.594056237667;10258.17934565248;10332.638357657446;672.1094549721638;695.6973716433367;697.8394969157122;710.1229980973494;716.3982254905904;4516.887077823015;4866.975665121722;4902.8774280643265;5035.597152227886;5059.392872855281;111695.88304117018;119579;120206.3989680046;120336;124872.37563812305;102305.48847255716;102751;105226.4738676317;107435;109600.4519977395;86101.56949215339;88376;90709.54645226864;93072;93250;9246.352755307063;9259.35184537076;9463.485842265205;9564.66523671668;9740.220782337254;52301.47698522966;52691.20963185632;52808;52921.4707852932;55047.449525505835;66920.33079669141;66988.6650566744;77085.22914770781;77167.98408103455;80093;12910.419031143809;13103.541376051793;13111.409986550438;13129.474821007052;13472.663183420102;14027.29863506841;14892.404303827725;14943.103413795207;15109.47116850949;16122.919385402998;13168.341582921008;13616.18302901829;13843.930780346034;14106.858931410554;14193.432262709788;13473.719996600308;13538.59384218475;13853.16880987144;13921.443142274196;13954.651133721738;12317.692057698629;12415.565455209024;13682.726345473235;13836.930815345859;14176.503822366167;11764.588239411922;11886.212706908584;12120.575779847662;12191.878081219429;12720.936395317964;11348.489317980875;12035.217710848767;12279.2018518796;12294.631161065183;12372.566960156351 17:36:29 INFO - PROCESS | 24258 | __end_tp_report 17:36:29 INFO - PROCESS | 24258 | __start_cc_report 17:36:29 INFO - PROCESS | 24258 | _x_x_mozilla_cycle_collect,338 17:36:29 INFO - PROCESS | 24258 | __end_cc_report 17:36:29 INFO - PROCESS | 24258 | __startTimestamp1469752589974__endTimestamp 17:36:29 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | ------- Summary: start ------- 17:36:29 INFO - PROCESS | 24258 | Number of tests: 6 17:36:29 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | [#0] dojo.html Cycles:165 Average:5352.35 Median:5543.61 stddev:606.71 (10.9%) stddev-sans-first:580.89 17:36:29 INFO - PROCESS | 24258 | Values: 3043.1 3060.0 3085.5 3090.3 3093.5 5261.6 5313.7 5401.6 5420.8 5485.5 5393.1 5406.3 5478.0 5484.6 5490.9 4890.2 4893.7 4936.0 4952.8 5038.3 4932.5 4989.3 5000.3 5039.7 5055.4 4715.5 4818.6 4870.3 4941.1 4952.9 4849.6 4868.1 4876.8 4882.1 4953.4 4871.8 4877.6 4889.9 4913.1 4989.6 5283.3 5351.0 5387.1 5393.7 5440.0 5677.0 5700.2 5724.8 5728.8 5801.5 5677.9 5719.4 5751.3 5781.8 5784.3 5181.2 5209.8 5249.1 5317.1 5356.3 5816.6 5835.3 5864.9 5875.7 5922.7 5556.1 5617.6 5619.6 5627.4 5651.9 5604.0 5711.5 5731.2 5772.4 5793.0 5490.3 5673.5 5727.5 5736.0 5833.4 5762.2 5762.6 5767.5 5770.6 5796.1 4371.3 4377.5 4442.3 4449.5 4450.0 3900.2 3942.6 3970.5 3978.2 3985.1 5449.7 5450.5 5452.3 5457.5 5458.4 5543.6 5645.9 5674.9 5675.1 5738.3 5490.3 5583.1 5590.9 5597.8 5611.6 5069.2 5074.7 5076.4 5088.2 5137.6 5816.5 5961.8 6059.6 6087.4 6104.1 5778.4 5841.5 5876.9 5881.0 5881.5 6053.2 6086.1 6089.7 6111.3 6119.1 5451.6 5578.9 5705.9 5745.2 5778.5 5699.6 5714.8 5747.6 5772.0 5811.3 5601.9 5607.9 5620.8 5621.6 5626.5 5480.7 5527.2 5590.8 5605.3 5639.0 5504.3 5510.8 5515.8 5541.6 5568.7 5592.4 5619.8 5634.0 5649.4 5665.1 5416.5 5519.5 5531.9 5551.5 5566.2 17:36:29 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | [#1] ext.html Cycles:180 Average:62191.00 Median:23107.66 stddev:128295.77 (555.2%) stddev-sans-first:128572.21 17:36:29 INFO - PROCESS | 24258 | Values: 554.0 586.2 587.0 613.2 618.8 38052.2 42069.8 42214.8 42367.8 42431.6 40768.0 41433.2 41441.6 41771.0 41880.6 8792.7 8811.4 8823.6 8877.7 8898.2 8746.6 8754.0 8759.8 8875.5 8908.6 8899.3 8945.1 8946.4 8952.2 8954.5 8818.9 8857.0 8878.7 8882.6 8913.1 8820.3 8876.1 8912.9 8922.9 8927.8 40873.0 40877.8 41225.2 41287.8 41290.0 2885.4 3166.9 3391.9 3495.5 4093.9 29882.9 29883.7 30315.2 31309.8 31599.0 4065.8 4066.1 4106.1 4170.6 4191.2 318124.0 319886.0 320464.4 320676.0 321369.0 33547.3 33672.0 33724.8 33726.2 33741.2 31417.4 31624.4 31724.5 31736.0 34883.5 14972.0 15027.0 15080.1 15106.5 15150.8 11429.8 11573.0 11597.6 11614.7 11640.9 18235.3 18343.4 18381.8 18405.5 18528.5 6379.5 6594.5 6712.1 6724.8 6772.8 963.7 1000.1 1050.2 1127.2 1154.9 32351.2 32406.0 32472.4 32639.8 33121.7 1093.9 1099.7 1138.3 1172.6 1203.5 15704.0 17052.9 17063.9 17086.9 17150.3 555306.0 561742.0 563536.0 570596.0 570803.9 59359.4 59874.4 60156.7 60945.4 61055.4 1300.6 1315.3 1359.4 1368.6 1377.4 30257.5 33076.0 33143.7 33351.8 35371.0 56668.4 57093.7 57385.1 57492.7 57737.1 521932.0 522201.0 522680.0 526682.0 531413.0 42129.8 43367.6 43646.3 43746.0 44295.0 47765.3 48060.5 48067.3 48984.8 49099.8 42463.0 43399.0 43545.0 44405.1 44888.8 42097.6 42300.6 42564.8 42690.4 43885.8 42024.2 44633.8 45220.8 45294.0 45938.1 40660.0 42416.8 43297.4 45018.0 46306.3 33143.5 34180.0 34856.5 34928.5 36513.8 17:36:29 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | [#2] jquery.html Cycles:180 Average:29274.81 Median:391.75 stddev:83415.11 (21293.1%) stddev-sans-first:83620.89 17:36:29 INFO - PROCESS | 24258 | Values: 372.9 382.0 384.0 399.5 409.2 18333.8 19145.1 19476.7 19873.3 20208.7 18453.8 18620.6 18967.9 19203.7 19386.8 5539.7 5820.0 5820.4 5953.9 5959.9 5614.0 5766.4 5805.3 5807.1 5812.6 5674.5 5692.1 5710.3 5753.4 5780.3 5642.0 5730.9 5740.4 5744.9 5766.5 5171.8 5178.8 5204.9 5228.9 5236.7 23093.7 23183.2 23286.8 23446.4 23841.6 2092.5 2198.1 2282.2 2538.5 2770.2 10320.6 10382.0 10539.9 10621.7 10685.7 1912.6 1919.8 1989.4 1990.2 2020.7 85972.0 86477.0 87910.6 88059.0 90714.5 10199.8 10242.0 10337.9 10348.3 10508.9 13810.0 13922.7 13971.6 14002.2 14216.6 7828.5 7934.4 7957.1 8118.7 8145.8 7642.9 7678.6 7681.0 7811.8 7980.6 4347.2 4376.6 4398.5 4598.8 4774.4 1768.3 1880.2 1883.6 1893.7 1926.2 940.7 971.3 971.7 982.7 997.4 19830.7 19885.0 20287.2 20291.9 20372.9 979.7 1008.5 1015.1 1029.6 1045.4 10385.5 11243.4 11258.2 11310.7 11365.4 493930.0 503794.0 505363.0 507024.0 521974.0 51270.0 55226.0 90261.5 96487.5 99742.5 914.5 936.9 957.2 959.2 959.7 17057.0 17447.5 17480.5 18172.0 18190.0 40132.4 41544.8 42156.2 42948.4 43480.6 51670.2 59251.4 61673.4 62242.4 64514.1 7107.9 7788.5 7846.7 7855.8 8020.8 12405.7 13517.7 13529.9 13608.5 13819.0 11487.4 11554.5 11830.9 12085.8 12501.1 11829.6 11917.5 11966.8 12001.7 12026.6 11685.4 11734.4 11797.9 11919.2 11965.9 7469.4 7641.0 7678.4 7814.7 7874.6 8723.7 11424.4 11927.6 11962.9 12000.2 17:36:29 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | [#3] mootools.html Cycles:180 Average:5827.58 Median:4633.15 stddev:3314.81 (71.5%) stddev-sans-first:3308.34 17:36:29 INFO - PROCESS | 24258 | Values: 1525.1 1539.4 1644.7 1739.2 1777.0 7855.6 8600.5 8712.3 9029.8 9111.1 8649.1 8946.4 8980.5 8982.0 9006.8 2320.4 2332.5 2340.9 2346.4 2354.9 2234.6 2276.2 2287.0 2293.4 2302.4 2317.3 2336.9 2348.3 2350.0 2361.9 2279.2 2290.7 2322.7 2331.4 2342.1 2270.1 2284.8 2287.4 2288.4 2290.4 9007.9 9065.0 9085.1 9101.4 9108.4 5124.7 5168.2 5218.7 5236.0 5258.5 3252.3 3278.3 3316.3 3347.6 3365.0 1089.6 1114.7 1121.7 1144.3 1153.8 11436.5 11507.6 11598.1 11633.2 11667.1 4456.7 4483.1 4631.6 4640.1 4668.2 10354.1 10361.0 10375.5 10389.2 10400.3 5345.1 5387.5 5389.9 5396.6 5433.0 4372.5 4634.7 4698.7 4702.6 4922.7 3905.4 3923.7 4051.4 4058.7 4101.4 1223.9 1223.9 1227.1 1260.7 1271.7 950.5 959.4 966.6 995.2 995.2 5612.9 5816.6 5847.1 5949.7 5964.9 423.4 429.0 429.6 433.2 1020.3 4180.6 4277.4 4277.9 4309.1 4322.6 11021.1 11073.5 11146.4 11155.8 11167.7 10299.1 10754.5 10778.2 11079.1 11138.7 8255.3 8457.8 8527.0 8537.4 8538.7 5982.2 6010.6 6049.0 6114.1 6211.0 10293.7 10337.1 10426.8 10440.7 10594.9 9470.5 9752.5 9912.5 10173.1 10547.7 7267.5 7840.3 7892.1 7971.1 8027.8 8722.1 8750.7 8776.9 8852.8 8874.6 7717.4 7813.8 7901.5 8025.2 8059.6 7737.8 7749.1 7801.1 7819.3 7910.8 7155.7 7164.2 7189.0 7196.2 7221.9 5271.5 5286.8 5319.3 5352.1 5456.0 5029.3 5105.4 5122.3 5212.8 5382.4 17:36:29 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | [#4] prototype.html Cycles:180 Average:4645.51 Median:5186.98 stddev:1336.62 (25.8%) stddev-sans-first:1300.36 17:36:29 INFO - PROCESS | 24258 | Values: 320.5 324.8 329.4 331.9 337.1 5281.9 5391.8 5461.5 5513.4 5548.3 5413.9 5433.0 5438.3 5455.0 5463.2 4235.6 4240.4 4249.9 4252.7 4274.8 4183.2 4251.3 4274.6 4284.6 4309.8 4263.6 4264.5 4276.2 4280.3 4281.7 4246.1 4278.0 4302.6 4318.5 4328.3 3664.6 3788.2 3796.8 3797.8 3804.7 5310.2 5345.8 5357.7 5411.9 5412.4 4883.4 4935.6 4943.7 4946.5 4956.4 5571.6 5683.8 5703.7 5722.0 5722.6 4106.3 4107.9 4116.9 4162.9 4176.6 5919.3 5984.2 6045.8 6047.2 6049.8 4086.0 4157.5 4252.7 4267.3 4278.2 4275.8 4276.4 4280.6 4285.0 4322.9 4906.7 4921.5 4921.7 4922.0 4940.2 5698.7 5797.8 5834.6 5837.7 5843.2 1438.2 1439.9 1443.4 1457.3 1460.1 910.9 932.8 953.6 963.8 974.7 4846.4 4900.7 4927.4 4927.9 4968.6 5191.6 5195.6 5199.8 5222.3 5227.9 4645.9 4838.7 4859.2 4915.7 4978.0 2737.3 2757.9 2762.0 2770.8 2780.2 5261.0 5320.4 5326.3 5336.6 5348.9 5065.0 5095.9 5230.2 5288.2 5298.6 5294.6 5332.5 5372.5 5378.6 5391.5 5055.1 5098.6 5145.8 5182.3 5205.0 4936.3 5079.5 5101.3 5117.6 5124.3 5305.5 5322.4 5324.8 5327.3 5352.1 3846.6 4006.0 4116.5 4211.3 4234.5 5826.2 5833.8 5847.0 5870.2 5904.7 5527.5 5739.7 5751.3 5760.4 5767.3 5639.7 5673.3 5694.0 5694.5 5729.3 5638.9 5651.9 5658.6 5659.3 5668.5 5555.3 5698.4 5727.5 5730.2 5813.3 5596.3 5605.0 5606.6 5617.2 5620.5 17:36:29 INFO - PROCESS | 24258 | 17:36:29 INFO - PROCESS | 24258 | [#5] yui.html Cycles:180 Average:21323.10 Median:4041.12 stddev:31218.40 (772.5%) stddev-sans-first:31267.68 17:36:29 INFO - PROCESS | 24258 | Values: 728.9 744.0 761.2 790.1 859.8 13514.2 14255.5 14471.1 14479.7 14493.9 12623.8 12691.2 12763.4 12845.0 12852.1 645.6 772.2 785.3 799.8 801.4 786.5 793.5 794.0 796.9 797.4 828.0 833.9 833.9 835.1 837.3 823.9 826.3 833.0 835.2 836.1 603.6 606.3 608.6 609.0 610.6 13193.1 13275.1 13335.0 13337.9 13359.5 15363.2 15418.3 15480.6 15530.1 15727.6 12428.8 12505.2 12656.9 12701.7 13195.3 3821.4 4034.8 4047.5 4076.3 4090.5 78316.6 78818.0 79638.6 80015.0 80169.2 10444.9 11096.4 11453.9 11466.7 11666.9 21140.6 21304.7 21324.3 21441.2 21563.9 8433.7 8491.5 8543.6 8631.8 8747.7 4827.2 4912.4 4933.7 4963.3 4975.0 3466.7 3511.6 3542.5 3578.1 3591.7 606.3 609.5 612.6 623.9 624.8 598.6 666.0 685.2 707.3 744.4 9669.9 10045.8 10148.6 10258.2 10332.6 672.1 695.7 697.8 710.1 716.4 4516.9 4867.0 4902.9 5035.6 5059.4 111695.9 119579.0 120206.4 120336.0 124872.4 102305.5 102751.0 105226.5 107435.0 109600.5 86101.6 88376.0 90709.5 93072.0 93250.0 9246.4 9259.4 9463.5 9564.7 9740.2 52301.5 52691.2 52808.0 52921.5 55047.4 66920.3 66988.7 77085.2 77168.0 80093.0 12910.4 13103.5 13111.4 13129.5 13472.7 14027.3 14892.4 14943.1 15109.5 16122.9 13168.3 13616.2 13843.9 14106.9 14193.4 13473.7 13538.6 13853.2 13921.4 13954.7 12317.7 12415.6 13682.7 13836.9 14176.5 11764.6 11886.2 12120.6 12191.9 12720.9 11348.5 12035.2 12279.2 12294.6 12372.6 17:36:29 INFO - PROCESS | 24258 | -------- Summary: end -------- 17:36:29 INFO - PROCESS | 24258 | 17:36:30 INFO - TEST-INFO | 24258: exit 0 17:36:30 INFO - TEST-OK | dromaeo_css | took 1112760ms 17:36:30 INFO - TEST-START | kraken 17:36:30 INFO - operating with platform_type : linux_ 17:36:30 INFO - Initialising browser for kraken test... 17:36:30 INFO - TEST-INFO | started process 24510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM0knEk/profile http://localhost:47303/getInfo.html) 17:36:34 INFO - PROCESS | 24510 | JavaScript error: , line 0: uncaught exception: undefined 17:36:35 INFO - PROCESS | 24510 | __metrics Screen width/height:1600/1200 17:36:35 INFO - PROCESS | 24510 | colorDepth:24 17:36:35 INFO - PROCESS | 24510 | Browser inner width/height: 1024/697 17:36:35 INFO - PROCESS | 24510 | __metrics 17:36:35 ERROR - PROCESS | 24510 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:36:36 INFO - TEST-INFO | 24510: exit 0 17:36:36 INFO - Browser initialized. 17:36:36 INFO - Running cycle 1/1 for kraken test... 17:36:36 INFO - TEST-INFO | started process 24627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM0knEk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:48 INFO - PROCESS | 24627 | RSS: Main: 164995072 17:36:48 INFO - PROCESS | 24627 | 17:36:51 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47303/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:52 INFO - PROCESS | 24627 | RSS: Main: 170106880 17:36:52 INFO - PROCESS | 24627 | 17:36:54 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47303/tests/kraken/driver.html?testName=audio-dft) 17:36:55 INFO - PROCESS | 24627 | RSS: Main: 169410560 17:36:55 INFO - PROCESS | 24627 | 17:36:58 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47303/tests/kraken/driver.html?testName=audio-fft) 17:36:58 INFO - PROCESS | 24627 | RSS: Main: 164941824 17:36:58 INFO - PROCESS | 24627 | 17:37:01 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47303/tests/kraken/driver.html?testName=audio-oscillator) 17:37:01 INFO - PROCESS | 24627 | RSS: Main: 166936576 17:37:01 INFO - PROCESS | 24627 | 17:37:03 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47303/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:04 INFO - PROCESS | 24627 | RSS: Main: 166756352 17:37:04 INFO - PROCESS | 24627 | 17:37:07 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47303/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:08 INFO - PROCESS | 24627 | RSS: Main: 166965248 17:37:08 INFO - PROCESS | 24627 | 17:37:11 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47303/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:12 INFO - PROCESS | 24627 | RSS: Main: 164896768 17:37:12 INFO - PROCESS | 24627 | 17:37:15 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47303/tests/kraken/driver.html?testName=json-parse-financial) 17:37:15 INFO - PROCESS | 24627 | RSS: Main: 165998592 17:37:15 INFO - PROCESS | 24627 | 17:37:17 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47303/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:18 INFO - PROCESS | 24627 | RSS: Main: 166211584 17:37:18 INFO - PROCESS | 24627 | 17:37:19 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47303/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:20 INFO - PROCESS | 24627 | RSS: Main: 166563840 17:37:20 INFO - PROCESS | 24627 | 17:37:22 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47303/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:23 INFO - PROCESS | 24627 | RSS: Main: 167141376 17:37:23 INFO - PROCESS | 24627 | 17:37:25 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:26 INFO - PROCESS | 24627 | RSS: Main: 167088128 17:37:26 INFO - PROCESS | 24627 | 17:37:29 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:29 INFO - PROCESS | 24627 | RSS: Main: 167329792 17:37:29 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | Cycle 1(1): loaded http://localhost:47303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47303/tests/kraken/driver.html?testName=ai-astar) 17:37:31 INFO - PROCESS | 24627 | RSS: Main: 167997440 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | __start_tp_report 17:37:31 INFO - PROCESS | 24627 | _x_x_mozilla_page_load 17:37:31 INFO - PROCESS | 24627 | _x_x_mozilla_page_load_details 17:37:31 INFO - PROCESS | 24627 | |i|pagename|runs| 17:37:31 INFO - PROCESS | 24627 | |0;ai-astar;104;112;106;111;112;112;112;112;112;112 17:37:31 INFO - PROCESS | 24627 | |1;audio-beat-detection;151;119;146;192;123;149;147;122;172;122 17:37:31 INFO - PROCESS | 24627 | |2;audio-dft;164;163;163;163;163;165;170;164;162;162 17:37:31 INFO - PROCESS | 24627 | |3;audio-fft;75;75;75;171;77;77;74;75;163;77 17:37:31 INFO - PROCESS | 24627 | |4;audio-oscillator;85;85;163;84;87;86;143;85;84;144 17:37:31 INFO - PROCESS | 24627 | |5;imaging-gaussian-blur;118;118;118;118;119;118;118;118;118;118 17:37:31 INFO - PROCESS | 24627 | |6;imaging-darkroom;147;146;147;150;147;148;147;149;147;148 17:37:31 INFO - PROCESS | 24627 | |7;imaging-desaturate;96;97;96;96;95;96;97;97;97;95 17:37:31 INFO - PROCESS | 24627 | |8;json-parse-financial;57;59;56;56;56;58;57;55;55;59 17:37:31 INFO - PROCESS | 24627 | |9;json-stringify-tinderbox;64;65;63;64;65;64;65;65;67;64 17:37:31 INFO - PROCESS | 24627 | |10;stanford-crypto-aes;83;78;77;80;77;82;78;76;81;79 17:37:31 INFO - PROCESS | 24627 | |11;stanford-crypto-ccm;143;130;135;130;120;128;122;137;158;120 17:37:31 INFO - PROCESS | 24627 | |12;stanford-crypto-pbkdf2;163;161;158;158;158;158;157;164;163;159 17:37:31 INFO - PROCESS | 24627 | |13;stanford-crypto-sha256-iterative;73;68;64;64;69;64;64;65;66;63 17:37:31 INFO - PROCESS | 24627 | __end_tp_report 17:37:31 INFO - PROCESS | 24627 | __start_cc_report 17:37:31 INFO - PROCESS | 24627 | _x_x_mozilla_cycle_collect,885 17:37:31 INFO - PROCESS | 24627 | __end_cc_report 17:37:31 INFO - PROCESS | 24627 | __startTimestamp1469752651843__endTimestamp 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | ------- Summary: start ------- 17:37:31 INFO - PROCESS | 24627 | Number of tests: 14 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:2.95 (2.6%) stddev-sans-first:1.99 17:37:31 INFO - PROCESS | 24627 | Values: 104.0 112.0 106.0 111.0 112.0 112.0 112.0 112.0 112.0 112.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:148.00 stddev:24.06 (16.3%) stddev-sans-first:25.39 17:37:31 INFO - PROCESS | 24627 | Values: 151.0 119.0 146.0 192.0 123.0 149.0 147.0 122.0 172.0 122.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.33 (1.4%) stddev-sans-first:2.47 17:37:31 INFO - PROCESS | 24627 | Values: 164.0 163.0 163.0 163.0 163.0 165.0 170.0 164.0 162.0 162.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.00 stddev:38.59 (51.4%) stddev-sans-first:40.32 17:37:31 INFO - PROCESS | 24627 | Values: 75.0 75.0 75.0 171.0 77.0 77.0 74.0 75.0 163.0 77.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:85.00 stddev:31.79 (37.4%) stddev-sans-first:32.92 17:37:31 INFO - PROCESS | 24627 | Values: 85.0 85.0 163.0 84.0 87.0 86.0 143.0 85.0 84.0 144.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:37:31 INFO - PROCESS | 24627 | Values: 118.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 118.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:1.22 17:37:31 INFO - PROCESS | 24627 | Values: 147.0 146.0 147.0 150.0 147.0 148.0 147.0 149.0 147.0 148.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 17:37:31 INFO - PROCESS | 24627 | Values: 96.0 97.0 96.0 96.0 95.0 96.0 97.0 97.0 97.0 95.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.48 (2.6%) stddev-sans-first:1.56 17:37:31 INFO - PROCESS | 24627 | Values: 57.0 59.0 56.0 56.0 56.0 58.0 57.0 55.0 55.0 59.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 17:37:31 INFO - PROCESS | 24627 | Values: 64.0 65.0 63.0 64.0 65.0 64.0 65.0 65.0 67.0 64.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:2.33 (2.9%) stddev-sans-first:2.00 17:37:31 INFO - PROCESS | 24627 | Values: 83.0 78.0 77.0 80.0 77.0 82.0 78.0 76.0 81.0 79.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:132.50 stddev:11.75 (8.9%) stddev-sans-first:11.81 17:37:31 INFO - PROCESS | 24627 | Values: 143.0 130.0 135.0 130.0 120.0 128.0 122.0 137.0 158.0 120.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.00 stddev:2.60 (1.6%) stddev-sans-first:2.51 17:37:31 INFO - PROCESS | 24627 | Values: 163.0 161.0 158.0 158.0 158.0 158.0 157.0 164.0 163.0 159.0 17:37:31 INFO - PROCESS | 24627 | 17:37:31 INFO - PROCESS | 24627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.50 stddev:3.13 (4.8%) stddev-sans-first:2.05 17:37:31 INFO - PROCESS | 24627 | Values: 73.0 68.0 64.0 64.0 69.0 64.0 64.0 65.0 66.0 63.0 17:37:31 INFO - PROCESS | 24627 | -------- Summary: end -------- 17:37:31 INFO - PROCESS | 24627 | 17:37:32 INFO - TEST-INFO | 24627: exit 0 17:37:32 INFO - TEST-OK | kraken | took 62163ms 17:37:32 INFO - SUITE-END | took 1174s 17:37:33 INFO - Completed test suite (00:19:35) 17:37:33 INFO - javascript benchmark 17:37:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7221.094325236603, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.1327071784544, 3059.9847000764994, 3085.4600444922135, 3090.2583379988796, 3093.505039193729, 5261.6316857819875, 5313.68117912925, 5401.621886467954, 5420.783168673253, 5485.506304432601, 5393.056215162341, 5406.297181366427, 5477.986572484093, 5484.561235101192, 5490.945090549093, 4890.193118135503, 4893.706377617345, 4936.0, 4952.826651067214, 5038.269450929613, 4932.482089380599, 4989.301497790312, 5000.299958005882, 5039.6976181429045, 5055.39335279767, 4715.504871988461, 4818.638602104821, 4870.342503761982, 4941.061198372297, 4952.87617809554, 4849.612031037544, 4868.05073010763, 4876.804927802919, 4882.072406242838, 4953.356063711731, 4871.8294859679745, 4877.6341774367065, 4889.853304400874, 4913.140200464904, 4989.625778066623, 5283.339582552181, 5351.0, 5387.1111266640955, 5393.703346315951, 5439.972800135974, 5677.0, 5700.173474846166, 5724.771009159628, 5728.828135155952, 5801.506871915893, 5677.943220567783, 5719.428057194247, 5751.281089863767, 5781.768729250825, 5784.2769653793275, 5181.1969144782615, 5209.817656382046, 5249.081410753103, 5317.1226747586215, 5356.330458692663, 5816.5928385013485, 5835.299764028344, 5864.9413505864395, 5875.706214689249, 5922.703864806743, 5556.138798486241, 5617.606767526316, 5619.606627536115, 5627.380988091307, 5651.943480565142, 5604.047311956977, 5711.543076553866, 5731.226284451629, 5772.422757724278, 5793.0, 5490.258815059916, 5673.5461163107675, 5727.5131613812455, 5736.0, 5833.38749431312, 5762.164486149485, 5762.625429347079, 5767.509761670305, 5770.567207459458, 5796.130580412888, 4371.256886329332, 4377.540358262337, 4442.267025940683, 4449.488308844459, 4450.020995381075, 3900.2004589059175, 3942.5860284669698, 3970.5235371754998, 3978.244133614604, 3985.0834308109297, 5449.700266485382, 5450.454954504517, 5452.291202143696, 5457.536109430743, 5458.426865179099, 5543.61194716374, 5645.943540564542, 5674.886502269931, 5675.091985282335, 5738.254026976467, 5490.313710786152, 5583.134614134816, 5590.888182236414, 5597.80407685729, 5611.635243709227, 5069.239614057847, 5074.695518268915, 5076.36545431821, 5088.160453525201, 5137.588992880561, 5816.47651711348, 5961.8211453655595, 6059.575829691879, 6087.421694938974, 6104.053871649901, 5778.422157784188, 5841.50347220491, 5876.94123058781, 5881.029630110984, 5881.470667639933, 6053.182820319201, 6086.1175129606845, 6089.725962331617, 6111.266648002268, 6119.051547010221, 5451.591130665137, 5578.944210557843, 5705.857353566028, 5745.224394706661, 5778.537716982715, 5699.629524080921, 5714.828555143353, 5747.626404283708, 5772.0, 5811.331696854747, 5601.943980560142, 5607.915881261866, 5620.803271885465, 5621.550275977994, 5626.465485778845, 5480.671159730429, 5527.170924361378, 5590.7763689453595, 5605.271314729059, 5638.971805140948, 5504.311961004874, 5510.80712175088, 5515.834524964257, 5541.639793413416, 5568.6658800472105, 5592.440755924537, 5619.80330688424, 5634.014047541746, 5649.350324712546, 5665.065264231355, 5416.51251387377, 5519.475649813261, 5531.8893622128135, 5551.500364967173, 5566.165075238747], "value": 5311.193484203621, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.0139090771164, 586.2173997713053, 587.0138167877964, 613.2089604410311, 618.8421952402136, 38052.23895522091, 42069.78965105174, 42214.788926055364, 42367.78816105923, 42431.57568424315, 40767.98080047993, 41433.17133657325, 41441.58558414415, 41771.0, 41880.581194188046, 8792.736217913473, 8811.427257228292, 8823.602937867812, 8877.68928087517, 8898.243649289818, 8746.562671866413, 8754.037055923875, 8759.78100547485, 8875.535536636447, 8908.599113039929, 8899.28805695546, 8945.060768619267, 8946.41848279863, 8952.239059679934, 8954.507502087383, 8818.911810881906, 8856.955715221415, 8878.689245876363, 8882.600282987249, 8913.064128266567, 8820.250278726251, 8876.112388761072, 8912.8663070054, 8922.86615700765, 8927.794747709042, 40873.0, 40877.795611022055, 41225.1754964902, 41287.793561032304, 41290.0, 2885.365219651694, 3166.8733250669948, 3391.9491207631904, 3495.4756786481976, 4093.9385909211387, 29882.85058574715, 29883.70116298831, 30315.242118946982, 31309.843450782828, 31599.0, 4065.79671016448, 4066.125782956649, 4106.096658735103, 4170.562090980464, 4191.161767646483, 318124.0, 319886.0, 320464.39767801244, 320676.0, 321369.0, 33547.329053419286, 33672.0, 33724.831375842965, 33726.156846079044, 33741.15647108842, 31417.37165256682, 31624.367512649616, 31724.524132138038, 31736.0, 34883.4767478488, 14972.0, 15027.0, 15080.095194288378, 15106.54680359591, 15150.848491515164, 11429.771404571862, 11573.0, 11597.594084207012, 11614.6515604532, 11640.883591164149, 18235.27058917655, 18343.431919531275, 18381.81618183828, 18405.5398615033, 18528.536786580444, 6379.489640828722, 6594.472442204708, 6712.060311556386, 6724.7646332378135, 6772.796816095525, 963.6579014449909, 1000.1498726082917, 1050.1598721023151, 1127.1940562497853, 1154.861416629993, 32351.191220219684, 32406.0, 32472.35055298928, 32639.836800815843, 33121.668783311856, 1093.9179561532917, 1099.70308016835, 1138.3113216504062, 1172.6013155527162, 1203.4644583160584, 15704.0, 17052.914735426242, 17063.91468042652, 17086.91456542734, 17150.313987440364, 555306.0, 561742.0, 563536.0, 570596.0, 570803.8977466451, 59359.40640593625, 59874.40125598775, 60156.699216503635, 60945.39054609486, 61055.38944610497, 1300.6033159886326, 1315.2897435384975, 1359.422245545639, 1368.637311112536, 1377.3526442571974, 30257.546136808407, 33076.0, 33143.66856331406, 33351.83324083364, 35371.0, 56668.433315667964, 57093.714531427075, 57385.13922291253, 57492.71253643705, 57737.13394299005, 521932.0, 522201.0, 522680.0, 526682.0, 531413.0, 42129.78935105305, 43367.56632433762, 43646.34530481982, 43746.0, 44295.0, 47765.283520747915, 48060.519394807, 48067.27899081447, 48984.75507622439, 49099.75450122727, 42463.0, 43399.0, 43545.0, 44405.11189776251, 44888.77555612331, 42097.579024209364, 42300.57699422966, 42564.78717606516, 42690.35964460474, 43885.78057109694, 42024.159516810105, 44633.77683111564, 45220.77389613031, 45294.0, 45938.081238375715, 40660.0, 42416.787916060224, 43297.35053974256, 45018.0, 46306.30540541827, 33143.502847456824, 34180.0, 34856.47715284323, 34928.47607285842, 36513.81743091268], "value": 19910.084364403956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8788143853247, 381.99427008594876, 384.01846472203425, 399.4766855419399, 409.2204350711893, 18333.816661833378, 19145.138468768888, 19476.70784938227, 19873.304434344802, 20208.696869546933, 18453.815461845377, 18620.62758744824, 18967.90516047418, 19203.711944320847, 19386.806131938676, 5539.723013849311, 5820.010598198316, 5820.447057529528, 5953.88092238155, 5959.910601340984, 5614.0, 5766.423357664221, 5805.303363596353, 5807.128930660392, 5812.564057695668, 5674.546036317085, 5692.060809966371, 5710.257666503348, 5753.424657534255, 5780.277465316835, 5641.971790141023, 5730.914036289459, 5740.368559458477, 5744.856378590527, 5766.481016708495, 5171.844844654666, 5178.818741344073, 5204.9479505204845, 5228.947710522884, 5236.685798852043, 23093.653595196087, 23183.188588399324, 23286.76713232863, 23446.413839653975, 23841.642375364383, 2092.4978005278776, 2198.1097655449566, 2282.167009041704, 2538.4796116796015, 2770.224337185591, 10320.638777642822, 10382.0, 10539.894601053968, 10621.681349559525, 10685.679429617125, 1912.6174765046908, 1919.827215550593, 1989.3932350633052, 1990.203918432624, 2020.7474065741783, 85972.0, 86477.0, 87910.56044719735, 88059.0, 90714.5464272681, 10199.796004080024, 10242.0, 10337.9483102584, 10348.327358721659, 10508.894911050944, 13810.033297669066, 13922.651933701738, 13971.58085257444, 14002.22987735664, 14216.64458388528, 7828.491148075357, 7934.365250779923, 7957.124716281204, 8118.675252989932, 8145.8370832584205, 7642.885356719654, 7678.577678227751, 7681.0, 7811.80470488231, 7980.640871160812, 4347.239233134189, 4376.6498680105515, 4398.494173170063, 4598.839040633628, 4774.355462012653, 1768.2838450427598, 1880.2385034061226, 1883.5950270691867, 1893.651871679108, 1926.2198809482181, 940.741296143566, 971.2715463402449, 971.6744890461633, 982.6757170133839, 997.396575072071, 19830.70253946192, 19885.0, 20287.18851245963, 20291.8985405075, 20372.89813550923, 979.6522234606755, 1008.4856723071287, 1015.1422048369117, 1029.629333439961, 1045.414567842011, 10385.480725963671, 11243.381614011145, 11258.155638327158, 11310.717232069099, 11365.431728413547, 493930.0, 503794.0, 505363.0, 507024.0, 521974.0, 51270.0, 55226.0, 90261.54869225612, 96487.51756241314, 99742.5012874931, 914.4513292024732, 936.9344145909721, 957.2198658093631, 959.203860795538, 959.7120863740989, 17057.0, 17447.47657570275, 17480.47558573245, 18172.0, 18190.0, 40132.3980140304, 41544.792276038424, 42156.15687686291, 42948.35577466278, 43480.565194347655, 51670.22494662508, 59251.40748592459, 61673.38326616676, 62242.377576223655, 64514.09686564022, 7107.893381599383, 7788.454808163374, 7846.686132554634, 7855.764327070197, 8020.799480013046, 12405.689857753629, 13517.729645407233, 13529.932350338186, 13608.523701670394, 13819.0, 11487.425628718698, 11554.537818487503, 11830.881691182978, 12085.75828483443, 12501.062420318694, 11829.645110646694, 11917.52329906794, 11966.760664786829, 12001.699957500783, 12026.639200823989, 11685.357305348287, 11734.413279335828, 11797.941010294893, 11919.225250358699, 11965.880341196476, 7469.439792015512, 7640.958814512976, 7678.385729141543, 7814.72648457324, 7874.645640946285, 8723.69467068675, 11424.371659558805, 11927.642170734893, 11962.940185299018, 12000.15998880105], "value": 9108.153818593157, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.1001908873761, 1539.3842463014794, 1644.7039532884085, 1739.1565090930903, 1777.0492786359293, 7855.60721963901, 8600.526971016592, 8712.346574006942, 9029.780979567764, 9111.088891110894, 8649.135086491347, 8946.373753837233, 8980.461172329664, 8982.0, 9006.774830629238, 2320.4198950262394, 2332.4985128197436, 2340.8946597403155, 2346.4133966508375, 2354.929352119439, 2234.5866014787234, 2276.157821606008, 2287.039443433762, 2293.4037150340864, 2302.3783578433813, 2317.339558225906, 2336.906523739048, 2348.295511346589, 2349.9765002350014, 2361.8819059047064, 2279.190887235041, 2290.713660792401, 2322.686437330964, 2331.393837602227, 2342.121704360865, 2270.137347807839, 2284.794368506826, 2287.4395773035544, 2288.39357570244, 2290.358699564125, 9007.909920900773, 9065.048169942127, 9085.13691199335, 9101.408408453495, 9108.362414630978, 5124.718140502271, 5168.173092305213, 5218.6868787872845, 5236.005159019774, 5258.474152584711, 3252.349530093991, 3278.2951665392056, 3316.3201543683485, 3347.5648165738544, 3365.0241429985276, 1089.6131873184984, 1114.7157474843943, 1121.7195701074731, 1144.3362849547325, 1153.7634784869165, 11436.542538298458, 11507.597234096851, 11598.072154227642, 11633.185677002613, 11667.06663466929, 4456.710313829591, 4483.14820184164, 4631.560001799824, 4640.141573808856, 4668.159731248408, 10354.068133867988, 10361.0, 10375.533101010473, 10389.220808439397, 10400.323978941344, 5345.1447768356875, 5387.515123638891, 5389.892202155935, 5396.568274538027, 5432.972835135799, 4372.540883207281, 4634.745089020136, 4698.671093023456, 4702.553257440606, 4922.655414121049, 3905.433712111728, 3923.725339226227, 4051.4125451809323, 4058.7158898877387, 4101.364288535282, 1223.8714934931882, 1223.9020878329711, 1227.0858210633135, 1260.6596219020996, 1271.6947932496319, 950.4907045400149, 959.4195511715451, 966.5747071288611, 995.1988649137369, 995.1988649137514, 5612.915806262909, 5816.563757718188, 5847.06446968483, 5949.702514874239, 5964.940350596526, 423.36706623597917, 428.9506706728704, 429.6455424274986, 433.20074462616424, 1020.2756043209405, 4180.602842729997, 4277.379779931893, 4277.914441711148, 4309.07354918694, 4322.610965013164, 11021.118310535137, 11073.50169242386, 11146.386948717736, 11155.776884462266, 11167.72080697989, 10299.073083422529, 10754.516046777913, 10778.19163562736, 11079.058280046287, 11138.721531961766, 8255.25702686749, 8457.830843383097, 8526.957365213135, 8537.445066070686, 8538.743837684879, 5982.222311099529, 6010.609310394811, 6048.969755151196, 6114.0828875669, 6211.0, 10293.691189264335, 10337.0696637303, 10426.791464170827, 10440.68677939663, 10594.894051059391, 9470.479123648265, 9752.46361450127, 9912.504374781376, 10173.084422401724, 10547.683569492927, 7267.491275610657, 7840.255175758294, 7892.0529536456, 7971.083325417651, 8027.799305017421, 8722.084181160886, 8750.737477875675, 8776.868346974928, 8852.822943540965, 8874.645014199617, 7717.382609391348, 7813.765587032398, 7901.525908445512, 8025.197480251928, 8059.597020148852, 7737.845243095219, 7749.108852482037, 7801.102873169431, 7819.335356494534, 7910.762677119696, 7155.677994490156, 7164.247753985965, 7189.0, 7196.244394338519, 7221.855562888608, 5271.525562699376, 5286.841394758163, 5319.335083114611, 5352.143657014859, 5456.0, 5029.321041659329, 5105.412877519133, 5122.334096567572, 5212.765425555935, 5382.407935127211], "value": 4600.615321348195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5368242889026, 324.790510120972, 329.37418904082244, 331.8523257150569, 337.1133917796196, 5281.947180528194, 5391.757370918308, 5461.535769459596, 5513.365962914261, 5548.250986116873, 5413.945860541394, 5433.0, 5438.265834112393, 5455.0, 5463.2078348639425, 4235.555266696999, 4240.427542281784, 4249.91754040521, 4252.744835309892, 4274.7862606869685, 4183.247015537202, 4251.319788833787, 4274.615284624383, 4284.60062365075, 4309.784510774464, 4263.63563659629, 4264.466941632296, 4276.230278549875, 4280.250956082688, 4281.743095414269, 4246.129543443602, 4277.957220427803, 4302.612764851178, 4318.5465526119615, 4328.264195086843, 3664.5785734640326, 3788.204477059821, 3796.8481260749536, 3797.82267497074, 3804.6766024887916, 5310.176922577007, 5345.812896548641, 5357.678539287655, 5411.918821217685, 5412.3505179378335, 4883.389576302962, 4935.6051515879, 4943.678660887031, 4946.505349465061, 4956.405231372259, 5571.582131340125, 5683.8010669626365, 5703.657780533182, 5721.971390143064, 5722.599418040697, 4106.260873042851, 4107.8973025674295, 4116.897077573085, 4162.895927601804, 4176.561461046576, 5919.3488716240745, 5984.162217289583, 6045.848853778691, 6047.244094488189, 6049.820285044418, 4086.0, 4157.521884983205, 4252.702310838212, 4267.295896177158, 4278.187144442546, 4275.8075886585175, 4276.401303817468, 4280.636145927569, 4284.9716068143425, 4322.8703138905885, 4906.730129842893, 4921.4832442593015, 4921.729304888266, 4922.015596880567, 4940.184869496493, 5698.746275819313, 5797.768089276382, 5834.649921004669, 5837.737301821428, 5843.152742852262, 1438.2233593859407, 1439.8920080993967, 1443.3721331220952, 1457.3369117051716, 1460.1312219229542, 910.904355042711, 932.7734029750856, 953.6423841059602, 963.8241345558407, 974.6929717139078, 4846.418429788448, 4900.656954013256, 4927.359443272423, 4927.926081108786, 4968.552830245295, 5191.636585439059, 5195.636305458582, 5199.816077247489, 5222.3472065991755, 5227.947720522822, 4645.907081858344, 4838.661293709407, 4859.246816743411, 4915.681914707629, 4978.0, 2737.3293543081672, 2757.869273597815, 2761.9585706214425, 2770.7644850187958, 2780.235435255321, 5261.0, 5320.430473010394, 5326.334208223972, 5336.62643614951, 5348.87673588543, 5065.027357707665, 5095.898082038412, 5230.189320655304, 5288.180332048539, 5298.576113910878, 5294.590961112684, 5332.520073193431, 5372.48961348679, 5378.623496355218, 5391.487808658171, 5055.140626093499, 5098.592112630907, 5145.78388507183, 5182.32629758129, 5205.0, 4936.259561065869, 5079.5428411443145, 5101.285819985279, 5117.5650069743, 5124.30821839047, 5305.495977882095, 5322.38792538863, 5324.8136315228785, 5327.254184414262, 5352.143657014859, 3846.6345697158727, 4005.9799701001307, 4116.485439320085, 4211.284081706179, 4234.470691163605, 5826.242588463472, 5833.812320379858, 5846.970765146317, 5870.152975806815, 5904.704764761659, 5527.535203171083, 5739.684317362585, 5751.252337196305, 5760.366359700346, 5767.3367562729145, 5639.7180140993605, 5673.290838645169, 5694.0, 5694.515966142924, 5729.341125770589, 5638.887222255614, 5651.886962260814, 5658.603897727119, 5659.320881494247, 5668.534187628395, 5555.2500412445415, 5698.373178950395, 5727.51084717968, 5730.226419433323, 5813.273340832396, 5596.3284405871555, 5604.971975140098, 5606.551475881838, 5617.1914042978515, 5620.494155526022], "value": 4218.050689710621, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.8578727148201, 743.9665215065321, 761.200739223815, 790.1466416270429, 859.8409294280557, 13514.189148651089, 14255.501057462965, 14471.059381140218, 14479.710405791879, 14493.855061449382, 12623.810642840364, 12691.238525688465, 12763.425645845937, 12845.0, 12852.051959995399, 645.6416688737748, 772.1622040086485, 785.3246208260891, 799.8360336131079, 801.3509057663282, 786.5477350523472, 793.5278509286965, 794.0312818361618, 796.8685166947447, 797.401948538596, 827.9917200828005, 833.8790875323075, 833.9124391938819, 835.1189495082685, 837.3217693668117, 823.8887750153773, 826.2563692676579, 832.9754402085408, 835.1564919431388, 836.0719601242646, 603.6378173096151, 606.3451472409787, 608.5892022884535, 609.0, 610.6122612141278, 13193.076484646079, 13275.137116087424, 13335.0, 13337.86662133376, 13359.465621375231, 15363.15502647354, 15418.306176222097, 15480.612984675361, 15530.145841978687, 15727.606809829731, 12428.75142497145, 12505.249685018836, 12656.873431265754, 12701.74596508074, 13195.340232988312, 3821.3885778275344, 4034.7895631310785, 4047.4535937648334, 4076.266272071026, 4090.468239128924, 78316.60841695812, 78818.0, 79638.60180699118, 80015.0, 80169.19830801734, 10444.895551044545, 11096.445177741081, 11453.885461145448, 11466.656000320003, 11666.88333116658, 21140.577188456144, 21304.680429793567, 21324.253651122137, 21441.249556265455, 21563.892180539, 8433.704820331259, 8491.532965686947, 8543.641145238971, 8631.827363452696, 8747.65009399617, 4827.179379505493, 4912.38595175603, 4933.679310844784, 4963.255511673206, 4975.029869175476, 3466.7053300469743, 3511.631278715698, 3542.4509201073874, 3578.0697018775304, 3591.730620203495, 606.3269770554681, 609.5367520684312, 612.592625903778, 623.8533944523033, 624.8156793745856, 598.5750117416683, 666.0079051383399, 685.2017399729259, 707.3068392974914, 744.3821628048706, 9669.9033009669, 10045.79908401828, 10148.594056237667, 10258.17934565248, 10332.638357657446, 672.1094549721638, 695.6973716433367, 697.8394969157122, 710.1229980973494, 716.3982254905904, 4516.887077823015, 4866.975665121722, 4902.8774280643265, 5035.597152227886, 5059.392872855281, 111695.88304117018, 119579.0, 120206.3989680046, 120336.0, 124872.37563812305, 102305.48847255716, 102751.0, 105226.4738676317, 107435.0, 109600.4519977395, 86101.56949215339, 88376.0, 90709.54645226864, 93072.0, 93250.0, 9246.352755307063, 9259.35184537076, 9463.485842265205, 9564.66523671668, 9740.220782337254, 52301.47698522966, 52691.20963185632, 52808.0, 52921.4707852932, 55047.449525505835, 66920.33079669141, 66988.6650566744, 77085.22914770781, 77167.98408103455, 80093.0, 12910.419031143809, 13103.541376051793, 13111.409986550438, 13129.474821007052, 13472.663183420102, 14027.29863506841, 14892.404303827725, 14943.103413795207, 15109.47116850949, 16122.919385402998, 13168.341582921008, 13616.18302901829, 13843.930780346034, 14106.858931410554, 14193.432262709788, 13473.719996600308, 13538.59384218475, 13853.16880987144, 13921.443142274196, 13954.651133721738, 12317.692057698629, 12415.565455209024, 13682.726345473235, 13836.930815345859, 14176.503822366167, 11764.588239411922, 11886.212706908584, 12120.575779847662, 12191.878081219429, 12720.936395317964, 11348.489317980875, 12035.217710848767, 12279.2018518796, 12294.631161065183, 12372.566960156351], "value": 7584.898913041159, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 106.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 146.0, 192.0, 123.0, 149.0, 147.0, 122.0, 172.0, 122.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 163.0, 165.0, 170.0, 164.0, 162.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 171.0, 77.0, 77.0, 74.0, 75.0, 163.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 163.0, 84.0, 87.0, 86.0, 143.0, 85.0, 84.0, 144.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 150.0, 147.0, 148.0, 147.0, 149.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 97.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 56.0, 56.0, 56.0, 58.0, 57.0, 55.0, 55.0, 59.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 65.0, 64.0, 65.0, 65.0, 67.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 77.0, 80.0, 77.0, 82.0, 78.0, 76.0, 81.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 130.0, 135.0, 130.0, 120.0, 128.0, 122.0, 137.0, 158.0, 120.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 158.0, 158.0, 158.0, 158.0, 157.0, 164.0, 163.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 64.0, 64.0, 69.0, 64.0, 64.0, 65.0, 66.0, 63.0], "value": 66.0, "unit": "score"}]}]} 17:37:33 INFO - Return code: 0 17:37:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:37:33 ERROR - # TBPL SUCCESS # 17:37:33 INFO - Running post-action listener: _resource_record_post_action 17:37:33 INFO - [mozharness: 2016-07-29 00:37:33.164062Z] Finished run-tests step (success) 17:37:33 INFO - Running post-run listener: _resource_record_post_run 17:37:33 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 565551104; Read time: 8; Write time: 551988 17:37:33 INFO - TinderboxPrint: CPU usage
13.5% 17:37:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 17:37:33 INFO - TinderboxPrint: I/O write bytes / time
565,551,104 / 551,988 17:37:33 INFO - TinderboxPrint: CPU idle
8,237.3 (86.5%) 17:37:33 INFO - TinderboxPrint: CPU user
1,219.8 (12.8%) 17:37:33 INFO - TinderboxPrint: Swap in / out
0 / 0 17:37:33 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256950272; Read time: 0; Write time: 312356 17:37:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296022016; Read time: 0; Write time: 237740 17:37:33 INFO - Running post-run listener: _upload_blobber_files 17:37:33 INFO - Blob upload gear active. 17:37:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:33 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 17:37:33 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'] 17:37:33 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 17:37:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:37:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:35 INFO - (blobuploader) - INFO - Done attempting. 17:37:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:37:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:37:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:40 INFO - (blobuploader) - INFO - Done attempting. 17:37:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:37:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:37:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:40 INFO - (blobuploader) - INFO - Done attempting. 17:37:40 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:40 INFO - Return code: 0 17:37:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:37:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7faa3cc0621211b129308326d36647b1c69f35958710e194c9d62625dca88cd233a7fab641ba315560de5169cc17b646aad6e0f07de17e0c6742615fc3aebe2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e31cb570485415991c1eb1079ef14a6b25ce4341a47e06424df078e2a9fe8d9ad9fecabb4b0f80de64520cc4cad9ed9511bcaeecf7445238897c64f03ffba57f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fa3638b812ec3b4f3faf7e8923360011195dd5fc6d4a37a56f10a0bda09f4da4856d1047d3ae1f8a3d3d8386d45d8160c931a105ec7f3d890cae69cb4097419"} 17:37:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:37:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:37:40 INFO - Contents: 17:37:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7faa3cc0621211b129308326d36647b1c69f35958710e194c9d62625dca88cd233a7fab641ba315560de5169cc17b646aad6e0f07de17e0c6742615fc3aebe2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e31cb570485415991c1eb1079ef14a6b25ce4341a47e06424df078e2a9fe8d9ad9fecabb4b0f80de64520cc4cad9ed9511bcaeecf7445238897c64f03ffba57f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fa3638b812ec3b4f3faf7e8923360011195dd5fc6d4a37a56f10a0bda09f4da4856d1047d3ae1f8a3d3d8386d45d8160c931a105ec7f3d890cae69cb4097419"} 17:37:40 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:40 INFO - Copying logs to upload dir... 17:37:40 INFO - mkdir: /builds/slave/test/build/upload/logs 17:37:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.146397 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-28 17:37:40.698885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 17:37:40.702700) ========= 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=52faae308a556c440401f8e5000001e8-1469749840.753002-418951562 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/7faa3cc0621211b129308326d36647b1c69f35958710e194c9d62625dca88cd233a7fab641ba315560de5169cc17b646aad6e0f07de17e0c6742615fc3aebe2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e31cb570485415991c1eb1079ef14a6b25ce4341a47e06424df078e2a9fe8d9ad9fecabb4b0f80de64520cc4cad9ed9511bcaeecf7445238897c64f03ffba57f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fa3638b812ec3b4f3faf7e8923360011195dd5fc6d4a37a56f10a0bda09f4da4856d1047d3ae1f8a3d3d8386d45d8160c931a105ec7f3d890cae69cb4097419"} build_url:https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/T_lntCrTQwu9uuNMa98NMQ/artifacts/public/build/firefox-50.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/7faa3cc0621211b129308326d36647b1c69f35958710e194c9d62625dca88cd233a7fab641ba315560de5169cc17b646aad6e0f07de17e0c6742615fc3aebe2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e31cb570485415991c1eb1079ef14a6b25ce4341a47e06424df078e2a9fe8d9ad9fecabb4b0f80de64520cc4cad9ed9511bcaeecf7445238897c64f03ffba57f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fa3638b812ec3b4f3faf7e8923360011195dd5fc6d4a37a56f10a0bda09f4da4856d1047d3ae1f8a3d3d8386d45d8160c931a105ec7f3d890cae69cb4097419"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 17:37:40.728004) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:37:40.728350) ========= 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=52faae308a556c440401f8e5000001e8-1469749840.753002-418951562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 17:37:40.811810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 17:37:40.812156) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 17:37:40.812494) ========= ========= Total master_lag: 0.15 =========