builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1463674468.64 results: success (0) buildid: 20160519082857 builduid: adb3077601154d27897ca3bfd922121d revision: ebd649229181d40d9f5ae41ea4d2109c8f782fe8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.635487) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.636198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.636790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.650901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.651234) ========= 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=d2a8c569965ab8367867b893000001a1-1463674467.788322-470605344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 09:14:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-05-19 09:14:29 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116798 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.794135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.794655) ========= 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=d2a8c569965ab8367867b893000001a1-1463674467.788322-470605344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018159 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.846599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:28.846987) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebd649229181d40d9f5ae41ea4d2109c8f782fe8 --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 ebd649229181d40d9f5ae41ea4d2109c8f782fe8 --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=d2a8c569965ab8367867b893000001a1-1463674467.788322-470605344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 09:14:29,154 truncating revision to first 12 chars 2016-05-19 09:14:29,154 Setting DEBUG logging. 2016-05-19 09:14:29,154 attempt 1/10 2016-05-19 09:14:29,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebd649229181?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 09:14:29,482 unpacking tar archive at: fx-team-ebd649229181/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:29.459489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:29.459900) ========= script_repo_revision: ebd649229181d40d9f5ae41ea4d2109c8f782fe8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:29.460420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:29.460803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 09:14:29.471620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-19 09:14:29.472048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1463674467.788322-470605344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:30 INFO - MultiFileLogger online at 20160519 09:14:30 in /builds/slave/test 09:14:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:14:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:30 INFO - {'append_to_log': False, 09:14:30 INFO - 'base_work_dir': '/builds/slave/test', 09:14:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:14:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:30 INFO - 'branch': 'Fx-Team-Non-PGO', 09:14:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:30 INFO - 'config_files': ('talos/linux_config.py',), 09:14:30 INFO - 'default_actions': ('clobber', 09:14:30 INFO - 'read-buildbot-config', 09:14:30 INFO - 'download-and-extract', 09:14:30 INFO - 'populate-webroot', 09:14:30 INFO - 'create-virtualenv', 09:14:30 INFO - 'install', 09:14:30 INFO - 'run-tests'), 09:14:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:30 INFO - 'download_minidump_stackwalk': True, 09:14:30 INFO - 'download_symbols': 'ondemand', 09:14:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:30 INFO - 'installer_path': 'installer.exe', 09:14:30 INFO - 'log_level': 'info', 09:14:30 INFO - 'log_name': 'talos', 09:14:30 INFO - 'log_to_console': True, 09:14:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:30 INFO - 'opt_config_files': (), 09:14:30 INFO - 'pip_index': False, 09:14:30 INFO - 'sps_profile': False, 09:14:30 INFO - 'sps_profile_interval': 0, 09:14:30 INFO - 'suite': 'dromaeojs-e10s', 09:14:30 INFO - 'system_bits': '32', 09:14:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:30 INFO - 'title': 'talos-linux64-ix-043', 09:14:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:30 INFO - 'use_talos_json': True, 09:14:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:30 INFO - 'work_dir': 'build'} 09:14:30 INFO - ##### 09:14:30 INFO - ##### Running clobber step. 09:14:30 INFO - ##### 09:14:30 INFO - Running pre-action listener: _resource_record_pre_action 09:14:30 INFO - Running main action method: clobber 09:14:30 INFO - rmtree: /builds/slave/test/build 09:14:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:30 INFO - Running post-action listener: _resource_record_post_action 09:14:30 INFO - ##### 09:14:30 INFO - ##### Finished clobber step (success) 09:14:30 INFO - ##### 09:14:30 INFO - ##### 09:14:30 INFO - ##### Running read-buildbot-config step. 09:14:30 INFO - ##### 09:14:30 INFO - Running pre-action listener: _resource_record_pre_action 09:14:30 INFO - Running main action method: read_buildbot_config 09:14:30 INFO - Using buildbot properties: 09:14:30 INFO - { 09:14:30 INFO - "project": "", 09:14:30 INFO - "product": "firefox", 09:14:30 INFO - "script_repo_revision": "production", 09:14:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:14:30 INFO - "repository": "", 09:14:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:14:30 INFO - "buildid": "20160519082857", 09:14:30 INFO - "pgo_build": "False", 09:14:30 INFO - "basedir": "/builds/slave/test", 09:14:30 INFO - "buildnumber": 1314, 09:14:30 INFO - "slavename": "talos-linux64-ix-043", 09:14:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:14:30 INFO - "platform": "ubuntu64_hw", 09:14:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:14:30 INFO - "branch": "fx-team", 09:14:30 INFO - "repo_path": "integration/fx-team", 09:14:30 INFO - "revision": "ebd649229181d40d9f5ae41ea4d2109c8f782fe8", 09:14:30 INFO - "stage_platform": "linux64", 09:14:30 INFO - "builduid": "adb3077601154d27897ca3bfd922121d", 09:14:30 INFO - "slavebuilddir": "test" 09:14:30 INFO - } 09:14:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:14:30 INFO - Running post-action listener: _resource_record_post_action 09:14:30 INFO - ##### 09:14:30 INFO - ##### Finished read-buildbot-config step (success) 09:14:30 INFO - ##### 09:14:30 INFO - ##### 09:14:30 INFO - ##### Running download-and-extract step. 09:14:30 INFO - ##### 09:14:30 INFO - Running pre-action listener: _resource_record_pre_action 09:14:30 INFO - Running main action method: download_and_extract 09:14:30 INFO - mkdir: /builds/slave/test/build/tests 09:14: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')]} 09:14:30 INFO - https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:31 INFO - Downloaded 1361 bytes. 09:14:31 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:14:31 INFO - Using the following test package requirements: 09:14:31 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:31 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:14:31 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:14:31 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:31 INFO - u'jsshell-linux-x86_64.zip'], 09:14:31 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:14:31 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:31 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:14:31 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:14:31 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:14:31 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:14:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:31 INFO - https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:32 INFO - Downloaded 22812201 bytes. 09:14:32 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'] 09:14:32 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 09:14:33 INFO - Return code: 0 09:14:33 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 09:14:33 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')]} 09:14:33 INFO - https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:34 INFO - Downloaded 22812201 bytes. 09:14:34 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'] 09:14:34 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 09:14:37 INFO - Return code: 0 09:14:37 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')]} 09:14:37 INFO - https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:38 INFO - Downloaded 10840194 bytes. 09:14:38 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'] 09:14:38 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 09:14:38 INFO - Return code: 0 09:14: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')]} 09:14:38 INFO - https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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 09:14:39 INFO - Downloaded 54797613 bytes. 09:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:14:39 INFO - mkdir: /builds/slave/test/properties 09:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:39 INFO - Contents: 09:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:14:40 INFO - Running post-action listener: _resource_record_post_action 09:14:40 INFO - Running post-action listener: set_extra_try_arguments 09:14:40 INFO - ##### 09:14:40 INFO - ##### Finished download-and-extract step (success) 09:14:40 INFO - ##### 09:14:40 INFO - ##### 09:14:40 INFO - ##### Running populate-webroot step. 09:14:40 INFO - ##### 09:14:40 INFO - Running pre-action listener: _resource_record_pre_action 09:14:40 INFO - Running main action method: populate_webroot 09:14:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:40 INFO - '--tppagecycles', 09:14:40 INFO - '7'], 09:14:40 INFO - 'tests': ['tsvgm']}}, 09:14:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:14:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:14:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:40 INFO - 'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:40 INFO - 'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['damp', 'tps']}, 09:14:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:40 INFO - 'tests': ['damp', 'tps']}, 09:14:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['dromaeo_dom']}, 09:14:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['a11yr', 09:14:40 INFO - 'ts_paint', 09:14:40 INFO - 'tpaint', 09:14:40 INFO - 'sessionrestore', 09:14:40 INFO - 'sessionrestore_no_auto_restore', 09:14:40 INFO - 'tabpaint']}, 09:14:40 INFO - 'other-e10s': {'tests': ['a11yr', 09:14:40 INFO - 'ts_paint', 09:14:40 INFO - 'tpaint', 09:14:40 INFO - 'sessionrestore', 09:14:40 INFO - 'sessionrestore_no_auto_restore', 09:14:40 INFO - 'tabpaint']}, 09:14:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:14:40 INFO - 'ts_paint', 09:14:40 INFO - 'tpaint', 09:14:40 INFO - 'sessionrestore', 09:14:40 INFO - 'sessionrestore_no_auto_restore', 09:14:40 INFO - 'tabpaint']}, 09:14:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:14:40 INFO - 'ts_paint', 09:14:40 INFO - 'tpaint', 09:14:40 INFO - 'sessionrestore', 09:14:40 INFO - 'sessionrestore_no_auto_restore', 09:14:40 INFO - 'tabpaint']}, 09:14:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['a11yr', 09:14:40 INFO - 'ts_paint', 09:14:40 INFO - 'tpaint', 09:14:40 INFO - 'sessionrestore', 09:14:40 INFO - 'sessionrestore_no_auto_restore', 09:14:40 INFO - 'tabpaint']}, 09:14:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['a11yr', 09:14:40 INFO - 'ts_paint', 09:14:40 INFO - 'tpaint', 09:14:40 INFO - 'sessionrestore', 09:14:40 INFO - 'sessionrestore_no_auto_restore', 09:14:40 INFO - 'tabpaint']}, 09:14:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['tsvgx', 09:14:40 INFO - 'tsvgr_opacity', 09:14:40 INFO - 'tart', 09:14:40 INFO - 'tscrollx', 09:14:40 INFO - 'cart']}, 09:14:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:14:40 INFO - 'tsvgr_opacity', 09:14:40 INFO - 'tart', 09:14:40 INFO - 'tscrollx', 09:14:40 INFO - 'cart']}, 09:14:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:40 INFO - 'talos_options': ['--disable-e10s'], 09:14:40 INFO - 'tests': ['tp5o']}, 09:14:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:40 INFO - 'tests': ['tp5o']}, 09:14:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:40 INFO - 'talos_options': ['--disable-e10s', 09:14:40 INFO - '--xperf_path', 09:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:40 INFO - 'tests': ['tp5n']}, 09:14:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:40 INFO - 'talos_options': ['--xperf_path', 09:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:40 INFO - 'tests': ['tp5n']}}, 09:14:40 INFO - 'talos.zip': {'path': '', 09:14:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:40 INFO - Running post-action listener: _resource_record_post_action 09:14:40 INFO - ##### 09:14:40 INFO - ##### Finished populate-webroot step (success) 09:14:40 INFO - ##### 09:14:40 INFO - ##### 09:14:40 INFO - ##### Running create-virtualenv step. 09:14:40 INFO - ##### 09:14:40 INFO - Running pre-action listener: _resource_record_pre_action 09:14:40 INFO - Running main action method: create_virtualenv 09:14:40 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:40 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 09:14:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:40 INFO - Using real prefix '/usr' 09:14:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:44 INFO - Installing pip.................done. 09:14:44 INFO - Return code: 0 09:14:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:44 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 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:14:44 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 09:14:44 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 09:14:44 INFO - Using env: {'DISPLAY': ':0', 09:14:44 INFO - 'HOME': '/home/cltbld', 09:14:44 INFO - 'LANG': 'en_US.UTF-8', 09:14:44 INFO - 'LANGUAGE': 'en_US:en', 09:14:44 INFO - 'LOGNAME': 'cltbld', 09:14:44 INFO - 'MAIL': '/var/mail/cltbld', 09:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:44 INFO - 'MOZ_NO_REMOTE': '1', 09:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:44 INFO - 'NO_EM_RESTART': '1', 09:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:44 INFO - 'PWD': '/builds/slave/test', 09:14:44 INFO - 'SHELL': '/bin/bash', 09:14:44 INFO - 'SHLVL': '1', 09:14:44 INFO - 'TERM': 'linux', 09:14:44 INFO - 'TMOUT': '86400', 09:14:44 INFO - 'USER': 'cltbld', 09:14:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:44 INFO - '_': '/tools/buildbot/bin/python'} 09:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:44 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 09:14:44 INFO - Cleaning up... 09:14:44 INFO - Return code: 0 09:14:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:44 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 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:14:44 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 09:14:44 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 09:14:44 INFO - Using env: {'DISPLAY': ':0', 09:14:44 INFO - 'HOME': '/home/cltbld', 09:14:44 INFO - 'LANG': 'en_US.UTF-8', 09:14:44 INFO - 'LANGUAGE': 'en_US:en', 09:14:44 INFO - 'LOGNAME': 'cltbld', 09:14:44 INFO - 'MAIL': '/var/mail/cltbld', 09:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:44 INFO - 'MOZ_NO_REMOTE': '1', 09:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:44 INFO - 'NO_EM_RESTART': '1', 09:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:44 INFO - 'PWD': '/builds/slave/test', 09:14:44 INFO - 'SHELL': '/bin/bash', 09:14:44 INFO - 'SHLVL': '1', 09:14:44 INFO - 'TERM': 'linux', 09:14:44 INFO - 'TMOUT': '86400', 09:14:44 INFO - 'USER': 'cltbld', 09:14:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:44 INFO - '_': '/tools/buildbot/bin/python'} 09:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:44 INFO - Downloading/unpacking psutil>=3.1.1 09:14:44 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 09:14:44 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 09:14:44 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 09:14:44 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 09:14:44 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 09:14:44 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 09:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:46 INFO - Installing collected packages: psutil 09:14:46 INFO - Running setup.py install for psutil 09:14:46 INFO - building 'psutil._psutil_linux' extension 09:14:46 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 09:14:48 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 09:14:48 INFO - building 'psutil._psutil_posix' extension 09:14:48 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 09:14:48 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 09:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:48 INFO - Successfully installed psutil 09:14:48 INFO - Cleaning up... 09:14:48 INFO - Return code: 0 09:14:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:14:48 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')]} 09:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:48 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')]} 09:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:48 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 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:14:48 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 09:14:48 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 09:14:48 INFO - Using env: {'DISPLAY': ':0', 09:14:48 INFO - 'HOME': '/home/cltbld', 09:14:48 INFO - 'LANG': 'en_US.UTF-8', 09:14:48 INFO - 'LANGUAGE': 'en_US:en', 09:14:48 INFO - 'LOGNAME': 'cltbld', 09:14:48 INFO - 'MAIL': '/var/mail/cltbld', 09:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:48 INFO - 'MOZ_NO_REMOTE': '1', 09:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:48 INFO - 'NO_EM_RESTART': '1', 09:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:48 INFO - 'PWD': '/builds/slave/test', 09:14:48 INFO - 'SHELL': '/bin/bash', 09:14:48 INFO - 'SHLVL': '1', 09:14:48 INFO - 'TERM': 'linux', 09:14:48 INFO - 'TMOUT': '86400', 09:14:48 INFO - 'USER': 'cltbld', 09:14:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:48 INFO - '_': '/tools/buildbot/bin/python'} 09:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:14:51 INFO - Installing collected packages: mozsystemmonitor 09:14:51 INFO - Running setup.py install for mozsystemmonitor 09:14:51 INFO - Successfully installed mozsystemmonitor 09:14:51 INFO - Cleaning up... 09:14:51 INFO - Return code: 0 09:14:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:14:51 INFO - Using env: {'DISPLAY': ':0', 09:14:51 INFO - 'HOME': '/home/cltbld', 09:14:51 INFO - 'LANG': 'en_US.UTF-8', 09:14:51 INFO - 'LANGUAGE': 'en_US:en', 09:14:51 INFO - 'LOGNAME': 'cltbld', 09:14:51 INFO - 'MAIL': '/var/mail/cltbld', 09:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:51 INFO - 'MOZ_NO_REMOTE': '1', 09:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:51 INFO - 'NO_EM_RESTART': '1', 09:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:51 INFO - 'PWD': '/builds/slave/test', 09:14:51 INFO - 'SHELL': '/bin/bash', 09:14:51 INFO - 'SHLVL': '1', 09:14:51 INFO - 'TERM': 'linux', 09:14:51 INFO - 'TMOUT': '86400', 09:14:51 INFO - 'USER': 'cltbld', 09:14:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:51 INFO - '_': '/tools/buildbot/bin/python'} 09:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:14:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:14:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14:54 INFO - Downloading docopt-0.6.1.tar.gz 09:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:14:54 INFO - Installing collected packages: blobuploader, requests, docopt 09:14:54 INFO - Running setup.py install for blobuploader 09:14:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:14:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:14:54 INFO - Running setup.py install for requests 09:14:54 INFO - Running setup.py install for docopt 09:14:54 INFO - Successfully installed blobuploader requests docopt 09:14:54 INFO - Cleaning up... 09:14:54 INFO - Return code: 0 09:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:54 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 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:14:54 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 09:14:54 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 09:14:54 INFO - Using env: {'DISPLAY': ':0', 09:14:54 INFO - 'HOME': '/home/cltbld', 09:14:54 INFO - 'LANG': 'en_US.UTF-8', 09:14:54 INFO - 'LANGUAGE': 'en_US:en', 09:14:54 INFO - 'LOGNAME': 'cltbld', 09:14:54 INFO - 'MAIL': '/var/mail/cltbld', 09:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:54 INFO - 'MOZ_NO_REMOTE': '1', 09:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:54 INFO - 'NO_EM_RESTART': '1', 09:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:54 INFO - 'PWD': '/builds/slave/test', 09:14:54 INFO - 'SHELL': '/bin/bash', 09:14:54 INFO - 'SHLVL': '1', 09:14:54 INFO - 'TERM': 'linux', 09:14:54 INFO - 'TMOUT': '86400', 09:14:54 INFO - 'USER': 'cltbld', 09:14:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:54 INFO - '_': '/tools/buildbot/bin/python'} 09:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:54 INFO - Running setup.py (path:/tmp/pip-o7H8Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:54 INFO - Running setup.py (path:/tmp/pip-UQcU6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:55 INFO - Running setup.py (path:/tmp/pip-J8WyL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:55 INFO - Running setup.py (path:/tmp/pip-Eawh9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:55 INFO - Running setup.py (path:/tmp/pip-uBGe8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:55 INFO - Running setup.py (path:/tmp/pip-65u4t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:55 INFO - Running setup.py (path:/tmp/pip-38r4oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:55 INFO - Running setup.py (path:/tmp/pip-1OlHsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:55 INFO - Running setup.py (path:/tmp/pip-dk3Q9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:55 INFO - Running setup.py (path:/tmp/pip-ni9Mmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:55 INFO - Running setup.py (path:/tmp/pip-cDQVFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:55 INFO - Running setup.py (path:/tmp/pip-pO5ryF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:55 INFO - Running setup.py (path:/tmp/pip-5fgo8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:55 INFO - Running setup.py (path:/tmp/pip-L3b4fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:55 INFO - Running setup.py (path:/tmp/pip-vato5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:55 INFO - Running setup.py (path:/tmp/pip-z7gD6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:56 INFO - Running setup.py (path:/tmp/pip-76MJk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:56 INFO - Running setup.py install for manifestparser 09:14:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Running setup.py install for mozcrash 09:14:56 INFO - Running setup.py install for mozdebug 09:14:56 INFO - Running setup.py install for mozdevice 09:14:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Running setup.py install for mozfile 09:14:56 INFO - Running setup.py install for mozhttpd 09:14:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Running setup.py install for mozinfo 09:14:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Running setup.py install for mozInstall 09:14:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:56 INFO - Running setup.py install for mozleak 09:14:56 INFO - Running setup.py install for mozlog 09:14:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:57 INFO - Running setup.py install for moznetwork 09:14:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:57 INFO - Running setup.py install for mozprocess 09:14:57 INFO - Running setup.py install for mozprofile 09:14:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:57 INFO - Running setup.py install for mozrunner 09:14:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:57 INFO - Running setup.py install for mozscreenshot 09:14:57 INFO - Running setup.py install for moztest 09:14:57 INFO - Running setup.py install for mozversion 09:14:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:57 INFO - Cleaning up... 09:14:57 INFO - Return code: 0 09:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:57 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 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:14:57 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 09:14:57 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 09:14:57 INFO - Using env: {'DISPLAY': ':0', 09:14:57 INFO - 'HOME': '/home/cltbld', 09:14:57 INFO - 'LANG': 'en_US.UTF-8', 09:14:57 INFO - 'LANGUAGE': 'en_US:en', 09:14:57 INFO - 'LOGNAME': 'cltbld', 09:14:57 INFO - 'MAIL': '/var/mail/cltbld', 09:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:57 INFO - 'MOZ_NO_REMOTE': '1', 09:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:57 INFO - 'NO_EM_RESTART': '1', 09:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:57 INFO - 'PWD': '/builds/slave/test', 09:14:57 INFO - 'SHELL': '/bin/bash', 09:14:57 INFO - 'SHLVL': '1', 09:14:57 INFO - 'TERM': 'linux', 09:14:57 INFO - 'TMOUT': '86400', 09:14:57 INFO - 'USER': 'cltbld', 09:14:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:57 INFO - '_': '/tools/buildbot/bin/python'} 09:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:58 INFO - Running setup.py (path:/tmp/pip-DZmPxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:58 INFO - Running setup.py (path:/tmp/pip-As5E7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:58 INFO - Running setup.py (path:/tmp/pip-YtI0Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:58 INFO - Running setup.py (path:/tmp/pip-XBjTrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:58 INFO - Running setup.py (path:/tmp/pip-hcjeeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:58 INFO - Running setup.py (path:/tmp/pip-gk5bMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:58 INFO - Running setup.py (path:/tmp/pip-85SQI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:58 INFO - Running setup.py (path:/tmp/pip-KJdZg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:58 INFO - Running setup.py (path:/tmp/pip-oGg92_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:58 INFO - Running setup.py (path:/tmp/pip-QPwRp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:58 INFO - Running setup.py (path:/tmp/pip-aKSRJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:58 INFO - Running setup.py (path:/tmp/pip-Te7pJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:58 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)) 09:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:58 INFO - Running setup.py (path:/tmp/pip-Yl41oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:59 INFO - Running setup.py (path:/tmp/pip-NIaSwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:59 INFO - Running setup.py (path:/tmp/pip-tCP1oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:59 INFO - Running setup.py (path:/tmp/pip-l3Pgxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:59 INFO - Running setup.py (path:/tmp/pip-LxnppA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:59 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)) 09:14:59 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)) 09:14:59 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)) 09:14:59 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)) 09:14:59 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)) 09:14:59 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)) 09:14:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:59 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 09:14:59 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 09:14:59 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 09:14:59 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 09:14:59 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 09:14:59 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 09:15:01 INFO - Downloading blessings-1.6.tar.gz 09:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:01 INFO - Installing collected packages: blessings 09:15:01 INFO - Running setup.py install for blessings 09:15:01 INFO - Successfully installed blessings 09:15:01 INFO - Cleaning up... 09:15:01 INFO - Return code: 0 09:15:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:01 INFO - Reading from file tmpfile_stdout 09:15:01 INFO - Current package versions: 09:15:01 INFO - argparse == 1.2.1 09:15:01 INFO - blessings == 1.6 09:15:01 INFO - blobuploader == 1.2.4 09:15:01 INFO - docopt == 0.6.1 09:15:01 INFO - manifestparser == 1.1 09:15:01 INFO - mozInstall == 1.12 09:15:01 INFO - mozcrash == 0.17 09:15:01 INFO - mozdebug == 0.1 09:15:01 INFO - mozdevice == 0.48 09:15:01 INFO - mozfile == 1.2 09:15:01 INFO - mozhttpd == 0.7 09:15:01 INFO - mozinfo == 0.9 09:15:01 INFO - mozleak == 0.1 09:15:01 INFO - mozlog == 3.2 09:15:01 INFO - moznetwork == 0.27 09:15:01 INFO - mozprocess == 0.22 09:15:01 INFO - mozprofile == 0.28 09:15:01 INFO - mozrunner == 6.11 09:15:01 INFO - mozscreenshot == 0.1 09:15:01 INFO - mozsystemmonitor == 0.3 09:15:01 INFO - moztest == 0.7 09:15:01 INFO - mozversion == 1.4 09:15:01 INFO - psutil == 3.1.1 09:15:01 INFO - requests == 1.2.3 09:15:01 INFO - wsgiref == 0.1.2 09:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:01 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')]} 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:01 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')]} 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:01 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 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:15:01 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 09:15:01 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 09:15:01 INFO - Using env: {'DISPLAY': ':0', 09:15:01 INFO - 'HOME': '/home/cltbld', 09:15:01 INFO - 'LANG': 'en_US.UTF-8', 09:15:01 INFO - 'LANGUAGE': 'en_US:en', 09:15:01 INFO - 'LOGNAME': 'cltbld', 09:15:01 INFO - 'MAIL': '/var/mail/cltbld', 09:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:01 INFO - 'MOZ_NO_REMOTE': '1', 09:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:01 INFO - 'NO_EM_RESTART': '1', 09:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:01 INFO - 'PWD': '/builds/slave/test', 09:15:01 INFO - 'SHELL': '/bin/bash', 09:15:01 INFO - 'SHLVL': '1', 09:15:01 INFO - 'TERM': 'linux', 09:15:01 INFO - 'TMOUT': '86400', 09:15:01 INFO - 'USER': 'cltbld', 09:15:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:01 INFO - '_': '/tools/buildbot/bin/python'} 09:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 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)) 09:15:01 INFO - Cleaning up... 09:15:01 INFO - Return code: 0 09:15:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15:01 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')]} 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:01 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')]} 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:01 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 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:15:01 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 09:15:01 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 09:15:01 INFO - Using env: {'DISPLAY': ':0', 09:15:01 INFO - 'HOME': '/home/cltbld', 09:15:01 INFO - 'LANG': 'en_US.UTF-8', 09:15:01 INFO - 'LANGUAGE': 'en_US:en', 09:15:01 INFO - 'LOGNAME': 'cltbld', 09:15:01 INFO - 'MAIL': '/var/mail/cltbld', 09:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:01 INFO - 'MOZ_NO_REMOTE': '1', 09:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:01 INFO - 'NO_EM_RESTART': '1', 09:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:01 INFO - 'PWD': '/builds/slave/test', 09:15:01 INFO - 'SHELL': '/bin/bash', 09:15:01 INFO - 'SHLVL': '1', 09:15:01 INFO - 'TERM': 'linux', 09:15:01 INFO - 'TMOUT': '86400', 09:15:01 INFO - 'USER': 'cltbld', 09:15:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:01 INFO - '_': '/tools/buildbot/bin/python'} 09:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:02 INFO - Downloading/unpacking jsonschema 09:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:04 INFO - Downloading/unpacking functools32 (from jsonschema) 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:04 INFO - warning: no files found matching '*.txt' 09:15:04 INFO - no previously-included directories found matching 'build' 09:15:04 INFO - no previously-included directories found matching 'dist' 09:15:04 INFO - no previously-included directories found matching '.git*' 09:15:04 INFO - Installing collected packages: jsonschema, functools32 09:15:04 INFO - Running setup.py install for functools32 09:15:04 INFO - warning: no files found matching '*.txt' 09:15:04 INFO - no previously-included directories found matching 'build' 09:15:04 INFO - no previously-included directories found matching 'dist' 09:15:04 INFO - no previously-included directories found matching '.git*' 09:15:04 INFO - Successfully installed jsonschema functools32 09:15:04 INFO - Cleaning up... 09:15:04 INFO - Return code: 0 09:15:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:15:04 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')]} 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:04 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')]} 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:04 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 0x7f6ae0afef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, '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': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', '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 09:15:04 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 09:15:04 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 09:15:04 INFO - Using env: {'DISPLAY': ':0', 09:15:04 INFO - 'HOME': '/home/cltbld', 09:15:04 INFO - 'LANG': 'en_US.UTF-8', 09:15:04 INFO - 'LANGUAGE': 'en_US:en', 09:15:04 INFO - 'LOGNAME': 'cltbld', 09:15:04 INFO - 'MAIL': '/var/mail/cltbld', 09:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:04 INFO - 'MOZ_NO_REMOTE': '1', 09:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:04 INFO - 'NO_EM_RESTART': '1', 09:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:04 INFO - 'PWD': '/builds/slave/test', 09:15:04 INFO - 'SHELL': '/bin/bash', 09:15:04 INFO - 'SHLVL': '1', 09:15:04 INFO - 'TERM': 'linux', 09:15:04 INFO - 'TMOUT': '86400', 09:15:04 INFO - 'USER': 'cltbld', 09:15:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:04 INFO - '_': '/tools/buildbot/bin/python'} 09:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:04 INFO - Downloading/unpacking flake8 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:15:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:15:06 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 09:15:06 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 09:15:06 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 09:15:06 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 09:15:06 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 09:15:06 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 09:15:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:15:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:15:06 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 09:15:06 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 09:15:06 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 09:15:06 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 09:15:06 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 09:15:06 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 09:15:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:07 INFO - no previously-included directories found matching 'docs/_build' 09:15:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:15:07 INFO - Running setup.py install for pep8 09:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:07 INFO - no previously-included directories found matching 'docs/_build' 09:15:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:15:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:15:07 INFO - Cleaning up... 09:15:07 INFO - Return code: 0 09:15:07 INFO - Running post-action listener: _resource_record_post_action 09:15:07 INFO - Running post-action listener: _start_resource_monitoring 09:15:07 INFO - Starting resource monitoring. 09:15:07 INFO - ##### 09:15:07 INFO - ##### Finished create-virtualenv step (success) 09:15:07 INFO - ##### 09:15:07 INFO - ##### 09:15:07 INFO - ##### Running install step. 09:15:07 INFO - ##### 09:15:07 INFO - Running pre-action listener: _resource_record_pre_action 09:15:07 INFO - Running main action method: install 09:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:07 INFO - Reading from file tmpfile_stdout 09:15:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:07 INFO - Reading from file tmpfile_stdout 09:15:07 INFO - Output received: 09:15:07 INFO - Usage: mozinstall [options] installer 09:15:07 INFO - Options: 09:15:07 INFO - -h, --help show this help message and exit 09:15:07 INFO - -d DEST, --destination=DEST 09:15:07 INFO - Directory to install application into. [default: 09:15:07 INFO - "/builds/slave/test"] 09:15:07 INFO - --app=APP Application being installed. [default: firefox] 09:15:07 INFO - mkdir: /builds/slave/test/build/application 09:15:07 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'] 09:15:07 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 09:15:23 INFO - Reading from file tmpfile_stdout 09:15:23 INFO - Output received: 09:15:23 INFO - /builds/slave/test/build/application/firefox/firefox 09:15:23 INFO - Running post-action listener: _resource_record_post_action 09:15:23 INFO - ##### 09:15:23 INFO - ##### Finished install step (success) 09:15:23 INFO - ##### 09:15:23 INFO - ##### 09:15:23 INFO - ##### Running run-tests step. 09:15:23 INFO - ##### 09:15:23 INFO - Running pre-action listener: _resource_record_pre_action 09:15:23 INFO - Running main action method: run_tests 09:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:23 INFO - Python 2.7.3 09:15:23 INFO - Return code: 0 09:15:23 INFO - grabbing minidump binary from tooltool 09:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:23 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 0x1ec69c0>, '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 0x1ec78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:23 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 09:15:23 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 09:15:23 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 09:15:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:23 INFO - Return code: 0 09:15:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:15:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:15:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:15:24 INFO - Return code: 0 09:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 09:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 09:15:24 INFO - Using env: {'DISPLAY': ':0', 09:15:24 INFO - 'HOME': '/home/cltbld', 09:15:24 INFO - 'LANG': 'en_US.UTF-8', 09:15:24 INFO - 'LANGUAGE': 'en_US:en', 09:15:24 INFO - 'LOGNAME': 'cltbld', 09:15:24 INFO - 'MAIL': '/var/mail/cltbld', 09:15:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:24 INFO - 'MOZ_NO_REMOTE': '1', 09:15:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:24 INFO - 'NO_EM_RESTART': '1', 09:15:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:24 INFO - 'PWD': '/builds/slave/test', 09:15:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:24 INFO - 'SHELL': '/bin/bash', 09:15:24 INFO - 'SHLVL': '1', 09:15:24 INFO - 'TERM': 'linux', 09:15:24 INFO - 'TMOUT': '86400', 09:15:24 INFO - 'USER': 'cltbld', 09:15:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463674467.788322-470605344', 09:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:24 INFO - '_': '/tools/buildbot/bin/python'} 09:15:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 09:15:25 INFO - mozversion application_buildid: 20160519082857 09:15:25 INFO - mozversion application_changeset: ebd649229181d40d9f5ae41ea4d2109c8f782fe8 09:15:25 INFO - mozversion application_display_name: Nightly 09:15:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:25 INFO - mozversion application_name: Firefox 09:15:25 INFO - mozversion application_remotingname: firefox 09:15:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:15:25 INFO - mozversion application_vendor: Mozilla 09:15:25 INFO - mozversion application_version: 49.0a1 09:15:25 INFO - mozversion platform_buildid: 20160519082857 09:15:25 INFO - mozversion platform_changeset: ebd649229181d40d9f5ae41ea4d2109c8f782fe8 09:15:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:15:25 INFO - mozversion platform_version: 49.0a1 09:15:25 INFO - using testdate: 1463674525 09:15:25 INFO - actual date: 1463674525 09:15:25 INFO - starting webserver on 'localhost:53543' 09:15:25 INFO - SUITE-START | Running 2 tests 09:15:25 INFO - TEST-START | dromaeo_css 09:15:25 INFO - operating with platform_type : linux_ 09:15:25 INFO - Initialising browser for dromaeo_css test... 09:15:25 INFO - TEST-INFO | started process 3283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL4whfd/profile http://localhost:53543/getInfo.html) 09:15:30 INFO - PROCESS | 3283 | 09:15:30 INFO - PROCESS | 3283 | (process:3353): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:15:31 INFO - PROCESS | 3283 | __metrics Screen width/height:1600/1200 09:15:31 INFO - PROCESS | 3283 | colorDepth:24 09:15:31 INFO - PROCESS | 3283 | Browser inner width/height: 1024/697 09:15:31 INFO - PROCESS | 3283 | __metrics 09:15:31 ERROR - PROCESS | 3283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:15:32 INFO - TEST-INFO | 3283: exit 0 09:15:32 INFO - Browser initialized. 09:15:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:32 INFO - TEST-INFO | started process 3404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL4whfd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:34 INFO - PROCESS | 3404 | 09:15:34 INFO - PROCESS | 3404 | (process:3466): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:15:44 INFO - PROCESS | 3404 | RSS: Main: 165130240 09:15:44 INFO - PROCESS | 3404 | 09:16:34 INFO - PROCESS | 3404 | 1463674594380 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] 09:18:45 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53543/tests/dromaeo/cssquery-ext.html) 09:18:46 INFO - PROCESS | 3404 | RSS: Main: 167780352 09:18:46 INFO - PROCESS | 3404 | 09:21:48 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-ext.html (next: http://localhost:53543/tests/dromaeo/cssquery-jquery.html) 09:21:48 INFO - PROCESS | 3404 | RSS: Main: 167555072 09:21:48 INFO - PROCESS | 3404 | 09:24:50 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53543/tests/dromaeo/cssquery-mootools.html) 09:24:51 INFO - PROCESS | 3404 | RSS: Main: 167841792 09:24:51 INFO - PROCESS | 3404 | 09:27:53 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53543/tests/dromaeo/cssquery-prototype.html) 09:27:53 INFO - PROCESS | 3404 | RSS: Main: 165617664 09:27:53 INFO - PROCESS | 3404 | 09:30:56 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53543/tests/dromaeo/cssquery-yui.html) 09:30:57 INFO - PROCESS | 3404 | RSS: Main: 166174720 09:30:57 INFO - PROCESS | 3404 | 09:33:59 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-yui.html (next: http://localhost:53543/tests/dromaeo/cssquery-dojo.html) 09:34:00 INFO - PROCESS | 3404 | RSS: Main: 168525824 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - PROCESS | 3404 | __start_tp_report 09:34:00 INFO - PROCESS | 3404 | _x_x_mozilla_page_load 09:34:00 INFO - PROCESS | 3404 | _x_x_mozilla_page_load_details 09:34:00 INFO - PROCESS | 3404 | |i|pagename|runs| 09:34:00 INFO - PROCESS | 3404 | |0;dojo.html;2674.3581540430296;2706.580480025596;2710.3359676879154;2713.5658294672858;2729.604207389927;4681.555252251035;4695.178343789836;4734.408198975124;4822.132016237076;4854.660173787836;4671.042436300559;4714;4725.291206319054;4779.139754844126;4816.951830481694;4264.360345948109;4328.653707703376;4442.06716589515;4450.933236001462;4455.665825063117;34.971541207041824;4312.1375724855;4351.673624478177;4386.188555117297;4477.7984990675495;4342.435483387139;4363.498197707257;4405.845795397146;4418.8453404130705;4424.203643344197;4404.339349097629;4443.044745379759;4445.1331990261915;4468.798904049326;4498.842540511099;4348.7390756554705;4373.497047839475;4390.604845563883;4419.4254746883025;4436.112777444492;4722.693024953402;4723.385959825235;4730.526947305277;4747.976260118678;4765.023170250125;4947.257911313296;5092.898142037138;5149.948500515022;5185.896282074375;5252.133397989327;5055.646104772667;5123.333966584358;5125.692458452505;5126.102931986888;5172.767225474862;4785.3300537924715;4825.782839772219;4895.461499235045;4902.4362198346935;4929.482404347564;5264.078786212397;5344.572434205332;5363.436839131913;5365.54392876602;5377.059014672495;5090.592752579785;5108.259302401131;5111.131107711698;5136.717480538607;5189.766460509286;5200.869978250498;5209.192575150858;5214.530692237717;5226.45122262157;5258.553022993012;4962.826301079445;5066.847994560096;5121.411037730634;5140.665856719302;5146.30524879144;5087.186050232019;5103.7192954387865;5112.71880046601;5119.48805119485;5137.17805151174;4323.113761678848;4330.0906809569715;4330.220560299176;4373.016071383913;4401.405810215644;3728.5712143103347;3736.663700266989;3763.9247215056093;3782.8108594570162;3806.695464362844;4413.426254586883;4496.39298694672;4514.774261286988;4516.864494065183;4535.569120933506;5216.686998780086;5218.504242096995;5219.217117432416;5236.3716354037;5286.3392075990505;4374.5625437456;4422.115576884636;4424.557544245614;4533.22935101027;4606.585407313358;4557.270836666184;4579.404677391918;4585.1746685596245;4597.7241365518175;4599.126166028444;4859.684120532295;4864.027194561102;4868.586170175504;4871.878203044952;4893.21708526634;5173.198154286091;5177.585793136464;5182.844514664566;5183.455737147545;5185.896282074262;4770.928436073392;4837.685550439211;4866.026794641157;4875.756212189447;4894.290327902506;5125.846224613268;5132.769025393792;5140.588752899834;5142.151544995184;5145.253938179018;5144.588432925432;5193.480651934928;5193.974030129825;5205.73971301441;5205.973970130125;4823.324734537097;4860.781264843161;4927.901441971068;4935.185694360391;4936.963237720119;4959.380077490314;4984.252362145708;5002.049610573979;5008.873003574166;5029.723365214802;4759.9286010709175;4863.905621235193;4869.683470574543;4888.877778055577;4952.034353301072;5037.0681423936685;5039.5968322534845;5073.086844368049;5098.056859481007;5102.948970510248;4980.277859710394;4993.850184494471;4998.500149984972;5003.824866129668;5073.188289873602 09:34:00 INFO - PROCESS | 3404 | |1;ext.html;590.6987436407434;591.7307625030611;608.8782243551291;633.4868756307392;643.1735220241984;33865;34543.65456345439;37088.44367334492;37123.25753484932;37318.813405933;38516.229675406474;39169;39218.8039059805;39231;39395.803020984924;7734.651940662669;7875.291223789858;7909.0113735783025;7917.168697286788;7940.047194336659;7736.2650548197835;7799.259070388304;7801.687932482694;7827.921720782805;7836;7792.727254546092;7838.568878711669;7896.210378962115;7900.288973992339;7907.209279072104;7667.5782831944225;7771.611419429034;7835.177306382861;7880.487768295043;7889.8027549311155;7741.148473667892;7879.566623835687;7880.527168369917;7895.8026049348655;7917;35596.288074238626;36278.637213628055;36399.63600363989;36449.63550364516;36634;2594.520013797435;3106.5806116174253;3381.1547113221695;3595;3930.2728995135703;28858.855705721548;29139.41721165586;29174;29381.26546836346;29516.70483295161;3232.8545215465124;3260.4783234682336;3315.270640459095;3316.1709572606846;3389.9661003389897;250584;251104;251899;251962.99999999817;252733.736331319;33169.66830331714;33644.32711345809;33670;33844.153896152304;34287.82856085704;35916.281674366364;35993.46009809855;36083.81958090193;36148;36191.63808361936;13753.656158596115;13794.65513362174;13918.791218131533;13934.930325348309;13950.511732089328;11183.105351571854;11336.036436902956;11372.43137843121;11406.42967851604;11414.42927853604;8169.754907352789;8296.958515207385;8299.585020748938;8346.374021948379;8377;3168.2298065302216;3226.1128189748006;3237.1259759864706;3243.8864639737494;3286.6549012353357;948.6252930092575;975.302658599105;979.7599588100818;987.9061489158519;1051.5373235776235;28656;29311.85344073266;29372.265693357836;29510.262243443656;29626;998.7453199434098;1043.0456132638703;1097.2209731090854;1107.8005958927308;1162.9418529073512;15403.821858804264;15461.690766184613;15602.219889005504;15823.287952042187;15879.603009924844;438527;439666;439985;444283;444798;51488.742556286976;51953.7402312986;52019;52061.2190817138;52108;1255.416231452379;1282.2626989481087;1284.4990453723055;1289.6517940156104;1294.1199984010775;27358.674512666646;28941.710582893902;28987.275318117216;29114.854425727735;29419.558706619846;43524.347134793636;44087.77956110327;44175.33736994012;44279.33580996352;44289;337870;338828;338983;340176;341091;25902.740972590786;26685.86657066702;26770.46459070769;26787.464250715268;26832.463350733266;44152;44356.556434435246;44643.77678111719;45486.317705233785;45554.54445455503;37529;38161.80919095387;38402.2319553613;38455.5003924744;38593.807030964665;37096.6290337104;38420.61579384282;38741;38746;38987.61012389953;37227.06932326713;37984.24031519299;38839.80580097081;38985.41521877117;41534.169316614105;31544;34886.98875867009;34913.82543087268;35034;35308.64691353054;26395;26472.8676356617;26604.201873943814;26620.334491637863;26657.733422665526 09:34:00 INFO - PROCESS | 3404 | |2;jquery.html;377.4432711750169;383.22205921978383;389.09147141424774;393.39220903703773;395.3634648216373;16110.35558577657;17210;17699.91150044251;17716.20277087531;17741.290348386083;17504.387346442876;17743.201555929983;18131.818681813176;18193.909030454863;18298.085095745228;5161.329027226465;5333.333333333333;5361.892762144755;5390.0836857734275;5394.406615272336;3696.4270538066507;5794.68129252891;6091.725872335755;6095.969520152393;6190.41191086846;5870.207521984542;6113.877722445548;6135.987562052256;6136.539759518032;6142.385761423844;5982.162497250389;6032.969835150796;6041.093835924625;6054.122152287893;6073.1497590337385;5204.401493828221;5277.287566178555;5298.867528311785;5429.4570542945785;5455.263539422167;21267.14931402742;21590.568188636298;21765.23821666234;21803.127874884987;21804.34586962378;1873.49415657773;2009.8392128629675;2010.6079314533672;2111.3771437425994;2145.8819764912923;12008.63974080779;12032.879671203264;13681.931590342085;13722.931385343009;13998.860011399858;1796.2276221224868;1843.7879643840995;2022.1203776357331;2028.503016760903;2043.7343145391003;70645.64677176633;72651.63674181649;74423.62788186024;74669.62665186639;76240.61879690622;10185.796284074277;10360.844587331196;10419.426931518688;10457.84313235302;10616.991385818335;14408.711825763636;14513.201773902325;14576;14596.12423254608;14622.341994610268;7446.329830315298;7566.31903128721;7588.582627955405;7624.847503049908;7636.198199189116;7176.354128128493;7190.245024272481;7223.241559636268;7286.744963926237;7304.96347518259;4502.617277531381;4528.796204170821;4542.93241088344;4585.977070114628;4603.700759450625;1602.3430393538592;1701.3024659889386;1706.3430579226838;1714.1771949464328;1752.684516786965;872.4111224923151;881.9559022049;935.6397786851975;973.0123924216925;975.5268694683073;16797.580060498585;16876.831231687527;17364.218610162574;17608.647827043387;17697.38059167923;908.68650315641;912.224609082288;917.27535247154;934.7102398256562;939.2345238630494;9515.23878089751;9826.115649591427;9865.605375785031;9954.253430992705;9988.60045598168;389928;394728;395347;395522;397262;46745.532544674796;82535;82990.17009829945;83448;84237.57881210555;948.606328373731;953.8712273842942;968.041638777605;974.3715303629119;977.3500622086233;15379.231038448257;15412.306446210172;15580.376784928476;15591.844081559493;15725.292361843516;35249.295014100084;36158.63841361658;36287.81856090808;36609.08477288089;37081;48239.5176048235;48755.26867096926;50379.74810125926;50932.49067509278;51134;7773.883391749241;7979.361651068017;8117.985251843519;8172.959135204286;8227.629756660845;10909.945450272699;11575.073994080622;11690.824637630612;11871.406429678309;12224.877751222373;9769.84032174581;10238.33450825694;10285.845712314172;10290.845637315597;10497.47512624381;9687.854682179914;9925.503724813874;10057.19542436618;10226.181905447695;10249.897501024894;10154.238432117769;10486;10550.577976880839;10730.94558438842;10742.946285268523;7563.508371955805;7591.164971853203;7669.923300766921;7725.961370193113;7762.184970578008;8731.345149113715;10182.949085254526;10365.9481702591;10391.792164156826;10543.472826358498 09:34:00 INFO - PROCESS | 3404 | |3;mootools.html;1525.5270866031535;1554.6191183160126;1713.143428285857;1834.8165183481663;1858.581819090704;7002.929970700291;7779.805504862381;7850.175731548191;8356.039055508625;8382.329413646901;7872.212778722125;8204.138565450632;8244.258016778489;8294.087650358455;8332.875006874901;2304.9423764405897;2337.392278007722;2343.60158773009;2355.611324131516;2358.363241924679;2286.8284878634167;2293.9311820645407;2337.8714170720605;2344.4842134730334;2351.447409858682;2317.640765681322;2320.628699408095;2331.0326214620914;2351.8588884666974;2353.3175379140116;2225.5993921094196;2244.45010972312;2256.334381357495;2258.503129311549;2267.0931627349028;2243.8317126215597;2286.5198308355266;2298.471351589144;2321.5356928614174;2325.279163459316;8095.271425571668;8114.63484143215;8154.714584989497;8156.388270879707;8193.8361232775;4764.285357196413;4881.1213981483315;4881.365422495089;4881.536254055859;4888.340074089988;3000.6249218847643;3016.291171574678;3201.2157021529874;3215.9678403215903;3247.6914693104354;1001.9849702254472;1002.5137808163108;1018.5467466977198;1023.6314926626409;1033.4316126130673;10862.891371086267;10919.235653504258;10960.068394186424;10974.573305470318;10996.450177491093;4363.6072753452345;4440.222960981815;4475.820967161342;4581.312803079565;4588.724676519353;9208.401453905475;9216.124468175512;9272.536373181449;9283.164515193665;9291.860622090675;4815.3017812417;4861.440934292602;4862.78117484714;4866.5376789205675;4876.073546026244;3810.809459527068;4251.171021650748;4382.474103107647;4387.539308372575;4393.29707246839;3850.172212974224;3893.7469064510715;3970.4242884781543;4011.438398624195;4016.794961511593;1275.6236910111538;1300.6228193823874;1306.2097431054265;1311.5344052861287;1317.1965101288206;804.0231119190212;858.2318824651902;880.8634661627458;893.3166127912152;943.1982814607529;5706.001449746278;5717;5748.511376532958;5823.184754134425;5947.672877991752;452.5451920819555;452.69443125889893;454.4569239758457;460.1257610539934;473.74181071315525;3832.463455116286;3857.7106716996336;3882.9029274267805;3907.531096268466;3937.547182074041;9629.133377996013;9893.505324733735;10089.899101009043;10108.191344692406;10108.949455252676;9927.652532161339;9945.80108397828;9973.650922217832;9979.900200997898;10008.39949603026;7330.486865919334;7600.733974310983;7657.770266892002;7660.923390766133;7744.999999999887;5618.85952851182;5639.859003524781;5742.454466825645;5750.8849823002465;5810.796622118206;8841.425307355;9165.450072995642;9203.677871274473;9320;9387.624495020124;9353.744046458709;9374.67188648394;9475.336726429085;9544.85682714746;9566.186874115778;6308.495320374451;6743.561668491532;6791.830204244933;7089.149302083783;7094.432445404458;7529.360004399688;7572.20491848348;7586.165521792488;7626;7628.8474230516185;6967.965160174167;6986.510944234058;7032.367086962198;7092.574445533284;7273.745418910313;6894.551854129466;6955.130608673916;6956.582605043714;7034;7053.470989675898;6397.0724244983285;6424.871502570016;6498.545101842826;6521.934780652133;6542.738290468328;4969.155243608523;4999.825006124768;5007.073691367109;5044.268581055653;5052.722100284373;4942.654014218971;4945.282933974626;4998.2502624606595;5022.246663000579;5025.824096156617 09:34:00 INFO - PROCESS | 3404 | |4;prototype.html;320.9935801283974;324.0796138965339;325.9975575106548;330.32283818172726;332.222599118064;4962.8263010794535;5008.273800298959;5067.391912970439;5069.873253168668;5087.227461033732;4923.5076492350745;4936.346323981462;4950.876228094299;4983.975080124604;4996.400431948171;3702.8889133326043;3827.4832897558754;3904.5900180481067;3908.9022774430723;3914.921701565981;3928.8428462861452;3936.8425262989444;3937.3897045957924;3952.2095580883793;3963.5640079591367;3850.114473671057;3866.9806650966707;3867.690584753213;3879.243547508223;3881.10734531058;3792.2984247914223;3855.9614403855885;3870.7096967727393;3936.921261574781;3953.2686453006;3464.34177506273;3487.755857089979;3490.5636795400574;3498.7900725956524;3503.754737168399;4787.13831510328;4800.3279540864305;4801.8079276828885;4809.711417314972;4849.2726091086615;4465.419495465601;4564.201264778683;4580.07636792548;4585.908281834378;4585.977070114628;5238.711870847102;5244.187150991603;5263.578913686896;5268.446813084609;5278.683279003272;3823.3118038753014;3862.594427585091;3871.98656698518;3875.5543112541854;3878.553966293884;5263.526282634582;5407.242985981927;5422.349318081816;5422.91865622016;5427.267318911936;3932.9213415731524;3947.7236593438756;3962.980185099056;3966.3058964681063;3973.900652483653;4010.598940106024;4014.711614379834;4039.8788036358956;4046.615571520701;4054.3107671695884;4463.799129039201;4484.690384451945;4520.95479045212;4536.8638940831825;4552.226121559343;5109.3613298337705;5215.6609820361555;5228.9738551307;5252.527272545489;5257.342832145981;1372.7323171981368;1383.522684673786;1387.8473367929519;1394.842280906845;1397.9091359061629;848.134902399549;881.2157180109707;888.7644774134859;893.9362159030862;898.2409863665192;4573.451185857718;4574.336721175411;4590.173768721662;4593.402857628487;4598.632109431237;5414.106672399089;5423.322084739408;5435.130379139318;5435.701036442954;5485.753141108659;4422.977885110554;4608.377868987711;4661.95338046622;4671;4689.273162659793;2850.372917958046;2858.757005654543;2887.133859842039;2888.7400133988044;2898.6086878271162;5015.924761128586;5095.694258344437;5118.97440512795;5133.948660513347;5166.61250406221;5414.431484694051;5480.725963701799;5522.91715624266;5547.25112109868;5591.8602034948635;5056.443791182967;5060.493950604984;5067.619928505377;5095.866042383981;5128.358955130609;5386.946130538645;5401.86495337604;5416.241726158262;5421.566274698093;5457.508824205841;5105.795768169231;5235.947640523546;5258.211268309784;5260.184671375943;5287.642347109536;5036.949630503648;5049.242613607841;5069.467705890976;5076.593872490118;5096.261042148942;4006.8196931137586;4007.0783719745205;4008.118213992917;4014.2774300625;4016.55817860041;5226.686398816083;5436.510714035756;5437.238786569963;5456.317960254968;5475.945240547543;5244.003639308519;5250.65870718402;5277.472252774692;5278.656887302313;5298.788048478018;5251.028559716465;5252.763625636932;5272.2882410874045;5296.152615581488;5302.814401495929;4940.344984430112;5138.537531622172;5190.558802501679;5196.350456192976;5225.268462415189;5003.124453220599;5167.689938603696;5271.841844744664;5272.815451459181;5290.68255904647;5156.948430515647;5191.714455704821;5213.973930130325;5214.556762675215;5239.816606418757 09:34:00 INFO - PROCESS | 3404 | |5;yui.html;664.7108507799107;721.1274358026787;807.5558442856432;813.1258896686064;816.7794695432234;11403.3728144952;11464.828027579571;11647.068234541248;12824.615261542145;13383.397747101379;12008;12146.81779773302;12473.68815779606;12729.618111456648;12775.041871859601;680.8195828105556;848.406115718996;851.2041241439258;862.7627402464341;868.374770165483;862.3316929379719;873.4235404632943;874.9868751968726;876.2508055612456;877.5656050255133;902.3999040637968;903.2142036428316;904.7783293093202;904.868794024866;906.8503696890006;890.3633901760272;894.2667013049302;895.122779675918;900.8873890763655;901.0853983207018;653.627432363553;658.0392626764929;659.3176062775053;660.9471242300605;661.3551787007677;12238.510459581606;12285.57000504978;12357.752844943141;12374.443150058269;12408.193467424679;12620.242785432903;12817.743645127139;12900.677483062904;13069.803952940618;13290.468381264738;10493.737656558571;10574.577016919315;10605.84091238632;10711.357318560911;10775.299605525615;3390.8135052572097;3460.377132116243;3460.723142148622;3484.703800176988;3489.581250249986;43884;45032.3245151323;49651;49705.25442118371;49815;10397.948010260052;10455.84316235257;10457.42484163363;10477.895221047693;10560.52477638508;17680.911595442198;17915.820841791676;17936.55158621019;17964.820351796578;17971.640567188584;7086.681099350541;7154.570725756367;7183.389411899942;7203.315685009916;7205.423566114699;3873.0898238913833;3891.0273327988766;3961.7226794124135;3979.7015223858325;3984.322665146932;2868.612737280482;2939.3092623233524;2943.5878976943245;2954.3648115654805;2960.8223506589675;523.8559396166008;529.5895680847298;533.751805410486;537.4410612962554;539.4201233673816;619.2568917299259;629.0532748213909;644.3427703742157;646.8576913079115;659.8449364399362;7812.218778122256;7999.720009799629;8143.714969976022;8152.755417337489;8392.874106888401;626.101544283954;628.8616504369031;634.8127302445789;636.7612145445459;642.2646070249538;3794.7912864792147;3845.769253844778;3899.239648268617;3984.442178095069;4012.057166565855;56508;57354.7132264336;57705.71147144237;58116;58152.12771808426;53225;53399.466005340226;53504.464955350726;54533;54711.45288547064;44048;45292;48877.51122488801;49411.258831117564;50029.49970500321;8654.740357789276;8674;8783.153801900262;8953.820923581623;9217.354785164975;32026.19934501563;32363;32707.34585308233;32833.671663283065;33616.15959601029;39181.2163756729;40475.19049618932;41144.79427602843;41720.582794172886;42766;10761.354318740901;10998.470351818967;11117.166212534254;11142.498587563741;11479.885201148216;12077.637670869888;12113.394330283627;12288.81566776517;12450;12481.313527756061;10873.238873279111;11592.536298547964;11804.881951180378;11911.285322880654;11966.341851198267;11392.25950313227;11488.48301826403;11590.826137607773;11602;11946.402679865798;10373.533191006574;10703.464826758474;10776.29954052984;10878.510467028844;10980.725481863017;9745.269104817025;9761.07269809367;9866.802663946824;9913.55389007482;9995.20038396941;9666.661666841626;9669.70990870275;9691.757706057122;10077.44574048405;10122.342047766871 09:34:00 INFO - PROCESS | 3404 | __end_tp_report 09:34:00 INFO - PROCESS | 3404 | __start_cc_report 09:34:00 INFO - PROCESS | 3404 | _x_x_mozilla_cycle_collect,389 09:34:00 INFO - PROCESS | 3404 | __end_cc_report 09:34:00 INFO - PROCESS | 3404 | __startTimestamp1463675640090__endTimestamp 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - PROCESS | 3404 | ------- Summary: start ------- 09:34:00 INFO - PROCESS | 3404 | Number of tests: 6 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - PROCESS | 3404 | [#0] dojo.html Cycles:165 Average:4729.00 Median:4869.68 stddev:626.29 (12.9%) stddev-sans-first:607.12 09:34:00 INFO - PROCESS | 3404 | Values: 2674.4 2706.6 2710.3 2713.6 2729.6 4681.6 4695.2 4734.4 4822.1 4854.7 4671.0 4714.0 4725.3 4779.1 4817.0 4264.4 4328.7 4442.1 4450.9 4455.7 35.0 4312.1 4351.7 4386.2 4477.8 4342.4 4363.5 4405.8 4418.8 4424.2 4404.3 4443.0 4445.1 4468.8 4498.8 4348.7 4373.5 4390.6 4419.4 4436.1 4722.7 4723.4 4730.5 4748.0 4765.0 4947.3 5092.9 5149.9 5185.9 5252.1 5055.6 5123.3 5125.7 5126.1 5172.8 4785.3 4825.8 4895.5 4902.4 4929.5 5264.1 5344.6 5363.4 5365.5 5377.1 5090.6 5108.3 5111.1 5136.7 5189.8 5200.9 5209.2 5214.5 5226.5 5258.6 4962.8 5066.8 5121.4 5140.7 5146.3 5087.2 5103.7 5112.7 5119.5 5137.2 4323.1 4330.1 4330.2 4373.0 4401.4 3728.6 3736.7 3763.9 3782.8 3806.7 4413.4 4496.4 4514.8 4516.9 4535.6 5216.7 5218.5 5219.2 5236.4 5286.3 4374.6 4422.1 4424.6 4533.2 4606.6 4557.3 4579.4 4585.2 4597.7 4599.1 4859.7 4864.0 4868.6 4871.9 4893.2 5173.2 5177.6 5182.8 5183.5 5185.9 4770.9 4837.7 4866.0 4875.8 4894.3 5125.8 5132.8 5140.6 5142.2 5145.3 5144.6 5193.5 5194.0 5205.7 5206.0 4823.3 4860.8 4927.9 4935.2 4937.0 4959.4 4984.3 5002.0 5008.9 5029.7 4759.9 4863.9 4869.7 4888.9 4952.0 5037.1 5039.6 5073.1 5098.1 5102.9 4980.3 4993.9 4998.5 5003.8 5073.2 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - PROCESS | 3404 | [#1] ext.html Cycles:180 Average:48526.92 Median:36169.82 stddev:93418.10 (258.3%) stddev-sans-first:93610.83 09:34:00 INFO - PROCESS | 3404 | Values: 590.7 591.7 608.9 633.5 643.2 33865.0 34543.7 37088.4 37123.3 37318.8 38516.2 39169.0 39218.8 39231.0 39395.8 7734.7 7875.3 7909.0 7917.2 7940.0 7736.3 7799.3 7801.7 7827.9 7836.0 7792.7 7838.6 7896.2 7900.3 7907.2 7667.6 7771.6 7835.2 7880.5 7889.8 7741.1 7879.6 7880.5 7895.8 7917.0 35596.3 36278.6 36399.6 36449.6 36634.0 2594.5 3106.6 3381.2 3595.0 3930.3 28858.9 29139.4 29174.0 29381.3 29516.7 3232.9 3260.5 3315.3 3316.2 3390.0 250584.0 251104.0 251899.0 251963.0 252733.7 33169.7 33644.3 33670.0 33844.2 34287.8 35916.3 35993.5 36083.8 36148.0 36191.6 13753.7 13794.7 13918.8 13934.9 13950.5 11183.1 11336.0 11372.4 11406.4 11414.4 8169.8 8297.0 8299.6 8346.4 8377.0 3168.2 3226.1 3237.1 3243.9 3286.7 948.6 975.3 979.8 987.9 1051.5 28656.0 29311.9 29372.3 29510.3 29626.0 998.7 1043.0 1097.2 1107.8 1162.9 15403.8 15461.7 15602.2 15823.3 15879.6 438527.0 439666.0 439985.0 444283.0 444798.0 51488.7 51953.7 52019.0 52061.2 52108.0 1255.4 1282.3 1284.5 1289.7 1294.1 27358.7 28941.7 28987.3 29114.9 29419.6 43524.3 44087.8 44175.3 44279.3 44289.0 337870.0 338828.0 338983.0 340176.0 341091.0 25902.7 26685.9 26770.5 26787.5 26832.5 44152.0 44356.6 44643.8 45486.3 45554.5 37529.0 38161.8 38402.2 38455.5 38593.8 37096.6 38420.6 38741.0 38746.0 38987.6 37227.1 37984.2 38839.8 38985.4 41534.2 31544.0 34887.0 34913.8 35034.0 35308.6 26395.0 26472.9 26604.2 26620.3 26657.7 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - PROCESS | 3404 | [#2] jquery.html Cycles:180 Average:24800.40 Median:396392.00 stddev:65154.96 (16.4%) stddev-sans-first:65311.94 09:34:00 INFO - PROCESS | 3404 | Values: 377.4 383.2 389.1 393.4 395.4 16110.4 17210.0 17699.9 17716.2 17741.3 17504.4 17743.2 18131.8 18193.9 18298.1 5161.3 5333.3 5361.9 5390.1 5394.4 3696.4 5794.7 6091.7 6096.0 6190.4 5870.2 6113.9 6136.0 6136.5 6142.4 5982.2 6033.0 6041.1 6054.1 6073.1 5204.4 5277.3 5298.9 5429.5 5455.3 21267.1 21590.6 21765.2 21803.1 21804.3 1873.5 2009.8 2010.6 2111.4 2145.9 12008.6 12032.9 13681.9 13722.9 13998.9 1796.2 1843.8 2022.1 2028.5 2043.7 70645.6 72651.6 74423.6 74669.6 76240.6 10185.8 10360.8 10419.4 10457.8 10617.0 14408.7 14513.2 14576.0 14596.1 14622.3 7446.3 7566.3 7588.6 7624.8 7636.2 7176.4 7190.2 7223.2 7286.7 7305.0 4502.6 4528.8 4542.9 4586.0 4603.7 1602.3 1701.3 1706.3 1714.2 1752.7 872.4 882.0 935.6 973.0 975.5 16797.6 16876.8 17364.2 17608.6 17697.4 908.7 912.2 917.3 934.7 939.2 9515.2 9826.1 9865.6 9954.3 9988.6 389928.0 394728.0 395347.0 395522.0 397262.0 46745.5 82535.0 82990.2 83448.0 84237.6 948.6 953.9 968.0 974.4 977.4 15379.2 15412.3 15580.4 15591.8 15725.3 35249.3 36158.6 36287.8 36609.1 37081.0 48239.5 48755.3 50379.7 50932.5 51134.0 7773.9 7979.4 8118.0 8173.0 8227.6 10909.9 11575.1 11690.8 11871.4 12224.9 9769.8 10238.3 10285.8 10290.8 10497.5 9687.9 9925.5 10057.2 10226.2 10249.9 10154.2 10486.0 10550.6 10730.9 10742.9 7563.5 7591.2 7669.9 7726.0 7762.2 8731.3 10182.9 10365.9 10391.8 10543.5 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - PROCESS | 3404 | [#3] mootools.html Cycles:180 Average:5369.95 Median:4957.22 stddev:2958.69 (59.7%) stddev-sans-first:2952.88 09:34:00 INFO - PROCESS | 3404 | Values: 1525.5 1554.6 1713.1 1834.8 1858.6 7002.9 7779.8 7850.2 8356.0 8382.3 7872.2 8204.1 8244.3 8294.1 8332.9 2304.9 2337.4 2343.6 2355.6 2358.4 2286.8 2293.9 2337.9 2344.5 2351.4 2317.6 2320.6 2331.0 2351.9 2353.3 2225.6 2244.5 2256.3 2258.5 2267.1 2243.8 2286.5 2298.5 2321.5 2325.3 8095.3 8114.6 8154.7 8156.4 8193.8 4764.3 4881.1 4881.4 4881.5 4888.3 3000.6 3016.3 3201.2 3216.0 3247.7 1002.0 1002.5 1018.5 1023.6 1033.4 10862.9 10919.2 10960.1 10974.6 10996.5 4363.6 4440.2 4475.8 4581.3 4588.7 9208.4 9216.1 9272.5 9283.2 9291.9 4815.3 4861.4 4862.8 4866.5 4876.1 3810.8 4251.2 4382.5 4387.5 4393.3 3850.2 3893.7 3970.4 4011.4 4016.8 1275.6 1300.6 1306.2 1311.5 1317.2 804.0 858.2 880.9 893.3 943.2 5706.0 5717.0 5748.5 5823.2 5947.7 452.5 452.7 454.5 460.1 473.7 3832.5 3857.7 3882.9 3907.5 3937.5 9629.1 9893.5 10089.9 10108.2 10108.9 9927.7 9945.8 9973.7 9979.9 10008.4 7330.5 7600.7 7657.8 7660.9 7745.0 5618.9 5639.9 5742.5 5750.9 5810.8 8841.4 9165.5 9203.7 9320.0 9387.6 9353.7 9374.7 9475.3 9544.9 9566.2 6308.5 6743.6 6791.8 7089.1 7094.4 7529.4 7572.2 7586.2 7626.0 7628.8 6968.0 6986.5 7032.4 7092.6 7273.7 6894.6 6955.1 6956.6 7034.0 7053.5 6397.1 6424.9 6498.5 6521.9 6542.7 4969.2 4999.8 5007.1 5044.3 5052.7 4942.7 4945.3 4998.3 5022.2 5025.8 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - PROCESS | 3404 | [#4] prototype.html Cycles:180 Average:4379.10 Median:4990.19 stddev:1253.81 (25.1%) stddev-sans-first:1219.77 09:34:00 INFO - PROCESS | 3404 | Values: 321.0 324.1 326.0 330.3 332.2 4962.8 5008.3 5067.4 5069.9 5087.2 4923.5 4936.3 4950.9 4984.0 4996.4 3702.9 3827.5 3904.6 3908.9 3914.9 3928.8 3936.8 3937.4 3952.2 3963.6 3850.1 3867.0 3867.7 3879.2 3881.1 3792.3 3856.0 3870.7 3936.9 3953.3 3464.3 3487.8 3490.6 3498.8 3503.8 4787.1 4800.3 4801.8 4809.7 4849.3 4465.4 4564.2 4580.1 4585.9 4586.0 5238.7 5244.2 5263.6 5268.4 5278.7 3823.3 3862.6 3872.0 3875.6 3878.6 5263.5 5407.2 5422.3 5422.9 5427.3 3932.9 3947.7 3963.0 3966.3 3973.9 4010.6 4014.7 4039.9 4046.6 4054.3 4463.8 4484.7 4521.0 4536.9 4552.2 5109.4 5215.7 5229.0 5252.5 5257.3 1372.7 1383.5 1387.8 1394.8 1397.9 848.1 881.2 888.8 893.9 898.2 4573.5 4574.3 4590.2 4593.4 4598.6 5414.1 5423.3 5435.1 5435.7 5485.8 4423.0 4608.4 4662.0 4671.0 4689.3 2850.4 2858.8 2887.1 2888.7 2898.6 5015.9 5095.7 5119.0 5133.9 5166.6 5414.4 5480.7 5522.9 5547.3 5591.9 5056.4 5060.5 5067.6 5095.9 5128.4 5386.9 5401.9 5416.2 5421.6 5457.5 5105.8 5235.9 5258.2 5260.2 5287.6 5036.9 5049.2 5069.5 5076.6 5096.3 4006.8 4007.1 4008.1 4014.3 4016.6 5226.7 5436.5 5437.2 5456.3 5475.9 5244.0 5250.7 5277.5 5278.7 5298.8 5251.0 5252.8 5272.3 5296.2 5302.8 4940.3 5138.5 5190.6 5196.4 5225.3 5003.1 5167.7 5271.8 5272.8 5290.7 5156.9 5191.7 5214.0 5214.6 5239.8 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - PROCESS | 3404 | [#5] yui.html Cycles:180 Average:13648.43 Median:42243.29 stddev:15924.67 (37.7%) stddev-sans-first:15939.50 09:34:00 INFO - PROCESS | 3404 | Values: 664.7 721.1 807.6 813.1 816.8 11403.4 11464.8 11647.1 12824.6 13383.4 12008.0 12146.8 12473.7 12729.6 12775.0 680.8 848.4 851.2 862.8 868.4 862.3 873.4 875.0 876.3 877.6 902.4 903.2 904.8 904.9 906.9 890.4 894.3 895.1 900.9 901.1 653.6 658.0 659.3 660.9 661.4 12238.5 12285.6 12357.8 12374.4 12408.2 12620.2 12817.7 12900.7 13069.8 13290.5 10493.7 10574.6 10605.8 10711.4 10775.3 3390.8 3460.4 3460.7 3484.7 3489.6 43884.0 45032.3 49651.0 49705.3 49815.0 10397.9 10455.8 10457.4 10477.9 10560.5 17680.9 17915.8 17936.6 17964.8 17971.6 7086.7 7154.6 7183.4 7203.3 7205.4 3873.1 3891.0 3961.7 3979.7 3984.3 2868.6 2939.3 2943.6 2954.4 2960.8 523.9 529.6 533.8 537.4 539.4 619.3 629.1 644.3 646.9 659.8 7812.2 7999.7 8143.7 8152.8 8392.9 626.1 628.9 634.8 636.8 642.3 3794.8 3845.8 3899.2 3984.4 4012.1 56508.0 57354.7 57705.7 58116.0 58152.1 53225.0 53399.5 53504.5 54533.0 54711.5 44048.0 45292.0 48877.5 49411.3 50029.5 8654.7 8674.0 8783.2 8953.8 9217.4 32026.2 32363.0 32707.3 32833.7 33616.2 39181.2 40475.2 41144.8 41720.6 42766.0 10761.4 10998.5 11117.2 11142.5 11479.9 12077.6 12113.4 12288.8 12450.0 12481.3 10873.2 11592.5 11804.9 11911.3 11966.3 11392.3 11488.5 11590.8 11602.0 11946.4 10373.5 10703.5 10776.3 10878.5 10980.7 9745.3 9761.1 9866.8 9913.6 9995.2 9666.7 9669.7 9691.8 10077.4 10122.3 09:34:00 INFO - PROCESS | 3404 | -------- Summary: end -------- 09:34:00 INFO - PROCESS | 3404 | 09:34:00 INFO - TEST-INFO | 3404: exit 0 09:34:00 INFO - TEST-OK | dromaeo_css | took 1115834ms 09:34:00 INFO - TEST-START | kraken 09:34:00 INFO - operating with platform_type : linux_ 09:34:00 INFO - Initialising browser for kraken test... 09:34:00 INFO - TEST-INFO | started process 3640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1VBXGi/profile http://localhost:53543/getInfo.html) 09:34:04 INFO - PROCESS | 3640 | 09:34:04 INFO - PROCESS | 3640 | (process:3708): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:34:05 INFO - PROCESS | 3640 | __metrics Screen width/height:1600/1200 09:34:05 INFO - PROCESS | 3640 | colorDepth:24 09:34:05 INFO - PROCESS | 3640 | Browser inner width/height: 1024/697 09:34:05 INFO - PROCESS | 3640 | __metrics 09:34:05 ERROR - PROCESS | 3640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:34:06 INFO - TEST-INFO | 3640: exit 0 09:34:06 INFO - Browser initialized. 09:34:06 INFO - Running cycle 1/1 for kraken test... 09:34:06 INFO - TEST-INFO | started process 3759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1VBXGi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:08 INFO - PROCESS | 3759 | 09:34:08 INFO - PROCESS | 3759 | (process:3819): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:34:18 INFO - PROCESS | 3759 | RSS: Main: 164708352 09:34:18 INFO - PROCESS | 3759 | 09:34:21 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53543/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:22 INFO - PROCESS | 3759 | RSS: Main: 168198144 09:34:22 INFO - PROCESS | 3759 | 09:34:25 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53543/tests/kraken/driver.html?testName=audio-dft) 09:34:25 INFO - PROCESS | 3759 | RSS: Main: 168022016 09:34:25 INFO - PROCESS | 3759 | 09:34:28 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53543/tests/kraken/driver.html?testName=audio-fft) 09:34:29 INFO - PROCESS | 3759 | RSS: Main: 164610048 09:34:29 INFO - PROCESS | 3759 | 09:34:31 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53543/tests/kraken/driver.html?testName=audio-oscillator) 09:34:32 INFO - PROCESS | 3759 | RSS: Main: 164974592 09:34:32 INFO - PROCESS | 3759 | 09:34:34 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53543/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:35 INFO - PROCESS | 3759 | RSS: Main: 165101568 09:34:35 INFO - PROCESS | 3759 | 09:34:38 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53543/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:39 INFO - PROCESS | 3759 | RSS: Main: 165060608 09:34:39 INFO - PROCESS | 3759 | 09:34:42 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53543/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:43 INFO - PROCESS | 3759 | RSS: Main: 162992128 09:34:43 INFO - PROCESS | 3759 | 09:34:46 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53543/tests/kraken/driver.html?testName=json-parse-financial) 09:34:47 INFO - PROCESS | 3759 | RSS: Main: 163725312 09:34:47 INFO - PROCESS | 3759 | 09:34:48 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53543/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:49 INFO - PROCESS | 3759 | RSS: Main: 164347904 09:34:49 INFO - PROCESS | 3759 | 09:34:51 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:52 INFO - PROCESS | 3759 | RSS: Main: 164237312 09:34:52 INFO - PROCESS | 3759 | 09:34:54 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:55 INFO - PROCESS | 3759 | RSS: Main: 164884480 09:34:55 INFO - PROCESS | 3759 | 09:34:57 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:58 INFO - PROCESS | 3759 | RSS: Main: 164474880 09:34:58 INFO - PROCESS | 3759 | 09:35:01 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:02 INFO - PROCESS | 3759 | RSS: Main: 164577280 09:35:02 INFO - PROCESS | 3759 | 09:35:03 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53543/tests/kraken/driver.html?testName=ai-astar) 09:35:04 INFO - PROCESS | 3759 | RSS: Main: 167325696 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | __start_tp_report 09:35:04 INFO - PROCESS | 3759 | _x_x_mozilla_page_load 09:35:04 INFO - PROCESS | 3759 | _x_x_mozilla_page_load_details 09:35:04 INFO - PROCESS | 3759 | |i|pagename|runs| 09:35:04 INFO - PROCESS | 3759 | |0;ai-astar;111;116;108;115;113;114;108;114;113;114 09:35:04 INFO - PROCESS | 3759 | |1;audio-beat-detection;154;130;164;227;129;154;150;135;177;142 09:35:04 INFO - PROCESS | 3759 | |2;audio-dft;163;165;164;167;161;164;162;162;161;163 09:35:04 INFO - PROCESS | 3759 | |3;audio-fft;76;77;75;170;77;74;77;75;169;76 09:35:04 INFO - PROCESS | 3759 | |4;audio-oscillator;94;94;183;93;93;93;140;94;94;148 09:35:04 INFO - PROCESS | 3759 | |5;imaging-gaussian-blur;120;120;122;118;121;122;122;123;122;122 09:35:04 INFO - PROCESS | 3759 | |6;imaging-darkroom;147;148;146;150;147;149;147;147;147;146 09:35:04 INFO - PROCESS | 3759 | |7;imaging-desaturate;95;96;96;95;95;95;96;95;96;95 09:35:04 INFO - PROCESS | 3759 | |8;json-parse-financial;63;65;64;64;63;63;66;64;64;64 09:35:04 INFO - PROCESS | 3759 | |9;json-stringify-tinderbox;64;69;65;65;65;65;65;65;65;65 09:35:04 INFO - PROCESS | 3759 | |10;stanford-crypto-aes;86;82;82;85;82;89;86;83;143;83 09:35:04 INFO - PROCESS | 3759 | |11;stanford-crypto-ccm;130;135;130;130;138;129;137;144;154;131 09:35:04 INFO - PROCESS | 3759 | |12;stanford-crypto-pbkdf2;175;170;178;172;174;169;170;172;170;170 09:35:04 INFO - PROCESS | 3759 | |13;stanford-crypto-sha256-iterative;67;68;67;68;65;68;65;68;67;69 09:35:04 INFO - PROCESS | 3759 | __end_tp_report 09:35:04 INFO - PROCESS | 3759 | __start_cc_report 09:35:04 INFO - PROCESS | 3759 | _x_x_mozilla_cycle_collect,939 09:35:04 INFO - PROCESS | 3759 | __end_cc_report 09:35:04 INFO - PROCESS | 3759 | __startTimestamp1463675704121__endTimestamp 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | ------- Summary: start ------- 09:35:04 INFO - PROCESS | 3759 | Number of tests: 14 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:2.76 (2.4%) stddev-sans-first:2.86 09:35:04 INFO - PROCESS | 3759 | Values: 111.0 116.0 108.0 115.0 113.0 114.0 108.0 114.0 113.0 114.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:154.00 stddev:29.12 (18.9%) stddev-sans-first:30.88 09:35:04 INFO - PROCESS | 3759 | Values: 154.0 130.0 164.0 227.0 129.0 154.0 150.0 135.0 177.0 142.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.87 (1.1%) stddev-sans-first:1.99 09:35:04 INFO - PROCESS | 3759 | Values: 163.0 165.0 164.0 167.0 161.0 164.0 162.0 162.0 161.0 163.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.49 (52.0%) stddev-sans-first:41.31 09:35:04 INFO - PROCESS | 3759 | Values: 76.0 77.0 75.0 170.0 77.0 74.0 77.0 75.0 169.0 76.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#4] audio-oscillator Cycles:10 Average:112.60 Median:93.50 stddev:32.48 (34.7%) stddev-sans-first:33.75 09:35:04 INFO - PROCESS | 3759 | Values: 94.0 94.0 183.0 93.0 93.0 93.0 140.0 94.0 94.0 148.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#5] imaging-gaussian-blur Cycles:10 Average:121.20 Median:122.00 stddev:1.48 (1.2%) stddev-sans-first:1.50 09:35:04 INFO - PROCESS | 3759 | Values: 120.0 120.0 122.0 118.0 121.0 122.0 122.0 123.0 122.0 122.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.26 (0.9%) stddev-sans-first:1.33 09:35:04 INFO - PROCESS | 3759 | Values: 147.0 148.0 146.0 150.0 147.0 149.0 147.0 147.0 147.0 146.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:35:04 INFO - PROCESS | 3759 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 09:35:04 INFO - PROCESS | 3759 | Values: 63.0 65.0 64.0 64.0 63.0 63.0 66.0 64.0 64.0 64.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.34 (2.1%) stddev-sans-first:1.33 09:35:04 INFO - PROCESS | 3759 | Values: 64.0 69.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:84.00 stddev:18.73 (22.3%) stddev-sans-first:19.81 09:35:04 INFO - PROCESS | 3759 | Values: 86.0 82.0 82.0 85.0 82.0 89.0 86.0 83.0 143.0 83.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:136.00 stddev:8.00 (5.9%) stddev-sans-first:8.20 09:35:04 INFO - PROCESS | 3759 | Values: 130.0 135.0 130.0 130.0 138.0 129.0 137.0 144.0 154.0 131.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:2.87 (1.7%) stddev-sans-first:2.83 09:35:04 INFO - PROCESS | 3759 | Values: 175.0 170.0 178.0 172.0 174.0 169.0 170.0 172.0 170.0 170.0 09:35:04 INFO - PROCESS | 3759 | 09:35:04 INFO - PROCESS | 3759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.32 (1.9%) stddev-sans-first:1.39 09:35:04 INFO - PROCESS | 3759 | Values: 67.0 68.0 67.0 68.0 65.0 68.0 65.0 68.0 67.0 69.0 09:35:04 INFO - PROCESS | 3759 | -------- Summary: end -------- 09:35:04 INFO - PROCESS | 3759 | 09:35:05 INFO - TEST-INFO | 3759: exit 0 09:35:05 INFO - TEST-OK | kraken | took 64254ms 09:35:05 INFO - SUITE-END | took 1180s 09:35:05 INFO - Completed test suite (00:19:40) 09:35:05 INFO - javascript benchmark 09:35:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6453.85731547849, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.3581540430296, 2706.580480025596, 2710.3359676879154, 2713.5658294672858, 2729.604207389927, 4681.555252251035, 4695.178343789836, 4734.408198975124, 4822.132016237076, 4854.660173787836, 4671.042436300559, 4714.0, 4725.291206319054, 4779.139754844126, 4816.951830481694, 4264.360345948109, 4328.653707703376, 4442.06716589515, 4450.933236001462, 4455.665825063117, 34.971541207041824, 4312.1375724855, 4351.673624478177, 4386.188555117297, 4477.7984990675495, 4342.435483387139, 4363.498197707257, 4405.845795397146, 4418.8453404130705, 4424.203643344197, 4404.339349097629, 4443.044745379759, 4445.1331990261915, 4468.798904049326, 4498.842540511099, 4348.7390756554705, 4373.497047839475, 4390.604845563883, 4419.4254746883025, 4436.112777444492, 4722.693024953402, 4723.385959825235, 4730.526947305277, 4747.976260118678, 4765.023170250125, 4947.257911313296, 5092.898142037138, 5149.948500515022, 5185.896282074375, 5252.133397989327, 5055.646104772667, 5123.333966584358, 5125.692458452505, 5126.102931986888, 5172.767225474862, 4785.3300537924715, 4825.782839772219, 4895.461499235045, 4902.4362198346935, 4929.482404347564, 5264.078786212397, 5344.572434205332, 5363.436839131913, 5365.54392876602, 5377.059014672495, 5090.592752579785, 5108.259302401131, 5111.131107711698, 5136.717480538607, 5189.766460509286, 5200.869978250498, 5209.192575150858, 5214.530692237717, 5226.45122262157, 5258.553022993012, 4962.826301079445, 5066.847994560096, 5121.411037730634, 5140.665856719302, 5146.30524879144, 5087.186050232019, 5103.7192954387865, 5112.71880046601, 5119.48805119485, 5137.17805151174, 4323.113761678848, 4330.0906809569715, 4330.220560299176, 4373.016071383913, 4401.405810215644, 3728.5712143103347, 3736.663700266989, 3763.9247215056093, 3782.8108594570162, 3806.695464362844, 4413.426254586883, 4496.39298694672, 4514.774261286988, 4516.864494065183, 4535.569120933506, 5216.686998780086, 5218.504242096995, 5219.217117432416, 5236.3716354037, 5286.3392075990505, 4374.5625437456, 4422.115576884636, 4424.557544245614, 4533.22935101027, 4606.585407313358, 4557.270836666184, 4579.404677391918, 4585.1746685596245, 4597.7241365518175, 4599.126166028444, 4859.684120532295, 4864.027194561102, 4868.586170175504, 4871.878203044952, 4893.21708526634, 5173.198154286091, 5177.585793136464, 5182.844514664566, 5183.455737147545, 5185.896282074262, 4770.928436073392, 4837.685550439211, 4866.026794641157, 4875.756212189447, 4894.290327902506, 5125.846224613268, 5132.769025393792, 5140.588752899834, 5142.151544995184, 5145.253938179018, 5144.588432925432, 5193.480651934928, 5193.974030129825, 5205.73971301441, 5205.973970130125, 4823.324734537097, 4860.781264843161, 4927.901441971068, 4935.185694360391, 4936.963237720119, 4959.380077490314, 4984.252362145708, 5002.049610573979, 5008.873003574166, 5029.723365214802, 4759.9286010709175, 4863.905621235193, 4869.683470574543, 4888.877778055577, 4952.034353301072, 5037.0681423936685, 5039.5968322534845, 5073.086844368049, 5098.056859481007, 5102.948970510248, 4980.277859710394, 4993.850184494471, 4998.500149984972, 5003.824866129668, 5073.188289873602], "value": 4691.137617687428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6987436407434, 591.7307625030611, 608.8782243551291, 633.4868756307392, 643.1735220241984, 33865.0, 34543.65456345439, 37088.44367334492, 37123.25753484932, 37318.813405933, 38516.229675406474, 39169.0, 39218.8039059805, 39231.0, 39395.803020984924, 7734.651940662669, 7875.291223789858, 7909.0113735783025, 7917.168697286788, 7940.047194336659, 7736.2650548197835, 7799.259070388304, 7801.687932482694, 7827.921720782805, 7836.0, 7792.727254546092, 7838.568878711669, 7896.210378962115, 7900.288973992339, 7907.209279072104, 7667.5782831944225, 7771.611419429034, 7835.177306382861, 7880.487768295043, 7889.8027549311155, 7741.148473667892, 7879.566623835687, 7880.527168369917, 7895.8026049348655, 7917.0, 35596.288074238626, 36278.637213628055, 36399.63600363989, 36449.63550364516, 36634.0, 2594.520013797435, 3106.5806116174253, 3381.1547113221695, 3595.0, 3930.2728995135703, 28858.855705721548, 29139.41721165586, 29174.0, 29381.26546836346, 29516.70483295161, 3232.8545215465124, 3260.4783234682336, 3315.270640459095, 3316.1709572606846, 3389.9661003389897, 250584.0, 251104.0, 251899.0, 251962.99999999817, 252733.736331319, 33169.66830331714, 33644.32711345809, 33670.0, 33844.153896152304, 34287.82856085704, 35916.281674366364, 35993.46009809855, 36083.81958090193, 36148.0, 36191.63808361936, 13753.656158596115, 13794.65513362174, 13918.791218131533, 13934.930325348309, 13950.511732089328, 11183.105351571854, 11336.036436902956, 11372.43137843121, 11406.42967851604, 11414.42927853604, 8169.754907352789, 8296.958515207385, 8299.585020748938, 8346.374021948379, 8377.0, 3168.2298065302216, 3226.1128189748006, 3237.1259759864706, 3243.8864639737494, 3286.6549012353357, 948.6252930092575, 975.302658599105, 979.7599588100818, 987.9061489158519, 1051.5373235776235, 28656.0, 29311.85344073266, 29372.265693357836, 29510.262243443656, 29626.0, 998.7453199434098, 1043.0456132638703, 1097.2209731090854, 1107.8005958927308, 1162.9418529073512, 15403.821858804264, 15461.690766184613, 15602.219889005504, 15823.287952042187, 15879.603009924844, 438527.0, 439666.0, 439985.0, 444283.0, 444798.0, 51488.742556286976, 51953.7402312986, 52019.0, 52061.2190817138, 52108.0, 1255.416231452379, 1282.2626989481087, 1284.4990453723055, 1289.6517940156104, 1294.1199984010775, 27358.674512666646, 28941.710582893902, 28987.275318117216, 29114.854425727735, 29419.558706619846, 43524.347134793636, 44087.77956110327, 44175.33736994012, 44279.33580996352, 44289.0, 337870.0, 338828.0, 338983.0, 340176.0, 341091.0, 25902.740972590786, 26685.86657066702, 26770.46459070769, 26787.464250715268, 26832.463350733266, 44152.0, 44356.556434435246, 44643.77678111719, 45486.317705233785, 45554.54445455503, 37529.0, 38161.80919095387, 38402.2319553613, 38455.5003924744, 38593.807030964665, 37096.6290337104, 38420.61579384282, 38741.0, 38746.0, 38987.61012389953, 37227.06932326713, 37984.24031519299, 38839.80580097081, 38985.41521877117, 41534.169316614105, 31544.0, 34886.98875867009, 34913.82543087268, 35034.0, 35308.64691353054, 26395.0, 26472.8676356617, 26604.201873943814, 26620.334491637863, 26657.733422665526], "value": 16865.500647392964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.4432711750169, 383.22205921978383, 389.09147141424774, 393.39220903703773, 395.3634648216373, 16110.35558577657, 17210.0, 17699.91150044251, 17716.20277087531, 17741.290348386083, 17504.387346442876, 17743.201555929983, 18131.818681813176, 18193.909030454863, 18298.085095745228, 5161.329027226465, 5333.333333333333, 5361.892762144755, 5390.0836857734275, 5394.406615272336, 3696.4270538066507, 5794.68129252891, 6091.725872335755, 6095.969520152393, 6190.41191086846, 5870.207521984542, 6113.877722445548, 6135.987562052256, 6136.539759518032, 6142.385761423844, 5982.162497250389, 6032.969835150796, 6041.093835924625, 6054.122152287893, 6073.1497590337385, 5204.401493828221, 5277.287566178555, 5298.867528311785, 5429.4570542945785, 5455.263539422167, 21267.14931402742, 21590.568188636298, 21765.23821666234, 21803.127874884987, 21804.34586962378, 1873.49415657773, 2009.8392128629675, 2010.6079314533672, 2111.3771437425994, 2145.8819764912923, 12008.63974080779, 12032.879671203264, 13681.931590342085, 13722.931385343009, 13998.860011399858, 1796.2276221224868, 1843.7879643840995, 2022.1203776357331, 2028.503016760903, 2043.7343145391003, 70645.64677176633, 72651.63674181649, 74423.62788186024, 74669.62665186639, 76240.61879690622, 10185.796284074277, 10360.844587331196, 10419.426931518688, 10457.84313235302, 10616.991385818335, 14408.711825763636, 14513.201773902325, 14576.0, 14596.12423254608, 14622.341994610268, 7446.329830315298, 7566.31903128721, 7588.582627955405, 7624.847503049908, 7636.198199189116, 7176.354128128493, 7190.245024272481, 7223.241559636268, 7286.744963926237, 7304.96347518259, 4502.617277531381, 4528.796204170821, 4542.93241088344, 4585.977070114628, 4603.700759450625, 1602.3430393538592, 1701.3024659889386, 1706.3430579226838, 1714.1771949464328, 1752.684516786965, 872.4111224923151, 881.9559022049, 935.6397786851975, 973.0123924216925, 975.5268694683073, 16797.580060498585, 16876.831231687527, 17364.218610162574, 17608.647827043387, 17697.38059167923, 908.68650315641, 912.224609082288, 917.27535247154, 934.7102398256562, 939.2345238630494, 9515.23878089751, 9826.115649591427, 9865.605375785031, 9954.253430992705, 9988.60045598168, 389928.0, 394728.0, 395347.0, 395522.0, 397262.0, 46745.532544674796, 82535.0, 82990.17009829945, 83448.0, 84237.57881210555, 948.606328373731, 953.8712273842942, 968.041638777605, 974.3715303629119, 977.3500622086233, 15379.231038448257, 15412.306446210172, 15580.376784928476, 15591.844081559493, 15725.292361843516, 35249.295014100084, 36158.63841361658, 36287.81856090808, 36609.08477288089, 37081.0, 48239.5176048235, 48755.26867096926, 50379.74810125926, 50932.49067509278, 51134.0, 7773.883391749241, 7979.361651068017, 8117.985251843519, 8172.959135204286, 8227.629756660845, 10909.945450272699, 11575.073994080622, 11690.824637630612, 11871.406429678309, 12224.877751222373, 9769.84032174581, 10238.33450825694, 10285.845712314172, 10290.845637315597, 10497.47512624381, 9687.854682179914, 9925.503724813874, 10057.19542436618, 10226.181905447695, 10249.897501024894, 10154.238432117769, 10486.0, 10550.577976880839, 10730.94558438842, 10742.946285268523, 7563.508371955805, 7591.164971853203, 7669.923300766921, 7725.961370193113, 7762.184970578008, 8731.345149113715, 10182.949085254526, 10365.9481702591, 10391.792164156826, 10543.472826358498], "value": 8541.606763315083, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.5270866031535, 1554.6191183160126, 1713.143428285857, 1834.8165183481663, 1858.581819090704, 7002.929970700291, 7779.805504862381, 7850.175731548191, 8356.039055508625, 8382.329413646901, 7872.212778722125, 8204.138565450632, 8244.258016778489, 8294.087650358455, 8332.875006874901, 2304.9423764405897, 2337.392278007722, 2343.60158773009, 2355.611324131516, 2358.363241924679, 2286.8284878634167, 2293.9311820645407, 2337.8714170720605, 2344.4842134730334, 2351.447409858682, 2317.640765681322, 2320.628699408095, 2331.0326214620914, 2351.8588884666974, 2353.3175379140116, 2225.5993921094196, 2244.45010972312, 2256.334381357495, 2258.503129311549, 2267.0931627349028, 2243.8317126215597, 2286.5198308355266, 2298.471351589144, 2321.5356928614174, 2325.279163459316, 8095.271425571668, 8114.63484143215, 8154.714584989497, 8156.388270879707, 8193.8361232775, 4764.285357196413, 4881.1213981483315, 4881.365422495089, 4881.536254055859, 4888.340074089988, 3000.6249218847643, 3016.291171574678, 3201.2157021529874, 3215.9678403215903, 3247.6914693104354, 1001.9849702254472, 1002.5137808163108, 1018.5467466977198, 1023.6314926626409, 1033.4316126130673, 10862.891371086267, 10919.235653504258, 10960.068394186424, 10974.573305470318, 10996.450177491093, 4363.6072753452345, 4440.222960981815, 4475.820967161342, 4581.312803079565, 4588.724676519353, 9208.401453905475, 9216.124468175512, 9272.536373181449, 9283.164515193665, 9291.860622090675, 4815.3017812417, 4861.440934292602, 4862.78117484714, 4866.5376789205675, 4876.073546026244, 3810.809459527068, 4251.171021650748, 4382.474103107647, 4387.539308372575, 4393.29707246839, 3850.172212974224, 3893.7469064510715, 3970.4242884781543, 4011.438398624195, 4016.794961511593, 1275.6236910111538, 1300.6228193823874, 1306.2097431054265, 1311.5344052861287, 1317.1965101288206, 804.0231119190212, 858.2318824651902, 880.8634661627458, 893.3166127912152, 943.1982814607529, 5706.001449746278, 5717.0, 5748.511376532958, 5823.184754134425, 5947.672877991752, 452.5451920819555, 452.69443125889893, 454.4569239758457, 460.1257610539934, 473.74181071315525, 3832.463455116286, 3857.7106716996336, 3882.9029274267805, 3907.531096268466, 3937.547182074041, 9629.133377996013, 9893.505324733735, 10089.899101009043, 10108.191344692406, 10108.949455252676, 9927.652532161339, 9945.80108397828, 9973.650922217832, 9979.900200997898, 10008.39949603026, 7330.486865919334, 7600.733974310983, 7657.770266892002, 7660.923390766133, 7744.999999999887, 5618.85952851182, 5639.859003524781, 5742.454466825645, 5750.8849823002465, 5810.796622118206, 8841.425307355, 9165.450072995642, 9203.677871274473, 9320.0, 9387.624495020124, 9353.744046458709, 9374.67188648394, 9475.336726429085, 9544.85682714746, 9566.186874115778, 6308.495320374451, 6743.561668491532, 6791.830204244933, 7089.149302083783, 7094.432445404458, 7529.360004399688, 7572.20491848348, 7586.165521792488, 7626.0, 7628.8474230516185, 6967.965160174167, 6986.510944234058, 7032.367086962198, 7092.574445533284, 7273.745418910313, 6894.551854129466, 6955.130608673916, 6956.582605043714, 7034.0, 7053.470989675898, 6397.0724244983285, 6424.871502570016, 6498.545101842826, 6521.934780652133, 6542.738290468328, 4969.155243608523, 4999.825006124768, 5007.073691367109, 5044.268581055653, 5052.722100284373, 4942.654014218971, 4945.282933974626, 4998.2502624606595, 5022.246663000579, 5025.824096156617], "value": 4294.917646536437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.9935801283974, 324.0796138965339, 325.9975575106548, 330.32283818172726, 332.222599118064, 4962.8263010794535, 5008.273800298959, 5067.391912970439, 5069.873253168668, 5087.227461033732, 4923.5076492350745, 4936.346323981462, 4950.876228094299, 4983.975080124604, 4996.400431948171, 3702.8889133326043, 3827.4832897558754, 3904.5900180481067, 3908.9022774430723, 3914.921701565981, 3928.8428462861452, 3936.8425262989444, 3937.3897045957924, 3952.2095580883793, 3963.5640079591367, 3850.114473671057, 3866.9806650966707, 3867.690584753213, 3879.243547508223, 3881.10734531058, 3792.2984247914223, 3855.9614403855885, 3870.7096967727393, 3936.921261574781, 3953.2686453006, 3464.34177506273, 3487.755857089979, 3490.5636795400574, 3498.7900725956524, 3503.754737168399, 4787.13831510328, 4800.3279540864305, 4801.8079276828885, 4809.711417314972, 4849.2726091086615, 4465.419495465601, 4564.201264778683, 4580.07636792548, 4585.908281834378, 4585.977070114628, 5238.711870847102, 5244.187150991603, 5263.578913686896, 5268.446813084609, 5278.683279003272, 3823.3118038753014, 3862.594427585091, 3871.98656698518, 3875.5543112541854, 3878.553966293884, 5263.526282634582, 5407.242985981927, 5422.349318081816, 5422.91865622016, 5427.267318911936, 3932.9213415731524, 3947.7236593438756, 3962.980185099056, 3966.3058964681063, 3973.900652483653, 4010.598940106024, 4014.711614379834, 4039.8788036358956, 4046.615571520701, 4054.3107671695884, 4463.799129039201, 4484.690384451945, 4520.95479045212, 4536.8638940831825, 4552.226121559343, 5109.3613298337705, 5215.6609820361555, 5228.9738551307, 5252.527272545489, 5257.342832145981, 1372.7323171981368, 1383.522684673786, 1387.8473367929519, 1394.842280906845, 1397.9091359061629, 848.134902399549, 881.2157180109707, 888.7644774134859, 893.9362159030862, 898.2409863665192, 4573.451185857718, 4574.336721175411, 4590.173768721662, 4593.402857628487, 4598.632109431237, 5414.106672399089, 5423.322084739408, 5435.130379139318, 5435.701036442954, 5485.753141108659, 4422.977885110554, 4608.377868987711, 4661.95338046622, 4671.0, 4689.273162659793, 2850.372917958046, 2858.757005654543, 2887.133859842039, 2888.7400133988044, 2898.6086878271162, 5015.924761128586, 5095.694258344437, 5118.97440512795, 5133.948660513347, 5166.61250406221, 5414.431484694051, 5480.725963701799, 5522.91715624266, 5547.25112109868, 5591.8602034948635, 5056.443791182967, 5060.493950604984, 5067.619928505377, 5095.866042383981, 5128.358955130609, 5386.946130538645, 5401.86495337604, 5416.241726158262, 5421.566274698093, 5457.508824205841, 5105.795768169231, 5235.947640523546, 5258.211268309784, 5260.184671375943, 5287.642347109536, 5036.949630503648, 5049.242613607841, 5069.467705890976, 5076.593872490118, 5096.261042148942, 4006.8196931137586, 4007.0783719745205, 4008.118213992917, 4014.2774300625, 4016.55817860041, 5226.686398816083, 5436.510714035756, 5437.238786569963, 5456.317960254968, 5475.945240547543, 5244.003639308519, 5250.65870718402, 5277.472252774692, 5278.656887302313, 5298.788048478018, 5251.028559716465, 5252.763625636932, 5272.2882410874045, 5296.152615581488, 5302.814401495929, 4940.344984430112, 5138.537531622172, 5190.558802501679, 5196.350456192976, 5225.268462415189, 5003.124453220599, 5167.689938603696, 5271.841844744664, 5272.815451459181, 5290.68255904647, 5156.948430515647, 5191.714455704821, 5213.973930130325, 5214.556762675215, 5239.816606418757], "value": 3983.9598271389227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.7108507799107, 721.1274358026787, 807.5558442856432, 813.1258896686064, 816.7794695432234, 11403.3728144952, 11464.828027579571, 11647.068234541248, 12824.615261542145, 13383.397747101379, 12008.0, 12146.81779773302, 12473.68815779606, 12729.618111456648, 12775.041871859601, 680.8195828105556, 848.406115718996, 851.2041241439258, 862.7627402464341, 868.374770165483, 862.3316929379719, 873.4235404632943, 874.9868751968726, 876.2508055612456, 877.5656050255133, 902.3999040637968, 903.2142036428316, 904.7783293093202, 904.868794024866, 906.8503696890006, 890.3633901760272, 894.2667013049302, 895.122779675918, 900.8873890763655, 901.0853983207018, 653.627432363553, 658.0392626764929, 659.3176062775053, 660.9471242300605, 661.3551787007677, 12238.510459581606, 12285.57000504978, 12357.752844943141, 12374.443150058269, 12408.193467424679, 12620.242785432903, 12817.743645127139, 12900.677483062904, 13069.803952940618, 13290.468381264738, 10493.737656558571, 10574.577016919315, 10605.84091238632, 10711.357318560911, 10775.299605525615, 3390.8135052572097, 3460.377132116243, 3460.723142148622, 3484.703800176988, 3489.581250249986, 43884.0, 45032.3245151323, 49651.0, 49705.25442118371, 49815.0, 10397.948010260052, 10455.84316235257, 10457.42484163363, 10477.895221047693, 10560.52477638508, 17680.911595442198, 17915.820841791676, 17936.55158621019, 17964.820351796578, 17971.640567188584, 7086.681099350541, 7154.570725756367, 7183.389411899942, 7203.315685009916, 7205.423566114699, 3873.0898238913833, 3891.0273327988766, 3961.7226794124135, 3979.7015223858325, 3984.322665146932, 2868.612737280482, 2939.3092623233524, 2943.5878976943245, 2954.3648115654805, 2960.8223506589675, 523.8559396166008, 529.5895680847298, 533.751805410486, 537.4410612962554, 539.4201233673816, 619.2568917299259, 629.0532748213909, 644.3427703742157, 646.8576913079115, 659.8449364399362, 7812.218778122256, 7999.720009799629, 8143.714969976022, 8152.755417337489, 8392.874106888401, 626.101544283954, 628.8616504369031, 634.8127302445789, 636.7612145445459, 642.2646070249538, 3794.7912864792147, 3845.769253844778, 3899.239648268617, 3984.442178095069, 4012.057166565855, 56508.0, 57354.7132264336, 57705.71147144237, 58116.0, 58152.12771808426, 53225.0, 53399.466005340226, 53504.464955350726, 54533.0, 54711.45288547064, 44048.0, 45292.0, 48877.51122488801, 49411.258831117564, 50029.49970500321, 8654.740357789276, 8674.0, 8783.153801900262, 8953.820923581623, 9217.354785164975, 32026.19934501563, 32363.0, 32707.34585308233, 32833.671663283065, 33616.15959601029, 39181.2163756729, 40475.19049618932, 41144.79427602843, 41720.582794172886, 42766.0, 10761.354318740901, 10998.470351818967, 11117.166212534254, 11142.498587563741, 11479.885201148216, 12077.637670869888, 12113.394330283627, 12288.81566776517, 12450.0, 12481.313527756061, 10873.238873279111, 11592.536298547964, 11804.881951180378, 11911.285322880654, 11966.341851198267, 11392.25950313227, 11488.48301826403, 11590.826137607773, 11602.0, 11946.402679865798, 10373.533191006574, 10703.464826758474, 10776.29954052984, 10878.510467028844, 10980.725481863017, 9745.269104817025, 9761.07269809367, 9866.802663946824, 9913.55389007482, 9995.20038396941, 9666.661666841626, 9669.70990870275, 9691.757706057122, 10077.44574048405, 10122.342047766871], "value": 6248.623306330562, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 108.0, 115.0, 113.0, 114.0, 108.0, 114.0, 113.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 164.0, 227.0, 129.0, 154.0, 150.0, 135.0, 177.0, 142.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 167.0, 161.0, 164.0, 162.0, 162.0, 161.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 170.0, 77.0, 74.0, 77.0, 75.0, 169.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 183.0, 93.0, 93.0, 93.0, 140.0, 94.0, 94.0, 148.0], "value": 112.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 122.0, 118.0, 121.0, 122.0, 122.0, 123.0, 122.0, 122.0], "value": 121.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 150.0, 147.0, 149.0, 147.0, 147.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 63.0, 63.0, 66.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 82.0, 85.0, 82.0, 89.0, 86.0, 83.0, 143.0, 83.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 130.0, 130.0, 138.0, 129.0, 137.0, 144.0, 154.0, 131.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 178.0, 172.0, 174.0, 169.0, 170.0, 172.0, 170.0, 170.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 65.0, 68.0, 65.0, 68.0, 67.0, 69.0], "value": 67.2, "unit": "score"}]}]} 09:35:05 INFO - Return code: 0 09:35:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:35:05 ERROR - # TBPL SUCCESS # 09:35:05 INFO - Running post-action listener: _resource_record_post_action 09:35:05 INFO - ##### 09:35:05 INFO - ##### Finished run-tests step (success) 09:35:05 INFO - ##### 09:35:05 INFO - Running post-run listener: _resource_record_post_run 09:35:05 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7892992; Write bytes: 445440000; Read time: 1292; Write time: 439768 09:35:05 INFO - TinderboxPrint: CPU usage
13.4% 09:35:05 INFO - TinderboxPrint: I/O read bytes / time
7,892,992 / 1,292 09:35:05 INFO - TinderboxPrint: I/O write bytes / time
445,440,000 / 439,768 09:35:05 INFO - TinderboxPrint: CPU idle
8,267.7 (86.5%) 09:35:05 INFO - TinderboxPrint: CPU user
1,228.6 (12.9%) 09:35:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:35:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94380032; Read time: 0; Write time: 109184 09:35:05 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 6131712; Write bytes: 351059968; Read time: 1228; Write time: 330584 09:35:06 INFO - Running post-run listener: _upload_blobber_files 09:35:06 INFO - Blob upload gear active. 09:35:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:35:06 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 09:35:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:35:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:35:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:35:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:07 INFO - (blobuploader) - INFO - Done attempting. 09:35:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:35:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:11 INFO - (blobuploader) - INFO - Done attempting. 09:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:12 INFO - (blobuploader) - INFO - Done attempting. 09:35:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:12 INFO - Return code: 0 09:35:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:35:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb686006c10ba61a59e5542f4cbcf335c2c234524758eaf75f5e83598f5b89a843ad7e58cdf28087aae69f5bbbbc1b84eed206503e3be3a3c461378163f4546e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24022a1f3425abcdee1b970af79be72f40e4341e508942e1750cba1aae5281ec5557c9a1c88a084c54f04e0ea4c30f5985b526e42388045c87ffda0ab48b246f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02c046c0164a745d4a22cb29a03c1825dc2d9357d837a90d79dbb38fe0babffbb6483980a6b85dca82a8a19c9ad9df94947a619d44c0e0ea8f8decf1de4ddea0"} 09:35:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:35:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:35:12 INFO - Contents: 09:35:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb686006c10ba61a59e5542f4cbcf335c2c234524758eaf75f5e83598f5b89a843ad7e58cdf28087aae69f5bbbbc1b84eed206503e3be3a3c461378163f4546e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24022a1f3425abcdee1b970af79be72f40e4341e508942e1750cba1aae5281ec5557c9a1c88a084c54f04e0ea4c30f5985b526e42388045c87ffda0ab48b246f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02c046c0164a745d4a22cb29a03c1825dc2d9357d837a90d79dbb38fe0babffbb6483980a6b85dca82a8a19c9ad9df94947a619d44c0e0ea8f8decf1de4ddea0"} 09:35:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:12 INFO - Copying logs to upload dir... 09:35:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:35:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.734386 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-19 09:35:12.540958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 09:35:12.544945) ========= 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=d2a8c569965ab8367867b893000001a1-1463674467.788322-470605344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb686006c10ba61a59e5542f4cbcf335c2c234524758eaf75f5e83598f5b89a843ad7e58cdf28087aae69f5bbbbc1b84eed206503e3be3a3c461378163f4546e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24022a1f3425abcdee1b970af79be72f40e4341e508942e1750cba1aae5281ec5557c9a1c88a084c54f04e0ea4c30f5985b526e42388045c87ffda0ab48b246f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02c046c0164a745d4a22cb29a03c1825dc2d9357d837a90d79dbb38fe0babffbb6483980a6b85dca82a8a19c9ad9df94947a619d44c0e0ea8f8decf1de4ddea0"} build_url:https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/Mi_t4JhgStK9kXdJf3lKWA/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-Non-PGO/sha512/fb686006c10ba61a59e5542f4cbcf335c2c234524758eaf75f5e83598f5b89a843ad7e58cdf28087aae69f5bbbbc1b84eed206503e3be3a3c461378163f4546e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24022a1f3425abcdee1b970af79be72f40e4341e508942e1750cba1aae5281ec5557c9a1c88a084c54f04e0ea4c30f5985b526e42388045c87ffda0ab48b246f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02c046c0164a745d4a22cb29a03c1825dc2d9357d837a90d79dbb38fe0babffbb6483980a6b85dca82a8a19c9ad9df94947a619d44c0e0ea8f8decf1de4ddea0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 09:35:12.569562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:35:12.569891) ========= 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=d2a8c569965ab8367867b893000001a1-1463674467.788322-470605344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:35:12.651710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 09:35:12.652066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 09:35:12.652401) ========= ========= Total master_lag: 0.50 =========