builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1463477002.09 results: success (0) buildid: 20160516233009 builduid: f0f9d8f4a7e846339ee28a0ec5cc4dbc revision: 4c709f7a03350ad5e36d0d726c8f12106ed2049d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.085869) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.086340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.086641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.102753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.103033) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 02:23:22-- 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% 223M=0s 2016-05-17 02:23:22 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.233894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.234210) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014104 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.283457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:22.283798) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c709f7a03350ad5e36d0d726c8f12106ed2049d --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 4c709f7a03350ad5e36d0d726c8f12106ed2049d --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=4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 02:23:22,360 truncating revision to first 12 chars 2016-05-17 02:23:22,360 Setting DEBUG logging. 2016-05-17 02:23:22,360 attempt 1/10 2016-05-17 02:23:22,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c709f7a0335?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 02:23:23,052 unpacking tar archive at: fx-team-4c709f7a0335/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:23.279579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:23.279904) ========= script_repo_revision: 4c709f7a03350ad5e36d0d726c8f12106ed2049d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:23.280293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:23.280573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 02:23:23.289138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-17 02:23:23.289415) ========= /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=4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:23:23 INFO - MultiFileLogger online at 20160517 02:23:23 in /builds/slave/test 02:23:23 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 02:23:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:23:23 INFO - {'append_to_log': False, 02:23:23 INFO - 'base_work_dir': '/builds/slave/test', 02:23:23 INFO - 'blob_upload_branch': 'Fx-Team', 02:23:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:23:23 INFO - 'branch': 'Fx-Team', 02:23:23 INFO - 'buildbot_json_path': 'buildprops.json', 02:23:23 INFO - 'config_files': ('talos/linux_config.py',), 02:23:23 INFO - 'default_actions': ('clobber', 02:23:23 INFO - 'read-buildbot-config', 02:23:23 INFO - 'download-and-extract', 02:23:23 INFO - 'populate-webroot', 02:23:23 INFO - 'create-virtualenv', 02:23:23 INFO - 'install', 02:23:23 INFO - 'run-tests'), 02:23:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:23:23 INFO - 'download_minidump_stackwalk': True, 02:23:23 INFO - 'download_symbols': 'ondemand', 02:23:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:23:23 INFO - 'tooltool.py': '/tools/tooltool.py', 02:23:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:23:23 INFO - '/tools/misc-python/virtualenv.py')}, 02:23:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:23:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:23:23 INFO - 'installer_path': 'installer.exe', 02:23:23 INFO - 'log_level': 'info', 02:23:23 INFO - 'log_name': 'talos', 02:23:23 INFO - 'log_to_console': True, 02:23:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:23:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:23:23 INFO - 'opt_config_files': (), 02:23:23 INFO - 'pip_index': False, 02:23:23 INFO - 'sps_profile': False, 02:23:23 INFO - 'sps_profile_interval': 0, 02:23:23 INFO - 'suite': 'dromaeojs-e10s', 02:23:23 INFO - 'system_bits': '32', 02:23:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:23:23 INFO - 'title': 'talos-linux64-ix-030', 02:23:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:23:23 INFO - 'use_talos_json': True, 02:23:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:23:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:23:23 INFO - 'work_dir': 'build'} 02:23:23 INFO - ##### 02:23:23 INFO - ##### Running clobber step. 02:23:23 INFO - ##### 02:23:23 INFO - Running pre-action listener: _resource_record_pre_action 02:23:23 INFO - Running main action method: clobber 02:23:23 INFO - rmtree: /builds/slave/test/build 02:23:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:23:23 INFO - Running post-action listener: _resource_record_post_action 02:23:23 INFO - ##### 02:23:23 INFO - ##### Finished clobber step (success) 02:23:23 INFO - ##### 02:23:23 INFO - ##### 02:23:23 INFO - ##### Running read-buildbot-config step. 02:23:23 INFO - ##### 02:23:23 INFO - Running pre-action listener: _resource_record_pre_action 02:23:23 INFO - Running main action method: read_buildbot_config 02:23:23 INFO - Using buildbot properties: 02:23:23 INFO - { 02:23:23 INFO - "project": "", 02:23:23 INFO - "product": "firefox", 02:23:23 INFO - "script_repo_revision": "production", 02:23:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:23:23 INFO - "repository": "", 02:23:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:23:23 INFO - "buildid": "20160516233009", 02:23:23 INFO - "pgo_build": "True", 02:23:23 INFO - "basedir": "/builds/slave/test", 02:23:23 INFO - "buildnumber": 471, 02:23:23 INFO - "slavename": "talos-linux64-ix-030", 02:23:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:23:23 INFO - "platform": "ubuntu64_hw", 02:23:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:23:23 INFO - "branch": "fx-team", 02:23:23 INFO - "repo_path": "integration/fx-team", 02:23:23 INFO - "revision": "4c709f7a03350ad5e36d0d726c8f12106ed2049d", 02:23:23 INFO - "stage_platform": "linux64-pgo", 02:23:23 INFO - "builduid": "f0f9d8f4a7e846339ee28a0ec5cc4dbc", 02:23:23 INFO - "slavebuilddir": "test" 02:23:23 INFO - } 02:23:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:23:23 INFO - Running post-action listener: _resource_record_post_action 02:23:23 INFO - ##### 02:23:23 INFO - ##### Finished read-buildbot-config step (success) 02:23:23 INFO - ##### 02:23:23 INFO - ##### 02:23:23 INFO - ##### Running download-and-extract step. 02:23:23 INFO - ##### 02:23:23 INFO - Running pre-action listener: _resource_record_pre_action 02:23:23 INFO - Running main action method: download_and_extract 02:23:23 INFO - mkdir: /builds/slave/test/build/tests 02:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:23 INFO - https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:23:24 INFO - Downloaded 1361 bytes. 02:23:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:23:24 INFO - Using the following test package requirements: 02:23:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:23:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:23:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:23:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'jsshell-linux-x86_64.zip'], 02:23:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:23:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:23:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:23:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:23:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:23:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:23:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:24 INFO - https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:23:25 INFO - Downloaded 24022682 bytes. 02:23:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:23:26 INFO - Return code: 0 02:23:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:23: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')]} 02:23:26 INFO - https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:23:27 INFO - Downloaded 24022682 bytes. 02:23:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:23:29 INFO - Return code: 0 02:23: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')]} 02:23:29 INFO - https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:23:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:23:30 INFO - Downloaded 10840194 bytes. 02:23:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:23:30 INFO - Return code: 0 02:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:30 INFO - https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:23:32 INFO - Downloaded 58424138 bytes. 02:23:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:32 INFO - mkdir: /builds/slave/test/properties 02:23:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:23:32 INFO - Writing to file /builds/slave/test/properties/build_url 02:23:32 INFO - Contents: 02:23:32 INFO - build_url:https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:23:33 INFO - Running post-action listener: _resource_record_post_action 02:23:33 INFO - Running post-action listener: set_extra_try_arguments 02:23:33 INFO - ##### 02:23:33 INFO - ##### Finished download-and-extract step (success) 02:23:33 INFO - ##### 02:23:33 INFO - ##### 02:23:33 INFO - ##### Running populate-webroot step. 02:23:33 INFO - ##### 02:23:33 INFO - Running pre-action listener: _resource_record_pre_action 02:23:33 INFO - Running main action method: populate_webroot 02:23:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:23:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:23:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:23:33 INFO - '--tppagecycles', 02:23:33 INFO - '7'], 02:23:33 INFO - 'tests': ['tsvgm']}}, 02:23:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:23:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:23:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:23:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:23:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:33 INFO - 'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:33 INFO - 'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['damp', 'tps']}, 02:23:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:33 INFO - 'tests': ['damp', 'tps']}, 02:23:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['dromaeo_dom']}, 02:23:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:23:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['a11yr', 02:23:33 INFO - 'ts_paint', 02:23:33 INFO - 'tpaint', 02:23:33 INFO - 'sessionrestore', 02:23:33 INFO - 'sessionrestore_no_auto_restore', 02:23:33 INFO - 'tabpaint']}, 02:23:33 INFO - 'other-e10s': {'tests': ['a11yr', 02:23:33 INFO - 'ts_paint', 02:23:33 INFO - 'tpaint', 02:23:33 INFO - 'sessionrestore', 02:23:33 INFO - 'sessionrestore_no_auto_restore', 02:23:33 INFO - 'tabpaint']}, 02:23:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:23:33 INFO - 'ts_paint', 02:23:33 INFO - 'tpaint', 02:23:33 INFO - 'sessionrestore', 02:23:33 INFO - 'sessionrestore_no_auto_restore', 02:23:33 INFO - 'tabpaint']}, 02:23:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:23:33 INFO - 'ts_paint', 02:23:33 INFO - 'tpaint', 02:23:33 INFO - 'sessionrestore', 02:23:33 INFO - 'sessionrestore_no_auto_restore', 02:23:33 INFO - 'tabpaint']}, 02:23:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['a11yr', 02:23:33 INFO - 'ts_paint', 02:23:33 INFO - 'tpaint', 02:23:33 INFO - 'sessionrestore', 02:23:33 INFO - 'sessionrestore_no_auto_restore', 02:23:33 INFO - 'tabpaint']}, 02:23:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['a11yr', 02:23:33 INFO - 'ts_paint', 02:23:33 INFO - 'tpaint', 02:23:33 INFO - 'sessionrestore', 02:23:33 INFO - 'sessionrestore_no_auto_restore', 02:23:33 INFO - 'tabpaint']}, 02:23:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['tsvgx', 02:23:33 INFO - 'tsvgr_opacity', 02:23:33 INFO - 'tart', 02:23:33 INFO - 'tscrollx', 02:23:33 INFO - 'cart']}, 02:23:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:23:33 INFO - 'tsvgr_opacity', 02:23:33 INFO - 'tart', 02:23:33 INFO - 'tscrollx', 02:23:33 INFO - 'cart']}, 02:23:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:33 INFO - 'talos_options': ['--disable-e10s'], 02:23:33 INFO - 'tests': ['tp5o']}, 02:23:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:33 INFO - 'tests': ['tp5o']}, 02:23:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:33 INFO - 'talos_options': ['--disable-e10s', 02:23:33 INFO - '--xperf_path', 02:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:33 INFO - 'tests': ['tp5n']}, 02:23:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:33 INFO - 'talos_options': ['--xperf_path', 02:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:33 INFO - 'tests': ['tp5n']}}, 02:23:33 INFO - 'talos.zip': {'path': '', 02:23:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:23:33 INFO - Running post-action listener: _resource_record_post_action 02:23:33 INFO - ##### 02:23:33 INFO - ##### Finished populate-webroot step (success) 02:23:33 INFO - ##### 02:23:33 INFO - ##### 02:23:33 INFO - ##### Running create-virtualenv step. 02:23:33 INFO - ##### 02:23:33 INFO - Running pre-action listener: _resource_record_pre_action 02:23:33 INFO - Running main action method: create_virtualenv 02:23:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:23:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:23:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:23:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:23:33 INFO - Using real prefix '/usr' 02:23:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:23:33 INFO - Installing distribute.............................................................................................................................................................................................done. 02:23:35 INFO - Installing pip.................done. 02:23:35 INFO - Return code: 0 02:23:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:23:35 INFO - Using env: {'DISPLAY': ':0', 02:23:35 INFO - 'HOME': '/home/cltbld', 02:23:35 INFO - 'LANG': 'en_US.UTF-8', 02:23:35 INFO - 'LANGUAGE': 'en_US:en', 02:23:35 INFO - 'LOGNAME': 'cltbld', 02:23:35 INFO - 'MAIL': '/var/mail/cltbld', 02:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:35 INFO - 'MOZ_NO_REMOTE': '1', 02:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:35 INFO - 'NO_EM_RESTART': '1', 02:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:35 INFO - 'PWD': '/builds/slave/test', 02:23:35 INFO - 'SHELL': '/bin/bash', 02:23:35 INFO - 'SHLVL': '1', 02:23:35 INFO - 'TERM': 'linux', 02:23:35 INFO - 'TMOUT': '86400', 02:23:35 INFO - 'USER': 'cltbld', 02:23:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:35 INFO - '_': '/tools/buildbot/bin/python'} 02:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:23:36 INFO - Cleaning up... 02:23:36 INFO - Return code: 0 02:23:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:23:36 INFO - Using env: {'DISPLAY': ':0', 02:23:36 INFO - 'HOME': '/home/cltbld', 02:23:36 INFO - 'LANG': 'en_US.UTF-8', 02:23:36 INFO - 'LANGUAGE': 'en_US:en', 02:23:36 INFO - 'LOGNAME': 'cltbld', 02:23:36 INFO - 'MAIL': '/var/mail/cltbld', 02:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:36 INFO - 'MOZ_NO_REMOTE': '1', 02:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:36 INFO - 'NO_EM_RESTART': '1', 02:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:36 INFO - 'PWD': '/builds/slave/test', 02:23:36 INFO - 'SHELL': '/bin/bash', 02:23:36 INFO - 'SHLVL': '1', 02:23:36 INFO - 'TERM': 'linux', 02:23:36 INFO - 'TMOUT': '86400', 02:23:36 INFO - 'USER': 'cltbld', 02:23:36 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:36 INFO - '_': '/tools/buildbot/bin/python'} 02:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:36 INFO - Downloading/unpacking psutil>=3.1.1 02:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:38 INFO - Installing collected packages: psutil 02:23:38 INFO - Running setup.py install for psutil 02:23:38 INFO - building 'psutil._psutil_linux' extension 02:23:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:23:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:23:38 INFO - building 'psutil._psutil_posix' extension 02:23:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:23:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:38 INFO - Successfully installed psutil 02:23:38 INFO - Cleaning up... 02:23:38 INFO - Return code: 0 02:23:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:23:38 INFO - Using env: {'DISPLAY': ':0', 02:23:38 INFO - 'HOME': '/home/cltbld', 02:23:38 INFO - 'LANG': 'en_US.UTF-8', 02:23:38 INFO - 'LANGUAGE': 'en_US:en', 02:23:38 INFO - 'LOGNAME': 'cltbld', 02:23:38 INFO - 'MAIL': '/var/mail/cltbld', 02:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:38 INFO - 'MOZ_NO_REMOTE': '1', 02:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:38 INFO - 'NO_EM_RESTART': '1', 02:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:38 INFO - 'PWD': '/builds/slave/test', 02:23:38 INFO - 'SHELL': '/bin/bash', 02:23:38 INFO - 'SHLVL': '1', 02:23:38 INFO - 'TERM': 'linux', 02:23:38 INFO - 'TMOUT': '86400', 02:23:38 INFO - 'USER': 'cltbld', 02:23:38 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:38 INFO - '_': '/tools/buildbot/bin/python'} 02:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:23:41 INFO - Installing collected packages: mozsystemmonitor 02:23:41 INFO - Running setup.py install for mozsystemmonitor 02:23:41 INFO - Successfully installed mozsystemmonitor 02:23:41 INFO - Cleaning up... 02:23:41 INFO - Return code: 0 02:23:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:41 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 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:23:41 INFO - Using env: {'DISPLAY': ':0', 02:23:41 INFO - 'HOME': '/home/cltbld', 02:23:41 INFO - 'LANG': 'en_US.UTF-8', 02:23:41 INFO - 'LANGUAGE': 'en_US:en', 02:23:41 INFO - 'LOGNAME': 'cltbld', 02:23:41 INFO - 'MAIL': '/var/mail/cltbld', 02:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:41 INFO - 'MOZ_NO_REMOTE': '1', 02:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:41 INFO - 'NO_EM_RESTART': '1', 02:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:41 INFO - 'PWD': '/builds/slave/test', 02:23:41 INFO - 'SHELL': '/bin/bash', 02:23:41 INFO - 'SHLVL': '1', 02:23:41 INFO - 'TERM': 'linux', 02:23:41 INFO - 'TMOUT': '86400', 02:23:41 INFO - 'USER': 'cltbld', 02:23:41 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:41 INFO - '_': '/tools/buildbot/bin/python'} 02:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:41 INFO - Downloading/unpacking blobuploader==1.2.4 02:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:23:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:23:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:43 INFO - Downloading docopt-0.6.1.tar.gz 02:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:23:43 INFO - Installing collected packages: blobuploader, requests, docopt 02:23:43 INFO - Running setup.py install for blobuploader 02:23:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:23:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:23:44 INFO - Running setup.py install for requests 02:23:44 INFO - Running setup.py install for docopt 02:23:44 INFO - Successfully installed blobuploader requests docopt 02:23:44 INFO - Cleaning up... 02:23:44 INFO - Return code: 0 02:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:44 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 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:23:44 INFO - Using env: {'DISPLAY': ':0', 02:23:44 INFO - 'HOME': '/home/cltbld', 02:23:44 INFO - 'LANG': 'en_US.UTF-8', 02:23:44 INFO - 'LANGUAGE': 'en_US:en', 02:23:44 INFO - 'LOGNAME': 'cltbld', 02:23:44 INFO - 'MAIL': '/var/mail/cltbld', 02:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:44 INFO - 'MOZ_NO_REMOTE': '1', 02:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:44 INFO - 'NO_EM_RESTART': '1', 02:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:44 INFO - 'PWD': '/builds/slave/test', 02:23:44 INFO - 'SHELL': '/bin/bash', 02:23:44 INFO - 'SHLVL': '1', 02:23:44 INFO - 'TERM': 'linux', 02:23:44 INFO - 'TMOUT': '86400', 02:23:44 INFO - 'USER': 'cltbld', 02:23:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:44 INFO - '_': '/tools/buildbot/bin/python'} 02:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:44 INFO - Running setup.py (path:/tmp/pip-Zx8QnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:44 INFO - Running setup.py (path:/tmp/pip-WMRBeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:44 INFO - Running setup.py (path:/tmp/pip-OJlA8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:45 INFO - Running setup.py (path:/tmp/pip-OtM59C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:45 INFO - Running setup.py (path:/tmp/pip-qD1XgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:45 INFO - Running setup.py (path:/tmp/pip-wrD0eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:45 INFO - Running setup.py (path:/tmp/pip-Jc7Osm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:45 INFO - Running setup.py (path:/tmp/pip-hfrDm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:45 INFO - Running setup.py (path:/tmp/pip-CiTd_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:45 INFO - Running setup.py (path:/tmp/pip-vziL9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:45 INFO - Running setup.py (path:/tmp/pip-6CiMPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:45 INFO - Running setup.py (path:/tmp/pip-aEpMzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:45 INFO - Running setup.py (path:/tmp/pip-JXgggH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:45 INFO - Running setup.py (path:/tmp/pip-XTTQeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:45 INFO - Running setup.py (path:/tmp/pip-rDsroQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:45 INFO - Running setup.py (path:/tmp/pip-UG3_RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:45 INFO - Running setup.py (path:/tmp/pip-miaqNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:23:46 INFO - Running setup.py install for manifestparser 02:23:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Running setup.py install for mozcrash 02:23:46 INFO - Running setup.py install for mozdebug 02:23:46 INFO - Running setup.py install for mozdevice 02:23:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Running setup.py install for mozfile 02:23:46 INFO - Running setup.py install for mozhttpd 02:23:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Running setup.py install for mozinfo 02:23:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Running setup.py install for mozInstall 02:23:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:23:46 INFO - Running setup.py install for mozleak 02:23:46 INFO - Running setup.py install for mozlog 02:23:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:23:47 INFO - Running setup.py install for moznetwork 02:23:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:23:47 INFO - Running setup.py install for mozprocess 02:23:47 INFO - Running setup.py install for mozprofile 02:23:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:23:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:23:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:23:47 INFO - Running setup.py install for mozrunner 02:23:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:23:47 INFO - Running setup.py install for mozscreenshot 02:23:47 INFO - Running setup.py install for moztest 02:23:47 INFO - Running setup.py install for mozversion 02:23:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:23:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:23:47 INFO - Cleaning up... 02:23:47 INFO - Return code: 0 02:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:47 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 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:23:47 INFO - Using env: {'DISPLAY': ':0', 02:23:47 INFO - 'HOME': '/home/cltbld', 02:23:47 INFO - 'LANG': 'en_US.UTF-8', 02:23:47 INFO - 'LANGUAGE': 'en_US:en', 02:23:47 INFO - 'LOGNAME': 'cltbld', 02:23:47 INFO - 'MAIL': '/var/mail/cltbld', 02:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:47 INFO - 'MOZ_NO_REMOTE': '1', 02:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:47 INFO - 'NO_EM_RESTART': '1', 02:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:47 INFO - 'PWD': '/builds/slave/test', 02:23:47 INFO - 'SHELL': '/bin/bash', 02:23:47 INFO - 'SHLVL': '1', 02:23:47 INFO - 'TERM': 'linux', 02:23:47 INFO - 'TMOUT': '86400', 02:23:47 INFO - 'USER': 'cltbld', 02:23:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:47 INFO - '_': '/tools/buildbot/bin/python'} 02:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:48 INFO - Running setup.py (path:/tmp/pip-9aYB9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:48 INFO - Running setup.py (path:/tmp/pip-V9qIgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:48 INFO - Running setup.py (path:/tmp/pip-UAcP8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:48 INFO - Running setup.py (path:/tmp/pip-IE2I4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:48 INFO - Running setup.py (path:/tmp/pip-BsLVW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:48 INFO - Running setup.py (path:/tmp/pip-Pnkap4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:48 INFO - Running setup.py (path:/tmp/pip-cqACT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:48 INFO - Running setup.py (path:/tmp/pip-FJgtMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:48 INFO - Running setup.py (path:/tmp/pip-wXlJuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:48 INFO - Running setup.py (path:/tmp/pip-vHhOHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:48 INFO - Running setup.py (path:/tmp/pip-Qp4dfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:48 INFO - Running setup.py (path:/tmp/pip-uJTecU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:48 INFO - Running setup.py (path:/tmp/pip-SUteBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:48 INFO - Running setup.py (path:/tmp/pip-7D_mPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:49 INFO - Running setup.py (path:/tmp/pip-69QAVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:49 INFO - Running setup.py (path:/tmp/pip-oZnEq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:49 INFO - Running setup.py (path:/tmp/pip-vi_juU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:51 INFO - Downloading blessings-1.6.tar.gz 02:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:51 INFO - Installing collected packages: blessings 02:23:51 INFO - Running setup.py install for blessings 02:23:51 INFO - Successfully installed blessings 02:23:51 INFO - Cleaning up... 02:23:51 INFO - Return code: 0 02:23:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:51 INFO - Reading from file tmpfile_stdout 02:23:51 INFO - Current package versions: 02:23:51 INFO - argparse == 1.2.1 02:23:51 INFO - blessings == 1.6 02:23:51 INFO - blobuploader == 1.2.4 02:23:51 INFO - docopt == 0.6.1 02:23:51 INFO - manifestparser == 1.1 02:23:51 INFO - mozInstall == 1.12 02:23:51 INFO - mozcrash == 0.17 02:23:51 INFO - mozdebug == 0.1 02:23:51 INFO - mozdevice == 0.48 02:23:51 INFO - mozfile == 1.2 02:23:51 INFO - mozhttpd == 0.7 02:23:51 INFO - mozinfo == 0.9 02:23:51 INFO - mozleak == 0.1 02:23:51 INFO - mozlog == 3.2 02:23:51 INFO - moznetwork == 0.27 02:23:51 INFO - mozprocess == 0.22 02:23:51 INFO - mozprofile == 0.28 02:23:51 INFO - mozrunner == 6.11 02:23:51 INFO - mozscreenshot == 0.1 02:23:51 INFO - mozsystemmonitor == 0.3 02:23:51 INFO - moztest == 0.7 02:23:51 INFO - mozversion == 1.4 02:23:51 INFO - psutil == 3.1.1 02:23:51 INFO - requests == 1.2.3 02:23:51 INFO - wsgiref == 0.1.2 02:23:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:51 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 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:23:51 INFO - Using env: {'DISPLAY': ':0', 02:23:51 INFO - 'HOME': '/home/cltbld', 02:23:51 INFO - 'LANG': 'en_US.UTF-8', 02:23:51 INFO - 'LANGUAGE': 'en_US:en', 02:23:51 INFO - 'LOGNAME': 'cltbld', 02:23:51 INFO - 'MAIL': '/var/mail/cltbld', 02:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:51 INFO - 'MOZ_NO_REMOTE': '1', 02:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:51 INFO - 'NO_EM_RESTART': '1', 02:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:51 INFO - 'PWD': '/builds/slave/test', 02:23:51 INFO - 'SHELL': '/bin/bash', 02:23:51 INFO - 'SHLVL': '1', 02:23:51 INFO - 'TERM': 'linux', 02:23:51 INFO - 'TMOUT': '86400', 02:23:51 INFO - 'USER': 'cltbld', 02:23:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:51 INFO - '_': '/tools/buildbot/bin/python'} 02:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:23:51 INFO - Cleaning up... 02:23:51 INFO - Return code: 0 02:23:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:23:51 INFO - Using env: {'DISPLAY': ':0', 02:23:51 INFO - 'HOME': '/home/cltbld', 02:23:51 INFO - 'LANG': 'en_US.UTF-8', 02:23:51 INFO - 'LANGUAGE': 'en_US:en', 02:23:51 INFO - 'LOGNAME': 'cltbld', 02:23:51 INFO - 'MAIL': '/var/mail/cltbld', 02:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:51 INFO - 'MOZ_NO_REMOTE': '1', 02:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:51 INFO - 'NO_EM_RESTART': '1', 02:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:51 INFO - 'PWD': '/builds/slave/test', 02:23:51 INFO - 'SHELL': '/bin/bash', 02:23:51 INFO - 'SHLVL': '1', 02:23:51 INFO - 'TERM': 'linux', 02:23:51 INFO - 'TMOUT': '86400', 02:23:51 INFO - 'USER': 'cltbld', 02:23:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:51 INFO - '_': '/tools/buildbot/bin/python'} 02:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:51 INFO - Downloading/unpacking jsonschema 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:23:53 INFO - Downloading/unpacking functools32 (from jsonschema) 02:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:54 INFO - Downloading functools32-3.2.3-2.tar.gz 02:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:23:54 INFO - warning: no files found matching '*.txt' 02:23:54 INFO - no previously-included directories found matching 'build' 02:23:54 INFO - no previously-included directories found matching 'dist' 02:23:54 INFO - no previously-included directories found matching '.git*' 02:23:54 INFO - Installing collected packages: jsonschema, functools32 02:23:54 INFO - Running setup.py install for functools32 02:23:54 INFO - warning: no files found matching '*.txt' 02:23:54 INFO - no previously-included directories found matching 'build' 02:23:54 INFO - no previously-included directories found matching 'dist' 02:23:54 INFO - no previously-included directories found matching '.git*' 02:23:54 INFO - Successfully installed jsonschema functools32 02:23:54 INFO - Cleaning up... 02:23:54 INFO - Return code: 0 02:23:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6230f1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:23:54 INFO - Using env: {'DISPLAY': ':0', 02:23:54 INFO - 'HOME': '/home/cltbld', 02:23:54 INFO - 'LANG': 'en_US.UTF-8', 02:23:54 INFO - 'LANGUAGE': 'en_US:en', 02:23:54 INFO - 'LOGNAME': 'cltbld', 02:23:54 INFO - 'MAIL': '/var/mail/cltbld', 02:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:54 INFO - 'MOZ_NO_REMOTE': '1', 02:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:54 INFO - 'NO_EM_RESTART': '1', 02:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:54 INFO - 'PWD': '/builds/slave/test', 02:23:54 INFO - 'SHELL': '/bin/bash', 02:23:54 INFO - 'SHLVL': '1', 02:23:54 INFO - 'TERM': 'linux', 02:23:54 INFO - 'TMOUT': '86400', 02:23:54 INFO - 'USER': 'cltbld', 02:23:54 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:54 INFO - '_': '/tools/buildbot/bin/python'} 02:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:54 INFO - Downloading/unpacking flake8 02:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:23:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:23:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:57 INFO - no previously-included directories found matching 'docs/_build' 02:23:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:23:57 INFO - Running setup.py install for pep8 02:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:57 INFO - no previously-included directories found matching 'docs/_build' 02:23:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:23:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:23:57 INFO - Cleaning up... 02:23:57 INFO - Return code: 0 02:23:57 INFO - Running post-action listener: _resource_record_post_action 02:23:57 INFO - Running post-action listener: _start_resource_monitoring 02:23:57 INFO - Starting resource monitoring. 02:23:57 INFO - ##### 02:23:57 INFO - ##### Finished create-virtualenv step (success) 02:23:57 INFO - ##### 02:23:57 INFO - ##### 02:23:57 INFO - ##### Running install step. 02:23:57 INFO - ##### 02:23:57 INFO - Running pre-action listener: _resource_record_pre_action 02:23:57 INFO - Running main action method: install 02:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:57 INFO - Reading from file tmpfile_stdout 02:23:57 INFO - Detecting whether we're running mozinstall >=1.0... 02:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:23:57 INFO - Reading from file tmpfile_stdout 02:23:57 INFO - Output received: 02:23:57 INFO - Usage: mozinstall [options] installer 02:23:57 INFO - Options: 02:23:57 INFO - -h, --help show this help message and exit 02:23:57 INFO - -d DEST, --destination=DEST 02:23:57 INFO - Directory to install application into. [default: 02:23:57 INFO - "/builds/slave/test"] 02:23:57 INFO - --app=APP Application being installed. [default: firefox] 02:23:57 INFO - mkdir: /builds/slave/test/build/application 02:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:24:14 INFO - Reading from file tmpfile_stdout 02:24:14 INFO - Output received: 02:24:14 INFO - /builds/slave/test/build/application/firefox/firefox 02:24:14 INFO - Running post-action listener: _resource_record_post_action 02:24:14 INFO - ##### 02:24:14 INFO - ##### Finished install step (success) 02:24:14 INFO - ##### 02:24:14 INFO - ##### 02:24:14 INFO - ##### Running run-tests step. 02:24:14 INFO - ##### 02:24:14 INFO - Running pre-action listener: _resource_record_pre_action 02:24:14 INFO - Running main action method: run_tests 02:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:24:14 INFO - Python 2.7.3 02:24:14 INFO - Return code: 0 02:24:14 INFO - grabbing minidump binary from tooltool 02:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:14 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 0x167e9c0>, '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 0x167f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:24:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:24:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:24:14 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 02:24:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:24:14 INFO - Return code: 0 02:24:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:24:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:24:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:24:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:24:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:24:15 INFO - Return code: 0 02:24:15 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/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:24:15 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/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:24:15 INFO - Using env: {'DISPLAY': ':0', 02:24:15 INFO - 'HOME': '/home/cltbld', 02:24:15 INFO - 'LANG': 'en_US.UTF-8', 02:24:15 INFO - 'LANGUAGE': 'en_US:en', 02:24:15 INFO - 'LOGNAME': 'cltbld', 02:24:15 INFO - 'MAIL': '/var/mail/cltbld', 02:24:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:24:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:15 INFO - 'MOZ_NO_REMOTE': '1', 02:24:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:15 INFO - 'NO_EM_RESTART': '1', 02:24:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:15 INFO - 'PWD': '/builds/slave/test', 02:24:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:24:15 INFO - 'SHELL': '/bin/bash', 02:24:15 INFO - 'SHLVL': '1', 02:24:15 INFO - 'TERM': 'linux', 02:24:15 INFO - 'TMOUT': '86400', 02:24:15 INFO - 'USER': 'cltbld', 02:24:15 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901', 02:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:15 INFO - '_': '/tools/buildbot/bin/python'} 02:24:15 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/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:24:15 INFO - mozversion application_buildid: 20160516233009 02:24:15 INFO - mozversion application_changeset: 4c709f7a03350ad5e36d0d726c8f12106ed2049d 02:24:15 INFO - mozversion application_display_name: Nightly 02:24:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:24:15 INFO - mozversion application_name: Firefox 02:24:15 INFO - mozversion application_remotingname: firefox 02:24:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:24:15 INFO - mozversion application_vendor: Mozilla 02:24:15 INFO - mozversion application_version: 49.0a1 02:24:15 INFO - mozversion platform_buildid: 20160516233009 02:24:15 INFO - mozversion platform_changeset: 4c709f7a03350ad5e36d0d726c8f12106ed2049d 02:24:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:24:15 INFO - mozversion platform_version: 49.0a1 02:24:15 INFO - using testdate: 1463477055 02:24:15 INFO - actual date: 1463477055 02:24:15 INFO - starting webserver on 'localhost:53031' 02:24:15 INFO - SUITE-START | Running 2 tests 02:24:15 INFO - TEST-START | dromaeo_css 02:24:15 INFO - operating with platform_type : linux_ 02:24:15 INFO - Initialising browser for dromaeo_css test... 02:24:15 INFO - TEST-INFO | started process 9661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLR0SRl/profile http://localhost:53031/getInfo.html) 02:24:18 INFO - PROCESS | 9661 | 02:24:18 INFO - PROCESS | 9661 | (process:9728): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:24:19 INFO - PROCESS | 9661 | __metrics Screen width/height:1600/1200 02:24:19 INFO - PROCESS | 9661 | colorDepth:24 02:24:19 INFO - PROCESS | 9661 | Browser inner width/height: 1024/697 02:24:19 INFO - PROCESS | 9661 | __metrics 02:24:20 ERROR - PROCESS | 9661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:24:21 INFO - TEST-INFO | 9661: exit 0 02:24:21 INFO - Browser initialized. 02:24:21 INFO - Running cycle 1/1 for dromaeo_css test... 02:24:21 INFO - TEST-INFO | started process 9779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLR0SRl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:24:22 INFO - PROCESS | 9779 | 02:24:22 INFO - PROCESS | 9779 | (process:9840): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:24:32 INFO - PROCESS | 9779 | RSS: Main: 163950592 02:24:32 INFO - PROCESS | 9779 | 02:25:22 INFO - PROCESS | 9779 | 1463477122482 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:27:30 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:53031/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53031/tests/dromaeo/cssquery-ext.html) 02:27:31 INFO - PROCESS | 9779 | RSS: Main: 166383616 02:27:31 INFO - PROCESS | 9779 | 02:30:33 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:53031/tests/dromaeo/cssquery-ext.html (next: http://localhost:53031/tests/dromaeo/cssquery-jquery.html) 02:30:34 INFO - PROCESS | 9779 | RSS: Main: 167100416 02:30:34 INFO - PROCESS | 9779 | 02:33:35 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:53031/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53031/tests/dromaeo/cssquery-mootools.html) 02:33:36 INFO - PROCESS | 9779 | RSS: Main: 168108032 02:33:36 INFO - PROCESS | 9779 | 02:36:38 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:53031/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53031/tests/dromaeo/cssquery-prototype.html) 02:36:38 INFO - PROCESS | 9779 | RSS: Main: 165502976 02:36:38 INFO - PROCESS | 9779 | 02:39:41 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:53031/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53031/tests/dromaeo/cssquery-yui.html) 02:39:42 INFO - PROCESS | 9779 | RSS: Main: 166551552 02:39:42 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:53031/tests/dromaeo/cssquery-yui.html (next: http://localhost:53031/tests/dromaeo/cssquery-dojo.html) 02:42:44 INFO - PROCESS | 9779 | RSS: Main: 168919040 02:42:44 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | __start_tp_report 02:42:44 INFO - PROCESS | 9779 | _x_x_mozilla_page_load 02:42:44 INFO - PROCESS | 9779 | _x_x_mozilla_page_load_details 02:42:44 INFO - PROCESS | 9779 | |i|pagename|runs| 02:42:44 INFO - PROCESS | 9779 | |0;dojo.html;3129.108204161814;3164.430402527544;3178.7615928805344;3200.61592608887;3203.2152122729935;5383.057964856149;5391.919121213185;5425.6202065855405;5449.754761035753;5453.536449401796;5269.446708095652;5400.756965936533;5454.045542030149;5465.426130256315;5479.506844384005;4891.144049791281;4912.140375434303;4968.925466118011;5067.695938243699;5085.364329458817;4900.264960255972;5081.618878584102;5104.081265372231;5115.386153661566;5116.104681680709;4869.902601947977;4909.656324057318;4930.457649658535;4993.201087825949;5005.349304590398;4955.4548999610015;4965.503449655042;4970.925436118461;4974.10466116099;5008.323876276692;4935.383077115361;4939.827106051307;4943.085529177114;4959.925601115986;5003.074431230234;5148.099082660519;5275.129603615399;5296.947030529684;5328.387235467932;5369.328833895763;5722.484976352148;5743.195952566644;5747.051736463479;5764.942350576524;5781.971090144522;5616.32604087508;5846.269216347957;5851.853703657443;5855.385184555603;5856.590038697293;5385.380681221671;5407.270018547485;5448.727563621843;5461.453854614507;5465.4261302563455;5918.378570250148;5922.822315330547;5955.404459554096;5955.731992060368;5965.791197308074;5554.250176226238;5660.26416565852;5702.800401985911;5704.543636509153;5718.714064296769;5772.422757724194;5814.767409303665;5827.980103481958;5836.67898265591;5883.558733095035;5608.523275521545;5697.059985102412;5783.652980821164;5790;5818.272715910512;5595.692236927008;5796.42035796417;5811.2445382100905;5841.678707671119;5847.210626565445;4341.891452713708;4378.992831648675;4425.114977004612;4425.756583387944;4428.3800267962515;3944.2900277950243;3954.387070004154;3970.463987361727;3975.185087057146;3991.560928297885;5386.084365657847;5458.699771512525;5566.471185237396;5567.554595632339;5575.60970732053;5770.913436298459;5781.855453613609;5803.47768700819;5859.707014649251;5875.294964604275;5552.250446189793;5553.500184983371;5555.416681248492;5561.388247292794;5561.77752889888;4841.854744357604;4968.801247950041;5024.256928588152;5029.220470826955;5067.822626208065;5953.196318497034;5955.047192449274;5963.731632076567;6005.6396616203165;6008.579399441997;5802.216700745515;5823.330317013513;5829.3004839417845;5832.270966129234;5833.387494313036;5779.104238842986;5955.851103722442;5995.370486099071;6010.368911264254;6012.458878700938;5664.716764161693;5672.744726487235;5677.829665110054;5679.233303503974;5732.598718089694;5766.625169363978;5810.099434587646;5824.184614154106;5829.679367634821;5837.182794408871;5509.696966666712;5602.971985140048;5667.744951477276;5706.172604972338;5720.456556627114;5491.972540137273;5612.214289999485;5614.29821272341;5616.466435688603;5668.688222147822;5559.27729395176;5581.972090139523;5591.356993945748;5608.6073974821375;5613.635113717595;5502.339719233718;5613.635113717595;5658.434156584309;5741.397153299011;5748.936446757363;5515.586331025109;5558.44415558441;5562.888742225214;5565.443455654402;5618.69097199658 02:42:44 INFO - PROCESS | 9779 | |1;ext.html;588.8439563515669;653.7483069018426;654.2247436787405;666.9599824010559;673.4780545077562;39311.606883931156;43221;43473.130537389276;43477.130457390835;43552.78223608877;43688.34467482982;43850;43920.56079439205;43938.56061439385;44104;8662.653493860238;8790.51652159131;8860.822783544325;8873.645054197825;8890;8812.471251724917;8850.778730531756;8906.777330566756;8910.10898910107;8928.866067009;8939.150780675858;8943.597538110767;8975.910240897605;8986.14631609996;9012.819743605123;8820.20618144367;8944.821103577924;8959.283257339397;8977.416467929628;8979.595918183697;8758.824823503557;8786.60460279289;8807.07525709804;8832.381733278673;8836.293096552261;34065.65934340675;40773.79613101915;41163.38254926178;41168;41331.38002929959;3270.117068391521;3453.3783918894587;3476.0614634048916;3482.1468740158825;3547.485614585896;30705.539416908763;30985.0704478866;31111.37777244465;31322.21694457634;32118.518222226685;4095.365218391154;4148;4162.604552567501;4175.812088455997;4253.957460425387;310626;311564;314451;315295;316179.9999999977;33450.49824252638;33523.4971475428;33663;33734.493982590284;33892.66107338944;35379;36231.4565281521;36294;38451.807740961114;38566.22867542633;15301.6174595636;15368.846311536965;15372.231388430757;15384.076955382488;15385.84614153844;12775.936120319338;12862.356882155855;12866.614001579968;12870.742585148431;12894.419751111223;19509.317173898846;19587.608247834964;19613.31353402624;19631;19733.40799776009;7318.524295920748;7390.371818395497;7438.814029649302;7496.263863689714;7509.887351689729;1032.1123833503182;1083.1767856429171;1101.6254473479055;1154.4862536171322;1169.6257197696825;31838;32034.19914502156;32379.838100809815;32665;32689.182770430452;1145.9312441253385;1164.9708757281135;1192.3740036480917;1247.95008199671;1258.7356655102349;17137;17179.742303865452;17251.654966900842;17398.21708023142;17471.38850140239;495520;504858;505897;506986;508414;58331.41668583345;59202.40797592055;59474;59493.107603385986;59517.40482595205;1402.200745575033;1419.7657386531107;1448.8551144885428;1454.7236025155187;1457.0820383158543;30784.384312314076;30984.380312393176;31505;31921.36157276795;32489.675103248665;53788.462115378345;55904.440955589926;56359.43640563542;62361.376386235555;62888;357537;358239;358416;359320;362721;27768.8611556949;42521.36217956795;42549.36175957425;42585.361219581115;42895.7855210722;44359.55640443554;47943;48826.26760598665;49399.25901111414;49932;42080.57919420767;43017.78491107524;43105;43211;43226;41856.16287674291;42128.78935605302;42517.5255990509;42594.361084583135;42662.57337426586;36744.81627591845;40911.38632920568;41160;41893.79053104715;42208.57791422046;35293.294134117685;36455.635443645224;37081;37088.07279818026;37490.25019499649;28302;28822.135335939955;28874.42251155007;29234;29282 02:42:44 INFO - PROCESS | 9779 | |2;jquery.html;394.21551113284573;397.0807580451255;407.559835377792;409.8872809977256;410.9239790638732;18030.639387212264;19170.233190672356;19565.21739130433;19623.11695973681;20377.08303126359;11765.882341176586;12332.815007774869;12334.383280835968;18782.718259226123;18900;5244.659097158691;5305.124654432014;5459.290292262021;5460.34475862895;5484.232207490954;5279.313689220396;5386.811461598845;5395.514403703666;5414;5423.050966080939;5213.165893457048;5350.224217488462;5356.437574054727;5367.194920761878;5389.946100539003;5294.788208471657;5300.125479295912;5326.2543243945875;5327.520523152934;5374.838754837361;5051.797928082909;5207.921881171786;5213.165893457029;5224.294720212761;5251.632385733;14058;14098.224597647126;14221.14673119616;14234.145951242856;17392.826071739248;2187.6827859960376;2303.4011157099276;2353.5410594933996;2556.3864672478658;2598.8700564971678;10416.375017498975;10475.685729428129;10570.894291057068;10752.838707419394;10778.946105269502;1981.6532106881382;1986.8410527157794;2062.61841559312;2073.3779866040277;2073.782252863458;66310;80548.59725701393;80816;80998.99999999942;82677.17322826755;11143.554257829757;11155.944220278847;11819.704507387212;11993.160478766576;12210.145289829627;16056.116913569866;16135.757963630555;16168.676626467404;16229.837701623068;16266.674666506604;8178.836423271501;8340.62467188978;8466.703665371682;8500.36247281444;8568;8058.758237252891;8072.556009419538;8097.716579919675;8218.794530136794;8251.257386835214;4806.95193048072;4828.61371090319;4889.779959901813;4950.084234416644;4954.702717836942;1968.2675176305343;2012.5270561418056;2032.8068833460798;2038.2458490358663;2047.918083276682;466.3354719524664;922.1516205091332;1073.4291372163625;1075.4676435164642;1084.1651928015383;11095.16786241019;11865.822012669816;12095.092868034933;12123.09076819242;12223.877761222275;482.20676986357944;488.2456604545985;491.13069866336383;499.11407252127765;502.90193412284987;6369.45859601939;6519.217693876671;6527.771527996498;6598.73605055802;6691.5650482718465;412984;415003;427855;439393;447965;61987.6900615494;79139.60430197927;89941;91314;96295.51852240694;486.8052778888473;501.53106845099217;504.6215338496128;504.8132191089247;506.7567567567588;11368.488418021043;11470.82793758111;11490.482928268415;11621.941890290494;11824.940875295568;39090;40442.59557404388;41041.794791027045;41769.79115104405;42615.360769589104;57169.428305716414;57218;60219.09671355021;60403;60498.395016049275;5917.704114794157;8471.49171049739;8514.914850851412;8577.914220857712;8805.647774088964;9423.29325300619;12759.234445933274;12870.099093063396;12918.741625167631;12938.029647776266;10830.079443247412;11104.944475277573;11301.604443844426;11330.37682927447;11430.942845285721;11094.112471002461;11208.495617697386;11210.66368008961;11335.546578136782;11347.37589432589;11360.488778004845;11477.426128693698;11643.359615220905;11649.242799218024;12131.272123672608;8594;8688.78278043054;8701.260392866425;8731.47611143308;9055.773605659911;8927.544925145377;11773.823392648947;11863.228890122115;12030.63908082759;12096 02:42:44 INFO - PROCESS | 9779 | |3;mootools.html;1531.1655147944366;1563.6012816731734;1753.9035353055585;1868.4581471373294;1892.6498597759407;8234.794130146749;8885.64457421703;8950.194482496574;9500.524973751311;9542.904570954288;9006.819863602725;9264.258859291258;9332.253419726405;9335.673251436201;9353.11145441182;2327.499587588668;2357.186770564161;2358.0685629176464;2361.740208577055;2369.206315884181;2314.652802079693;2314.9652755208685;2371.798397136237;2373.738888722239;2380.4643955110137;2307.5615633029756;2325.7092863392077;2358.433975845793;2406.3142004528713;2409.0725070847675;2255.334676270504;2278.943026424336;2295.8737269450176;2302.9866858582254;2312.814974802012;2310.7342655594653;2323.047550504302;2330.7086614173227;2331.80179684727;2342.3324352559607;9310.929243137058;9424.623015079389;9429.057094290516;9436.056394360578;9443.05569443057;5200.76596553156;5207.4792520748;5207.609429292818;5278.076336641111;5398.352197736258;3366.175287054663;3413.566302153102;3471.878484253039;3483.686468217847;3508.0703613542432;1110.572429614596;2082.989585052065;2174.510735084609;2186.431527802767;2191.6274233380204;12623.873761262454;13035.41340639664;13044.478220871153;13086.738265234642;13447.3948672309;4736.455307639597;4746.857594272177;4809.95190048102;4821.035792841446;4855.830045948375;10060;10066.44634545107;10137.898621013843;10142.442165680959;10177.949110254402;5234.764435600331;5257.106291930305;5282.154855223146;5284;5286.101362768261;4274.444322238089;4765;4779.928301075487;4899.730514821719;4900.779464924087;4101.446304748821;4117.1765646870745;4134.524529679065;4159.521655009652;4168.145530166309;1225.9877401226051;1226.1110694746417;1230.3294704385953;1234.5493894728538;1243.160866415166;1007.1892126837965;1044.587387981743;1049.742813010802;1051.0803047333584;1067.2529229539352;6049.122877182872;6153.630782153085;6161.938380616226;6324.936750632527;6359.043851695376;481.32614339924385;483.16894940701934;487.12804080695156;1073.7154654016692;1097.4841824342707;4249.617534421917;4302.677299202573;4325.178216138924;4332.891677708019;4362.280223763107;11539.942300288445;11742.941285293518;11779.469923853447;11801.468933897824;11836.822447663291;10912.236143469881;11648.88351116495;11751.353675547756;11755.588554400554;11806.586769463027;8401.747947561584;8689.695860644973;8735.257503112307;8804.427712198687;8825.07336729647;6184.350643182581;6217;6316.242050953915;6387.776427825004;6541.182352205974;10732.087772539422;10823.621173259213;10863.402512861869;10922.890771092505;10976;10286.382817031003;10659.840102398315;11244.212905096565;11245.325280483197;11247.325160490396;7602.441499492701;8023.277904988579;8084;8321.750347489586;8374.623141958504;9164.404313719588;9213.723588292361;9219.86170207434;9240.95379523098;9293.953530232306;7552.848943020999;7775.961120194363;8031.397645176752;8038.477498962548;8114.634841432267;7720.8455830884195;7825.647845847065;7839.216078392115;7911.169327220559;8014;6821.761238356832;7283.781486555412;7305.086864141982;7364.889526657212;7386.113666360071;5247.422783493889;5326.813561525328;5366.597505187048;5498.890022199614;5516.531094856982;5519.227308176778;5574.832755017356;5575.163725441216;5579.860503487445;5681.204631351531 02:42:44 INFO - PROCESS | 9779 | |4;prototype.html;341.38550608903967;341.4724251032155;341.67540836205603;344.5710090936784;345.6410001738138;5605.439456054392;5607.672815781456;5612.102063669814;5620.241267428896;5624.537620218747;5523.177351474014;5540.695261760601;5556.888862222753;5586.910552442276;5608.130739735338;4208.600182982612;4324.654027677778;4329.870103896888;4357.7385356878685;4360.389545463638;4321.805518751664;4336.089421221547;4343.652507799368;4343.891402714926;4348.260795664729;4308.504521979981;4313.331433627777;4333.869983900472;4335.371371151197;4340.544242854487;4181.310083836163;4275.337322714984;4279.1013887083745;4353.521112677603;4363.498197707273;3750.912235451716;3753.436984452354;3758.699304055669;3771.641694039062;3780.5822816443833;5293.015119330251;5354.651947623431;5355.571554275649;5374.205413185122;5385.569154467633;4715.221988371914;4890.926636100461;4935.703857768545;4938.1111399947995;4969.279454479117;5675.2054712340305;5748.770049198027;5751.281089863767;5803.21656576361;5827.854303642401;4104.774237416941;4121.361189015707;4130.690198235115;4140.585941405865;4140.958590414088;5890.558208134365;6056.3338032816355;6067.089936509515;6067.544934129914;6107.114468402056;4130.864012396555;4181.289180839264;4210.578942105765;4229.111886503807;4255.382969469471;4269.380939763717;4293.935590966138;4295.183915056129;4298.441202643637;4324.740515569076;4700.623950083985;4932.520243926808;4937.456879743226;4938.827141050046;4953.975230123826;5871.559633027455;5876.265466816648;5893.410658934073;5910.852228694317;5930.7924222652;1470.6838029823639;1486.613480495079;1489.270257573781;1496.6707324388835;1503.8195416550084;926.0693003531408;940.6989763275686;953.1278879824882;953.2850362228329;964.9131578158;4995.150824359867;5001.299818025479;5004.524570165829;5039.69761814285;5069.138246498104;5332.733363331818;5360.303160589098;5375.75809088592;5375.919361209585;5424.945750542523;5111.284420181178;5136.460671629425;5155.845324640267;5280.891012887337;5741.339745929272;3225.5806745123455;3229.273413481995;3233.4826427771445;3245.334706385185;3246.1559994401155;5971.044632858721;6183.876322473615;6191.9690401547705;6211.3478084800445;6248.9062664060075;5822.446867547576;5931.58478906481;6076.7516019072345;6145.446909778141;6151.661658608819;6175.783847565313;6256.374362563707;6271.874562508724;6296.527760417987;6304;5915.615484993462;5981.1327357532045;6009.707912798769;6063.393660633901;6085.939140608537;5832.358440571618;5856.736446859987;5977.671228082497;5977.850553736192;5993.9700301498215;6140.8639401710825;6141.477974372228;6171.629702217701;6183.690815459119;6201.627902325875;4024;4203.306454435106;4216.765114489325;4270.252705776415;4276.332230430073;6004.609700369462;6024.427679370453;6089.360617135137;6089.878202436015;6093.969530152321;5856.824295271149;5857.677827719516;5904.261967254093;5907.9704601476715;5953.047512397996;5585.888282234414;5855.2973643163095;5874.765009399576;5877.82443511308;5892.941070589411;5739.942600573941;5747;5751.252337196138;5770.567207459541;5774;5741.971290143522;5918.970405147947;5933.703314834327;5974.761009559743;5975.701214939322;5758.696521391309;5768.53851691872;5774.740136693775;5779.162021506942;5817.738201781015 02:42:44 INFO - PROCESS | 9779 | |5;yui.html;743.8735414979453;754.9471536992413;759.6201899050475;763.8510490454361;768.3929695540521;13167.14413563119;14898.255087245636;15088.17015064171;15134.848651513481;15138.621534461645;13481.123726957765;13529.255890925995;13539;13549;13586.524471643494;685.5646664368112;800.8318253166842;819.8934138561979;822.3298012120104;827.3298628111219;814.2630919018297;817.7424111404919;819.7417813388794;820.9179082091773;823.0904850140569;873.6199753107387;875.3303722652176;875.5578432891381;875.671623141322;876.6843936182969;853.564682012172;865.5758678247677;869.0787764969122;871.4553404122423;874.3486102853351;631.3907079668096;632.4213344789512;632.8386261503333;637.37537213531;638.0301941049624;13683.931580342134;13701.725965480735;13729.519466818614;13733.725325493435;13738.175709457464;14141.222232777192;14188.21964791936;14192;14197.858021419861;14230.146191228456;11061.778764424747;11121.27711698737;11152.944235278852;11193.160512961478;11244.831327530093;3838.712096592739;3853.2486165197797;3866.7679939203736;3915.295246855565;3920.2355540669582;56129.43870561283;56619;57044.714776425855;57338.999999999585;57420;11108.44457777124;11300.604478843365;11445.427728613537;11557.653270401901;11675.299482031105;20170;20305.898470507553;20336.288229912177;20350.18599256043;20413.285535006202;8194.713185038496;8239.134890836496;8254.958725206336;8344.207300306462;8449.408541402043;4511;4527.84152554659;4590.472095708969;4622.791974361162;4632.2125238709505;3281.8851340202978;3351.497275408708;3365.209175843675;3366.377220214219;3378.476336167898;620.77031498345;643.0868167202584;643.353429803045;644.7582156691241;644.7936660268668;646.2826262848234;701.3827831508343;720.2941117704574;741.7552207771422;765.1239330966124;8881.511516866505;9339.719808405758;9466.621335146654;9618.278629102846;9647.083527065059;691.3881215124651;700.5883145461898;747.174372318591;767.9632496130291;785.0265670568454;4350.956490435118;4514.375483130885;4546.52261512543;4578.2903649934315;4686.484486706459;69593.65203173952;70090;72470;72605.27394726091;72807;61635.6918215415;61765.38234617686;61786.69106654528;62426.68786656128;63536.682316589046;56958;57153.428465715646;57324.42675573274;57571.42428575744;58184.41815581875;8603.397762156588;8678;8797.648094076165;8814.691485798223;8901.465912045298;37632.2473550522;38039.80980095082;38375.232495350494;38642.80678596589;39086.804565976985;49110.26334604912;51912.48087519076;51988.22017669814;52039.73980130075;52471.21293180529;11335.093192544411;11409.545609940675;11589;11614.5354185835;11710.94144529272;11541.249818761753;11614.6515604532;12334.568290109803;12447.253164810141;12746.490140394651;11404.48679809394;11495.885041149482;11521.596744113916;11704.94147529257;11770.82343764827;11386.259893107253;11462.4268786562;11509.712257193301;11772.05823534098;11785.292882427082;11518.654440366803;11552.191346605658;11628;11631.88368116308;11972.700682483008;9824.754381140528;9882.802343952937;10160.745981350525;10188.490575471345;10211.489425528545;9889.577053621908;10099.596016159565;10110.89889101129;10153.331141465247;10222.59109635636 02:42:44 INFO - PROCESS | 9779 | __end_tp_report 02:42:44 INFO - PROCESS | 9779 | __start_cc_report 02:42:44 INFO - PROCESS | 9779 | _x_x_mozilla_cycle_collect,353 02:42:44 INFO - PROCESS | 9779 | __end_cc_report 02:42:44 INFO - PROCESS | 9779 | __startTimestamp1463478164564__endTimestamp 02:42:44 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | ------- Summary: start ------- 02:42:44 INFO - PROCESS | 9779 | Number of tests: 6 02:42:44 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | [#0] dojo.html Cycles:165 Average:5384.95 Median:5567.55 stddev:598.82 (10.8%) stddev-sans-first:573.91 02:42:44 INFO - PROCESS | 9779 | Values: 3129.1 3164.4 3178.8 3200.6 3203.2 5383.1 5391.9 5425.6 5449.8 5453.5 5269.4 5400.8 5454.0 5465.4 5479.5 4891.1 4912.1 4968.9 5067.7 5085.4 4900.3 5081.6 5104.1 5115.4 5116.1 4869.9 4909.7 4930.5 4993.2 5005.3 4955.5 4965.5 4970.9 4974.1 5008.3 4935.4 4939.8 4943.1 4959.9 5003.1 5148.1 5275.1 5296.9 5328.4 5369.3 5722.5 5743.2 5747.1 5764.9 5782.0 5616.3 5846.3 5851.9 5855.4 5856.6 5385.4 5407.3 5448.7 5461.5 5465.4 5918.4 5922.8 5955.4 5955.7 5965.8 5554.3 5660.3 5702.8 5704.5 5718.7 5772.4 5814.8 5828.0 5836.7 5883.6 5608.5 5697.1 5783.7 5790.0 5818.3 5595.7 5796.4 5811.2 5841.7 5847.2 4341.9 4379.0 4425.1 4425.8 4428.4 3944.3 3954.4 3970.5 3975.2 3991.6 5386.1 5458.7 5566.5 5567.6 5575.6 5770.9 5781.9 5803.5 5859.7 5875.3 5552.3 5553.5 5555.4 5561.4 5561.8 4841.9 4968.8 5024.3 5029.2 5067.8 5953.2 5955.0 5963.7 6005.6 6008.6 5802.2 5823.3 5829.3 5832.3 5833.4 5779.1 5955.9 5995.4 6010.4 6012.5 5664.7 5672.7 5677.8 5679.2 5732.6 5766.6 5810.1 5824.2 5829.7 5837.2 5509.7 5603.0 5667.7 5706.2 5720.5 5492.0 5612.2 5614.3 5616.5 5668.7 5559.3 5582.0 5591.4 5608.6 5613.6 5502.3 5613.6 5658.4 5741.4 5748.9 5515.6 5558.4 5562.9 5565.4 5618.7 02:42:44 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | [#1] ext.html Cycles:180 Average:55410.88 Median:22503.38 stddev:105966.13 (470.9%) stddev-sans-first:106183.45 02:42:44 INFO - PROCESS | 9779 | Values: 588.8 653.7 654.2 667.0 673.5 39311.6 43221.0 43473.1 43477.1 43552.8 43688.3 43850.0 43920.6 43938.6 44104.0 8662.7 8790.5 8860.8 8873.6 8890.0 8812.5 8850.8 8906.8 8910.1 8928.9 8939.2 8943.6 8975.9 8986.1 9012.8 8820.2 8944.8 8959.3 8977.4 8979.6 8758.8 8786.6 8807.1 8832.4 8836.3 34065.7 40773.8 41163.4 41168.0 41331.4 3270.1 3453.4 3476.1 3482.1 3547.5 30705.5 30985.1 31111.4 31322.2 32118.5 4095.4 4148.0 4162.6 4175.8 4254.0 310626.0 311564.0 314451.0 315295.0 316180.0 33450.5 33523.5 33663.0 33734.5 33892.7 35379.0 36231.5 36294.0 38451.8 38566.2 15301.6 15368.8 15372.2 15384.1 15385.8 12775.9 12862.4 12866.6 12870.7 12894.4 19509.3 19587.6 19613.3 19631.0 19733.4 7318.5 7390.4 7438.8 7496.3 7509.9 1032.1 1083.2 1101.6 1154.5 1169.6 31838.0 32034.2 32379.8 32665.0 32689.2 1145.9 1165.0 1192.4 1248.0 1258.7 17137.0 17179.7 17251.7 17398.2 17471.4 495520.0 504858.0 505897.0 506986.0 508414.0 58331.4 59202.4 59474.0 59493.1 59517.4 1402.2 1419.8 1448.9 1454.7 1457.1 30784.4 30984.4 31505.0 31921.4 32489.7 53788.5 55904.4 56359.4 62361.4 62888.0 357537.0 358239.0 358416.0 359320.0 362721.0 27768.9 42521.4 42549.4 42585.4 42895.8 44359.6 47943.0 48826.3 49399.3 49932.0 42080.6 43017.8 43105.0 43211.0 43226.0 41856.2 42128.8 42517.5 42594.4 42662.6 36744.8 40911.4 41160.0 41893.8 42208.6 35293.3 36455.6 37081.0 37088.1 37490.3 28302.0 28822.1 28874.4 29234.0 29282.0 02:42:44 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | [#2] jquery.html Cycles:180 Average:26094.06 Median:228386.40 stddev:71043.33 (31.1%) stddev-sans-first:71216.42 02:42:44 INFO - PROCESS | 9779 | Values: 394.2 397.1 407.6 409.9 410.9 18030.6 19170.2 19565.2 19623.1 20377.1 11765.9 12332.8 12334.4 18782.7 18900.0 5244.7 5305.1 5459.3 5460.3 5484.2 5279.3 5386.8 5395.5 5414.0 5423.1 5213.2 5350.2 5356.4 5367.2 5389.9 5294.8 5300.1 5326.3 5327.5 5374.8 5051.8 5207.9 5213.2 5224.3 5251.6 14058.0 14098.2 14221.1 14234.1 17392.8 2187.7 2303.4 2353.5 2556.4 2598.9 10416.4 10475.7 10570.9 10752.8 10778.9 1981.7 1986.8 2062.6 2073.4 2073.8 66310.0 80548.6 80816.0 80999.0 82677.2 11143.6 11155.9 11819.7 11993.2 12210.1 16056.1 16135.8 16168.7 16229.8 16266.7 8178.8 8340.6 8466.7 8500.4 8568.0 8058.8 8072.6 8097.7 8218.8 8251.3 4807.0 4828.6 4889.8 4950.1 4954.7 1968.3 2012.5 2032.8 2038.2 2047.9 466.3 922.2 1073.4 1075.5 1084.2 11095.2 11865.8 12095.1 12123.1 12223.9 482.2 488.2 491.1 499.1 502.9 6369.5 6519.2 6527.8 6598.7 6691.6 412984.0 415003.0 427855.0 439393.0 447965.0 61987.7 79139.6 89941.0 91314.0 96295.5 486.8 501.5 504.6 504.8 506.8 11368.5 11470.8 11490.5 11621.9 11824.9 39090.0 40442.6 41041.8 41769.8 42615.4 57169.4 57218.0 60219.1 60403.0 60498.4 5917.7 8471.5 8514.9 8577.9 8805.6 9423.3 12759.2 12870.1 12918.7 12938.0 10830.1 11104.9 11301.6 11330.4 11430.9 11094.1 11208.5 11210.7 11335.5 11347.4 11360.5 11477.4 11643.4 11649.2 12131.3 8594.0 8688.8 8701.3 8731.5 9055.8 8927.5 11773.8 11863.2 12030.6 12096.0 02:42:44 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | [#3] mootools.html Cycles:180 Average:6077.30 Median:4329.03 stddev:3490.79 (80.6%) stddev-sans-first:3483.86 02:42:44 INFO - PROCESS | 9779 | Values: 1531.2 1563.6 1753.9 1868.5 1892.6 8234.8 8885.6 8950.2 9500.5 9542.9 9006.8 9264.3 9332.3 9335.7 9353.1 2327.5 2357.2 2358.1 2361.7 2369.2 2314.7 2315.0 2371.8 2373.7 2380.5 2307.6 2325.7 2358.4 2406.3 2409.1 2255.3 2278.9 2295.9 2303.0 2312.8 2310.7 2323.0 2330.7 2331.8 2342.3 9310.9 9424.6 9429.1 9436.1 9443.1 5200.8 5207.5 5207.6 5278.1 5398.4 3366.2 3413.6 3471.9 3483.7 3508.1 1110.6 2083.0 2174.5 2186.4 2191.6 12623.9 13035.4 13044.5 13086.7 13447.4 4736.5 4746.9 4810.0 4821.0 4855.8 10060.0 10066.4 10137.9 10142.4 10177.9 5234.8 5257.1 5282.2 5284.0 5286.1 4274.4 4765.0 4779.9 4899.7 4900.8 4101.4 4117.2 4134.5 4159.5 4168.1 1226.0 1226.1 1230.3 1234.5 1243.2 1007.2 1044.6 1049.7 1051.1 1067.3 6049.1 6153.6 6161.9 6324.9 6359.0 481.3 483.2 487.1 1073.7 1097.5 4249.6 4302.7 4325.2 4332.9 4362.3 11539.9 11742.9 11779.5 11801.5 11836.8 10912.2 11648.9 11751.4 11755.6 11806.6 8401.7 8689.7 8735.3 8804.4 8825.1 6184.4 6217.0 6316.2 6387.8 6541.2 10732.1 10823.6 10863.4 10922.9 10976.0 10286.4 10659.8 11244.2 11245.3 11247.3 7602.4 8023.3 8084.0 8321.8 8374.6 9164.4 9213.7 9219.9 9241.0 9294.0 7552.8 7776.0 8031.4 8038.5 8114.6 7720.8 7825.6 7839.2 7911.2 8014.0 6821.8 7283.8 7305.1 7364.9 7386.1 5247.4 5326.8 5366.6 5498.9 5516.5 5519.2 5574.8 5575.2 5579.9 5681.2 02:42:44 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | [#4] prototype.html Cycles:180 Average:4870.48 Median:5548.79 stddev:1441.61 (26.0%) stddev-sans-first:1405.00 02:42:44 INFO - PROCESS | 9779 | Values: 341.4 341.5 341.7 344.6 345.6 5605.4 5607.7 5612.1 5620.2 5624.5 5523.2 5540.7 5556.9 5586.9 5608.1 4208.6 4324.7 4329.9 4357.7 4360.4 4321.8 4336.1 4343.7 4343.9 4348.3 4308.5 4313.3 4333.9 4335.4 4340.5 4181.3 4275.3 4279.1 4353.5 4363.5 3750.9 3753.4 3758.7 3771.6 3780.6 5293.0 5354.7 5355.6 5374.2 5385.6 4715.2 4890.9 4935.7 4938.1 4969.3 5675.2 5748.8 5751.3 5803.2 5827.9 4104.8 4121.4 4130.7 4140.6 4141.0 5890.6 6056.3 6067.1 6067.5 6107.1 4130.9 4181.3 4210.6 4229.1 4255.4 4269.4 4293.9 4295.2 4298.4 4324.7 4700.6 4932.5 4937.5 4938.8 4954.0 5871.6 5876.3 5893.4 5910.9 5930.8 1470.7 1486.6 1489.3 1496.7 1503.8 926.1 940.7 953.1 953.3 964.9 4995.2 5001.3 5004.5 5039.7 5069.1 5332.7 5360.3 5375.8 5375.9 5424.9 5111.3 5136.5 5155.8 5280.9 5741.3 3225.6 3229.3 3233.5 3245.3 3246.2 5971.0 6183.9 6192.0 6211.3 6248.9 5822.4 5931.6 6076.8 6145.4 6151.7 6175.8 6256.4 6271.9 6296.5 6304.0 5915.6 5981.1 6009.7 6063.4 6085.9 5832.4 5856.7 5977.7 5977.9 5994.0 6140.9 6141.5 6171.6 6183.7 6201.6 4024.0 4203.3 4216.8 4270.3 4276.3 6004.6 6024.4 6089.4 6089.9 6094.0 5856.8 5857.7 5904.3 5908.0 5953.0 5585.9 5855.3 5874.8 5877.8 5892.9 5739.9 5747.0 5751.3 5770.6 5774.0 5742.0 5919.0 5933.7 5974.8 5975.7 5758.7 5768.5 5774.7 5779.2 5817.7 02:42:44 INFO - PROCESS | 9779 | 02:42:44 INFO - PROCESS | 9779 | [#5] yui.html Cycles:180 Average:15700.94 Median:4659.35 stddev:19368.29 (415.7%) stddev-sans-first:19390.06 02:42:44 INFO - PROCESS | 9779 | Values: 743.9 754.9 759.6 763.9 768.4 13167.1 14898.3 15088.2 15134.8 15138.6 13481.1 13529.3 13539.0 13549.0 13586.5 685.6 800.8 819.9 822.3 827.3 814.3 817.7 819.7 820.9 823.1 873.6 875.3 875.6 875.7 876.7 853.6 865.6 869.1 871.5 874.3 631.4 632.4 632.8 637.4 638.0 13683.9 13701.7 13729.5 13733.7 13738.2 14141.2 14188.2 14192.0 14197.9 14230.1 11061.8 11121.3 11152.9 11193.2 11244.8 3838.7 3853.2 3866.8 3915.3 3920.2 56129.4 56619.0 57044.7 57339.0 57420.0 11108.4 11300.6 11445.4 11557.7 11675.3 20170.0 20305.9 20336.3 20350.2 20413.3 8194.7 8239.1 8255.0 8344.2 8449.4 4511.0 4527.8 4590.5 4622.8 4632.2 3281.9 3351.5 3365.2 3366.4 3378.5 620.8 643.1 643.4 644.8 644.8 646.3 701.4 720.3 741.8 765.1 8881.5 9339.7 9466.6 9618.3 9647.1 691.4 700.6 747.2 768.0 785.0 4351.0 4514.4 4546.5 4578.3 4686.5 69593.7 70090.0 72470.0 72605.3 72807.0 61635.7 61765.4 61786.7 62426.7 63536.7 56958.0 57153.4 57324.4 57571.4 58184.4 8603.4 8678.0 8797.6 8814.7 8901.5 37632.2 38039.8 38375.2 38642.8 39086.8 49110.3 51912.5 51988.2 52039.7 52471.2 11335.1 11409.5 11589.0 11614.5 11710.9 11541.2 11614.7 12334.6 12447.3 12746.5 11404.5 11495.9 11521.6 11704.9 11770.8 11386.3 11462.4 11509.7 11772.1 11785.3 11518.7 11552.2 11628.0 11631.9 11972.7 9824.8 9882.8 10160.7 10188.5 10211.5 9889.6 10099.6 10110.9 10153.3 10222.6 02:42:44 INFO - PROCESS | 9779 | -------- Summary: end -------- 02:42:44 INFO - PROCESS | 9779 | 02:42:45 INFO - TEST-INFO | 9779: exit 0 02:42:45 INFO - TEST-OK | dromaeo_css | took 1109687ms 02:42:45 INFO - TEST-START | kraken 02:42:45 INFO - operating with platform_type : linux_ 02:42:45 INFO - Initialising browser for kraken test... 02:42:45 INFO - TEST-INFO | started process 10013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu93iz8/profile http://localhost:53031/getInfo.html) 02:42:48 INFO - PROCESS | 10013 | 02:42:48 INFO - PROCESS | 10013 | (process:10079): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:42:49 INFO - PROCESS | 10013 | __metrics Screen width/height:1600/1200 02:42:49 INFO - PROCESS | 10013 | colorDepth:24 02:42:49 INFO - PROCESS | 10013 | Browser inner width/height: 1024/697 02:42:49 INFO - PROCESS | 10013 | __metrics 02:42:49 ERROR - PROCESS | 10013 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:42:50 INFO - TEST-INFO | 10013: exit 0 02:42:50 INFO - Browser initialized. 02:42:50 INFO - Running cycle 1/1 for kraken test... 02:42:50 INFO - TEST-INFO | started process 10130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu93iz8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:52 INFO - PROCESS | 10130 | 02:42:52 INFO - PROCESS | 10130 | (process:10193): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:43:02 INFO - PROCESS | 10130 | RSS: Main: 163561472 02:43:02 INFO - PROCESS | 10130 | 02:43:05 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53031/tests/kraken/driver.html?testName=audio-beat-detection) 02:43:05 INFO - PROCESS | 10130 | RSS: Main: 168214528 02:43:05 INFO - PROCESS | 10130 | 02:43:08 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53031/tests/kraken/driver.html?testName=audio-dft) 02:43:09 INFO - PROCESS | 10130 | RSS: Main: 168321024 02:43:09 INFO - PROCESS | 10130 | 02:43:12 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53031/tests/kraken/driver.html?testName=audio-fft) 02:43:12 INFO - PROCESS | 10130 | RSS: Main: 163205120 02:43:12 INFO - PROCESS | 10130 | 02:43:15 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53031/tests/kraken/driver.html?testName=audio-oscillator) 02:43:15 INFO - PROCESS | 10130 | RSS: Main: 163713024 02:43:15 INFO - PROCESS | 10130 | 02:43:18 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53031/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:43:18 INFO - PROCESS | 10130 | RSS: Main: 163598336 02:43:18 INFO - PROCESS | 10130 | 02:43:21 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53031/tests/kraken/driver.html?testName=imaging-darkroom) 02:43:22 INFO - PROCESS | 10130 | RSS: Main: 163631104 02:43:22 INFO - PROCESS | 10130 | 02:43:25 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53031/tests/kraken/driver.html?testName=imaging-desaturate) 02:43:26 INFO - PROCESS | 10130 | RSS: Main: 162336768 02:43:26 INFO - PROCESS | 10130 | 02:43:29 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53031/tests/kraken/driver.html?testName=json-parse-financial) 02:43:30 INFO - PROCESS | 10130 | RSS: Main: 162840576 02:43:30 INFO - PROCESS | 10130 | 02:43:31 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53031/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:43:32 INFO - PROCESS | 10130 | RSS: Main: 163209216 02:43:32 INFO - PROCESS | 10130 | 02:43:34 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53031/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:43:34 INFO - PROCESS | 10130 | RSS: Main: 163422208 02:43:34 INFO - PROCESS | 10130 | 02:43:37 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53031/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:43:37 INFO - PROCESS | 10130 | RSS: Main: 163586048 02:43:37 INFO - PROCESS | 10130 | 02:43:40 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:43:40 INFO - PROCESS | 10130 | RSS: Main: 164511744 02:43:40 INFO - PROCESS | 10130 | 02:43:43 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:43:44 INFO - PROCESS | 10130 | RSS: Main: 164655104 02:43:44 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | Cycle 1(1): loaded http://localhost:53031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53031/tests/kraken/driver.html?testName=ai-astar) 02:43:46 INFO - PROCESS | 10130 | RSS: Main: 165847040 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | __start_tp_report 02:43:46 INFO - PROCESS | 10130 | _x_x_mozilla_page_load 02:43:46 INFO - PROCESS | 10130 | _x_x_mozilla_page_load_details 02:43:46 INFO - PROCESS | 10130 | |i|pagename|runs| 02:43:46 INFO - PROCESS | 10130 | |0;ai-astar;108;112;103;108;109;110;103;109;110;110 02:43:46 INFO - PROCESS | 10130 | |1;audio-beat-detection;154;124;150;214;133;159;146;133;198;126 02:43:46 INFO - PROCESS | 10130 | |2;audio-dft;163;163;160;164;164;168;166;166;166;162 02:43:46 INFO - PROCESS | 10130 | |3;audio-fft;75;75;75;161;76;86;75;74;181;75 02:43:46 INFO - PROCESS | 10130 | |4;audio-oscillator;91;92;185;91;91;91;144;91;92;139 02:43:46 INFO - PROCESS | 10130 | |5;imaging-gaussian-blur;119;117;117;117;118;117;118;117;118;117 02:43:46 INFO - PROCESS | 10130 | |6;imaging-darkroom;147;147;147;146;147;147;146;145;146;145 02:43:46 INFO - PROCESS | 10130 | |7;imaging-desaturate;95;96;95;95;96;95;95;95;96;96 02:43:46 INFO - PROCESS | 10130 | |8;json-parse-financial;57;57;60;57;60;59;59;58;57;56 02:43:46 INFO - PROCESS | 10130 | |9;json-stringify-tinderbox;59;62;60;59;58;59;59;59;59;60 02:43:46 INFO - PROCESS | 10130 | |10;stanford-crypto-aes;77;79;79;81;78;84;80;78;145;78 02:43:46 INFO - PROCESS | 10130 | |11;stanford-crypto-ccm;124;127;120;126;120;117;119;122;140;123 02:43:46 INFO - PROCESS | 10130 | |12;stanford-crypto-pbkdf2;172;168;167;163;161;161;163;161;165;164 02:43:46 INFO - PROCESS | 10130 | |13;stanford-crypto-sha256-iterative;63;66;64;63;65;62;63;65;63;61 02:43:46 INFO - PROCESS | 10130 | __end_tp_report 02:43:46 INFO - PROCESS | 10130 | __start_cc_report 02:43:46 INFO - PROCESS | 10130 | _x_x_mozilla_cycle_collect,861 02:43:46 INFO - PROCESS | 10130 | __end_cc_report 02:43:46 INFO - PROCESS | 10130 | __startTimestamp1463478226349__endTimestamp 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | ------- Summary: start ------- 02:43:46 INFO - PROCESS | 10130 | Number of tests: 14 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.50 stddev:2.97 (2.7%) stddev-sans-first:3.15 02:43:46 INFO - PROCESS | 10130 | Values: 108.0 112.0 103.0 108.0 109.0 110.0 103.0 109.0 110.0 110.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:152.00 stddev:30.20 (19.9%) stddev-sans-first:32.03 02:43:46 INFO - PROCESS | 10130 | Values: 154.0 124.0 150.0 214.0 133.0 159.0 146.0 133.0 198.0 126.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:2.35 (1.4%) stddev-sans-first:2.45 02:43:46 INFO - PROCESS | 10130 | Values: 163.0 163.0 160.0 164.0 164.0 168.0 166.0 166.0 166.0 162.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.00 stddev:40.32 (53.8%) stddev-sans-first:42.10 02:43:46 INFO - PROCESS | 10130 | Values: 75.0 75.0 75.0 161.0 76.0 86.0 75.0 74.0 181.0 75.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:91.00 stddev:33.45 (36.8%) stddev-sans-first:34.71 02:43:46 INFO - PROCESS | 10130 | Values: 91.0 92.0 185.0 91.0 91.0 91.0 144.0 91.0 92.0 139.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 02:43:46 INFO - PROCESS | 10130 | Values: 119.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 02:43:46 INFO - PROCESS | 10130 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 145.0 146.0 145.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:43:46 INFO - PROCESS | 10130 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.50 stddev:1.41 (2.4%) stddev-sans-first:1.45 02:43:46 INFO - PROCESS | 10130 | Values: 57.0 57.0 60.0 57.0 60.0 59.0 59.0 58.0 57.0 56.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.07 (1.8%) stddev-sans-first:1.13 02:43:46 INFO - PROCESS | 10130 | Values: 59.0 62.0 60.0 59.0 58.0 59.0 59.0 59.0 59.0 60.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:79.00 stddev:20.86 (26.4%) stddev-sans-first:21.88 02:43:46 INFO - PROCESS | 10130 | Values: 77.0 79.0 79.0 81.0 78.0 84.0 80.0 78.0 145.0 78.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:123.50 stddev:6.49 (5.3%) stddev-sans-first:6.89 02:43:46 INFO - PROCESS | 10130 | Values: 124.0 127.0 120.0 126.0 120.0 117.0 119.0 122.0 140.0 123.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.50 stddev:3.60 (2.2%) stddev-sans-first:2.60 02:43:46 INFO - PROCESS | 10130 | Values: 172.0 168.0 167.0 163.0 161.0 161.0 163.0 161.0 165.0 164.0 02:43:46 INFO - PROCESS | 10130 | 02:43:46 INFO - PROCESS | 10130 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.51 (2.4%) stddev-sans-first:1.59 02:43:46 INFO - PROCESS | 10130 | Values: 63.0 66.0 64.0 63.0 65.0 62.0 63.0 65.0 63.0 61.0 02:43:46 INFO - PROCESS | 10130 | -------- Summary: end -------- 02:43:46 INFO - PROCESS | 10130 | 02:43:47 INFO - TEST-INFO | 10130: exit 0 02:43:47 INFO - TEST-OK | kraken | took 62059ms 02:43:47 INFO - SUITE-END | took 1171s 02:43:47 INFO - Completed test suite (00:19:32) 02:43:47 INFO - javascript benchmark 02:43:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7085.7209459839505, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.108204161814, 3164.430402527544, 3178.7615928805344, 3200.61592608887, 3203.2152122729935, 5383.057964856149, 5391.919121213185, 5425.6202065855405, 5449.754761035753, 5453.536449401796, 5269.446708095652, 5400.756965936533, 5454.045542030149, 5465.426130256315, 5479.506844384005, 4891.144049791281, 4912.140375434303, 4968.925466118011, 5067.695938243699, 5085.364329458817, 4900.264960255972, 5081.618878584102, 5104.081265372231, 5115.386153661566, 5116.104681680709, 4869.902601947977, 4909.656324057318, 4930.457649658535, 4993.201087825949, 5005.349304590398, 4955.4548999610015, 4965.503449655042, 4970.925436118461, 4974.10466116099, 5008.323876276692, 4935.383077115361, 4939.827106051307, 4943.085529177114, 4959.925601115986, 5003.074431230234, 5148.099082660519, 5275.129603615399, 5296.947030529684, 5328.387235467932, 5369.328833895763, 5722.484976352148, 5743.195952566644, 5747.051736463479, 5764.942350576524, 5781.971090144522, 5616.32604087508, 5846.269216347957, 5851.853703657443, 5855.385184555603, 5856.590038697293, 5385.380681221671, 5407.270018547485, 5448.727563621843, 5461.453854614507, 5465.4261302563455, 5918.378570250148, 5922.822315330547, 5955.404459554096, 5955.731992060368, 5965.791197308074, 5554.250176226238, 5660.26416565852, 5702.800401985911, 5704.543636509153, 5718.714064296769, 5772.422757724194, 5814.767409303665, 5827.980103481958, 5836.67898265591, 5883.558733095035, 5608.523275521545, 5697.059985102412, 5783.652980821164, 5790.0, 5818.272715910512, 5595.692236927008, 5796.42035796417, 5811.2445382100905, 5841.678707671119, 5847.210626565445, 4341.891452713708, 4378.992831648675, 4425.114977004612, 4425.756583387944, 4428.3800267962515, 3944.2900277950243, 3954.387070004154, 3970.463987361727, 3975.185087057146, 3991.560928297885, 5386.084365657847, 5458.699771512525, 5566.471185237396, 5567.554595632339, 5575.60970732053, 5770.913436298459, 5781.855453613609, 5803.47768700819, 5859.707014649251, 5875.294964604275, 5552.250446189793, 5553.500184983371, 5555.416681248492, 5561.388247292794, 5561.77752889888, 4841.854744357604, 4968.801247950041, 5024.256928588152, 5029.220470826955, 5067.822626208065, 5953.196318497034, 5955.047192449274, 5963.731632076567, 6005.6396616203165, 6008.579399441997, 5802.216700745515, 5823.330317013513, 5829.3004839417845, 5832.270966129234, 5833.387494313036, 5779.104238842986, 5955.851103722442, 5995.370486099071, 6010.368911264254, 6012.458878700938, 5664.716764161693, 5672.744726487235, 5677.829665110054, 5679.233303503974, 5732.598718089694, 5766.625169363978, 5810.099434587646, 5824.184614154106, 5829.679367634821, 5837.182794408871, 5509.696966666712, 5602.971985140048, 5667.744951477276, 5706.172604972338, 5720.456556627114, 5491.972540137273, 5612.214289999485, 5614.29821272341, 5616.466435688603, 5668.688222147822, 5559.27729395176, 5581.972090139523, 5591.356993945748, 5608.6073974821375, 5613.635113717595, 5502.339719233718, 5613.635113717595, 5658.434156584309, 5741.397153299011, 5748.936446757363, 5515.586331025109, 5558.44415558441, 5562.888742225214, 5565.443455654402, 5618.69097199658], "value": 5345.436191508556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.8439563515669, 653.7483069018426, 654.2247436787405, 666.9599824010559, 673.4780545077562, 39311.606883931156, 43221.0, 43473.130537389276, 43477.130457390835, 43552.78223608877, 43688.34467482982, 43850.0, 43920.56079439205, 43938.56061439385, 44104.0, 8662.653493860238, 8790.51652159131, 8860.822783544325, 8873.645054197825, 8890.0, 8812.471251724917, 8850.778730531756, 8906.777330566756, 8910.10898910107, 8928.866067009, 8939.150780675858, 8943.597538110767, 8975.910240897605, 8986.14631609996, 9012.819743605123, 8820.20618144367, 8944.821103577924, 8959.283257339397, 8977.416467929628, 8979.595918183697, 8758.824823503557, 8786.60460279289, 8807.07525709804, 8832.381733278673, 8836.293096552261, 34065.65934340675, 40773.79613101915, 41163.38254926178, 41168.0, 41331.38002929959, 3270.117068391521, 3453.3783918894587, 3476.0614634048916, 3482.1468740158825, 3547.485614585896, 30705.539416908763, 30985.0704478866, 31111.37777244465, 31322.21694457634, 32118.518222226685, 4095.365218391154, 4148.0, 4162.604552567501, 4175.812088455997, 4253.957460425387, 310626.0, 311564.0, 314451.0, 315295.0, 316179.9999999977, 33450.49824252638, 33523.4971475428, 33663.0, 33734.493982590284, 33892.66107338944, 35379.0, 36231.4565281521, 36294.0, 38451.807740961114, 38566.22867542633, 15301.6174595636, 15368.846311536965, 15372.231388430757, 15384.076955382488, 15385.84614153844, 12775.936120319338, 12862.356882155855, 12866.614001579968, 12870.742585148431, 12894.419751111223, 19509.317173898846, 19587.608247834964, 19613.31353402624, 19631.0, 19733.40799776009, 7318.524295920748, 7390.371818395497, 7438.814029649302, 7496.263863689714, 7509.887351689729, 1032.1123833503182, 1083.1767856429171, 1101.6254473479055, 1154.4862536171322, 1169.6257197696825, 31838.0, 32034.19914502156, 32379.838100809815, 32665.0, 32689.182770430452, 1145.9312441253385, 1164.9708757281135, 1192.3740036480917, 1247.95008199671, 1258.7356655102349, 17137.0, 17179.742303865452, 17251.654966900842, 17398.21708023142, 17471.38850140239, 495520.0, 504858.0, 505897.0, 506986.0, 508414.0, 58331.41668583345, 59202.40797592055, 59474.0, 59493.107603385986, 59517.40482595205, 1402.200745575033, 1419.7657386531107, 1448.8551144885428, 1454.7236025155187, 1457.0820383158543, 30784.384312314076, 30984.380312393176, 31505.0, 31921.36157276795, 32489.675103248665, 53788.462115378345, 55904.440955589926, 56359.43640563542, 62361.376386235555, 62888.0, 357537.0, 358239.0, 358416.0, 359320.0, 362721.0, 27768.8611556949, 42521.36217956795, 42549.36175957425, 42585.361219581115, 42895.7855210722, 44359.55640443554, 47943.0, 48826.26760598665, 49399.25901111414, 49932.0, 42080.57919420767, 43017.78491107524, 43105.0, 43211.0, 43226.0, 41856.16287674291, 42128.78935605302, 42517.5255990509, 42594.361084583135, 42662.57337426586, 36744.81627591845, 40911.38632920568, 41160.0, 41893.79053104715, 42208.57791422046, 35293.294134117685, 36455.635443645224, 37081.0, 37088.07279818026, 37490.25019499649, 28302.0, 28822.135335939955, 28874.42251155007, 29234.0, 29282.0], "value": 19732.123300844487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.21551113284573, 397.0807580451255, 407.559835377792, 409.8872809977256, 410.9239790638732, 18030.639387212264, 19170.233190672356, 19565.21739130433, 19623.11695973681, 20377.08303126359, 11765.882341176586, 12332.815007774869, 12334.383280835968, 18782.718259226123, 18900.0, 5244.659097158691, 5305.124654432014, 5459.290292262021, 5460.34475862895, 5484.232207490954, 5279.313689220396, 5386.811461598845, 5395.514403703666, 5414.0, 5423.050966080939, 5213.165893457048, 5350.224217488462, 5356.437574054727, 5367.194920761878, 5389.946100539003, 5294.788208471657, 5300.125479295912, 5326.2543243945875, 5327.520523152934, 5374.838754837361, 5051.797928082909, 5207.921881171786, 5213.165893457029, 5224.294720212761, 5251.632385733, 14058.0, 14098.224597647126, 14221.14673119616, 14234.145951242856, 17392.826071739248, 2187.6827859960376, 2303.4011157099276, 2353.5410594933996, 2556.3864672478658, 2598.8700564971678, 10416.375017498975, 10475.685729428129, 10570.894291057068, 10752.838707419394, 10778.946105269502, 1981.6532106881382, 1986.8410527157794, 2062.61841559312, 2073.3779866040277, 2073.782252863458, 66310.0, 80548.59725701393, 80816.0, 80998.99999999942, 82677.17322826755, 11143.554257829757, 11155.944220278847, 11819.704507387212, 11993.160478766576, 12210.145289829627, 16056.116913569866, 16135.757963630555, 16168.676626467404, 16229.837701623068, 16266.674666506604, 8178.836423271501, 8340.62467188978, 8466.703665371682, 8500.36247281444, 8568.0, 8058.758237252891, 8072.556009419538, 8097.716579919675, 8218.794530136794, 8251.257386835214, 4806.95193048072, 4828.61371090319, 4889.779959901813, 4950.084234416644, 4954.702717836942, 1968.2675176305343, 2012.5270561418056, 2032.8068833460798, 2038.2458490358663, 2047.918083276682, 466.3354719524664, 922.1516205091332, 1073.4291372163625, 1075.4676435164642, 1084.1651928015383, 11095.16786241019, 11865.822012669816, 12095.092868034933, 12123.09076819242, 12223.877761222275, 482.20676986357944, 488.2456604545985, 491.13069866336383, 499.11407252127765, 502.90193412284987, 6369.45859601939, 6519.217693876671, 6527.771527996498, 6598.73605055802, 6691.5650482718465, 412984.0, 415003.0, 427855.0, 439393.0, 447965.0, 61987.6900615494, 79139.60430197927, 89941.0, 91314.0, 96295.51852240694, 486.8052778888473, 501.53106845099217, 504.6215338496128, 504.8132191089247, 506.7567567567588, 11368.488418021043, 11470.82793758111, 11490.482928268415, 11621.941890290494, 11824.940875295568, 39090.0, 40442.59557404388, 41041.794791027045, 41769.79115104405, 42615.360769589104, 57169.428305716414, 57218.0, 60219.09671355021, 60403.0, 60498.395016049275, 5917.704114794157, 8471.49171049739, 8514.914850851412, 8577.914220857712, 8805.647774088964, 9423.29325300619, 12759.234445933274, 12870.099093063396, 12918.741625167631, 12938.029647776266, 10830.079443247412, 11104.944475277573, 11301.604443844426, 11330.37682927447, 11430.942845285721, 11094.112471002461, 11208.495617697386, 11210.66368008961, 11335.546578136782, 11347.37589432589, 11360.488778004845, 11477.426128693698, 11643.359615220905, 11649.242799218024, 12131.272123672608, 8594.0, 8688.78278043054, 8701.260392866425, 8731.47611143308, 9055.773605659911, 8927.544925145377, 11773.823392648947, 11863.228890122115, 12030.63908082759, 12096.0], "value": 8247.445020489888, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.1655147944366, 1563.6012816731734, 1753.9035353055585, 1868.4581471373294, 1892.6498597759407, 8234.794130146749, 8885.64457421703, 8950.194482496574, 9500.524973751311, 9542.904570954288, 9006.819863602725, 9264.258859291258, 9332.253419726405, 9335.673251436201, 9353.11145441182, 2327.499587588668, 2357.186770564161, 2358.0685629176464, 2361.740208577055, 2369.206315884181, 2314.652802079693, 2314.9652755208685, 2371.798397136237, 2373.738888722239, 2380.4643955110137, 2307.5615633029756, 2325.7092863392077, 2358.433975845793, 2406.3142004528713, 2409.0725070847675, 2255.334676270504, 2278.943026424336, 2295.8737269450176, 2302.9866858582254, 2312.814974802012, 2310.7342655594653, 2323.047550504302, 2330.7086614173227, 2331.80179684727, 2342.3324352559607, 9310.929243137058, 9424.623015079389, 9429.057094290516, 9436.056394360578, 9443.05569443057, 5200.76596553156, 5207.4792520748, 5207.609429292818, 5278.076336641111, 5398.352197736258, 3366.175287054663, 3413.566302153102, 3471.878484253039, 3483.686468217847, 3508.0703613542432, 1110.572429614596, 2082.989585052065, 2174.510735084609, 2186.431527802767, 2191.6274233380204, 12623.873761262454, 13035.41340639664, 13044.478220871153, 13086.738265234642, 13447.3948672309, 4736.455307639597, 4746.857594272177, 4809.95190048102, 4821.035792841446, 4855.830045948375, 10060.0, 10066.44634545107, 10137.898621013843, 10142.442165680959, 10177.949110254402, 5234.764435600331, 5257.106291930305, 5282.154855223146, 5284.0, 5286.101362768261, 4274.444322238089, 4765.0, 4779.928301075487, 4899.730514821719, 4900.779464924087, 4101.446304748821, 4117.1765646870745, 4134.524529679065, 4159.521655009652, 4168.145530166309, 1225.9877401226051, 1226.1110694746417, 1230.3294704385953, 1234.5493894728538, 1243.160866415166, 1007.1892126837965, 1044.587387981743, 1049.742813010802, 1051.0803047333584, 1067.2529229539352, 6049.122877182872, 6153.630782153085, 6161.938380616226, 6324.936750632527, 6359.043851695376, 481.32614339924385, 483.16894940701934, 487.12804080695156, 1073.7154654016692, 1097.4841824342707, 4249.617534421917, 4302.677299202573, 4325.178216138924, 4332.891677708019, 4362.280223763107, 11539.942300288445, 11742.941285293518, 11779.469923853447, 11801.468933897824, 11836.822447663291, 10912.236143469881, 11648.88351116495, 11751.353675547756, 11755.588554400554, 11806.586769463027, 8401.747947561584, 8689.695860644973, 8735.257503112307, 8804.427712198687, 8825.07336729647, 6184.350643182581, 6217.0, 6316.242050953915, 6387.776427825004, 6541.182352205974, 10732.087772539422, 10823.621173259213, 10863.402512861869, 10922.890771092505, 10976.0, 10286.382817031003, 10659.840102398315, 11244.212905096565, 11245.325280483197, 11247.325160490396, 7602.441499492701, 8023.277904988579, 8084.0, 8321.750347489586, 8374.623141958504, 9164.404313719588, 9213.723588292361, 9219.86170207434, 9240.95379523098, 9293.953530232306, 7552.848943020999, 7775.961120194363, 8031.397645176752, 8038.477498962548, 8114.634841432267, 7720.8455830884195, 7825.647845847065, 7839.216078392115, 7911.169327220559, 8014.0, 6821.761238356832, 7283.781486555412, 7305.086864141982, 7364.889526657212, 7386.113666360071, 5247.422783493889, 5326.813561525328, 5366.597505187048, 5498.890022199614, 5516.531094856982, 5519.227308176778, 5574.832755017356, 5575.163725441216, 5579.860503487445, 5681.204631351531], "value": 4850.312954749814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.38550608903967, 341.4724251032155, 341.67540836205603, 344.5710090936784, 345.6410001738138, 5605.439456054392, 5607.672815781456, 5612.102063669814, 5620.241267428896, 5624.537620218747, 5523.177351474014, 5540.695261760601, 5556.888862222753, 5586.910552442276, 5608.130739735338, 4208.600182982612, 4324.654027677778, 4329.870103896888, 4357.7385356878685, 4360.389545463638, 4321.805518751664, 4336.089421221547, 4343.652507799368, 4343.891402714926, 4348.260795664729, 4308.504521979981, 4313.331433627777, 4333.869983900472, 4335.371371151197, 4340.544242854487, 4181.310083836163, 4275.337322714984, 4279.1013887083745, 4353.521112677603, 4363.498197707273, 3750.912235451716, 3753.436984452354, 3758.699304055669, 3771.641694039062, 3780.5822816443833, 5293.015119330251, 5354.651947623431, 5355.571554275649, 5374.205413185122, 5385.569154467633, 4715.221988371914, 4890.926636100461, 4935.703857768545, 4938.1111399947995, 4969.279454479117, 5675.2054712340305, 5748.770049198027, 5751.281089863767, 5803.21656576361, 5827.854303642401, 4104.774237416941, 4121.361189015707, 4130.690198235115, 4140.585941405865, 4140.958590414088, 5890.558208134365, 6056.3338032816355, 6067.089936509515, 6067.544934129914, 6107.114468402056, 4130.864012396555, 4181.289180839264, 4210.578942105765, 4229.111886503807, 4255.382969469471, 4269.380939763717, 4293.935590966138, 4295.183915056129, 4298.441202643637, 4324.740515569076, 4700.623950083985, 4932.520243926808, 4937.456879743226, 4938.827141050046, 4953.975230123826, 5871.559633027455, 5876.265466816648, 5893.410658934073, 5910.852228694317, 5930.7924222652, 1470.6838029823639, 1486.613480495079, 1489.270257573781, 1496.6707324388835, 1503.8195416550084, 926.0693003531408, 940.6989763275686, 953.1278879824882, 953.2850362228329, 964.9131578158, 4995.150824359867, 5001.299818025479, 5004.524570165829, 5039.69761814285, 5069.138246498104, 5332.733363331818, 5360.303160589098, 5375.75809088592, 5375.919361209585, 5424.945750542523, 5111.284420181178, 5136.460671629425, 5155.845324640267, 5280.891012887337, 5741.339745929272, 3225.5806745123455, 3229.273413481995, 3233.4826427771445, 3245.334706385185, 3246.1559994401155, 5971.044632858721, 6183.876322473615, 6191.9690401547705, 6211.3478084800445, 6248.9062664060075, 5822.446867547576, 5931.58478906481, 6076.7516019072345, 6145.446909778141, 6151.661658608819, 6175.783847565313, 6256.374362563707, 6271.874562508724, 6296.527760417987, 6304.0, 5915.615484993462, 5981.1327357532045, 6009.707912798769, 6063.393660633901, 6085.939140608537, 5832.358440571618, 5856.736446859987, 5977.671228082497, 5977.850553736192, 5993.9700301498215, 6140.8639401710825, 6141.477974372228, 6171.629702217701, 6183.690815459119, 6201.627902325875, 4024.0, 4203.306454435106, 4216.765114489325, 4270.252705776415, 4276.332230430073, 6004.609700369462, 6024.427679370453, 6089.360617135137, 6089.878202436015, 6093.969530152321, 5856.824295271149, 5857.677827719516, 5904.261967254093, 5907.9704601476715, 5953.047512397996, 5585.888282234414, 5855.2973643163095, 5874.765009399576, 5877.82443511308, 5892.941070589411, 5739.942600573941, 5747.0, 5751.252337196138, 5770.567207459541, 5774.0, 5741.971290143522, 5918.970405147947, 5933.703314834327, 5974.761009559743, 5975.701214939322, 5758.696521391309, 5768.53851691872, 5774.740136693775, 5779.162021506942, 5817.738201781015], "value": 4408.920105106623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.8735414979453, 754.9471536992413, 759.6201899050475, 763.8510490454361, 768.3929695540521, 13167.14413563119, 14898.255087245636, 15088.17015064171, 15134.848651513481, 15138.621534461645, 13481.123726957765, 13529.255890925995, 13539.0, 13549.0, 13586.524471643494, 685.5646664368112, 800.8318253166842, 819.8934138561979, 822.3298012120104, 827.3298628111219, 814.2630919018297, 817.7424111404919, 819.7417813388794, 820.9179082091773, 823.0904850140569, 873.6199753107387, 875.3303722652176, 875.5578432891381, 875.671623141322, 876.6843936182969, 853.564682012172, 865.5758678247677, 869.0787764969122, 871.4553404122423, 874.3486102853351, 631.3907079668096, 632.4213344789512, 632.8386261503333, 637.37537213531, 638.0301941049624, 13683.931580342134, 13701.725965480735, 13729.519466818614, 13733.725325493435, 13738.175709457464, 14141.222232777192, 14188.21964791936, 14192.0, 14197.858021419861, 14230.146191228456, 11061.778764424747, 11121.27711698737, 11152.944235278852, 11193.160512961478, 11244.831327530093, 3838.712096592739, 3853.2486165197797, 3866.7679939203736, 3915.295246855565, 3920.2355540669582, 56129.43870561283, 56619.0, 57044.714776425855, 57338.999999999585, 57420.0, 11108.44457777124, 11300.604478843365, 11445.427728613537, 11557.653270401901, 11675.299482031105, 20170.0, 20305.898470507553, 20336.288229912177, 20350.18599256043, 20413.285535006202, 8194.713185038496, 8239.134890836496, 8254.958725206336, 8344.207300306462, 8449.408541402043, 4511.0, 4527.84152554659, 4590.472095708969, 4622.791974361162, 4632.2125238709505, 3281.8851340202978, 3351.497275408708, 3365.209175843675, 3366.377220214219, 3378.476336167898, 620.77031498345, 643.0868167202584, 643.353429803045, 644.7582156691241, 644.7936660268668, 646.2826262848234, 701.3827831508343, 720.2941117704574, 741.7552207771422, 765.1239330966124, 8881.511516866505, 9339.719808405758, 9466.621335146654, 9618.278629102846, 9647.083527065059, 691.3881215124651, 700.5883145461898, 747.174372318591, 767.9632496130291, 785.0265670568454, 4350.956490435118, 4514.375483130885, 4546.52261512543, 4578.2903649934315, 4686.484486706459, 69593.65203173952, 70090.0, 72470.0, 72605.27394726091, 72807.0, 61635.6918215415, 61765.38234617686, 61786.69106654528, 62426.68786656128, 63536.682316589046, 56958.0, 57153.428465715646, 57324.42675573274, 57571.42428575744, 58184.41815581875, 8603.397762156588, 8678.0, 8797.648094076165, 8814.691485798223, 8901.465912045298, 37632.2473550522, 38039.80980095082, 38375.232495350494, 38642.80678596589, 39086.804565976985, 49110.26334604912, 51912.48087519076, 51988.22017669814, 52039.73980130075, 52471.21293180529, 11335.093192544411, 11409.545609940675, 11589.0, 11614.5354185835, 11710.94144529272, 11541.249818761753, 11614.6515604532, 12334.568290109803, 12447.253164810141, 12746.490140394651, 11404.48679809394, 11495.885041149482, 11521.596744113916, 11704.94147529257, 11770.82343764827, 11386.259893107253, 11462.4268786562, 11509.712257193301, 11772.05823534098, 11785.292882427082, 11518.654440366803, 11552.191346605658, 11628.0, 11631.88368116308, 11972.700682483008, 9824.754381140528, 9882.802343952937, 10160.745981350525, 10188.490575471345, 10211.489425528545, 9889.577053621908, 10099.596016159565, 10110.89889101129, 10153.331141465247, 10222.59109635636], "value": 6802.770827330558, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 103.0, 108.0, 109.0, 110.0, 103.0, 109.0, 110.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 150.0, 214.0, 133.0, 159.0, 146.0, 133.0, 198.0, 126.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 160.0, 164.0, 164.0, 168.0, 166.0, 166.0, 166.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 161.0, 76.0, 86.0, 75.0, 74.0, 181.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 185.0, 91.0, 91.0, 91.0, 144.0, 91.0, 92.0, 139.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 60.0, 57.0, 60.0, 59.0, 59.0, 58.0, 57.0, 56.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 79.0, 81.0, 78.0, 84.0, 80.0, 78.0, 145.0, 78.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 127.0, 120.0, 126.0, 120.0, 117.0, 119.0, 122.0, 140.0, 123.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 167.0, 163.0, 161.0, 161.0, 163.0, 161.0, 165.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 63.0, 65.0, 62.0, 63.0, 65.0, 63.0, 61.0], "value": 63.5, "unit": "score"}]}]} 02:43:47 INFO - Return code: 0 02:43:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:43:47 ERROR - # TBPL SUCCESS # 02:43:47 INFO - Running post-action listener: _resource_record_post_action 02:43:47 INFO - ##### 02:43:47 INFO - ##### Finished run-tests step (success) 02:43:47 INFO - ##### 02:43:47 INFO - Running post-run listener: _resource_record_post_run 02:43:47 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 539967488; Read time: 0; Write time: 512432 02:43:47 INFO - TinderboxPrint: CPU usage
13.4% 02:43:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:43:47 INFO - TinderboxPrint: I/O write bytes / time
539,967,488 / 512,432 02:43:47 INFO - TinderboxPrint: CPU idle
8,223.2 (86.6%) 02:43:47 INFO - TinderboxPrint: CPU user
1,217.0 (12.8%) 02:43:47 INFO - TinderboxPrint: Swap in / out
0 / 0 02:43:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252669952; Read time: 0; Write time: 269576 02:43:47 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 287125504; Read time: 0; Write time: 242836 02:43:48 INFO - Running post-run listener: _upload_blobber_files 02:43:48 INFO - Blob upload gear active. 02:43:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:43:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:43:48 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'] 02:43:48 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 02:43:48 INFO - (blobuploader) - INFO - Open directory for files ... 02:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:43:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:49 INFO - (blobuploader) - INFO - Done attempting. 02:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:43:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:50 INFO - (blobuploader) - INFO - Done attempting. 02:43:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:43:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:43:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:53 INFO - (blobuploader) - INFO - Done attempting. 02:43:53 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:53 INFO - Return code: 0 02:43:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83c565b9a6a74f1eb2977d12df41a129df757a88081e8e4a8cbdeb47f54c1da90b816c0091571266cae8c16391f3c06faa540d72fe05c28ecf52c6f9e3f2b25e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f89b941eb5cf8cc71d399f4b394a0e8ae28df8a34ec9fcf1be553915d3389bd8b6fe64609c93d8acc101df9492cc47f916ed419fb6e5f1ee67c22c87fb11279a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136f2477d384a6c082ae4c239afa898255bf8ffe36d2941555d96be01c401b77c2cbf6b3f4d6dfac777c670878a3898d94e85eaab80707c25cab51daa710b46a"} 02:43:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:53 INFO - Contents: 02:43:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83c565b9a6a74f1eb2977d12df41a129df757a88081e8e4a8cbdeb47f54c1da90b816c0091571266cae8c16391f3c06faa540d72fe05c28ecf52c6f9e3f2b25e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f89b941eb5cf8cc71d399f4b394a0e8ae28df8a34ec9fcf1be553915d3389bd8b6fe64609c93d8acc101df9492cc47f916ed419fb6e5f1ee67c22c87fb11279a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136f2477d384a6c082ae4c239afa898255bf8ffe36d2941555d96be01c401b77c2cbf6b3f4d6dfac777c670878a3898d94e85eaab80707c25cab51daa710b46a"} 02:43:53 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:53 INFO - Copying logs to upload dir... 02:43:53 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.538907 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-17 02:43:53.850398) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 02:43:53.853862) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901 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/83c565b9a6a74f1eb2977d12df41a129df757a88081e8e4a8cbdeb47f54c1da90b816c0091571266cae8c16391f3c06faa540d72fe05c28ecf52c6f9e3f2b25e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f89b941eb5cf8cc71d399f4b394a0e8ae28df8a34ec9fcf1be553915d3389bd8b6fe64609c93d8acc101df9492cc47f916ed419fb6e5f1ee67c22c87fb11279a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136f2477d384a6c082ae4c239afa898255bf8ffe36d2941555d96be01c401b77c2cbf6b3f4d6dfac777c670878a3898d94e85eaab80707c25cab51daa710b46a"} build_url:https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/cmlXd_OBRdSU_hq81l0N3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83c565b9a6a74f1eb2977d12df41a129df757a88081e8e4a8cbdeb47f54c1da90b816c0091571266cae8c16391f3c06faa540d72fe05c28ecf52c6f9e3f2b25e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f89b941eb5cf8cc71d399f4b394a0e8ae28df8a34ec9fcf1be553915d3389bd8b6fe64609c93d8acc101df9492cc47f916ed419fb6e5f1ee67c22c87fb11279a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136f2477d384a6c082ae4c239afa898255bf8ffe36d2941555d96be01c401b77c2cbf6b3f4d6dfac777c670878a3898d94e85eaab80707c25cab51daa710b46a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 02:43:53.877969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 02:43:53.878267) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463477001.412342-913899901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 02:43:53.962284) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 02:43:53.962601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 02:43:53.962901) ========= ========= Total master_lag: 0.18 =========