builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1463810959.87 results: success (0) buildid: 20160520203038 builduid: abeca14195a54ba0a7b3eb8e3a460e64 revision: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:19.874193) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:19.874667) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:19.874957) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:19.884014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:19.884293) ========= 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=7de08804244eb36560b44971000001c3-1463810178.515319-594916301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 23:09:20-- 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% 423M=0s 2016-05-20 23:09:20 (423 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.346319 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.239588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.239893) ========= 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=7de08804244eb36560b44971000001c3-1463810178.515319-594916301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009623 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.290296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.290642) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 --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 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 --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=7de08804244eb36560b44971000001c3-1463810178.515319-594916301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 23:09:20,807 truncating revision to first 12 chars 2016-05-20 23:09:20,807 Setting DEBUG logging. 2016-05-20 23:09:20,807 attempt 1/10 2016-05-20 23:09:20,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06d9362a57a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 23:09:21,023 unpacking tar archive at: fx-team-06d9362a57a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.449124 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.747573) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.747935) ========= script_repo_revision: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.748323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.748618) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.754276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-20 23:09:20.754581) ========= /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=7de08804244eb36560b44971000001c3-1463810178.515319-594916301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:21 INFO - MultiFileLogger online at 20160520 23:09:21 in /builds/slave/test 23:09:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:09:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:21 INFO - {'append_to_log': False, 23:09:21 INFO - 'base_work_dir': '/builds/slave/test', 23:09:21 INFO - 'blob_upload_branch': 'Fx-Team', 23:09:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:21 INFO - 'branch': 'Fx-Team', 23:09:21 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:21 INFO - 'config_files': ('talos/linux_config.py',), 23:09:21 INFO - 'default_actions': ('clobber', 23:09:21 INFO - 'read-buildbot-config', 23:09:21 INFO - 'download-and-extract', 23:09:21 INFO - 'populate-webroot', 23:09:21 INFO - 'create-virtualenv', 23:09:21 INFO - 'install', 23:09:21 INFO - 'run-tests'), 23:09:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:21 INFO - 'download_minidump_stackwalk': True, 23:09:21 INFO - 'download_symbols': 'ondemand', 23:09:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:21 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:21 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:21 INFO - 'installer_path': 'installer.exe', 23:09:21 INFO - 'log_level': 'info', 23:09:21 INFO - 'log_name': 'talos', 23:09:21 INFO - 'log_to_console': True, 23:09:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:21 INFO - 'opt_config_files': (), 23:09:21 INFO - 'pip_index': False, 23:09:21 INFO - 'sps_profile': False, 23:09:21 INFO - 'sps_profile_interval': 0, 23:09:21 INFO - 'suite': 'dromaeojs-e10s', 23:09:21 INFO - 'system_bits': '32', 23:09:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:21 INFO - 'title': 'talos-linux64-ix-003', 23:09:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:21 INFO - 'use_talos_json': True, 23:09:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:21 INFO - 'work_dir': 'build'} 23:09:21 INFO - ##### 23:09:21 INFO - ##### Running clobber step. 23:09:21 INFO - ##### 23:09:21 INFO - Running pre-action listener: _resource_record_pre_action 23:09:21 INFO - Running main action method: clobber 23:09:21 INFO - rmtree: /builds/slave/test/build 23:09:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:22 INFO - Running post-action listener: _resource_record_post_action 23:09:22 INFO - ##### 23:09:22 INFO - ##### Finished clobber step (success) 23:09:22 INFO - ##### 23:09:22 INFO - ##### 23:09:22 INFO - ##### Running read-buildbot-config step. 23:09:22 INFO - ##### 23:09:22 INFO - Running pre-action listener: _resource_record_pre_action 23:09:22 INFO - Running main action method: read_buildbot_config 23:09:22 INFO - Using buildbot properties: 23:09:22 INFO - { 23:09:22 INFO - "project": "", 23:09:22 INFO - "product": "firefox", 23:09:22 INFO - "script_repo_revision": "production", 23:09:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:09:22 INFO - "repository": "", 23:09:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:09:22 INFO - "buildid": "20160520203038", 23:09:22 INFO - "pgo_build": "True", 23:09:22 INFO - "basedir": "/builds/slave/test", 23:09:22 INFO - "buildnumber": 356, 23:09:22 INFO - "slavename": "talos-linux64-ix-003", 23:09:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:09:22 INFO - "platform": "ubuntu64_hw", 23:09:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:09:22 INFO - "branch": "fx-team", 23:09:22 INFO - "repo_path": "integration/fx-team", 23:09:22 INFO - "revision": "06d9362a57a10396f3f7c7989c21f1a416f4c7e9", 23:09:22 INFO - "stage_platform": "linux64-pgo", 23:09:22 INFO - "builduid": "abeca14195a54ba0a7b3eb8e3a460e64", 23:09:22 INFO - "slavebuilddir": "test" 23:09:22 INFO - } 23:09:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:09:22 INFO - Running post-action listener: _resource_record_post_action 23:09:22 INFO - ##### 23:09:22 INFO - ##### Finished read-buildbot-config step (success) 23:09:22 INFO - ##### 23:09:22 INFO - ##### 23:09:22 INFO - ##### Running download-and-extract step. 23:09:22 INFO - ##### 23:09:22 INFO - Running pre-action listener: _resource_record_pre_action 23:09:22 INFO - Running main action method: download_and_extract 23:09:22 INFO - mkdir: /builds/slave/test/build/tests 23:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:22 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:09:24 INFO - Downloaded 1361 bytes. 23:09:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:24 INFO - Using the following test package requirements: 23:09:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:24 INFO - u'jsshell-linux-x86_64.zip'], 23:09:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09: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')]} 23:09:24 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:26 INFO - Downloaded 24389251 bytes. 23:09:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:27 INFO - Return code: 0 23:09:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:27 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:29 INFO - Downloaded 24389251 bytes. 23:09:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:30 INFO - Return code: 0 23:09: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')]} 23:09:30 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:09:32 INFO - Downloaded 10840359 bytes. 23:09:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:09:32 INFO - Return code: 0 23:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:32 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:09:35 INFO - Downloaded 58593479 bytes. 23:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:35 INFO - mkdir: /builds/slave/test/properties 23:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:35 INFO - Contents: 23:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:35 INFO - Running post-action listener: _resource_record_post_action 23:09:35 INFO - Running post-action listener: set_extra_try_arguments 23:09:35 INFO - ##### 23:09:35 INFO - ##### Finished download-and-extract step (success) 23:09:35 INFO - ##### 23:09:35 INFO - ##### 23:09:35 INFO - ##### Running populate-webroot step. 23:09:35 INFO - ##### 23:09:35 INFO - Running pre-action listener: _resource_record_pre_action 23:09:35 INFO - Running main action method: populate_webroot 23:09:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:35 INFO - '--tppagecycles', 23:09:35 INFO - '7'], 23:09:35 INFO - 'tests': ['tsvgm']}}, 23:09:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['damp', 'tps']}, 23:09:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'tests': ['damp', 'tps']}, 23:09:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['dromaeo_dom']}, 23:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['tsvgx', 23:09:35 INFO - 'tsvgr_opacity', 23:09:35 INFO - 'tart', 23:09:35 INFO - 'tscrollx', 23:09:35 INFO - 'cart']}, 23:09:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:35 INFO - 'tsvgr_opacity', 23:09:35 INFO - 'tart', 23:09:35 INFO - 'tscrollx', 23:09:35 INFO - 'cart']}, 23:09:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['tp5o']}, 23:09:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'tests': ['tp5o']}, 23:09:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--disable-e10s', 23:09:35 INFO - '--xperf_path', 23:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:35 INFO - 'tests': ['tp5n']}, 23:09:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--xperf_path', 23:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:35 INFO - 'tests': ['tp5n']}}, 23:09:35 INFO - 'talos.zip': {'path': '', 23:09:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:35 INFO - Running post-action listener: _resource_record_post_action 23:09:35 INFO - ##### 23:09:35 INFO - ##### Finished populate-webroot step (success) 23:09:35 INFO - ##### 23:09:35 INFO - ##### 23:09:35 INFO - ##### Running create-virtualenv step. 23:09:35 INFO - ##### 23:09:35 INFO - Running pre-action listener: _resource_record_pre_action 23:09:35 INFO - Running main action method: create_virtualenv 23:09:35 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:36 INFO - Using real prefix '/usr' 23:09:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:38 INFO - Installing pip.................done. 23:09:38 INFO - Return code: 0 23:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09: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', 'pip>=1.5'] in /builds/slave/test/build 23:09: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 pip>=1.5 23:09:38 INFO - Using env: {'DISPLAY': ':0', 23:09:38 INFO - 'HOME': '/home/cltbld', 23:09:38 INFO - 'LANG': 'en_US.UTF-8', 23:09:38 INFO - 'LANGUAGE': 'en_US:en', 23:09:38 INFO - 'LOGNAME': 'cltbld', 23:09:38 INFO - 'MAIL': '/var/mail/cltbld', 23:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:38 INFO - 'MOZ_NO_REMOTE': '1', 23:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:38 INFO - 'NO_EM_RESTART': '1', 23:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:38 INFO - 'PWD': '/builds/slave/test', 23:09:38 INFO - 'SHELL': '/bin/bash', 23:09:38 INFO - 'SHLVL': '1', 23:09:38 INFO - 'TERM': 'linux', 23:09:38 INFO - 'TMOUT': '86400', 23:09:38 INFO - 'USER': 'cltbld', 23:09:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:38 INFO - '_': '/tools/buildbot/bin/python'} 23:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:09:38 INFO - Cleaning up... 23:09:38 INFO - Return code: 0 23:09:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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', '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 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:09: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 psutil>=3.1.1 23:09:38 INFO - Using env: {'DISPLAY': ':0', 23:09:38 INFO - 'HOME': '/home/cltbld', 23:09:38 INFO - 'LANG': 'en_US.UTF-8', 23:09:38 INFO - 'LANGUAGE': 'en_US:en', 23:09:38 INFO - 'LOGNAME': 'cltbld', 23:09:38 INFO - 'MAIL': '/var/mail/cltbld', 23:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:38 INFO - 'MOZ_NO_REMOTE': '1', 23:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:38 INFO - 'NO_EM_RESTART': '1', 23:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:38 INFO - 'PWD': '/builds/slave/test', 23:09:38 INFO - 'SHELL': '/bin/bash', 23:09:38 INFO - 'SHLVL': '1', 23:09:38 INFO - 'TERM': 'linux', 23:09:38 INFO - 'TMOUT': '86400', 23:09:38 INFO - 'USER': 'cltbld', 23:09:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:38 INFO - '_': '/tools/buildbot/bin/python'} 23:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:38 INFO - Downloading/unpacking psutil>=3.1.1 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:40 INFO - Installing collected packages: psutil 23:09:40 INFO - Running setup.py install for psutil 23:09:41 INFO - building 'psutil._psutil_linux' extension 23:09:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:09:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:09:41 INFO - building 'psutil._psutil_posix' extension 23:09:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:09:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:41 INFO - Successfully installed psutil 23:09:41 INFO - Cleaning up... 23:09:41 INFO - Return code: 0 23:09:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:09: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 mozsystemmonitor==0.3 23:09:41 INFO - Using env: {'DISPLAY': ':0', 23:09:41 INFO - 'HOME': '/home/cltbld', 23:09:41 INFO - 'LANG': 'en_US.UTF-8', 23:09:41 INFO - 'LANGUAGE': 'en_US:en', 23:09:41 INFO - 'LOGNAME': 'cltbld', 23:09:41 INFO - 'MAIL': '/var/mail/cltbld', 23:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:41 INFO - 'MOZ_NO_REMOTE': '1', 23:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:41 INFO - 'NO_EM_RESTART': '1', 23:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:41 INFO - 'PWD': '/builds/slave/test', 23:09:41 INFO - 'SHELL': '/bin/bash', 23:09:41 INFO - 'SHLVL': '1', 23:09:41 INFO - 'TERM': 'linux', 23:09:41 INFO - 'TMOUT': '86400', 23:09:41 INFO - 'USER': 'cltbld', 23:09:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:41 INFO - '_': '/tools/buildbot/bin/python'} 23:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:09:43 INFO - Installing collected packages: mozsystemmonitor 23:09:43 INFO - Running setup.py install for mozsystemmonitor 23:09:43 INFO - Successfully installed mozsystemmonitor 23:09:43 INFO - Cleaning up... 23:09:43 INFO - Return code: 0 23:09:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:43 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 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:09:43 INFO - Using env: {'DISPLAY': ':0', 23:09:43 INFO - 'HOME': '/home/cltbld', 23:09:43 INFO - 'LANG': 'en_US.UTF-8', 23:09:43 INFO - 'LANGUAGE': 'en_US:en', 23:09:43 INFO - 'LOGNAME': 'cltbld', 23:09:43 INFO - 'MAIL': '/var/mail/cltbld', 23:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:43 INFO - 'MOZ_NO_REMOTE': '1', 23:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:43 INFO - 'NO_EM_RESTART': '1', 23:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:43 INFO - 'PWD': '/builds/slave/test', 23:09:43 INFO - 'SHELL': '/bin/bash', 23:09:43 INFO - 'SHLVL': '1', 23:09:43 INFO - 'TERM': 'linux', 23:09:43 INFO - 'TMOUT': '86400', 23:09:43 INFO - 'USER': 'cltbld', 23:09:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:43 INFO - '_': '/tools/buildbot/bin/python'} 23:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:45 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:46 INFO - Downloading docopt-0.6.1.tar.gz 23:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:46 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:46 INFO - Running setup.py install for blobuploader 23:09:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:46 INFO - Running setup.py install for requests 23:09:46 INFO - Running setup.py install for docopt 23:09:46 INFO - Successfully installed blobuploader requests docopt 23:09:46 INFO - Cleaning up... 23:09:46 INFO - Return code: 0 23:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:46 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 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:09:46 INFO - Using env: {'DISPLAY': ':0', 23:09:46 INFO - 'HOME': '/home/cltbld', 23:09:46 INFO - 'LANG': 'en_US.UTF-8', 23:09:46 INFO - 'LANGUAGE': 'en_US:en', 23:09:46 INFO - 'LOGNAME': 'cltbld', 23:09:46 INFO - 'MAIL': '/var/mail/cltbld', 23:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:46 INFO - 'MOZ_NO_REMOTE': '1', 23:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:46 INFO - 'NO_EM_RESTART': '1', 23:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:46 INFO - 'PWD': '/builds/slave/test', 23:09:46 INFO - 'SHELL': '/bin/bash', 23:09:46 INFO - 'SHLVL': '1', 23:09:46 INFO - 'TERM': 'linux', 23:09:46 INFO - 'TMOUT': '86400', 23:09:46 INFO - 'USER': 'cltbld', 23:09:46 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:46 INFO - '_': '/tools/buildbot/bin/python'} 23:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:47 INFO - Running setup.py (path:/tmp/pip-D0KWj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:47 INFO - Running setup.py (path:/tmp/pip-QYXYix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:47 INFO - Running setup.py (path:/tmp/pip-CxIGXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:47 INFO - Running setup.py (path:/tmp/pip-j0lNe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:47 INFO - Running setup.py (path:/tmp/pip-7ycX2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:47 INFO - Running setup.py (path:/tmp/pip-UvWgt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:47 INFO - Running setup.py (path:/tmp/pip-M0joBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:47 INFO - Running setup.py (path:/tmp/pip-ynrZYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:47 INFO - Running setup.py (path:/tmp/pip-Ch1IKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:47 INFO - Running setup.py (path:/tmp/pip-C8VrRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:47 INFO - Running setup.py (path:/tmp/pip-9TpJkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:47 INFO - Running setup.py (path:/tmp/pip-5YjS5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:47 INFO - Running setup.py (path:/tmp/pip-1RQunD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:47 INFO - Running setup.py (path:/tmp/pip-i2r2hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:47 INFO - Running setup.py (path:/tmp/pip-qkS9m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:47 INFO - Running setup.py (path:/tmp/pip-yYCqH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:48 INFO - Running setup.py (path:/tmp/pip-qA3sNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:48 INFO - Running setup.py install for manifestparser 23:09:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Running setup.py install for mozcrash 23:09:48 INFO - Running setup.py install for mozdebug 23:09:48 INFO - Running setup.py install for mozdevice 23:09:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Running setup.py install for mozfile 23:09:48 INFO - Running setup.py install for mozhttpd 23:09:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Running setup.py install for mozinfo 23:09:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Running setup.py install for mozInstall 23:09:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:48 INFO - Running setup.py install for mozleak 23:09:48 INFO - Running setup.py install for mozlog 23:09:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for moznetwork 23:09:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for mozprocess 23:09:49 INFO - Running setup.py install for mozprofile 23:09:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for mozrunner 23:09:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for mozscreenshot 23:09:49 INFO - Running setup.py install for moztest 23:09:49 INFO - Running setup.py install for mozversion 23:09:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:49 INFO - Cleaning up... 23:09:49 INFO - Return code: 0 23:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:49 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 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:09:49 INFO - Using env: {'DISPLAY': ':0', 23:09:49 INFO - 'HOME': '/home/cltbld', 23:09:49 INFO - 'LANG': 'en_US.UTF-8', 23:09:49 INFO - 'LANGUAGE': 'en_US:en', 23:09:49 INFO - 'LOGNAME': 'cltbld', 23:09:49 INFO - 'MAIL': '/var/mail/cltbld', 23:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:49 INFO - 'MOZ_NO_REMOTE': '1', 23:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:49 INFO - 'NO_EM_RESTART': '1', 23:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:49 INFO - 'PWD': '/builds/slave/test', 23:09:49 INFO - 'SHELL': '/bin/bash', 23:09:49 INFO - 'SHLVL': '1', 23:09:49 INFO - 'TERM': 'linux', 23:09:49 INFO - 'TMOUT': '86400', 23:09:49 INFO - 'USER': 'cltbld', 23:09:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:49 INFO - '_': '/tools/buildbot/bin/python'} 23:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:49 INFO - Running setup.py (path:/tmp/pip-O8h22F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:49 INFO - Running setup.py (path:/tmp/pip-GTUjbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:50 INFO - Running setup.py (path:/tmp/pip-qYbi6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:50 INFO - Running setup.py (path:/tmp/pip-cqKSPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:50 INFO - Running setup.py (path:/tmp/pip-AK1Jv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:50 INFO - Running setup.py (path:/tmp/pip-mb5sr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:50 INFO - Running setup.py (path:/tmp/pip-SjDeVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:50 INFO - Running setup.py (path:/tmp/pip-cGGr9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:50 INFO - Running setup.py (path:/tmp/pip-GYsL10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:50 INFO - Running setup.py (path:/tmp/pip-0L4tET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:50 INFO - Running setup.py (path:/tmp/pip-E5Epeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:50 INFO - Running setup.py (path:/tmp/pip-3VCaEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:50 INFO - Running setup.py (path:/tmp/pip-pUjcco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:50 INFO - Running setup.py (path:/tmp/pip-aS0JCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:50 INFO - Running setup.py (path:/tmp/pip-YGj33i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:50 INFO - Running setup.py (path:/tmp/pip-ODG0hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:50 INFO - Running setup.py (path:/tmp/pip-VVT_ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:09:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:52 INFO - Downloading blessings-1.6.tar.gz 23:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:09:52 INFO - Installing collected packages: blessings 23:09:52 INFO - Running setup.py install for blessings 23:09:52 INFO - Successfully installed blessings 23:09:52 INFO - Cleaning up... 23:09:52 INFO - Return code: 0 23:09:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:53 INFO - Reading from file tmpfile_stdout 23:09:53 INFO - Current package versions: 23:09:53 INFO - argparse == 1.2.1 23:09:53 INFO - blessings == 1.6 23:09:53 INFO - blobuploader == 1.2.4 23:09:53 INFO - docopt == 0.6.1 23:09:53 INFO - manifestparser == 1.1 23:09:53 INFO - mozInstall == 1.12 23:09:53 INFO - mozcrash == 0.17 23:09:53 INFO - mozdebug == 0.1 23:09:53 INFO - mozdevice == 0.48 23:09:53 INFO - mozfile == 1.2 23:09:53 INFO - mozhttpd == 0.7 23:09:53 INFO - mozinfo == 0.9 23:09:53 INFO - mozleak == 0.1 23:09:53 INFO - mozlog == 3.2 23:09:53 INFO - moznetwork == 0.27 23:09:53 INFO - mozprocess == 0.22 23:09:53 INFO - mozprofile == 0.28 23:09:53 INFO - mozrunner == 6.11 23:09:53 INFO - mozscreenshot == 0.1 23:09:53 INFO - mozsystemmonitor == 0.3 23:09:53 INFO - moztest == 0.7 23:09:53 INFO - mozversion == 1.4 23:09:53 INFO - psutil == 3.1.1 23:09:53 INFO - requests == 1.2.3 23:09:53 INFO - wsgiref == 0.1.2 23:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:53 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 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:09:53 INFO - Using env: {'DISPLAY': ':0', 23:09:53 INFO - 'HOME': '/home/cltbld', 23:09:53 INFO - 'LANG': 'en_US.UTF-8', 23:09:53 INFO - 'LANGUAGE': 'en_US:en', 23:09:53 INFO - 'LOGNAME': 'cltbld', 23:09:53 INFO - 'MAIL': '/var/mail/cltbld', 23:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:53 INFO - 'MOZ_NO_REMOTE': '1', 23:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:53 INFO - 'NO_EM_RESTART': '1', 23:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:53 INFO - 'PWD': '/builds/slave/test', 23:09:53 INFO - 'SHELL': '/bin/bash', 23:09:53 INFO - 'SHLVL': '1', 23:09:53 INFO - 'TERM': 'linux', 23:09:53 INFO - 'TMOUT': '86400', 23:09:53 INFO - 'USER': 'cltbld', 23:09:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:53 INFO - '_': '/tools/buildbot/bin/python'} 23:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:09:53 INFO - Cleaning up... 23:09:53 INFO - Return code: 0 23:09:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:09:53 INFO - Using env: {'DISPLAY': ':0', 23:09:53 INFO - 'HOME': '/home/cltbld', 23:09:53 INFO - 'LANG': 'en_US.UTF-8', 23:09:53 INFO - 'LANGUAGE': 'en_US:en', 23:09:53 INFO - 'LOGNAME': 'cltbld', 23:09:53 INFO - 'MAIL': '/var/mail/cltbld', 23:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:53 INFO - 'MOZ_NO_REMOTE': '1', 23:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:53 INFO - 'NO_EM_RESTART': '1', 23:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:53 INFO - 'PWD': '/builds/slave/test', 23:09:53 INFO - 'SHELL': '/bin/bash', 23:09:53 INFO - 'SHLVL': '1', 23:09:53 INFO - 'TERM': 'linux', 23:09:53 INFO - 'TMOUT': '86400', 23:09:53 INFO - 'USER': 'cltbld', 23:09:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:53 INFO - '_': '/tools/buildbot/bin/python'} 23:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:53 INFO - Downloading/unpacking jsonschema 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:09:55 INFO - Downloading/unpacking functools32 (from jsonschema) 23:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:55 INFO - Downloading functools32-3.2.3-2.tar.gz 23:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:09:55 INFO - warning: no files found matching '*.txt' 23:09:55 INFO - no previously-included directories found matching 'build' 23:09:55 INFO - no previously-included directories found matching 'dist' 23:09:55 INFO - no previously-included directories found matching '.git*' 23:09:55 INFO - Installing collected packages: jsonschema, functools32 23:09:55 INFO - Running setup.py install for functools32 23:09:55 INFO - warning: no files found matching '*.txt' 23:09:55 INFO - no previously-included directories found matching 'build' 23:09:55 INFO - no previously-included directories found matching 'dist' 23:09:55 INFO - no previously-included directories found matching '.git*' 23:09:55 INFO - Successfully installed jsonschema functools32 23:09:55 INFO - Cleaning up... 23:09:55 INFO - Return code: 0 23:09:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:55 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 0x7fdca7c28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, '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': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:09:55 INFO - Using env: {'DISPLAY': ':0', 23:09:55 INFO - 'HOME': '/home/cltbld', 23:09:55 INFO - 'LANG': 'en_US.UTF-8', 23:09:55 INFO - 'LANGUAGE': 'en_US:en', 23:09:55 INFO - 'LOGNAME': 'cltbld', 23:09:55 INFO - 'MAIL': '/var/mail/cltbld', 23:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:55 INFO - 'MOZ_NO_REMOTE': '1', 23:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:55 INFO - 'NO_EM_RESTART': '1', 23:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:55 INFO - 'PWD': '/builds/slave/test', 23:09:55 INFO - 'SHELL': '/bin/bash', 23:09:55 INFO - 'SHLVL': '1', 23:09:55 INFO - 'TERM': 'linux', 23:09:55 INFO - 'TMOUT': '86400', 23:09:55 INFO - 'USER': 'cltbld', 23:09:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:55 INFO - '_': '/tools/buildbot/bin/python'} 23:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:56 INFO - Downloading/unpacking flake8 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:09:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:09:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:09:58 INFO - no previously-included directories found matching 'docs/_build' 23:09:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:09:58 INFO - Running setup.py install for pep8 23:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:09:58 INFO - no previously-included directories found matching 'docs/_build' 23:09:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:09:58 INFO - Cleaning up... 23:09:58 INFO - Return code: 0 23:09:58 INFO - Running post-action listener: _resource_record_post_action 23:09:58 INFO - Running post-action listener: _start_resource_monitoring 23:09:58 INFO - Starting resource monitoring. 23:09:58 INFO - ##### 23:09:58 INFO - ##### Finished create-virtualenv step (success) 23:09:58 INFO - ##### 23:09:58 INFO - ##### 23:09:58 INFO - ##### Running install step. 23:09:58 INFO - ##### 23:09:58 INFO - Running pre-action listener: _resource_record_pre_action 23:09:58 INFO - Running main action method: install 23:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:59 INFO - Reading from file tmpfile_stdout 23:09:59 INFO - Detecting whether we're running mozinstall >=1.0... 23:09:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:09:59 INFO - Reading from file tmpfile_stdout 23:09:59 INFO - Output received: 23:09:59 INFO - Usage: mozinstall [options] installer 23:09:59 INFO - Options: 23:09:59 INFO - -h, --help show this help message and exit 23:09:59 INFO - -d DEST, --destination=DEST 23:09:59 INFO - Directory to install application into. [default: 23:09:59 INFO - "/builds/slave/test"] 23:09:59 INFO - --app=APP Application being installed. [default: firefox] 23:09:59 INFO - mkdir: /builds/slave/test/build/application 23:09:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:10:15 INFO - Reading from file tmpfile_stdout 23:10:15 INFO - Output received: 23:10:15 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:15 INFO - Running post-action listener: _resource_record_post_action 23:10:15 INFO - ##### 23:10:15 INFO - ##### Finished install step (success) 23:10:15 INFO - ##### 23:10:15 INFO - ##### 23:10:15 INFO - ##### Running run-tests step. 23:10:15 INFO - ##### 23:10:15 INFO - Running pre-action listener: _resource_record_pre_action 23:10:15 INFO - Running main action method: run_tests 23:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:15 INFO - Python 2.7.3 23:10:15 INFO - Return code: 0 23:10:15 INFO - grabbing minidump binary from tooltool 23:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:15 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 0x28309c0>, '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 0x28318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:10:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:10:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:10:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:15 INFO - Return code: 0 23:10:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:10:16 INFO - Return code: 0 23:10:16 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/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:10:16 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/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:10:16 INFO - Using env: {'DISPLAY': ':0', 23:10:16 INFO - 'HOME': '/home/cltbld', 23:10:16 INFO - 'LANG': 'en_US.UTF-8', 23:10:16 INFO - 'LANGUAGE': 'en_US:en', 23:10:16 INFO - 'LOGNAME': 'cltbld', 23:10:16 INFO - 'MAIL': '/var/mail/cltbld', 23:10:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:16 INFO - 'MOZ_NO_REMOTE': '1', 23:10:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:16 INFO - 'NO_EM_RESTART': '1', 23:10:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:16 INFO - 'PWD': '/builds/slave/test', 23:10:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:16 INFO - 'SHELL': '/bin/bash', 23:10:16 INFO - 'SHLVL': '1', 23:10:16 INFO - 'TERM': 'linux', 23:10:16 INFO - 'TMOUT': '86400', 23:10:16 INFO - 'USER': 'cltbld', 23:10:16 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463810178.515319-594916301', 23:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:16 INFO - '_': '/tools/buildbot/bin/python'} 23:10:16 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/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:10:17 INFO - mozversion application_buildid: 20160520203038 23:10:17 INFO - mozversion application_changeset: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 23:10:17 INFO - mozversion application_display_name: Nightly 23:10:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:17 INFO - mozversion application_name: Firefox 23:10:17 INFO - mozversion application_remotingname: firefox 23:10:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:10:17 INFO - mozversion application_vendor: Mozilla 23:10:17 INFO - mozversion application_version: 49.0a1 23:10:17 INFO - mozversion platform_buildid: 20160520203038 23:10:17 INFO - mozversion platform_changeset: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 23:10:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:10:17 INFO - mozversion platform_version: 49.0a1 23:10:17 INFO - using testdate: 1463811017 23:10:17 INFO - actual date: 1463811017 23:10:17 INFO - starting webserver on 'localhost:54270' 23:10:17 INFO - SUITE-START | Running 2 tests 23:10:17 INFO - TEST-START | dromaeo_css 23:10:17 INFO - operating with platform_type : linux_ 23:10:17 INFO - Initialising browser for dromaeo_css test... 23:10:17 INFO - TEST-INFO | started process 14550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6vvaMw/profile http://localhost:54270/getInfo.html) 23:10:20 INFO - PROCESS | 14550 | 23:10:20 INFO - PROCESS | 14550 | (process:14619): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:21 INFO - PROCESS | 14550 | __metrics Screen width/height:1600/1200 23:10:21 INFO - PROCESS | 14550 | colorDepth:24 23:10:21 INFO - PROCESS | 14550 | Browser inner width/height: 1024/697 23:10:21 INFO - PROCESS | 14550 | __metrics 23:10:22 ERROR - PROCESS | 14550 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:10:22 INFO - TEST-INFO | 14550: exit 0 23:10:22 INFO - Browser initialized. 23:10:22 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:22 INFO - TEST-INFO | started process 14670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6vvaMw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:24 INFO - PROCESS | 14670 | 23:10:24 INFO - PROCESS | 14670 | (process:14730): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:34 INFO - PROCESS | 14670 | RSS: Main: 163205120 23:10:34 INFO - PROCESS | 14670 | 23:11:23 INFO - PROCESS | 14670 | 1463811083797 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:13:31 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:54270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54270/tests/dromaeo/cssquery-ext.html) 23:13:32 INFO - PROCESS | 14670 | RSS: Main: 166019072 23:13:32 INFO - PROCESS | 14670 | 23:16:34 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:54270/tests/dromaeo/cssquery-ext.html (next: http://localhost:54270/tests/dromaeo/cssquery-jquery.html) 23:16:35 INFO - PROCESS | 14670 | RSS: Main: 166313984 23:16:35 INFO - PROCESS | 14670 | 23:19:37 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:54270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54270/tests/dromaeo/cssquery-mootools.html) 23:19:37 INFO - PROCESS | 14670 | RSS: Main: 167288832 23:19:37 INFO - PROCESS | 14670 | 23:22:39 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:54270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54270/tests/dromaeo/cssquery-prototype.html) 23:22:40 INFO - PROCESS | 14670 | RSS: Main: 164659200 23:22:40 INFO - PROCESS | 14670 | 23:25:42 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:54270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54270/tests/dromaeo/cssquery-yui.html) 23:25:42 INFO - PROCESS | 14670 | RSS: Main: 166305792 23:25:42 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | Cycle 1(1): loaded http://localhost:54270/tests/dromaeo/cssquery-yui.html (next: http://localhost:54270/tests/dromaeo/cssquery-dojo.html) 23:28:45 INFO - PROCESS | 14670 | RSS: Main: 168099840 23:28:45 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | __start_tp_report 23:28:45 INFO - PROCESS | 14670 | _x_x_mozilla_page_load 23:28:45 INFO - PROCESS | 14670 | _x_x_mozilla_page_load_details 23:28:45 INFO - PROCESS | 14670 | |i|pagename|runs| 23:28:45 INFO - PROCESS | 14670 | |0;dojo.html;3123.656397796242;3131.4363414585373;3134.686531346865;3146.889858854939;3175.079227024163;5323.467653234675;5365;5372.194170874366;5409.756560954756;5541.307336582927;5196.246544251081;5282.181261904411;5291.3385826771655;5302.549283310914;5322.733863306838;4840.588549973248;4846.933674591584;4988.42633097193;4996.025774973881;5044.873878153057;4828.879278018043;5052.242163675442;5052.46949070346;5053.343065401493;5078.898422031557;4778.116048531033;4802.783874725611;4823.1800593899125;4909.312696222514;4957.7769000395065;4796.280557916306;4811.27830825379;4813.4945830687975;4855.295982082578;4874.195757699975;4824.975875120637;4840.080384726891;4852.126617208901;4861.052094841507;4892.143874821892;5205.167173252262;5221.295125158131;5252.8686782830355;5302.2046692996355;5363.785448582052;5784.871949969757;5826.563007774392;5849.122631605251;5852.151438041503;5868.41315868414;5591.608587398884;5861;5867;5869.882602347929;5875.823725288248;5343.118385466393;5461.989531936604;5463.562914966793;5464.808731694372;5525.392206857283;5937.406259374115;5959.702014899238;5993;5994.400559943971;6001.219841420588;5565.30433695788;5602.215689803431;5686.459786320375;5728.484436400744;5762;5732.082866741302;5792.478676919098;5803.100519419412;5805.564582656318;5848.210491583667;5650.23721797552;5669.1496275558175;5756.280464941882;5774.682392468455;5783.16144159103;5483.945160548344;5788.739506722208;5794.333651630117;5813.069908814569;5854.912176317359;4310.913781724348;4387.078713470143;4409.382686423904;4419.491758447755;4425.446819147606;3943.723939324277;3949.881503554898;3953.0512676957323;3957.485526881487;3984.1234928315725;5420.295361602966;5437.265969094201;5544.722763861791;5600.887982240332;5627.212190293362;5771.026054485232;5810.389909059572;5821.27234095738;5831;5835.67903765297;5492.395836457987;5511.200875872976;5517.36550296713;5522.861928451821;5535.58483113768;4883;4987.62592805541;4997.075541024922;5025.874353141201;5060;6033.5173186145;6043.54673399488;6045.697715114315;6062.727177277033;6069.939300607026;5823.505002074787;5849.912251316148;5850.034744267318;5851.297844258716;5855.94144058571;5799.159121927212;5986.491148252448;6012.789552365646;6031.155638210742;6077.088436734525;5696.629719068247;5700.743466543932;5719.3136823581435;5722.7710891563875;5730.799422020209;5631.155326701028;5796.42035796417;5799.565032622486;5825.417458254141;5854.736536855937;5596.720163991866;5632.380438151718;5633.718314084197;5652.971735141463;5654.180143879033;5444.564434845123;5520.723963801714;5525.281713377235;5617.43825617435;5618.550515958796;5478.945210547843;5481.232627432242;5544.667319960815;5550.833474995757;5565.276514053147;5570.526505246938;5607.243022191952;5608.4111168326735;5718.51392631631;5783.884322313446;5624.550035997028;5631.662100273997;5650.124230744241;5653.858653533694;5693.430656934273 23:28:45 INFO - PROCESS | 14670 | |1;ext.html;568.2300482845744;602.3193791016151;609.2445367743996;613.5061275673082;639.5970538560706;38230.99999999996;41776.79111604438;42033.159336813245;42109;42275.15449691004;42068;42409.57590424095;42563.57436425635;42620;42629.36055959163;8474.78813029673;8677.783055423602;8700.216980471756;8738.344624153182;8760.167784060504;8423.49459032457;8460.57697115145;8476.576171191417;8493.108223636491;8500.319974402064;8652.567371631425;8693.869591956094;8702.129787021311;8742.082081381459;8783.429077109999;8559.700410485635;8647.999999999969;8655.047944726075;8672.956635216846;8677.956610216972;8542.829143417159;8590.828183436297;8593.527355995418;8619.051904290523;8646.43798153118;31787.523187152212;40290.19419611591;40835.59164408348;40892.79553602243;41081.589184108074;3331.6501767314567;3417.8632854685784;3559.5906470755936;3608.585012723544;3724.2365315110337;30598.69401305981;31180.844095779375;31359.05922822319;33237.33525329504;33919;4235.470566179228;4312.654987601016;4327.7186982846015;4388.5830846069575;4501.437320334958;331413;341102;342782;344197;345246;30531.69468305333;31484.68515314863;31504;62127.378726213065;62146.689266554284;37500.24999500049;37631.81184094117;37746.81126594349;37797.433038504445;37909.24181516354;15864.762028569581;16030.438934637232;16051.598710032342;16061.67876642484;16122.355105795872;13013.609591712264;13162.14446061003;13194.802077968838;13197.010224233221;13240.20558766477;8470.957645211734;8472.110428405053;8484.830303394021;8511.95744021276;8542.10307917672;3370.292238629915;3376.29097889446;3388.186835159593;3389.474631432132;3417.8120203388553;1024.9436281004616;1032.1897310611134;1040.0327695243345;1063.5958335832333;1085.2999815119363;31684.683153168633;31730;31880;32392.676073238967;32446.675533244837;1096.6545538155456;1132.1452303510962;1145.8968692817687;1167.3054532553117;1246.4515613130193;16519.421820236235;17132;17158.48524544266;17392.391266305618;17426.12869356527;488487.1332076699;489434;489765;492821;494112;57134.142987855215;57958.13062804061;58059;58161.70919145462;58302.7084864573;1359.6804750883534;1368.7809950407886;1400.4258254115764;1400.95096671616;1406.2617126008927;29969.850150749106;31660;31777.20556986094;31898.61334155355;32031.35937281288;51879.740601296755;52132.47867521276;52349.47650523446;52507.73746131245;52532.7373363146;403247;405884;406234;406559;407159;28621.570676440286;29110.563341550318;29145.271368215963;29172.854135729187;29268.7073129266;48085.27872081852;48533.51466485431;48900.2664960033;49831.501684984134;49876.75061624669;40291.798541007105;41435.7928210357;41792.37311440392;41877.371839423045;42712.35931460968;41355.7932210337;41724;41784;41974.37038444487;42256.36615450709;40673;40873.59126408698;41596.37605435981;41690.374644380965;41705.58294417017;33758;36806.63193368032;37047.25905481821;37142.44286335653;37289.254214916094;27610.171694849185;27840.303992400353;27904.58143127814;27944.580831287953;27949.441011179257 23:28:45 INFO - PROCESS | 14670 | |2;jquery.html;381.2013831024005;384.1229193341869;397.0569896495821;399.45274973286604;414.9957103808782;17530.73703894441;18367.816321836777;19061.618767624655;19084.42746717599;19251.807481925178;16455.588610284747;16504.917475412636;16808.915955420238;18204.726929096076;18453.907730461364;5407.134858422653;5430.59270554709;5635.6618602883755;5651.689157096358;5675.801346952858;5542.140968149944;5544.722763861811;5561.749721262553;5583.972080139593;5606.383297837235;5407.810726624569;5460.645058071233;5498.752556134964;5543.168524721304;5545.861353466155;5547.889042219153;5548.86127846803;5556.777728890839;5561.388247292814;5565.499105080522;4784.952150478485;4938.925916111261;4965.131102057126;4985.800567977277;5014;20944.37166884996;21338.786612133834;21680.94031067046;21949;21997.120115195372;2294.265834932822;2443.218170185541;2458.496008318308;2493.8379005364595;2626.2383908666657;13178.934105329412;13905.16569005863;14133.434662613483;14140;14413.78379324311;1920.5294702797903;1931.94204173875;1974.1609815828358;2021.6512975334617;2036.562139140077;71918.64040679763;75314.62342688306;76249.23750762477;76482.23517764806;76502.23497765006;9993.950030249802;10076.74808129788;10325.690229293134;10385.63650272237;10526.842097368546;14106.506272280627;14195.574132776033;14240.501582444773;14268.429262829579;14278.500252491112;7995.320397766139;8250.628721707537;8279.296259817862;8319.209675080858;8388.07731149573;8087.716929907425;8114.229148230908;8148.307393871469;8194.959025204955;8213.83572328562;6390.552661313756;6440.645764482904;6444.871102577922;6483.578567393104;6512.73949042033;1892.9810701892804;1896.3173257627243;1931.420573827846;1933.9033048347808;1945.299692110839;874.9693760718344;1033.9172866170688;1049.3022140276782;1108.4291589831244;1120.2046546951592;16058.27737751804;16297.103659298853;18278.908605456887;18636.695431319677;18952.336668216547;971.2812518736225;979.9755006124761;995.9651412200539;1016.3546148195949;1038.050184081572;10480.266381353385;10647.94676026615;10735.94632026835;10759.30064545802;10780.191485638608;260426;421104;438823;440185;442386;72314.63842680753;77902;80294.19705802984;91249;94706.52646736722;1014.7716763728102;1046;1085.3976043296047;1086.4241951765578;1091.5688303120223;16303.184840758151;16606.50180494587;16703.582410439838;16970.321187152374;17129.314827406764;38803.61196388113;39007;39809.40285895772;39978.2004359917;40239.597604023584;50914.490855090975;53315.20027199518;53406.46593534015;53903;54060.459395405545;7924.484908481161;7991.440599158003;8050.074241462073;8170.387220958333;8517.190866867637;9189.770255743393;12173;12245.326507042199;13083.476660933837;13145.53990610324;11134.3876086816;11367.602133925273;11562.826557601475;11619;11638.941805290919;11088.279261847954;11397.259178153394;11412.144089193178;11485.19603627738;11537.653870383901;11037.613683521038;11364.318140911571;11426.82859757121;11499;11760.529578817093;6997.230304666585;7408.888866666896;7586.734464293723;7807.102183248999;8829.602667879832;10543.209259305737;11562.826557601475;11716.531338746354;11786.174967752519;11802.996745276747 23:28:45 INFO - PROCESS | 14670 | |3;mootools.html;1530.7015132049248;1554.1607531932757;1726.542466246445;1825.8448031917287;1839.0620783400461;7703.422243331758;8377.623006964686;8486.490810551371;8900.599473023705;8901.732948011562;8677.652893884237;8992.820143597124;9012.188902998729;9014.639414423415;9026.90973090269;2336.147306233221;2372.5408873542733;2374.1334412939327;2379.3218932604213;2399.6160614301716;2335.089315167086;2335.801456876168;2336.6728657987896;2340.028888011473;2342.273895092518;2311.9422014449606;2328.1036800831635;2328.871912044837;2336.6845475860796;2336.8481048731865;2229.6989906362596;2244.629636110048;2249;2256.650219216024;2283.9543209135722;2267.115824828302;2274.0449011415244;2285.165914441217;2287.2795069553035;2296.150424342987;8896.466212027299;8989.235914947238;9000.59497322622;9055.366124371296;9095.681651142178;5136.357955255593;5284.973575132138;5297.046531624306;5322.361316642027;5344.171653393731;3282.8522716477814;3333.887676941578;3396.813175275359;3450.344434557426;3471.2536804586885;1107.44074242507;1120.5125770289949;1121.4616983847798;1141.2353723005606;1165.7785020846097;12456.626301210978;12513.687157821036;12515.687107822287;12550.560730374393;12560.497580096786;4526.456825180933;4526.592606665416;4538;4557.817687292538;4560.293154561048;10423;10540.524326594283;10541.262111652111;10557.788844223072;10559.419231942164;5193.402758682724;5222.477752224747;5273.947260527346;5281.762320695578;5307.230451584576;4224.070704445017;4708.4349878014855;4834.226523756182;4870.123377791961;4885.047415753965;4019.437278780973;4059.594040595917;4093.85671501496;4121.5878412159145;4156.25187466259;1238.5169783784331;1284.1973766396002;1285.9807102893465;1286.395394164741;1290.5289569307135;905.4522014181457;945.4280160502934;960.8606752020918;969.8981606931312;987.0672214757129;5696.3733989261145;5787.797427090031;5913.113033045078;6032.668203248863;6042.063480160582;993.5231089077139;999.9150072243796;1013.8175128476945;1029.4543891737392;1051.5478344311866;3864.555576108727;4066.5933406659096;4071.491063617048;4115.588441155861;4137.958620413818;11193.720156995978;11511.884881151249;11591.478383472764;11635.709107272385;11667;11287;11336.263142895685;11357.602483913188;11372.374519401346;11386.202965792481;8373.874391884248;8565.743027709179;8647.221750042401;8656.740297791077;8665.220130188187;5903.439173278532;6022.2171117754415;6030.6080104793045;6045.244344456943;6079.422454866781;10228.48857557134;10481.842772358268;10623.309484883457;10665.573377064831;10684.786304274026;10397.896021039995;10642.935706429294;10680.252382333161;10883.346999180074;10947.288426252268;6760.898586521304;7455.589942553212;7674.731384401519;7751.302382785577;7908.130105688255;8925.928888533157;8927.062658420773;8943.552822358986;8953.686620968236;8992.775180620276;7867.17394673551;8063.717769878026;8107.473014254055;8151.755447336589;8205.179482051746;7924;8043.919560804317;8290.37822163328;8380.622871970654;8415.957920210605;6700.530962832555;6752.358525940028;6807.795766127024;6809.046733457419;6853.691583878638;5298;5371.355437347544;5390.299261096189;5404.270423492778;5438.320209973754;5338.38608560005;5378.327709036371;5393.633841472485;5457;5538.196961440488 23:28:45 INFO - PROCESS | 14670 | |4;prototype.html;311.7505995203838;319.6308263955133;322.39229053234646;328.64834626949164;329.15243248634766;5377.381601115868;5405.864853378667;5424.240606315119;5444.646098003632;5480.725963701819;5373.596980226489;5410.5401040911565;5416.8104116355935;5444.564434845212;5455.399906010336;3998.1803730235233;4015.8393664253394;4118.599676110122;4122;4134.966258435391;4163.125743593849;4163.250614889319;4163.479565054368;4192.9790351048205;4234.110836724291;4128.380742888561;4143.627073563379;4144.875653730378;4150.190712811003;4175.66594672427;4048.4939382577177;4103.4460347852955;4118.485189351331;4127.587241275878;4173.165366926612;3617.2042150726797;3626.984444355585;3636.6181550937035;3644.125409901631;3645.8359373828243;5059.949400505985;5097.7196254206;5138.691678499302;5176.327077479941;5186.611004174664;4646;4739.95260047402;4744.501827308118;4757.690750101232;4761.333413322138;5553.611247212697;5556.222128901957;5568.081266591008;5579.330480342344;5586.608937374385;4022.6781857451333;4030.8186131624147;4031.4154447605224;4032.5765794591734;4043.0700938784244;5631.7465714042555;5711.228984087136;5753.33836608787;5796;5846.649201047951;4050.797460126982;4054.878353649395;4060.9187816244103;4087.2234275487563;4098.995746042238;4101.097758493127;4146.295129827937;4147.212029714345;4167.895507690464;4181.937270940938;4647.419072615923;4697.671163018625;4731.810727570927;4736.384270044872;4743.525647435298;5516.172574113834;5542.7782888684005;5568.638038527482;5596.552275817925;5599.664020158803;1419.531554586984;1458.8030615866935;1461.415433826478;1465.1209274435466;1465.5310300703886;885.5129678676702;924.7410724997012;928.8560273157672;946.4794363100267;979.3585201692903;5415.214793854869;5488.655279456559;5530.617345663584;5531.8893622128135;5567.443255674481;5746.482816546531;5806.622569532967;5861.589688721834;5872.765089396462;5878.617889837233;5361.705106219196;5420.674759514442;5422.186671999231;5431.131019036935;5455.727213639381;3058.143719758471;3108.1607965849093;3109.2693217093965;3121.3133110715607;3123.7500999919953;5680.488756011896;5902.2032025676845;5935.198748168942;5974.2233509643465;5984.251968503937;5908.632079714522;5942;5978.701064946822;5986.640801551921;6006.12911127884;6054.334023257438;6078.999999999912;6081.969590152021;6107.053406721965;6124.326324104345;5658.830235092953;5831.504322132666;5837.241158649348;5854.063349864001;5867.383924688017;5748.166515855094;5800.665846855162;5805.332386775406;5833.241678581927;5838.211841401527;5763.3286346960585;5965.970170149121;5969.134475500941;6028.969855150872;6100.359462256399;4081.40819581165;4094.2016306819883;4094.61101195386;4096.3036283831225;4102.282100632317;5842.532597392284;5851.64890106595;5928.822135335947;5933.495652869555;5975.133605627247;5571.3871474137;5678.706350316724;5800.9419905800405;5803.881583222178;5834.94165058344;5647.124695672177;5648.265725455664;5736.569757268138;5740.225069615549;5744.885102298014;5368.128051492589;5404.0272750905215;5599.972000139973;5650.745716442852;5661.235733176133;5702.146802289356;5711.543076553782;5773.451522105393;5780.0173970424285;5787.074068149076;5620.26936498269;5643.209950607001;5668.1214411764595;5716.171155182392;5735.541156707537 23:28:45 INFO - PROCESS | 14670 | |5;yui.html;819.8893149424827;835.2649668291903;835.9958200208998;841.0958219913595;850.7830503221678;13948;13993.580192594212;14256.358463869125;14307.85537157029;14319.069260498087;14116.647083822883;14280.4287828487;14329.856701432982;14378.856211437882;14400.279986000683;787.8818177273412;802.314021511608;802.8675268580706;803.3292201012162;804.859149648812;667.9064930909676;788.7515432638701;810.9067457242434;815.8816971539123;817.648411183191;856.575994882534;858.9613467393951;860.27736701171;861.1990848510883;863.9395242333039;845.2266176448542;850.3324889961351;858.2618947704968;860.165639329849;864.7621903976457;620.3114542857425;625.9687015649245;626.1797045869924;626.4455956478504;627.4760574919902;11693.239939403997;11764.294142351486;11781.764364712744;11789.292642441482;11871.228370155912;13828.446862125504;14242.92878535611;14266.714665706731;14300;14515.201663908481;10658.680239592824;10784.838227426595;10826.140077279872;11594.71013224676;11711.765764684744;4502.302143167814;4536.56902594253;4539.319102134673;4632.143053535073;4751.667383283171;56740.148897766565;56863.147052794244;57693.711531442495;58254.70872645652;59268;10682.94658526718;10714.732131696614;10964.054895077003;11085.667429976953;11222.438878056228;17519.82480175182;17587.56031099233;17654.823451765576;17682.11589420524;17717.911410443125;7971.481853679492;8010.639521221559;8059.5164290142775;8064.637091330904;8300.875486867702;4655.95344046562;4760.33355330254;4805.807767689324;4820.542048505386;4881.219004959261;3355.681210285019;3401.013706025225;3408.812515311632;3412.283420481727;3435.793852368866;597.1162679234757;599.9310079340844;606.6511755740466;610.7343305662051;613.8127870999299;566.5382713088902;721.931789892955;724.6449239872425;749.7263498822999;749.966251518683;9463.76340591477;9523.428594284365;9838.212942964547;10109.82443033246;10541.262111652264;746.5073051785795;771.548644043241;772.4168252968973;780.4965797060864;812.7196117339508;4246.193223287565;4624.930626040612;4633.72197668141;4676.485586585472;4704.3649107370065;65175;65686.67156664186;66091.66954165198;66357.33642663511;67295.60691734277;56806;57101.428985710445;59036.70481647564;59652;62169.689151553954;52531.73734131305;52858.48732465875;54237.999999999214;54916.72541637346;55028;9129.680461183827;9151.725448236564;9172.862407063765;9175.44947303164;9184.862227066733;32565.511517326784;33695;34146.31707365789;35625;37458.25083498369;45685.77157114193;45809.541904580525;46519;46876.7656161717;48082.51917480781;12631.178973366701;12670.239785612892;12799.424025919043;12799.616011519669;13305.534306299232;13738.450461981809;13757;13992.16047037181;14275;14398.928005359907;13093.0834841564;13199.274039927512;13207.471701132232;13296.468141274627;13757.761801437919;13182.868171318547;13537;13573.321333933462;13691.726165476435;14014.929925350716;13112.73774524485;13485.797713034117;13716.314184290944;13983.860161398256;14037.5086871959;10044.447555384524;10150.49247537635;10212.438315892698;10263.794724105326;10449.738756531147;10325;10488.577290019479;10507.106895913934;10628.946855265984;10977.052047823945 23:28:45 INFO - PROCESS | 14670 | __end_tp_report 23:28:45 INFO - PROCESS | 14670 | __start_cc_report 23:28:45 INFO - PROCESS | 14670 | _x_x_mozilla_cycle_collect,299 23:28:45 INFO - PROCESS | 14670 | __end_cc_report 23:28:45 INFO - PROCESS | 14670 | __startTimestamp1463812125594__endTimestamp 23:28:45 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | ------- Summary: start ------- 23:28:45 INFO - PROCESS | 14670 | Number of tests: 6 23:28:45 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | [#0] dojo.html Cycles:165 Average:5369.26 Median:5565.30 stddev:618.39 (11.1%) stddev-sans-first:594.66 23:28:45 INFO - PROCESS | 14670 | Values: 3123.7 3131.4 3134.7 3146.9 3175.1 5323.5 5365.0 5372.2 5409.8 5541.3 5196.2 5282.2 5291.3 5302.5 5322.7 4840.6 4846.9 4988.4 4996.0 5044.9 4828.9 5052.2 5052.5 5053.3 5078.9 4778.1 4802.8 4823.2 4909.3 4957.8 4796.3 4811.3 4813.5 4855.3 4874.2 4825.0 4840.1 4852.1 4861.1 4892.1 5205.2 5221.3 5252.9 5302.2 5363.8 5784.9 5826.6 5849.1 5852.2 5868.4 5591.6 5861.0 5867.0 5869.9 5875.8 5343.1 5462.0 5463.6 5464.8 5525.4 5937.4 5959.7 5993.0 5994.4 6001.2 5565.3 5602.2 5686.5 5728.5 5762.0 5732.1 5792.5 5803.1 5805.6 5848.2 5650.2 5669.1 5756.3 5774.7 5783.2 5483.9 5788.7 5794.3 5813.1 5854.9 4310.9 4387.1 4409.4 4419.5 4425.4 3943.7 3949.9 3953.1 3957.5 3984.1 5420.3 5437.3 5544.7 5600.9 5627.2 5771.0 5810.4 5821.3 5831.0 5835.7 5492.4 5511.2 5517.4 5522.9 5535.6 4883.0 4987.6 4997.1 5025.9 5060.0 6033.5 6043.5 6045.7 6062.7 6069.9 5823.5 5849.9 5850.0 5851.3 5855.9 5799.2 5986.5 6012.8 6031.2 6077.1 5696.6 5700.7 5719.3 5722.8 5730.8 5631.2 5796.4 5799.6 5825.4 5854.7 5596.7 5632.4 5633.7 5653.0 5654.2 5444.6 5520.7 5525.3 5617.4 5618.6 5478.9 5481.2 5544.7 5550.8 5565.3 5570.5 5607.2 5608.4 5718.5 5783.9 5624.6 5631.7 5650.1 5653.9 5693.4 23:28:45 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | [#1] ext.html Cycles:180 Average:56331.55 Median:223616.00 stddev:110511.35 (49.4%) stddev-sans-first:110742.06 23:28:45 INFO - PROCESS | 14670 | Values: 568.2 602.3 609.2 613.5 639.6 38231.0 41776.8 42033.2 42109.0 42275.2 42068.0 42409.6 42563.6 42620.0 42629.4 8474.8 8677.8 8700.2 8738.3 8760.2 8423.5 8460.6 8476.6 8493.1 8500.3 8652.6 8693.9 8702.1 8742.1 8783.4 8559.7 8648.0 8655.0 8673.0 8678.0 8542.8 8590.8 8593.5 8619.1 8646.4 31787.5 40290.2 40835.6 40892.8 41081.6 3331.7 3417.9 3559.6 3608.6 3724.2 30598.7 31180.8 31359.1 33237.3 33919.0 4235.5 4312.7 4327.7 4388.6 4501.4 331413.0 341102.0 342782.0 344197.0 345246.0 30531.7 31484.7 31504.0 62127.4 62146.7 37500.2 37631.8 37746.8 37797.4 37909.2 15864.8 16030.4 16051.6 16061.7 16122.4 13013.6 13162.1 13194.8 13197.0 13240.2 8471.0 8472.1 8484.8 8512.0 8542.1 3370.3 3376.3 3388.2 3389.5 3417.8 1024.9 1032.2 1040.0 1063.6 1085.3 31684.7 31730.0 31880.0 32392.7 32446.7 1096.7 1132.1 1145.9 1167.3 1246.5 16519.4 17132.0 17158.5 17392.4 17426.1 488487.1 489434.0 489765.0 492821.0 494112.0 57134.1 57958.1 58059.0 58161.7 58302.7 1359.7 1368.8 1400.4 1401.0 1406.3 29969.9 31660.0 31777.2 31898.6 32031.4 51879.7 52132.5 52349.5 52507.7 52532.7 403247.0 405884.0 406234.0 406559.0 407159.0 28621.6 29110.6 29145.3 29172.9 29268.7 48085.3 48533.5 48900.3 49831.5 49876.8 40291.8 41435.8 41792.4 41877.4 42712.4 41355.8 41724.0 41784.0 41974.4 42256.4 40673.0 40873.6 41596.4 41690.4 41705.6 33758.0 36806.6 37047.3 37142.4 37289.3 27610.2 27840.3 27904.6 27944.6 27949.4 23:28:45 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | [#2] jquery.html Cycles:180 Average:25730.12 Median:2450.86 stddev:67296.58 (2745.8%) stddev-sans-first:67458.45 23:28:45 INFO - PROCESS | 14670 | Values: 381.2 384.1 397.1 399.5 415.0 17530.7 18367.8 19061.6 19084.4 19251.8 16455.6 16504.9 16808.9 18204.7 18453.9 5407.1 5430.6 5635.7 5651.7 5675.8 5542.1 5544.7 5561.7 5584.0 5606.4 5407.8 5460.6 5498.8 5543.2 5545.9 5547.9 5548.9 5556.8 5561.4 5565.5 4785.0 4938.9 4965.1 4985.8 5014.0 20944.4 21338.8 21680.9 21949.0 21997.1 2294.3 2443.2 2458.5 2493.8 2626.2 13178.9 13905.2 14133.4 14140.0 14413.8 1920.5 1931.9 1974.2 2021.7 2036.6 71918.6 75314.6 76249.2 76482.2 76502.2 9994.0 10076.7 10325.7 10385.6 10526.8 14106.5 14195.6 14240.5 14268.4 14278.5 7995.3 8250.6 8279.3 8319.2 8388.1 8087.7 8114.2 8148.3 8195.0 8213.8 6390.6 6440.6 6444.9 6483.6 6512.7 1893.0 1896.3 1931.4 1933.9 1945.3 875.0 1033.9 1049.3 1108.4 1120.2 16058.3 16297.1 18278.9 18636.7 18952.3 971.3 980.0 996.0 1016.4 1038.1 10480.3 10647.9 10735.9 10759.3 10780.2 260426.0 421104.0 438823.0 440185.0 442386.0 72314.6 77902.0 80294.2 91249.0 94706.5 1014.8 1046.0 1085.4 1086.4 1091.6 16303.2 16606.5 16703.6 16970.3 17129.3 38803.6 39007.0 39809.4 39978.2 40239.6 50914.5 53315.2 53406.5 53903.0 54060.5 7924.5 7991.4 8050.1 8170.4 8517.2 9189.8 12173.0 12245.3 13083.5 13145.5 11134.4 11367.6 11562.8 11619.0 11638.9 11088.3 11397.3 11412.1 11485.2 11537.7 11037.6 11364.3 11426.8 11499.0 11760.5 6997.2 7408.9 7586.7 7807.1 8829.6 10543.2 11562.8 11716.5 11786.2 11803.0 23:28:45 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | [#3] mootools.html Cycles:180 Average:5926.90 Median:4532.30 stddev:3422.05 (75.5%) stddev-sans-first:3415.71 23:28:45 INFO - PROCESS | 14670 | Values: 1530.7 1554.2 1726.5 1825.8 1839.1 7703.4 8377.6 8486.5 8900.6 8901.7 8677.7 8992.8 9012.2 9014.6 9026.9 2336.1 2372.5 2374.1 2379.3 2399.6 2335.1 2335.8 2336.7 2340.0 2342.3 2311.9 2328.1 2328.9 2336.7 2336.8 2229.7 2244.6 2249.0 2256.7 2284.0 2267.1 2274.0 2285.2 2287.3 2296.2 8896.5 8989.2 9000.6 9055.4 9095.7 5136.4 5285.0 5297.0 5322.4 5344.2 3282.9 3333.9 3396.8 3450.3 3471.3 1107.4 1120.5 1121.5 1141.2 1165.8 12456.6 12513.7 12515.7 12550.6 12560.5 4526.5 4526.6 4538.0 4557.8 4560.3 10423.0 10540.5 10541.3 10557.8 10559.4 5193.4 5222.5 5273.9 5281.8 5307.2 4224.1 4708.4 4834.2 4870.1 4885.0 4019.4 4059.6 4093.9 4121.6 4156.3 1238.5 1284.2 1286.0 1286.4 1290.5 905.5 945.4 960.9 969.9 987.1 5696.4 5787.8 5913.1 6032.7 6042.1 993.5 999.9 1013.8 1029.5 1051.5 3864.6 4066.6 4071.5 4115.6 4138.0 11193.7 11511.9 11591.5 11635.7 11667.0 11287.0 11336.3 11357.6 11372.4 11386.2 8373.9 8565.7 8647.2 8656.7 8665.2 5903.4 6022.2 6030.6 6045.2 6079.4 10228.5 10481.8 10623.3 10665.6 10684.8 10397.9 10642.9 10680.3 10883.3 10947.3 6760.9 7455.6 7674.7 7751.3 7908.1 8925.9 8927.1 8943.6 8953.7 8992.8 7867.2 8063.7 8107.5 8151.8 8205.2 7924.0 8043.9 8290.4 8380.6 8416.0 6700.5 6752.4 6807.8 6809.0 6853.7 5298.0 5371.4 5390.3 5404.3 5438.3 5338.4 5378.3 5393.6 5457.0 5538.2 23:28:45 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | [#4] prototype.html Cycles:180 Average:4756.06 Median:5455.56 stddev:1417.83 (26.0%) stddev-sans-first:1382.01 23:28:45 INFO - PROCESS | 14670 | Values: 311.8 319.6 322.4 328.6 329.2 5377.4 5405.9 5424.2 5444.6 5480.7 5373.6 5410.5 5416.8 5444.6 5455.4 3998.2 4015.8 4118.6 4122.0 4135.0 4163.1 4163.3 4163.5 4193.0 4234.1 4128.4 4143.6 4144.9 4150.2 4175.7 4048.5 4103.4 4118.5 4127.6 4173.2 3617.2 3627.0 3636.6 3644.1 3645.8 5059.9 5097.7 5138.7 5176.3 5186.6 4646.0 4740.0 4744.5 4757.7 4761.3 5553.6 5556.2 5568.1 5579.3 5586.6 4022.7 4030.8 4031.4 4032.6 4043.1 5631.7 5711.2 5753.3 5796.0 5846.6 4050.8 4054.9 4060.9 4087.2 4099.0 4101.1 4146.3 4147.2 4167.9 4181.9 4647.4 4697.7 4731.8 4736.4 4743.5 5516.2 5542.8 5568.6 5596.6 5599.7 1419.5 1458.8 1461.4 1465.1 1465.5 885.5 924.7 928.9 946.5 979.4 5415.2 5488.7 5530.6 5531.9 5567.4 5746.5 5806.6 5861.6 5872.8 5878.6 5361.7 5420.7 5422.2 5431.1 5455.7 3058.1 3108.2 3109.3 3121.3 3123.8 5680.5 5902.2 5935.2 5974.2 5984.3 5908.6 5942.0 5978.7 5986.6 6006.1 6054.3 6079.0 6082.0 6107.1 6124.3 5658.8 5831.5 5837.2 5854.1 5867.4 5748.2 5800.7 5805.3 5833.2 5838.2 5763.3 5966.0 5969.1 6029.0 6100.4 4081.4 4094.2 4094.6 4096.3 4102.3 5842.5 5851.6 5928.8 5933.5 5975.1 5571.4 5678.7 5800.9 5803.9 5834.9 5647.1 5648.3 5736.6 5740.2 5744.9 5368.1 5404.0 5600.0 5650.7 5661.2 5702.1 5711.5 5773.5 5780.0 5787.1 5620.3 5643.2 5668.1 5716.2 5735.5 23:28:45 INFO - PROCESS | 14670 | 23:28:45 INFO - PROCESS | 14670 | [#5] yui.html Cycles:180 Average:15327.92 Median:25576.36 stddev:18136.30 (70.9%) stddev-sans-first:18154.46 23:28:45 INFO - PROCESS | 14670 | Values: 819.9 835.3 836.0 841.1 850.8 13948.0 13993.6 14256.4 14307.9 14319.1 14116.6 14280.4 14329.9 14378.9 14400.3 787.9 802.3 802.9 803.3 804.9 667.9 788.8 810.9 815.9 817.6 856.6 859.0 860.3 861.2 863.9 845.2 850.3 858.3 860.2 864.8 620.3 626.0 626.2 626.4 627.5 11693.2 11764.3 11781.8 11789.3 11871.2 13828.4 14242.9 14266.7 14300.0 14515.2 10658.7 10784.8 10826.1 11594.7 11711.8 4502.3 4536.6 4539.3 4632.1 4751.7 56740.1 56863.1 57693.7 58254.7 59268.0 10682.9 10714.7 10964.1 11085.7 11222.4 17519.8 17587.6 17654.8 17682.1 17717.9 7971.5 8010.6 8059.5 8064.6 8300.9 4656.0 4760.3 4805.8 4820.5 4881.2 3355.7 3401.0 3408.8 3412.3 3435.8 597.1 599.9 606.7 610.7 613.8 566.5 721.9 724.6 749.7 750.0 9463.8 9523.4 9838.2 10109.8 10541.3 746.5 771.5 772.4 780.5 812.7 4246.2 4624.9 4633.7 4676.5 4704.4 65175.0 65686.7 66091.7 66357.3 67295.6 56806.0 57101.4 59036.7 59652.0 62169.7 52531.7 52858.5 54238.0 54916.7 55028.0 9129.7 9151.7 9172.9 9175.4 9184.9 32565.5 33695.0 34146.3 35625.0 37458.3 45685.8 45809.5 46519.0 46876.8 48082.5 12631.2 12670.2 12799.4 12799.6 13305.5 13738.5 13757.0 13992.2 14275.0 14398.9 13093.1 13199.3 13207.5 13296.5 13757.8 13182.9 13537.0 13573.3 13691.7 14014.9 13112.7 13485.8 13716.3 13983.9 14037.5 10044.4 10150.5 10212.4 10263.8 10449.7 10325.0 10488.6 10507.1 10628.9 10977.1 23:28:45 INFO - PROCESS | 14670 | -------- Summary: end -------- 23:28:45 INFO - PROCESS | 14670 | 23:28:46 INFO - TEST-INFO | 14670: exit 0 23:28:46 INFO - TEST-OK | dromaeo_css | took 1109062ms 23:28:46 INFO - TEST-START | kraken 23:28:46 INFO - operating with platform_type : linux_ 23:28:46 INFO - Initialising browser for kraken test... 23:28:46 INFO - TEST-INFO | started process 14907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoZZ3fQ/profile http://localhost:54270/getInfo.html) 23:28:49 INFO - PROCESS | 14907 | 23:28:49 INFO - PROCESS | 14907 | (process:14974): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:50 INFO - PROCESS | 14907 | __metrics Screen width/height:1600/1200 23:28:50 INFO - PROCESS | 14907 | colorDepth:24 23:28:50 INFO - PROCESS | 14907 | Browser inner width/height: 1024/697 23:28:50 INFO - PROCESS | 14907 | __metrics 23:28:51 ERROR - PROCESS | 14907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:28:52 INFO - TEST-INFO | 14907: exit 0 23:28:52 INFO - Browser initialized. 23:28:52 INFO - Running cycle 1/1 for kraken test... 23:28:52 INFO - TEST-INFO | started process 15025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoZZ3fQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:53 INFO - PROCESS | 15025 | 23:28:53 INFO - PROCESS | 15025 | (process:15085): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:29:03 INFO - PROCESS | 15025 | RSS: Main: 162627584 23:29:03 INFO - PROCESS | 15025 | 23:29:06 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54270/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:06 INFO - PROCESS | 15025 | RSS: Main: 167157760 23:29:06 INFO - PROCESS | 15025 | 23:29:09 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54270/tests/kraken/driver.html?testName=audio-dft) 23:29:10 INFO - PROCESS | 15025 | RSS: Main: 168341504 23:29:10 INFO - PROCESS | 15025 | 23:29:13 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54270/tests/kraken/driver.html?testName=audio-fft) 23:29:13 INFO - PROCESS | 15025 | RSS: Main: 161673216 23:29:13 INFO - PROCESS | 15025 | 23:29:16 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54270/tests/kraken/driver.html?testName=audio-oscillator) 23:29:16 INFO - PROCESS | 15025 | RSS: Main: 162332672 23:29:16 INFO - PROCESS | 15025 | 23:29:18 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:19 INFO - PROCESS | 15025 | RSS: Main: 163622912 23:29:19 INFO - PROCESS | 15025 | 23:29:22 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54270/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:23 INFO - PROCESS | 15025 | RSS: Main: 162996224 23:29:23 INFO - PROCESS | 15025 | 23:29:26 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54270/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:27 INFO - PROCESS | 15025 | RSS: Main: 162119680 23:29:27 INFO - PROCESS | 15025 | 23:29:30 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54270/tests/kraken/driver.html?testName=json-parse-financial) 23:29:31 INFO - PROCESS | 15025 | RSS: Main: 162095104 23:29:31 INFO - PROCESS | 15025 | 23:29:32 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:33 INFO - PROCESS | 15025 | RSS: Main: 162340864 23:29:33 INFO - PROCESS | 15025 | 23:29:35 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54270/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:35 INFO - PROCESS | 15025 | RSS: Main: 162484224 23:29:35 INFO - PROCESS | 15025 | 23:29:37 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:38 INFO - PROCESS | 15025 | RSS: Main: 163053568 23:29:38 INFO - PROCESS | 15025 | 23:29:41 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:41 INFO - PROCESS | 15025 | RSS: Main: 163061760 23:29:41 INFO - PROCESS | 15025 | 23:29:44 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:45 INFO - PROCESS | 15025 | RSS: Main: 162934784 23:29:45 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:54270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54270/tests/kraken/driver.html?testName=ai-astar) 23:29:46 INFO - PROCESS | 15025 | RSS: Main: 164823040 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | __start_tp_report 23:29:46 INFO - PROCESS | 15025 | _x_x_mozilla_page_load 23:29:46 INFO - PROCESS | 15025 | _x_x_mozilla_page_load_details 23:29:46 INFO - PROCESS | 15025 | |i|pagename|runs| 23:29:46 INFO - PROCESS | 15025 | |0;ai-astar;112;121;110;110;111;111;112;110;111;113 23:29:46 INFO - PROCESS | 15025 | |1;audio-beat-detection;154;138;155;215;140;154;159;133;180;138 23:29:46 INFO - PROCESS | 15025 | |2;audio-dft;163;163;162;163;164;165;173;177;163;162 23:29:46 INFO - PROCESS | 15025 | |3;audio-fft;78;75;76;164;79;78;77;75;163;76 23:29:46 INFO - PROCESS | 15025 | |4;audio-oscillator;94;92;172;93;93;92;140;92;95;141 23:29:46 INFO - PROCESS | 15025 | |5;imaging-gaussian-blur;118;118;118;118;118;119;119;118;119;119 23:29:46 INFO - PROCESS | 15025 | |6;imaging-darkroom;149;150;153;151;150;150;152;155;149;150 23:29:46 INFO - PROCESS | 15025 | |7;imaging-desaturate;97;97;110;98;97;97;99;96;96;97 23:29:46 INFO - PROCESS | 15025 | |8;json-parse-financial;57;57;58;56;57;56;57;56;55;56 23:29:46 INFO - PROCESS | 15025 | |9;json-stringify-tinderbox;62;62;62;63;64;62;62;63;62;64 23:29:46 INFO - PROCESS | 15025 | |10;stanford-crypto-aes;85;81;83;80;83;83;81;81;140;82 23:29:46 INFO - PROCESS | 15025 | |11;stanford-crypto-ccm;136;137;134;133;139;136;140;136;143;126 23:29:46 INFO - PROCESS | 15025 | |12;stanford-crypto-pbkdf2;162;164;166;167;164;163;162;163;164;159 23:29:46 INFO - PROCESS | 15025 | |13;stanford-crypto-sha256-iterative;65;65;65;64;63;64;67;64;63;63 23:29:46 INFO - PROCESS | 15025 | __end_tp_report 23:29:46 INFO - PROCESS | 15025 | __start_cc_report 23:29:46 INFO - PROCESS | 15025 | _x_x_mozilla_cycle_collect,745 23:29:46 INFO - PROCESS | 15025 | __end_cc_report 23:29:46 INFO - PROCESS | 15025 | __startTimestamp1463812186957__endTimestamp 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | ------- Summary: start ------- 23:29:46 INFO - PROCESS | 15025 | Number of tests: 14 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:3.28 (2.9%) stddev-sans-first:3.48 23:29:46 INFO - PROCESS | 15025 | Values: 112.0 121.0 110.0 110.0 111.0 111.0 112.0 110.0 111.0 113.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:154.50 stddev:24.73 (16.0%) stddev-sans-first:26.21 23:29:46 INFO - PROCESS | 15025 | Values: 154.0 138.0 155.0 215.0 140.0 154.0 159.0 133.0 180.0 138.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#2] audio-dft Cycles:10 Average:165.50 Median:163.50 stddev:5.17 (3.2%) stddev-sans-first:5.40 23:29:46 INFO - PROCESS | 15025 | Values: 163.0 163.0 162.0 163.0 164.0 165.0 173.0 177.0 163.0 162.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.50 stddev:36.60 (47.8%) stddev-sans-first:38.36 23:29:46 INFO - PROCESS | 15025 | Values: 78.0 75.0 76.0 164.0 79.0 78.0 77.0 75.0 163.0 76.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.50 stddev:29.32 (31.7%) stddev-sans-first:30.49 23:29:46 INFO - PROCESS | 15025 | Values: 94.0 92.0 172.0 93.0 93.0 92.0 140.0 92.0 95.0 141.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:29:46 INFO - PROCESS | 15025 | Values: 118.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 119.0 119.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:150.50 stddev:1.91 (1.3%) stddev-sans-first:1.90 23:29:46 INFO - PROCESS | 15025 | Values: 149.0 150.0 153.0 151.0 150.0 150.0 152.0 155.0 149.0 150.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:97.00 stddev:4.17 (4.3%) stddev-sans-first:4.39 23:29:46 INFO - PROCESS | 15025 | Values: 97.0 97.0 110.0 98.0 97.0 97.0 99.0 96.0 96.0 97.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 23:29:46 INFO - PROCESS | 15025 | Values: 57.0 57.0 58.0 56.0 57.0 56.0 57.0 56.0 55.0 56.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 23:29:46 INFO - PROCESS | 15025 | Values: 62.0 62.0 62.0 63.0 64.0 62.0 62.0 63.0 62.0 64.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:82.50 stddev:18.36 (22.3%) stddev-sans-first:19.45 23:29:46 INFO - PROCESS | 15025 | Values: 85.0 81.0 83.0 80.0 83.0 83.0 81.0 81.0 140.0 82.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:136.50 stddev:4.57 (3.3%) stddev-sans-first:4.85 23:29:46 INFO - PROCESS | 15025 | Values: 136.0 137.0 134.0 133.0 139.0 136.0 140.0 136.0 143.0 126.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:2.22 (1.4%) stddev-sans-first:2.30 23:29:46 INFO - PROCESS | 15025 | Values: 162.0 164.0 166.0 167.0 164.0 163.0 162.0 163.0 164.0 159.0 23:29:46 INFO - PROCESS | 15025 | 23:29:46 INFO - PROCESS | 15025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 23:29:46 INFO - PROCESS | 15025 | Values: 65.0 65.0 65.0 64.0 63.0 64.0 67.0 64.0 63.0 63.0 23:29:46 INFO - PROCESS | 15025 | -------- Summary: end -------- 23:29:46 INFO - PROCESS | 15025 | 23:29:47 INFO - TEST-INFO | 15025: exit 0 23:29:47 INFO - TEST-OK | kraken | took 61610ms 23:29:47 INFO - SUITE-END | took 1170s 23:29:48 INFO - Completed test suite (00:19:31) 23:29:48 INFO - javascript benchmark 23:29:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7075.993282336495, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.656397796242, 3131.4363414585373, 3134.686531346865, 3146.889858854939, 3175.079227024163, 5323.467653234675, 5365.0, 5372.194170874366, 5409.756560954756, 5541.307336582927, 5196.246544251081, 5282.181261904411, 5291.3385826771655, 5302.549283310914, 5322.733863306838, 4840.588549973248, 4846.933674591584, 4988.42633097193, 4996.025774973881, 5044.873878153057, 4828.879278018043, 5052.242163675442, 5052.46949070346, 5053.343065401493, 5078.898422031557, 4778.116048531033, 4802.783874725611, 4823.1800593899125, 4909.312696222514, 4957.7769000395065, 4796.280557916306, 4811.27830825379, 4813.4945830687975, 4855.295982082578, 4874.195757699975, 4824.975875120637, 4840.080384726891, 4852.126617208901, 4861.052094841507, 4892.143874821892, 5205.167173252262, 5221.295125158131, 5252.8686782830355, 5302.2046692996355, 5363.785448582052, 5784.871949969757, 5826.563007774392, 5849.122631605251, 5852.151438041503, 5868.41315868414, 5591.608587398884, 5861.0, 5867.0, 5869.882602347929, 5875.823725288248, 5343.118385466393, 5461.989531936604, 5463.562914966793, 5464.808731694372, 5525.392206857283, 5937.406259374115, 5959.702014899238, 5993.0, 5994.400559943971, 6001.219841420588, 5565.30433695788, 5602.215689803431, 5686.459786320375, 5728.484436400744, 5762.0, 5732.082866741302, 5792.478676919098, 5803.100519419412, 5805.564582656318, 5848.210491583667, 5650.23721797552, 5669.1496275558175, 5756.280464941882, 5774.682392468455, 5783.16144159103, 5483.945160548344, 5788.739506722208, 5794.333651630117, 5813.069908814569, 5854.912176317359, 4310.913781724348, 4387.078713470143, 4409.382686423904, 4419.491758447755, 4425.446819147606, 3943.723939324277, 3949.881503554898, 3953.0512676957323, 3957.485526881487, 3984.1234928315725, 5420.295361602966, 5437.265969094201, 5544.722763861791, 5600.887982240332, 5627.212190293362, 5771.026054485232, 5810.389909059572, 5821.27234095738, 5831.0, 5835.67903765297, 5492.395836457987, 5511.200875872976, 5517.36550296713, 5522.861928451821, 5535.58483113768, 4883.0, 4987.62592805541, 4997.075541024922, 5025.874353141201, 5060.0, 6033.5173186145, 6043.54673399488, 6045.697715114315, 6062.727177277033, 6069.939300607026, 5823.505002074787, 5849.912251316148, 5850.034744267318, 5851.297844258716, 5855.94144058571, 5799.159121927212, 5986.491148252448, 6012.789552365646, 6031.155638210742, 6077.088436734525, 5696.629719068247, 5700.743466543932, 5719.3136823581435, 5722.7710891563875, 5730.799422020209, 5631.155326701028, 5796.42035796417, 5799.565032622486, 5825.417458254141, 5854.736536855937, 5596.720163991866, 5632.380438151718, 5633.718314084197, 5652.971735141463, 5654.180143879033, 5444.564434845123, 5520.723963801714, 5525.281713377235, 5617.43825617435, 5618.550515958796, 5478.945210547843, 5481.232627432242, 5544.667319960815, 5550.833474995757, 5565.276514053147, 5570.526505246938, 5607.243022191952, 5608.4111168326735, 5718.51392631631, 5783.884322313446, 5624.550035997028, 5631.662100273997, 5650.124230744241, 5653.858653533694, 5693.430656934273], "value": 5327.352625116699, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2300482845744, 602.3193791016151, 609.2445367743996, 613.5061275673082, 639.5970538560706, 38230.99999999996, 41776.79111604438, 42033.159336813245, 42109.0, 42275.15449691004, 42068.0, 42409.57590424095, 42563.57436425635, 42620.0, 42629.36055959163, 8474.78813029673, 8677.783055423602, 8700.216980471756, 8738.344624153182, 8760.167784060504, 8423.49459032457, 8460.57697115145, 8476.576171191417, 8493.108223636491, 8500.319974402064, 8652.567371631425, 8693.869591956094, 8702.129787021311, 8742.082081381459, 8783.429077109999, 8559.700410485635, 8647.999999999969, 8655.047944726075, 8672.956635216846, 8677.956610216972, 8542.829143417159, 8590.828183436297, 8593.527355995418, 8619.051904290523, 8646.43798153118, 31787.523187152212, 40290.19419611591, 40835.59164408348, 40892.79553602243, 41081.589184108074, 3331.6501767314567, 3417.8632854685784, 3559.5906470755936, 3608.585012723544, 3724.2365315110337, 30598.69401305981, 31180.844095779375, 31359.05922822319, 33237.33525329504, 33919.0, 4235.470566179228, 4312.654987601016, 4327.7186982846015, 4388.5830846069575, 4501.437320334958, 331413.0, 341102.0, 342782.0, 344197.0, 345246.0, 30531.69468305333, 31484.68515314863, 31504.0, 62127.378726213065, 62146.689266554284, 37500.24999500049, 37631.81184094117, 37746.81126594349, 37797.433038504445, 37909.24181516354, 15864.762028569581, 16030.438934637232, 16051.598710032342, 16061.67876642484, 16122.355105795872, 13013.609591712264, 13162.14446061003, 13194.802077968838, 13197.010224233221, 13240.20558766477, 8470.957645211734, 8472.110428405053, 8484.830303394021, 8511.95744021276, 8542.10307917672, 3370.292238629915, 3376.29097889446, 3388.186835159593, 3389.474631432132, 3417.8120203388553, 1024.9436281004616, 1032.1897310611134, 1040.0327695243345, 1063.5958335832333, 1085.2999815119363, 31684.683153168633, 31730.0, 31880.0, 32392.676073238967, 32446.675533244837, 1096.6545538155456, 1132.1452303510962, 1145.8968692817687, 1167.3054532553117, 1246.4515613130193, 16519.421820236235, 17132.0, 17158.48524544266, 17392.391266305618, 17426.12869356527, 488487.1332076699, 489434.0, 489765.0, 492821.0, 494112.0, 57134.142987855215, 57958.13062804061, 58059.0, 58161.70919145462, 58302.7084864573, 1359.6804750883534, 1368.7809950407886, 1400.4258254115764, 1400.95096671616, 1406.2617126008927, 29969.850150749106, 31660.0, 31777.20556986094, 31898.61334155355, 32031.35937281288, 51879.740601296755, 52132.47867521276, 52349.47650523446, 52507.73746131245, 52532.7373363146, 403247.0, 405884.0, 406234.0, 406559.0, 407159.0, 28621.570676440286, 29110.563341550318, 29145.271368215963, 29172.854135729187, 29268.7073129266, 48085.27872081852, 48533.51466485431, 48900.2664960033, 49831.501684984134, 49876.75061624669, 40291.798541007105, 41435.7928210357, 41792.37311440392, 41877.371839423045, 42712.35931460968, 41355.7932210337, 41724.0, 41784.0, 41974.37038444487, 42256.36615450709, 40673.0, 40873.59126408698, 41596.37605435981, 41690.374644380965, 41705.58294417017, 33758.0, 36806.63193368032, 37047.25905481821, 37142.44286335653, 37289.254214916094, 27610.171694849185, 27840.303992400353, 27904.58143127814, 27944.580831287953, 27949.441011179257], "value": 18694.29788435576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.2013831024005, 384.1229193341869, 397.0569896495821, 399.45274973286604, 414.9957103808782, 17530.73703894441, 18367.816321836777, 19061.618767624655, 19084.42746717599, 19251.807481925178, 16455.588610284747, 16504.917475412636, 16808.915955420238, 18204.726929096076, 18453.907730461364, 5407.134858422653, 5430.59270554709, 5635.6618602883755, 5651.689157096358, 5675.801346952858, 5542.140968149944, 5544.722763861811, 5561.749721262553, 5583.972080139593, 5606.383297837235, 5407.810726624569, 5460.645058071233, 5498.752556134964, 5543.168524721304, 5545.861353466155, 5547.889042219153, 5548.86127846803, 5556.777728890839, 5561.388247292814, 5565.499105080522, 4784.952150478485, 4938.925916111261, 4965.131102057126, 4985.800567977277, 5014.0, 20944.37166884996, 21338.786612133834, 21680.94031067046, 21949.0, 21997.120115195372, 2294.265834932822, 2443.218170185541, 2458.496008318308, 2493.8379005364595, 2626.2383908666657, 13178.934105329412, 13905.16569005863, 14133.434662613483, 14140.0, 14413.78379324311, 1920.5294702797903, 1931.94204173875, 1974.1609815828358, 2021.6512975334617, 2036.562139140077, 71918.64040679763, 75314.62342688306, 76249.23750762477, 76482.23517764806, 76502.23497765006, 9993.950030249802, 10076.74808129788, 10325.690229293134, 10385.63650272237, 10526.842097368546, 14106.506272280627, 14195.574132776033, 14240.501582444773, 14268.429262829579, 14278.500252491112, 7995.320397766139, 8250.628721707537, 8279.296259817862, 8319.209675080858, 8388.07731149573, 8087.716929907425, 8114.229148230908, 8148.307393871469, 8194.959025204955, 8213.83572328562, 6390.552661313756, 6440.645764482904, 6444.871102577922, 6483.578567393104, 6512.73949042033, 1892.9810701892804, 1896.3173257627243, 1931.420573827846, 1933.9033048347808, 1945.299692110839, 874.9693760718344, 1033.9172866170688, 1049.3022140276782, 1108.4291589831244, 1120.2046546951592, 16058.27737751804, 16297.103659298853, 18278.908605456887, 18636.695431319677, 18952.336668216547, 971.2812518736225, 979.9755006124761, 995.9651412200539, 1016.3546148195949, 1038.050184081572, 10480.266381353385, 10647.94676026615, 10735.94632026835, 10759.30064545802, 10780.191485638608, 260426.0, 421104.0, 438823.0, 440185.0, 442386.0, 72314.63842680753, 77902.0, 80294.19705802984, 91249.0, 94706.52646736722, 1014.7716763728102, 1046.0, 1085.3976043296047, 1086.4241951765578, 1091.5688303120223, 16303.184840758151, 16606.50180494587, 16703.582410439838, 16970.321187152374, 17129.314827406764, 38803.61196388113, 39007.0, 39809.40285895772, 39978.2004359917, 40239.597604023584, 50914.490855090975, 53315.20027199518, 53406.46593534015, 53903.0, 54060.459395405545, 7924.484908481161, 7991.440599158003, 8050.074241462073, 8170.387220958333, 8517.190866867637, 9189.770255743393, 12173.0, 12245.326507042199, 13083.476660933837, 13145.53990610324, 11134.3876086816, 11367.602133925273, 11562.826557601475, 11619.0, 11638.941805290919, 11088.279261847954, 11397.259178153394, 11412.144089193178, 11485.19603627738, 11537.653870383901, 11037.613683521038, 11364.318140911571, 11426.82859757121, 11499.0, 11760.529578817093, 6997.230304666585, 7408.888866666896, 7586.734464293723, 7807.102183248999, 8829.602667879832, 10543.209259305737, 11562.826557601475, 11716.531338746354, 11786.174967752519, 11802.996745276747], "value": 9028.504061739919, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.7015132049248, 1554.1607531932757, 1726.542466246445, 1825.8448031917287, 1839.0620783400461, 7703.422243331758, 8377.623006964686, 8486.490810551371, 8900.599473023705, 8901.732948011562, 8677.652893884237, 8992.820143597124, 9012.188902998729, 9014.639414423415, 9026.90973090269, 2336.147306233221, 2372.5408873542733, 2374.1334412939327, 2379.3218932604213, 2399.6160614301716, 2335.089315167086, 2335.801456876168, 2336.6728657987896, 2340.028888011473, 2342.273895092518, 2311.9422014449606, 2328.1036800831635, 2328.871912044837, 2336.6845475860796, 2336.8481048731865, 2229.6989906362596, 2244.629636110048, 2249.0, 2256.650219216024, 2283.9543209135722, 2267.115824828302, 2274.0449011415244, 2285.165914441217, 2287.2795069553035, 2296.150424342987, 8896.466212027299, 8989.235914947238, 9000.59497322622, 9055.366124371296, 9095.681651142178, 5136.357955255593, 5284.973575132138, 5297.046531624306, 5322.361316642027, 5344.171653393731, 3282.8522716477814, 3333.887676941578, 3396.813175275359, 3450.344434557426, 3471.2536804586885, 1107.44074242507, 1120.5125770289949, 1121.4616983847798, 1141.2353723005606, 1165.7785020846097, 12456.626301210978, 12513.687157821036, 12515.687107822287, 12550.560730374393, 12560.497580096786, 4526.456825180933, 4526.592606665416, 4538.0, 4557.817687292538, 4560.293154561048, 10423.0, 10540.524326594283, 10541.262111652111, 10557.788844223072, 10559.419231942164, 5193.402758682724, 5222.477752224747, 5273.947260527346, 5281.762320695578, 5307.230451584576, 4224.070704445017, 4708.4349878014855, 4834.226523756182, 4870.123377791961, 4885.047415753965, 4019.437278780973, 4059.594040595917, 4093.85671501496, 4121.5878412159145, 4156.25187466259, 1238.5169783784331, 1284.1973766396002, 1285.9807102893465, 1286.395394164741, 1290.5289569307135, 905.4522014181457, 945.4280160502934, 960.8606752020918, 969.8981606931312, 987.0672214757129, 5696.3733989261145, 5787.797427090031, 5913.113033045078, 6032.668203248863, 6042.063480160582, 993.5231089077139, 999.9150072243796, 1013.8175128476945, 1029.4543891737392, 1051.5478344311866, 3864.555576108727, 4066.5933406659096, 4071.491063617048, 4115.588441155861, 4137.958620413818, 11193.720156995978, 11511.884881151249, 11591.478383472764, 11635.709107272385, 11667.0, 11287.0, 11336.263142895685, 11357.602483913188, 11372.374519401346, 11386.202965792481, 8373.874391884248, 8565.743027709179, 8647.221750042401, 8656.740297791077, 8665.220130188187, 5903.439173278532, 6022.2171117754415, 6030.6080104793045, 6045.244344456943, 6079.422454866781, 10228.48857557134, 10481.842772358268, 10623.309484883457, 10665.573377064831, 10684.786304274026, 10397.896021039995, 10642.935706429294, 10680.252382333161, 10883.346999180074, 10947.288426252268, 6760.898586521304, 7455.589942553212, 7674.731384401519, 7751.302382785577, 7908.130105688255, 8925.928888533157, 8927.062658420773, 8943.552822358986, 8953.686620968236, 8992.775180620276, 7867.17394673551, 8063.717769878026, 8107.473014254055, 8151.755447336589, 8205.179482051746, 7924.0, 8043.919560804317, 8290.37822163328, 8380.622871970654, 8415.957920210605, 6700.530962832555, 6752.358525940028, 6807.795766127024, 6809.046733457419, 6853.691583878638, 5298.0, 5371.355437347544, 5390.299261096189, 5404.270423492778, 5438.320209973754, 5338.38608560005, 5378.327709036371, 5393.633841472485, 5457.0, 5538.196961440488], "value": 4723.392795539149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.7505995203838, 319.6308263955133, 322.39229053234646, 328.64834626949164, 329.15243248634766, 5377.381601115868, 5405.864853378667, 5424.240606315119, 5444.646098003632, 5480.725963701819, 5373.596980226489, 5410.5401040911565, 5416.8104116355935, 5444.564434845212, 5455.399906010336, 3998.1803730235233, 4015.8393664253394, 4118.599676110122, 4122.0, 4134.966258435391, 4163.125743593849, 4163.250614889319, 4163.479565054368, 4192.9790351048205, 4234.110836724291, 4128.380742888561, 4143.627073563379, 4144.875653730378, 4150.190712811003, 4175.66594672427, 4048.4939382577177, 4103.4460347852955, 4118.485189351331, 4127.587241275878, 4173.165366926612, 3617.2042150726797, 3626.984444355585, 3636.6181550937035, 3644.125409901631, 3645.8359373828243, 5059.949400505985, 5097.7196254206, 5138.691678499302, 5176.327077479941, 5186.611004174664, 4646.0, 4739.95260047402, 4744.501827308118, 4757.690750101232, 4761.333413322138, 5553.611247212697, 5556.222128901957, 5568.081266591008, 5579.330480342344, 5586.608937374385, 4022.6781857451333, 4030.8186131624147, 4031.4154447605224, 4032.5765794591734, 4043.0700938784244, 5631.7465714042555, 5711.228984087136, 5753.33836608787, 5796.0, 5846.649201047951, 4050.797460126982, 4054.878353649395, 4060.9187816244103, 4087.2234275487563, 4098.995746042238, 4101.097758493127, 4146.295129827937, 4147.212029714345, 4167.895507690464, 4181.937270940938, 4647.419072615923, 4697.671163018625, 4731.810727570927, 4736.384270044872, 4743.525647435298, 5516.172574113834, 5542.7782888684005, 5568.638038527482, 5596.552275817925, 5599.664020158803, 1419.531554586984, 1458.8030615866935, 1461.415433826478, 1465.1209274435466, 1465.5310300703886, 885.5129678676702, 924.7410724997012, 928.8560273157672, 946.4794363100267, 979.3585201692903, 5415.214793854869, 5488.655279456559, 5530.617345663584, 5531.8893622128135, 5567.443255674481, 5746.482816546531, 5806.622569532967, 5861.589688721834, 5872.765089396462, 5878.617889837233, 5361.705106219196, 5420.674759514442, 5422.186671999231, 5431.131019036935, 5455.727213639381, 3058.143719758471, 3108.1607965849093, 3109.2693217093965, 3121.3133110715607, 3123.7500999919953, 5680.488756011896, 5902.2032025676845, 5935.198748168942, 5974.2233509643465, 5984.251968503937, 5908.632079714522, 5942.0, 5978.701064946822, 5986.640801551921, 6006.12911127884, 6054.334023257438, 6078.999999999912, 6081.969590152021, 6107.053406721965, 6124.326324104345, 5658.830235092953, 5831.504322132666, 5837.241158649348, 5854.063349864001, 5867.383924688017, 5748.166515855094, 5800.665846855162, 5805.332386775406, 5833.241678581927, 5838.211841401527, 5763.3286346960585, 5965.970170149121, 5969.134475500941, 6028.969855150872, 6100.359462256399, 4081.40819581165, 4094.2016306819883, 4094.61101195386, 4096.3036283831225, 4102.282100632317, 5842.532597392284, 5851.64890106595, 5928.822135335947, 5933.495652869555, 5975.133605627247, 5571.3871474137, 5678.706350316724, 5800.9419905800405, 5803.881583222178, 5834.94165058344, 5647.124695672177, 5648.265725455664, 5736.569757268138, 5740.225069615549, 5744.885102298014, 5368.128051492589, 5404.0272750905215, 5599.972000139973, 5650.745716442852, 5661.235733176133, 5702.146802289356, 5711.543076553782, 5773.451522105393, 5780.0173970424285, 5787.074068149076, 5620.26936498269, 5643.209950607001, 5668.1214411764595, 5716.171155182392, 5735.541156707537], "value": 4298.551337071581, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.8893149424827, 835.2649668291903, 835.9958200208998, 841.0958219913595, 850.7830503221678, 13948.0, 13993.580192594212, 14256.358463869125, 14307.85537157029, 14319.069260498087, 14116.647083822883, 14280.4287828487, 14329.856701432982, 14378.856211437882, 14400.279986000683, 787.8818177273412, 802.314021511608, 802.8675268580706, 803.3292201012162, 804.859149648812, 667.9064930909676, 788.7515432638701, 810.9067457242434, 815.8816971539123, 817.648411183191, 856.575994882534, 858.9613467393951, 860.27736701171, 861.1990848510883, 863.9395242333039, 845.2266176448542, 850.3324889961351, 858.2618947704968, 860.165639329849, 864.7621903976457, 620.3114542857425, 625.9687015649245, 626.1797045869924, 626.4455956478504, 627.4760574919902, 11693.239939403997, 11764.294142351486, 11781.764364712744, 11789.292642441482, 11871.228370155912, 13828.446862125504, 14242.92878535611, 14266.714665706731, 14300.0, 14515.201663908481, 10658.680239592824, 10784.838227426595, 10826.140077279872, 11594.71013224676, 11711.765764684744, 4502.302143167814, 4536.56902594253, 4539.319102134673, 4632.143053535073, 4751.667383283171, 56740.148897766565, 56863.147052794244, 57693.711531442495, 58254.70872645652, 59268.0, 10682.94658526718, 10714.732131696614, 10964.054895077003, 11085.667429976953, 11222.438878056228, 17519.82480175182, 17587.56031099233, 17654.823451765576, 17682.11589420524, 17717.911410443125, 7971.481853679492, 8010.639521221559, 8059.5164290142775, 8064.637091330904, 8300.875486867702, 4655.95344046562, 4760.33355330254, 4805.807767689324, 4820.542048505386, 4881.219004959261, 3355.681210285019, 3401.013706025225, 3408.812515311632, 3412.283420481727, 3435.793852368866, 597.1162679234757, 599.9310079340844, 606.6511755740466, 610.7343305662051, 613.8127870999299, 566.5382713088902, 721.931789892955, 724.6449239872425, 749.7263498822999, 749.966251518683, 9463.76340591477, 9523.428594284365, 9838.212942964547, 10109.82443033246, 10541.262111652264, 746.5073051785795, 771.548644043241, 772.4168252968973, 780.4965797060864, 812.7196117339508, 4246.193223287565, 4624.930626040612, 4633.72197668141, 4676.485586585472, 4704.3649107370065, 65175.0, 65686.67156664186, 66091.66954165198, 66357.33642663511, 67295.60691734277, 56806.0, 57101.428985710445, 59036.70481647564, 59652.0, 62169.689151553954, 52531.73734131305, 52858.48732465875, 54237.999999999214, 54916.72541637346, 55028.0, 9129.680461183827, 9151.725448236564, 9172.862407063765, 9175.44947303164, 9184.862227066733, 32565.511517326784, 33695.0, 34146.31707365789, 35625.0, 37458.25083498369, 45685.77157114193, 45809.541904580525, 46519.0, 46876.7656161717, 48082.51917480781, 12631.178973366701, 12670.239785612892, 12799.424025919043, 12799.616011519669, 13305.534306299232, 13738.450461981809, 13757.0, 13992.16047037181, 14275.0, 14398.928005359907, 13093.0834841564, 13199.274039927512, 13207.471701132232, 13296.468141274627, 13757.761801437919, 13182.868171318547, 13537.0, 13573.321333933462, 13691.726165476435, 14014.929925350716, 13112.73774524485, 13485.797713034117, 13716.314184290944, 13983.860161398256, 14037.5086871959, 10044.447555384524, 10150.49247537635, 10212.438315892698, 10263.794724105326, 10449.738756531147, 10325.0, 10488.577290019479, 10507.106895913934, 10628.946855265984, 10977.052047823945], "value": 6874.9754489763845, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 121.0, 110.0, 110.0, 111.0, 111.0, 112.0, 110.0, 111.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 138.0, 155.0, 215.0, 140.0, 154.0, 159.0, 133.0, 180.0, 138.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 164.0, 165.0, 173.0, 177.0, 163.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 76.0, 164.0, 79.0, 78.0, 77.0, 75.0, 163.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 172.0, 93.0, 93.0, 92.0, 140.0, 92.0, 95.0, 141.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 119.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 153.0, 151.0, 150.0, 150.0, 152.0, 155.0, 149.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 110.0, 98.0, 97.0, 97.0, 99.0, 96.0, 96.0, 97.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 56.0, 57.0, 56.0, 57.0, 56.0, 55.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 62.0, 62.0, 63.0, 62.0, 64.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 83.0, 80.0, 83.0, 83.0, 81.0, 81.0, 140.0, 82.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 134.0, 133.0, 139.0, 136.0, 140.0, 136.0, 143.0, 126.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 166.0, 167.0, 164.0, 163.0, 162.0, 163.0, 164.0, 159.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 63.0, 64.0, 67.0, 64.0, 63.0, 63.0], "value": 64.3, "unit": "score"}]}]} 23:29:48 INFO - Return code: 0 23:29:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:29:48 ERROR - # TBPL SUCCESS # 23:29:48 INFO - Running post-action listener: _resource_record_post_action 23:29:48 INFO - ##### 23:29:48 INFO - ##### Finished run-tests step (success) 23:29:48 INFO - ##### 23:29:48 INFO - Running post-run listener: _resource_record_post_run 23:29:48 INFO - Total resource usage - Wall time: 1189s; CPU: 26.0%; Read bytes: 0; Write bytes: 553394176; Read time: 0; Write time: 599148 23:29:48 INFO - TinderboxPrint: CPU usage
25.7% 23:29:48 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:29:48 INFO - TinderboxPrint: I/O write bytes / time
553,394,176 / 599,148 23:29:48 INFO - TinderboxPrint: CPU idle
7,047.3 (74.2%) 23:29:48 INFO - TinderboxPrint: CPU user
2,400.3 (25.3%) 23:29:48 INFO - TinderboxPrint: Swap in / out
0 / 0 23:29:48 INFO - install - Wall time: 17s; CPU: 26.0%; Read bytes: 0; Write bytes: 259309568; Read time: 0; Write time: 292436 23:29:48 INFO - run-tests - Wall time: 1172s; CPU: 26.0%; Read bytes: 0; Write bytes: 293793792; Read time: 0; Write time: 306692 23:29:48 INFO - Running post-run listener: _upload_blobber_files 23:29:48 INFO - Blob upload gear active. 23:29:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:29: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 23:29: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'] 23:29: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 23:29:49 INFO - (blobuploader) - INFO - Open directory for files ... 23:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:50 INFO - (blobuploader) - INFO - Done attempting. 23:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:50 INFO - (blobuploader) - INFO - Done attempting. 23:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:57 INFO - (blobuploader) - INFO - Done attempting. 23:29:57 INFO - (blobuploader) - INFO - Iteration through files over. 23:29:57 INFO - Return code: 0 23:29:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:29:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:29:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a2b3be7669250ffc8dc8d68736bb0f7ea3e6427bec6a84e3c8e7ed62f1034c03528b19448aec0da65a9bc63d307b8d378641ebd7cba24eacd6346c6ec5e0f9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f292a2c7b5ce75904b4b76e290b9f58dfa9d63e4483441ca2e2f78a951a3683da472a11beff9cc86337f952167d32e62c01868d0d47da3a04d724ea181f40e5b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae75a0ce6efc86c0d7d2d2c41fca9451a42a601b6f1321e18e038ac9b6fdb45512b9f3f44911cb8d767920adfb2183a171dc36f33fdd352e7031b58d8a62d527"} 23:29:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:29:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:29:57 INFO - Contents: 23:29:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a2b3be7669250ffc8dc8d68736bb0f7ea3e6427bec6a84e3c8e7ed62f1034c03528b19448aec0da65a9bc63d307b8d378641ebd7cba24eacd6346c6ec5e0f9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f292a2c7b5ce75904b4b76e290b9f58dfa9d63e4483441ca2e2f78a951a3683da472a11beff9cc86337f952167d32e62c01868d0d47da3a04d724ea181f40e5b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae75a0ce6efc86c0d7d2d2c41fca9451a42a601b6f1321e18e038ac9b6fdb45512b9f3f44911cb8d767920adfb2183a171dc36f33fdd352e7031b58d8a62d527"} 23:29:57 INFO - Running post-run listener: copy_logs_to_upload_dir 23:29:57 INFO - Copying logs to upload dir... 23:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs 23:29:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.246500 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-20 23:29:57.012512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 23:29:57.015991) ========= 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=7de08804244eb36560b44971000001c3-1463810178.515319-594916301 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/3a2b3be7669250ffc8dc8d68736bb0f7ea3e6427bec6a84e3c8e7ed62f1034c03528b19448aec0da65a9bc63d307b8d378641ebd7cba24eacd6346c6ec5e0f9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f292a2c7b5ce75904b4b76e290b9f58dfa9d63e4483441ca2e2f78a951a3683da472a11beff9cc86337f952167d32e62c01868d0d47da3a04d724ea181f40e5b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae75a0ce6efc86c0d7d2d2c41fca9451a42a601b6f1321e18e038ac9b6fdb45512b9f3f44911cb8d767920adfb2183a171dc36f33fdd352e7031b58d8a62d527"} build_url:https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005385 build_url: 'https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/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/3a2b3be7669250ffc8dc8d68736bb0f7ea3e6427bec6a84e3c8e7ed62f1034c03528b19448aec0da65a9bc63d307b8d378641ebd7cba24eacd6346c6ec5e0f9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f292a2c7b5ce75904b4b76e290b9f58dfa9d63e4483441ca2e2f78a951a3683da472a11beff9cc86337f952167d32e62c01868d0d47da3a04d724ea181f40e5b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae75a0ce6efc86c0d7d2d2c41fca9451a42a601b6f1321e18e038ac9b6fdb45512b9f3f44911cb8d767920adfb2183a171dc36f33fdd352e7031b58d8a62d527"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 23:29:57.029939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:29:57.030243) ========= 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=7de08804244eb36560b44971000001c3-1463810178.515319-594916301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002167 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:29:57.115888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 23:29:57.116203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 23:29:57.116495) ========= ========= Total master_lag: 0.16 =========