builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1460093120.8 results: success (0) buildid: 20160407220538 builduid: c50cd10d59474e33af57162747c82975 revision: 34293bb847d1e28198d596a87ea4baf96bfb0286 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.802779) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.803258) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.803592) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006409 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.827512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.827864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.841231) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.841550) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.892052) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.892388) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.892790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:20.893110) ========= 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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 22:25:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.2M=0s 2016-04-07 22:25:21 (32.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.071017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.071368) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014925 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.130485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.130861) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 34293bb847d1e28198d596a87ea4baf96bfb0286 --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 34293bb847d1e28198d596a87ea4baf96bfb0286 --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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 22:25:21,948 truncating revision to first 12 chars 2016-04-07 22:25:21,948 Setting DEBUG logging. 2016-04-07 22:25:21,948 attempt 1/10 2016-04-07 22:25:21,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/34293bb847d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 22:25:22,206 unpacking tar archive at: fx-team-34293bb847d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.690489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.690896) ========= echo 34293bb847d1e28198d596a87ea4baf96bfb0286 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'34293bb847d1e28198d596a87ea4baf96bfb0286'] 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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 34293bb847d1e28198d596a87ea4baf96bfb0286 program finished with exit code 0 elapsedTime=0.004778 script_repo_revision: '34293bb847d1e28198d596a87ea4baf96bfb0286' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.742179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.742540) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.771256) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-07 22:25:21.771639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:25:22 INFO - MultiFileLogger online at 20160407 22:25:22 in /builds/slave/test 22:25:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 22:25:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:25:22 INFO - {'append_to_log': False, 22:25:22 INFO - 'base_work_dir': '/builds/slave/test', 22:25:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:25:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:25:22 INFO - 'branch': 'Fx-Team-Non-PGO', 22:25:22 INFO - 'buildbot_json_path': 'buildprops.json', 22:25:22 INFO - 'config_files': ('talos/linux_config.py',), 22:25:22 INFO - 'default_actions': ('clobber', 22:25:22 INFO - 'read-buildbot-config', 22:25:22 INFO - 'download-and-extract', 22:25:22 INFO - 'populate-webroot', 22:25:22 INFO - 'create-virtualenv', 22:25:22 INFO - 'install', 22:25:22 INFO - 'run-tests'), 22:25:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:25:22 INFO - 'download_minidump_stackwalk': True, 22:25:22 INFO - 'download_symbols': 'ondemand', 22:25:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:25:22 INFO - 'tooltool.py': '/tools/tooltool.py', 22:25:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:25:22 INFO - '/tools/misc-python/virtualenv.py')}, 22:25:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:25:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:25:22 INFO - 'installer_path': 'installer.exe', 22:25:22 INFO - 'log_level': 'info', 22:25:22 INFO - 'log_name': 'talos', 22:25:22 INFO - 'log_to_console': True, 22:25:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:25:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:25:22 INFO - 'opt_config_files': (), 22:25:22 INFO - 'pip_index': False, 22:25:22 INFO - 'sps_profile': False, 22:25:22 INFO - 'sps_profile_interval': 0, 22:25:22 INFO - 'suite': 'dromaeojs', 22:25:22 INFO - 'system_bits': '32', 22:25:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:25:22 INFO - 'title': 'talos-linux64-ix-035', 22:25:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:25:22 INFO - 'use_talos_json': True, 22:25:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:25:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:25:22 INFO - 'work_dir': 'build'} 22:25:22 INFO - ##### 22:25:22 INFO - ##### Running clobber step. 22:25:22 INFO - ##### 22:25:22 INFO - Running pre-action listener: _resource_record_pre_action 22:25:22 INFO - Running main action method: clobber 22:25:22 INFO - rmtree: /builds/slave/test/build 22:25:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:25:23 INFO - Running post-action listener: _resource_record_post_action 22:25:23 INFO - ##### 22:25:23 INFO - ##### Running read-buildbot-config step. 22:25:23 INFO - ##### 22:25:23 INFO - Running pre-action listener: _resource_record_pre_action 22:25:23 INFO - Running main action method: read_buildbot_config 22:25:23 INFO - Using buildbot properties: 22:25:23 INFO - { 22:25:23 INFO - "project": "", 22:25:23 INFO - "product": "firefox", 22:25:23 INFO - "script_repo_revision": "production", 22:25:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:25:23 INFO - "repository": "", 22:25:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:25:23 INFO - "buildid": "20160407220538", 22:25:23 INFO - "pgo_build": "False", 22:25:23 INFO - "basedir": "/builds/slave/test", 22:25:23 INFO - "buildnumber": 1631, 22:25:23 INFO - "slavename": "talos-linux64-ix-035", 22:25:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:25:23 INFO - "platform": "ubuntu64_hw", 22:25:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:25:23 INFO - "branch": "fx-team", 22:25:23 INFO - "repo_path": "integration/fx-team", 22:25:23 INFO - "revision": "34293bb847d1e28198d596a87ea4baf96bfb0286", 22:25:23 INFO - "stage_platform": "linux64", 22:25:23 INFO - "builduid": "c50cd10d59474e33af57162747c82975", 22:25:23 INFO - "slavebuilddir": "test" 22:25:23 INFO - } 22:25:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:25:23 INFO - Running post-action listener: _resource_record_post_action 22:25:23 INFO - ##### 22:25:23 INFO - ##### Running download-and-extract step. 22:25:23 INFO - ##### 22:25:23 INFO - Running pre-action listener: _resource_record_pre_action 22:25:23 INFO - Running main action method: download_and_extract 22:25:23 INFO - mkdir: /builds/slave/test/build/tests 22:25: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')]} 22:25:23 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:25:30 INFO - Downloaded 1361 bytes. 22:25:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:25:30 INFO - Using the following test package requirements: 22:25:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:25:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:25:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:25:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:30 INFO - u'jsshell-linux-x86_64.zip'], 22:25:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:25:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:25:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:25:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:25:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:25:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:25:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:25: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')]} 22:25:30 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:25:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:25:35 INFO - Downloaded 22186728 bytes. 22:25:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:25:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:25:36 INFO - Return code: 0 22:25:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:36 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:25:41 INFO - Downloaded 22186728 bytes. 22:25:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:25:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:25:42 INFO - Return code: 0 22:25:42 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')]} 22:25:42 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:25:43 INFO - Downloaded 10847693 bytes. 22:25:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:25:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:25:43 INFO - Return code: 0 22:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:43 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:25:46 INFO - Downloaded 54048357 bytes. 22:25:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:46 INFO - mkdir: /builds/slave/test/properties 22:25:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:25:46 INFO - Writing to file /builds/slave/test/properties/build_url 22:25:46 INFO - Contents: 22:25:46 INFO - build_url:https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:47 INFO - Running post-action listener: _resource_record_post_action 22:25:47 INFO - Running post-action listener: set_extra_try_arguments 22:25:47 INFO - ##### 22:25:47 INFO - ##### Running populate-webroot step. 22:25:47 INFO - ##### 22:25:47 INFO - Running pre-action listener: _resource_record_pre_action 22:25:47 INFO - Running main action method: populate_webroot 22:25:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:25:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:25:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:25:47 INFO - '--tppagecycles', 22:25:47 INFO - '7'], 22:25:47 INFO - 'tests': ['tsvgm']}}, 22:25:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:25:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:25:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:25:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:25:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:47 INFO - 'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:25:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:25:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:47 INFO - 'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['damp', 'tps']}, 22:25:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:47 INFO - 'tests': ['damp', 'tps']}, 22:25:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['dromaeo_dom']}, 22:25:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:25:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['a11yr', 22:25:47 INFO - 'ts_paint', 22:25:47 INFO - 'tpaint', 22:25:47 INFO - 'sessionrestore', 22:25:47 INFO - 'sessionrestore_no_auto_restore', 22:25:47 INFO - 'tabpaint']}, 22:25:47 INFO - 'other-e10s': {'tests': ['a11yr', 22:25:47 INFO - 'ts_paint', 22:25:47 INFO - 'tpaint', 22:25:47 INFO - 'sessionrestore', 22:25:47 INFO - 'sessionrestore_no_auto_restore', 22:25:47 INFO - 'tabpaint']}, 22:25:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:25:47 INFO - 'ts_paint', 22:25:47 INFO - 'tpaint', 22:25:47 INFO - 'sessionrestore', 22:25:47 INFO - 'sessionrestore_no_auto_restore', 22:25:47 INFO - 'tabpaint']}, 22:25:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:25:47 INFO - 'ts_paint', 22:25:47 INFO - 'tpaint', 22:25:47 INFO - 'sessionrestore', 22:25:47 INFO - 'sessionrestore_no_auto_restore', 22:25:47 INFO - 'tabpaint']}, 22:25:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['a11yr', 22:25:47 INFO - 'ts_paint', 22:25:47 INFO - 'tpaint', 22:25:47 INFO - 'sessionrestore', 22:25:47 INFO - 'sessionrestore_no_auto_restore', 22:25:47 INFO - 'tabpaint']}, 22:25:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['a11yr', 22:25:47 INFO - 'ts_paint', 22:25:47 INFO - 'tpaint', 22:25:47 INFO - 'sessionrestore', 22:25:47 INFO - 'sessionrestore_no_auto_restore', 22:25:47 INFO - 'tabpaint']}, 22:25:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['tsvgx', 22:25:47 INFO - 'tsvgr_opacity', 22:25:47 INFO - 'tart', 22:25:47 INFO - 'tscrollx', 22:25:47 INFO - 'cart']}, 22:25:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:25:47 INFO - 'tsvgr_opacity', 22:25:47 INFO - 'tart', 22:25:47 INFO - 'tscrollx', 22:25:47 INFO - 'cart']}, 22:25:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:47 INFO - 'talos_options': ['--disable-e10s'], 22:25:47 INFO - 'tests': ['tp5o']}, 22:25:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:47 INFO - 'tests': ['tp5o']}, 22:25:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:47 INFO - 'talos_options': ['--disable-e10s', 22:25:47 INFO - '--xperf_path', 22:25:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:25:47 INFO - 'tests': ['tp5n']}, 22:25:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:47 INFO - 'talos_options': ['--xperf_path', 22:25:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:25:47 INFO - 'tests': ['tp5n']}}, 22:25:47 INFO - 'talos.zip': {'path': '', 22:25:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:25:47 INFO - Running post-action listener: _resource_record_post_action 22:25:47 INFO - ##### 22:25:47 INFO - ##### Running create-virtualenv step. 22:25:47 INFO - ##### 22:25:47 INFO - Running pre-action listener: _resource_record_pre_action 22:25:47 INFO - Running main action method: create_virtualenv 22:25:47 INFO - Creating virtualenv /builds/slave/test/build/venv 22:25:47 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 22:25:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:25:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:25:47 INFO - Using real prefix '/usr' 22:25:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:25:47 INFO - Installing distribute.............................................................................................................................................................................................done. 22:25:49 INFO - Installing pip.................done. 22:25:49 INFO - Return code: 0 22:25:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:25:49 INFO - Using env: {'DISPLAY': ':0', 22:25:49 INFO - 'HOME': '/home/cltbld', 22:25:49 INFO - 'LANG': 'en_US.UTF-8', 22:25:49 INFO - 'LANGUAGE': 'en_US:en', 22:25:49 INFO - 'LOGNAME': 'cltbld', 22:25:49 INFO - 'MAIL': '/var/mail/cltbld', 22:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:49 INFO - 'MOZ_NO_REMOTE': '1', 22:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:49 INFO - 'NO_EM_RESTART': '1', 22:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:49 INFO - 'PWD': '/builds/slave/test', 22:25:49 INFO - 'SHELL': '/bin/bash', 22:25:49 INFO - 'SHLVL': '1', 22:25:49 INFO - 'TERM': 'linux', 22:25:49 INFO - 'TMOUT': '86400', 22:25:49 INFO - 'USER': 'cltbld', 22:25:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:49 INFO - '_': '/tools/buildbot/bin/python'} 22:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:49 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 22:25:49 INFO - Cleaning up... 22:25:49 INFO - Return code: 0 22:25:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:25:49 INFO - Using env: {'DISPLAY': ':0', 22:25:49 INFO - 'HOME': '/home/cltbld', 22:25:49 INFO - 'LANG': 'en_US.UTF-8', 22:25:49 INFO - 'LANGUAGE': 'en_US:en', 22:25:49 INFO - 'LOGNAME': 'cltbld', 22:25:49 INFO - 'MAIL': '/var/mail/cltbld', 22:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:49 INFO - 'MOZ_NO_REMOTE': '1', 22:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:49 INFO - 'NO_EM_RESTART': '1', 22:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:49 INFO - 'PWD': '/builds/slave/test', 22:25:49 INFO - 'SHELL': '/bin/bash', 22:25:49 INFO - 'SHLVL': '1', 22:25:49 INFO - 'TERM': 'linux', 22:25:49 INFO - 'TMOUT': '86400', 22:25:49 INFO - 'USER': 'cltbld', 22:25:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:49 INFO - '_': '/tools/buildbot/bin/python'} 22:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:50 INFO - Downloading/unpacking psutil>=0.7.1 22:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:25:52 INFO - Installing collected packages: psutil 22:25:52 INFO - Running setup.py install for psutil 22:25:52 INFO - building 'psutil._psutil_linux' extension 22:25:52 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 22:25:52 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 22:25:52 INFO - building 'psutil._psutil_posix' extension 22:25:52 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 22:25:52 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 22:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:25:52 INFO - Successfully installed psutil 22:25:52 INFO - Cleaning up... 22:25:52 INFO - Return code: 0 22:25:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:25:52 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')]} 22:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:52 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')]} 22:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:52 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:25:52 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.0.0'] in /builds/slave/test/build 22:25:52 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.0.0 22:25:52 INFO - Using env: {'DISPLAY': ':0', 22:25:52 INFO - 'HOME': '/home/cltbld', 22:25:52 INFO - 'LANG': 'en_US.UTF-8', 22:25:52 INFO - 'LANGUAGE': 'en_US:en', 22:25:52 INFO - 'LOGNAME': 'cltbld', 22:25:52 INFO - 'MAIL': '/var/mail/cltbld', 22:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:52 INFO - 'MOZ_NO_REMOTE': '1', 22:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:52 INFO - 'NO_EM_RESTART': '1', 22:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:52 INFO - 'PWD': '/builds/slave/test', 22:25:52 INFO - 'SHELL': '/bin/bash', 22:25:52 INFO - 'SHLVL': '1', 22:25:52 INFO - 'TERM': 'linux', 22:25:52 INFO - 'TMOUT': '86400', 22:25:52 INFO - 'USER': 'cltbld', 22:25:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:52 INFO - '_': '/tools/buildbot/bin/python'} 22:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:25:54 INFO - Installing collected packages: mozsystemmonitor 22:25:54 INFO - Running setup.py install for mozsystemmonitor 22:25:54 INFO - Successfully installed mozsystemmonitor 22:25:54 INFO - Cleaning up... 22:25:54 INFO - Return code: 0 22:25:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:25: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')]} 22:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25: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')]} 22:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:25:54 INFO - Using env: {'DISPLAY': ':0', 22:25:54 INFO - 'HOME': '/home/cltbld', 22:25:54 INFO - 'LANG': 'en_US.UTF-8', 22:25:54 INFO - 'LANGUAGE': 'en_US:en', 22:25:54 INFO - 'LOGNAME': 'cltbld', 22:25:54 INFO - 'MAIL': '/var/mail/cltbld', 22:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:55 INFO - 'MOZ_NO_REMOTE': '1', 22:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:55 INFO - 'NO_EM_RESTART': '1', 22:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:55 INFO - 'PWD': '/builds/slave/test', 22:25:55 INFO - 'SHELL': '/bin/bash', 22:25:55 INFO - 'SHLVL': '1', 22:25:55 INFO - 'TERM': 'linux', 22:25:55 INFO - 'TMOUT': '86400', 22:25:55 INFO - 'USER': 'cltbld', 22:25:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:55 INFO - '_': '/tools/buildbot/bin/python'} 22:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:55 INFO - Downloading/unpacking blobuploader==1.2.4 22:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:57 INFO - Downloading blobuploader-1.2.4.tar.gz 22:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:25:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:25:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:57 INFO - Downloading docopt-0.6.1.tar.gz 22:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:25:57 INFO - Installing collected packages: blobuploader, requests, docopt 22:25:57 INFO - Running setup.py install for blobuploader 22:25:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:25:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:25:57 INFO - Running setup.py install for requests 22:25:58 INFO - Running setup.py install for docopt 22:25:58 INFO - Successfully installed blobuploader requests docopt 22:25:58 INFO - Cleaning up... 22:25:58 INFO - Return code: 0 22:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:58 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 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:25:58 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 22:25:58 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 22:25:58 INFO - Using env: {'DISPLAY': ':0', 22:25:58 INFO - 'HOME': '/home/cltbld', 22:25:58 INFO - 'LANG': 'en_US.UTF-8', 22:25:58 INFO - 'LANGUAGE': 'en_US:en', 22:25:58 INFO - 'LOGNAME': 'cltbld', 22:25:58 INFO - 'MAIL': '/var/mail/cltbld', 22:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:58 INFO - 'MOZ_NO_REMOTE': '1', 22:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:58 INFO - 'NO_EM_RESTART': '1', 22:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:58 INFO - 'PWD': '/builds/slave/test', 22:25:58 INFO - 'SHELL': '/bin/bash', 22:25:58 INFO - 'SHLVL': '1', 22:25:58 INFO - 'TERM': 'linux', 22:25:58 INFO - 'TMOUT': '86400', 22:25:58 INFO - 'USER': 'cltbld', 22:25:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:58 INFO - '_': '/tools/buildbot/bin/python'} 22:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:25:58 INFO - Running setup.py (path:/tmp/pip-fozyuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:25:58 INFO - Running setup.py (path:/tmp/pip-Ck3fFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:25:58 INFO - Running setup.py (path:/tmp/pip-z0yPGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:25:58 INFO - Running setup.py (path:/tmp/pip-VV5gft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:25:58 INFO - Running setup.py (path:/tmp/pip-SNUOTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:25:59 INFO - Running setup.py (path:/tmp/pip-nPP7jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:25:59 INFO - Running setup.py (path:/tmp/pip-f1tmUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:25:59 INFO - Running setup.py (path:/tmp/pip-Vy87TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:25:59 INFO - Running setup.py (path:/tmp/pip-WOuve8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:25:59 INFO - Running setup.py (path:/tmp/pip-l3mj8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:25:59 INFO - Running setup.py (path:/tmp/pip-Q7ZZiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:25:59 INFO - Running setup.py (path:/tmp/pip-s9Kub3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:25:59 INFO - Running setup.py (path:/tmp/pip-zoy4Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:25:59 INFO - Running setup.py (path:/tmp/pip-DVtYfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:59 INFO - Running setup.py (path:/tmp/pip-YK0Xyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:25:59 INFO - Running setup.py (path:/tmp/pip-rAA4Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:25:59 INFO - Running setup.py (path:/tmp/pip-X9uOjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:25:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:25:59 INFO - Running setup.py install for manifestparser 22:25:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:25:59 INFO - Running setup.py install for mozcrash 22:26:00 INFO - Running setup.py install for mozdebug 22:26:00 INFO - Running setup.py install for mozdevice 22:26:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Running setup.py install for mozfile 22:26:00 INFO - Running setup.py install for mozhttpd 22:26:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Running setup.py install for mozinfo 22:26:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Running setup.py install for mozInstall 22:26:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Running setup.py install for mozleak 22:26:00 INFO - Running setup.py install for mozlog 22:26:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Running setup.py install for moznetwork 22:26:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:26:00 INFO - Running setup.py install for mozprocess 22:26:01 INFO - Running setup.py install for mozprofile 22:26:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:26:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:26:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:26:01 INFO - Running setup.py install for mozrunner 22:26:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:26:01 INFO - Running setup.py install for mozscreenshot 22:26:01 INFO - Running setup.py install for moztest 22:26:01 INFO - Running setup.py install for mozversion 22:26:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:26:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:26:01 INFO - Cleaning up... 22:26:01 INFO - Return code: 0 22:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:26: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')]} 22:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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')]} 22:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:01 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 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:26:01 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 22:26:01 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 22:26:01 INFO - Using env: {'DISPLAY': ':0', 22:26:01 INFO - 'HOME': '/home/cltbld', 22:26:01 INFO - 'LANG': 'en_US.UTF-8', 22:26:01 INFO - 'LANGUAGE': 'en_US:en', 22:26:01 INFO - 'LOGNAME': 'cltbld', 22:26:01 INFO - 'MAIL': '/var/mail/cltbld', 22:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:01 INFO - 'MOZ_NO_REMOTE': '1', 22:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:01 INFO - 'NO_EM_RESTART': '1', 22:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:01 INFO - 'PWD': '/builds/slave/test', 22:26:01 INFO - 'SHELL': '/bin/bash', 22:26:01 INFO - 'SHLVL': '1', 22:26:01 INFO - 'TERM': 'linux', 22:26:01 INFO - 'TMOUT': '86400', 22:26:01 INFO - 'USER': 'cltbld', 22:26:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:01 INFO - '_': '/tools/buildbot/bin/python'} 22:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:26:02 INFO - Running setup.py (path:/tmp/pip-R5xqAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:26:02 INFO - Running setup.py (path:/tmp/pip-BHtmdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:26:02 INFO - Running setup.py (path:/tmp/pip-kNX3cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:26:02 INFO - Running setup.py (path:/tmp/pip-sHBDaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:26:02 INFO - Running setup.py (path:/tmp/pip-z0sRkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:26:02 INFO - Running setup.py (path:/tmp/pip-NX9exl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:26:02 INFO - Running setup.py (path:/tmp/pip-I13pBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:26:02 INFO - Running setup.py (path:/tmp/pip-YcQPQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:26:02 INFO - Running setup.py (path:/tmp/pip-HkGKlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:26:02 INFO - Running setup.py (path:/tmp/pip-hdeVcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:26:02 INFO - Running setup.py (path:/tmp/pip-euZNh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:26:02 INFO - Running setup.py (path:/tmp/pip-Rj7_ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:26:02 INFO - Running setup.py (path:/tmp/pip-EB6BvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:26:02 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)) 22:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:26:02 INFO - Running setup.py (path:/tmp/pip-4OPjV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:26:03 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)) 22:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:03 INFO - Running setup.py (path:/tmp/pip-nx1EMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:03 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)) 22:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:26:03 INFO - Running setup.py (path:/tmp/pip-SB6N6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:26:03 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)) 22:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:26:03 INFO - Running setup.py (path:/tmp/pip-3kgPX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:26:03 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)) 22:26:03 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)) 22:26:03 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)) 22:26:03 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)) 22:26:03 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)) 22:26:03 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)) 22:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:26:03 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 22:26:03 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 22:26:03 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 22:26:03 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 22:26:03 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 22:26:03 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 22:26:05 INFO - Downloading blessings-1.6.tar.gz 22:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:26:05 INFO - Installing collected packages: blessings 22:26:05 INFO - Running setup.py install for blessings 22:26:05 INFO - Successfully installed blessings 22:26:05 INFO - Cleaning up... 22:26:05 INFO - Return code: 0 22:26:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:26:05 INFO - Reading from file tmpfile_stdout 22:26:05 INFO - Current package versions: 22:26:05 INFO - argparse == 1.2.1 22:26:05 INFO - blessings == 1.6 22:26:05 INFO - blobuploader == 1.2.4 22:26:05 INFO - docopt == 0.6.1 22:26:05 INFO - manifestparser == 1.1 22:26:05 INFO - mozInstall == 1.12 22:26:05 INFO - mozcrash == 0.17 22:26:05 INFO - mozdebug == 0.1 22:26:05 INFO - mozdevice == 0.48 22:26:05 INFO - mozfile == 1.2 22:26:05 INFO - mozhttpd == 0.7 22:26:05 INFO - mozinfo == 0.9 22:26:05 INFO - mozleak == 0.1 22:26:05 INFO - mozlog == 3.1 22:26:05 INFO - moznetwork == 0.27 22:26:05 INFO - mozprocess == 0.22 22:26:05 INFO - mozprofile == 0.28 22:26:05 INFO - mozrunner == 6.11 22:26:05 INFO - mozscreenshot == 0.1 22:26:05 INFO - mozsystemmonitor == 0.0 22:26:05 INFO - moztest == 0.7 22:26:05 INFO - mozversion == 1.4 22:26:05 INFO - psutil == 3.1.1 22:26:05 INFO - requests == 1.2.3 22:26:05 INFO - wsgiref == 0.1.2 22:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:05 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 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:26:05 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 22:26:05 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 22:26:05 INFO - Using env: {'DISPLAY': ':0', 22:26:05 INFO - 'HOME': '/home/cltbld', 22:26:05 INFO - 'LANG': 'en_US.UTF-8', 22:26:05 INFO - 'LANGUAGE': 'en_US:en', 22:26:05 INFO - 'LOGNAME': 'cltbld', 22:26:05 INFO - 'MAIL': '/var/mail/cltbld', 22:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:05 INFO - 'MOZ_NO_REMOTE': '1', 22:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:05 INFO - 'NO_EM_RESTART': '1', 22:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:05 INFO - 'PWD': '/builds/slave/test', 22:26:05 INFO - 'SHELL': '/bin/bash', 22:26:05 INFO - 'SHLVL': '1', 22:26:05 INFO - 'TERM': 'linux', 22:26:05 INFO - 'TMOUT': '86400', 22:26:05 INFO - 'USER': 'cltbld', 22:26:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:05 INFO - '_': '/tools/buildbot/bin/python'} 22:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 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)) 22:26:05 INFO - Cleaning up... 22:26:05 INFO - Return code: 0 22:26:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:26:05 INFO - Using env: {'DISPLAY': ':0', 22:26:05 INFO - 'HOME': '/home/cltbld', 22:26:05 INFO - 'LANG': 'en_US.UTF-8', 22:26:05 INFO - 'LANGUAGE': 'en_US:en', 22:26:05 INFO - 'LOGNAME': 'cltbld', 22:26:05 INFO - 'MAIL': '/var/mail/cltbld', 22:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:05 INFO - 'MOZ_NO_REMOTE': '1', 22:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:05 INFO - 'NO_EM_RESTART': '1', 22:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:05 INFO - 'PWD': '/builds/slave/test', 22:26:05 INFO - 'SHELL': '/bin/bash', 22:26:05 INFO - 'SHLVL': '1', 22:26:05 INFO - 'TERM': 'linux', 22:26:05 INFO - 'TMOUT': '86400', 22:26:05 INFO - 'USER': 'cltbld', 22:26:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:05 INFO - '_': '/tools/buildbot/bin/python'} 22:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:05 INFO - Downloading/unpacking jsonschema 22:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:26:07 INFO - Downloading/unpacking functools32 (from jsonschema) 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26:08 INFO - Downloading functools32-3.2.3-2.tar.gz 22:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:26:08 INFO - warning: no files found matching '*.txt' 22:26:08 INFO - no previously-included directories found matching 'build' 22:26:08 INFO - no previously-included directories found matching 'dist' 22:26:08 INFO - no previously-included directories found matching '.git*' 22:26:08 INFO - Installing collected packages: jsonschema, functools32 22:26:08 INFO - Running setup.py install for functools32 22:26:08 INFO - warning: no files found matching '*.txt' 22:26:08 INFO - no previously-included directories found matching 'build' 22:26:08 INFO - no previously-included directories found matching 'dist' 22:26:08 INFO - no previously-included directories found matching '.git*' 22:26:08 INFO - Successfully installed jsonschema functools32 22:26:08 INFO - Cleaning up... 22:26:08 INFO - Return code: 0 22:26:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:26:08 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')]} 22:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:08 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')]} 22:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:08 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 0x7ff3ef839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', '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 22:26:08 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 22:26:08 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 22:26:08 INFO - Using env: {'DISPLAY': ':0', 22:26:08 INFO - 'HOME': '/home/cltbld', 22:26:08 INFO - 'LANG': 'en_US.UTF-8', 22:26:08 INFO - 'LANGUAGE': 'en_US:en', 22:26:08 INFO - 'LOGNAME': 'cltbld', 22:26:08 INFO - 'MAIL': '/var/mail/cltbld', 22:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:08 INFO - 'MOZ_NO_REMOTE': '1', 22:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:08 INFO - 'NO_EM_RESTART': '1', 22:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:08 INFO - 'PWD': '/builds/slave/test', 22:26:08 INFO - 'SHELL': '/bin/bash', 22:26:08 INFO - 'SHLVL': '1', 22:26:08 INFO - 'TERM': 'linux', 22:26:08 INFO - 'TMOUT': '86400', 22:26:08 INFO - 'USER': 'cltbld', 22:26:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:08 INFO - '_': '/tools/buildbot/bin/python'} 22:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:08 INFO - Downloading/unpacking flake8 22:26:08 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 22:26:08 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 22:26:08 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 22:26:08 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 22:26:08 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 22:26:08 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 22:26:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:26:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:26:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:10 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 22:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:26:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:26:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:26:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:26:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:26:11 INFO - no previously-included directories found matching 'docs/_build' 22:26:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:26:11 INFO - Running setup.py install for pep8 22:26:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:26:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:26:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:26:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:26:11 INFO - no previously-included directories found matching 'docs/_build' 22:26:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:26:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:26:11 INFO - Cleaning up... 22:26:11 INFO - Return code: 0 22:26:11 INFO - Running post-action listener: _resource_record_post_action 22:26:11 INFO - Running post-action listener: _start_resource_monitoring 22:26:11 INFO - Starting resource monitoring. 22:26:11 INFO - ##### 22:26:11 INFO - ##### Running install step. 22:26:11 INFO - ##### 22:26:11 INFO - Running pre-action listener: _resource_record_pre_action 22:26:11 INFO - Running main action method: install 22:26:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:26:11 INFO - Reading from file tmpfile_stdout 22:26:11 INFO - Detecting whether we're running mozinstall >=1.0... 22:26:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:26:11 INFO - Reading from file tmpfile_stdout 22:26:11 INFO - Output received: 22:26:11 INFO - Usage: mozinstall [options] installer 22:26:11 INFO - Options: 22:26:11 INFO - -h, --help show this help message and exit 22:26:11 INFO - -d DEST, --destination=DEST 22:26:11 INFO - Directory to install application into. [default: 22:26:11 INFO - "/builds/slave/test"] 22:26:11 INFO - --app=APP Application being installed. [default: firefox] 22:26:11 INFO - mkdir: /builds/slave/test/build/application 22:26:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:26:27 INFO - Reading from file tmpfile_stdout 22:26:27 INFO - Output received: 22:26:27 INFO - /builds/slave/test/build/application/firefox/firefox 22:26:27 INFO - Running post-action listener: _resource_record_post_action 22:26:27 INFO - ##### 22:26:27 INFO - ##### Running run-tests step. 22:26:27 INFO - ##### 22:26:27 INFO - Running pre-action listener: _resource_record_pre_action 22:26:27 INFO - Running main action method: run_tests 22:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:26:27 INFO - Python 2.7.3 22:26:27 INFO - Return code: 0 22:26:27 INFO - grabbing minidump binary from tooltool 22:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:27 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002410>, '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 0x1003310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10037a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:26:27 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 22:26:27 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 22:26:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:26:27 INFO - Return code: 0 22:26:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:26:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:26:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:26:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:26:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:26:28 INFO - Return code: 0 22:26:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:26:28 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:26:28 INFO - Using env: {'DISPLAY': ':0', 22:26:28 INFO - 'HOME': '/home/cltbld', 22:26:28 INFO - 'LANG': 'en_US.UTF-8', 22:26:28 INFO - 'LANGUAGE': 'en_US:en', 22:26:28 INFO - 'LOGNAME': 'cltbld', 22:26:28 INFO - 'MAIL': '/var/mail/cltbld', 22:26:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:26:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:28 INFO - 'MOZ_NO_REMOTE': '1', 22:26:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:28 INFO - 'NO_EM_RESTART': '1', 22:26:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:28 INFO - 'PWD': '/builds/slave/test', 22:26:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:26:28 INFO - 'SHELL': '/bin/bash', 22:26:28 INFO - 'SHLVL': '1', 22:26:28 INFO - 'TERM': 'linux', 22:26:28 INFO - 'TMOUT': '86400', 22:26:28 INFO - 'USER': 'cltbld', 22:26:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974', 22:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:28 INFO - '_': '/tools/buildbot/bin/python'} 22:26:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:26:28 INFO - mozversion application_buildid: 20160407220538 22:26:28 INFO - mozversion application_changeset: 34293bb847d1e28198d596a87ea4baf96bfb0286 22:26:28 INFO - mozversion application_display_name: Nightly 22:26:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:26:28 INFO - mozversion application_name: Firefox 22:26:28 INFO - mozversion application_remotingname: firefox 22:26:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:26:28 INFO - mozversion application_vendor: Mozilla 22:26:28 INFO - mozversion application_version: 48.0a1 22:26:28 INFO - mozversion platform_buildid: 20160407220538 22:26:28 INFO - mozversion platform_changeset: 34293bb847d1e28198d596a87ea4baf96bfb0286 22:26:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:26:28 INFO - mozversion platform_version: 48.0a1 22:26:28 INFO - using testdate: 1460093188 22:26:28 INFO - actual date: 1460093188 22:26:28 INFO - starting webserver on 'localhost:40234' 22:26:28 INFO - SUITE-START | Running 2 tests 22:26:28 INFO - TEST-START | dromaeo_css 22:26:28 INFO - operating with platform_type : linux_ 22:26:28 INFO - Initialising browser for dromaeo_css test... 22:26:28 INFO - TEST-INFO | started process 27144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNBOgDy/profile http://localhost:40234/getInfo.html) 22:26:32 INFO - PROCESS | 27144 | __metrics Screen width/height:1600/1200 22:26:32 INFO - PROCESS | 27144 | colorDepth:24 22:26:32 INFO - PROCESS | 27144 | Browser inner width/height: 1024/697 22:26:32 INFO - PROCESS | 27144 | __metrics 22:26:33 ERROR - PROCESS | 27144 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:26:34 INFO - TEST-INFO | 27144: exit 0 22:26:34 INFO - Browser initialized. 22:26:34 INFO - Running cycle 1/1 for dromaeo_css test... 22:26:34 INFO - TEST-INFO | started process 27222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNBOgDy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:46 INFO - PROCESS | 27222 | RSS: Main: 153628672 22:26:46 INFO - PROCESS | 27222 | 22:27:37 INFO - PROCESS | 27222 | 1460093257692 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] 22:29:50 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:40234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40234/tests/dromaeo/cssquery-ext.html) 22:29:51 INFO - PROCESS | 27222 | RSS: Main: 235466752 22:29:51 INFO - PROCESS | 27222 | 22:32:53 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:40234/tests/dromaeo/cssquery-ext.html (next: http://localhost:40234/tests/dromaeo/cssquery-jquery.html) 22:32:54 INFO - PROCESS | 27222 | RSS: Main: 232443904 22:32:54 INFO - PROCESS | 27222 | 22:35:56 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:40234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40234/tests/dromaeo/cssquery-mootools.html) 22:35:56 INFO - PROCESS | 27222 | RSS: Main: 239628288 22:35:56 INFO - PROCESS | 27222 | 22:38:58 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:40234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40234/tests/dromaeo/cssquery-prototype.html) 22:38:59 INFO - PROCESS | 27222 | RSS: Main: 219697152 22:38:59 INFO - PROCESS | 27222 | 22:42:02 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:40234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40234/tests/dromaeo/cssquery-yui.html) 22:42:02 INFO - PROCESS | 27222 | RSS: Main: 215724032 22:42:02 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | Cycle 1(1): loaded http://localhost:40234/tests/dromaeo/cssquery-yui.html (next: http://localhost:40234/tests/dromaeo/cssquery-dojo.html) 22:45:05 INFO - PROCESS | 27222 | RSS: Main: 274661376 22:45:05 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | __start_tp_report 22:45:05 INFO - PROCESS | 27222 | _x_x_mozilla_page_load 22:45:05 INFO - PROCESS | 27222 | _x_x_mozilla_page_load_details 22:45:05 INFO - PROCESS | 27222 | |i|pagename|runs| 22:45:05 INFO - PROCESS | 27222 | |0;dojo.html;2602.726713695062;2639.3929396238855;2677.4645070985794;2682.3562345037185;2688.3144798076487;4510.954890451103;4594.494605593391;4594.8391806286745;4663.976680116599;4665.253559430492;4587.90824183517;4627.190241707704;4698.835540756074;4700.177468942929;4702.412198475191;4196.706230563862;4223.577642235775;4224.61978421942;4240.639545638609;4392.582704643054;4309.224339618867;4357.542458041908;4402.031553058322;4405.537418571052;4408.052268762215;4144.336906095041;4221.409002739619;4238.0888109056705;4268.9786551067355;4294.978525107385;4260.552641972579;4309.547497512779;4318.762468064255;4336.891577710551;4365.454318210223;4276.358546218092;4292.098659281554;4293.635041021517;4338.110687309126;4342.392065110887;4439.334099885011;4551.908961820745;4605.332226827091;4609.170349337118;4611.169989401907;5001.44984051754;5028.4971502849785;5048.419431765357;5086.847394578169;5097.541221290065;5007.148784706608;5029.924551131736;5045.520675535819;5096.057229412533;5099.33708617881;4493.618042466427;4590.632749380042;4689.929651055237;4698.671093023524;4703.318018887242;5004.099262132779;5030.597552195815;5032.094223039888;5047.16721740916;5082.618803589671;4845.224764037737;4846.39420072491;4851.781669824796;4855.247436647325;4873.975630121827;4848.927266091011;4898.828541001048;4936.333594964633;4969.950300496948;4983.377077865267;4940.75296235194;4949.232868905326;4959.305697202394;4971.353724015927;4999.500049995044;4934.8766280843265;4940.851774446773;4942.357493525818;4943.406791185009;4980.900381992412;4219.303814870512;4300.956990430118;4302.161078589645;4303.311470164758;4365.279728844768;3725.7578257413184;3743.8689645862264;3747.737658363943;3761.9059523512133;3768.1144930941205;4243.342281946241;4248.91502169961;4252.192083504125;4263.59495847894;4337.436133302651;4906.067847109038;4954.3063971044085;4955.058538877602;4957.380327459067;4985.875353116201;4326.091520780671;4340.045190058182;4341.218580655449;4342.891427714332;4379.627731642846;4438.467383913951;4554;4564.794584243717;4581.2440947243995;4622.352870598119;4724.149653062344;4733.408323959505;4736.881577960441;4773.689710168828;4775.617950563947;4926.989967056673;4929.285253638274;4958.528939750718;4963.528464795839;5011.874703132451;4622.537746225351;4691.953080469289;4744.359511465908;4770.785314660918;4775.71345719258;4844.903101938012;4846.5638092570425;4851.854444366674;4863.367762190893;4907.975460122677;4932.8520144395725;4935.16102262609;4938.111139994836;4940.407151141886;4987.10232158215;4624.237000894815;4811.735354555533;4848.80604775805;4888.413390393175;4902.2156454967035;4753.120672675566;4769.332293478985;4774.164521208844;4776.832810851603;4813.879653008563;4618.468876079294;4703.60019398355;4719.268513380432;4726.976365118152;4752.619790416689;4894.486078961658;4916.139675556692;4916.680415772963;4959.950400495949;4968.950310496849;4730.266808644666;4764.690295130806;4772.117158325721;4773.785179666854;4821.7348045856415 22:45:05 INFO - PROCESS | 27222 | |1;ext.html;591.2373038779973;612.83147134538;617.7127635649422;628.4658040665435;644.4779728419983;33589.160270993234;34646.653533464654;34682.30635387294;34690.47964280538;34708.82645586768;35943.4608480873;36681.81659091707;36875.63124368755;36877.078073048186;36934.0139081224;7671.424643151758;7873.330766884822;7876.291133797957;7880.487768295071;7882.60586970652;7797.727079552217;7926.9207307927045;7930.206979302053;7931.643076061591;7932.286094251516;7873.133955264916;7970.163132871052;7971;7971.043474783034;7975.7208497702595;7839.608019599026;7927.3658107351275;7935.365170786324;7936.166702496213;7938.245866642688;7782.377409807202;7822.569758663271;7826;7880.330171935392;7880.527168369858;37392.626073739186;37760.24479510394;37962.81018594917;38028.619713802786;38167.80916095402;3103.767217458677;3183.363327334542;3210.5184222366597;3225.741940644766;3325.933481330384;27872;28085.85957070222;28156.577651335247;28350;28492.428704045742;3208.6470488246273;3258.804471731704;3278.4918337657464;3288.342331533679;3309.040378290293;230828;231290.84354578287;231747;231826;231876;51616.48383516117;52364.73817630888;52412.47587524152;52456.73771631194;52457.2131418029;58845.411545883995;60488;60550;60558;60783.39216607866;15155.242237888062;15330.846691532943;15392.461263855712;15395.538133856002;15401.306941187673;11413.657590272305;11478.19652624325;11484.253523520945;11485.138614603939;11491.942540287246;17800.3769868054;18026.3690770825;18039.278428862697;18583.44249672512;18704.15831287568;6746.190457145174;6869.931300686929;7005.493818828976;7013.001294631005;7212.350888420067;895.9865602015975;929.1823195587974;933.6545478173119;954.7183580843667;1072.6406653770919;27630.723692762815;28156.29609259744;28429;28533.71466285352;29110.7088929108;1008.8032833597525;1015.4719545836124;1021.7315974456681;1096.8683757949098;1148.190525679394;14752.852471475147;15137.243137843065;15172.317245723749;15422.383104675688;15432.15123168214;333696;339357;340453;341735;342231;49151;49840.252396214084;49976.25035624469;50126;50236;1060.8886066962857;1161.895429411357;1229.6126720083146;1272.5991312736458;1280.8847203751707;26884.462310753283;27352.639864071523;29527.704722952494;29869.402611948073;30162.09513714592;42129;42701.35947960721;43104.78447607742;43152.56847431611;43161;302581;310583;310958;311458;311565;32531.512027319135;38397.808010959765;41176.58823411848;41826.372604410346;42217.78891105648;40605.1878962425;41518.37722434106;41584.1683166341;41951.37072943847;42229.78885105555;34938.65061349456;35680.10799730028;36105.45841812322;36123.63876361203;36460.81769591135;35550.46674299836;36066.639333607374;36117.63882361143;36383.09042273858;36385.818070909474;35556.746138047914;36153.096172594844;36260.27479450449;36471.45292820663;36860;30444.695553044185;32650;32882.5067623981;33034.66965330412;33089.33821323608;25164.119255826692;25497;25710.61434078453;25853.224403267934;26023.219303420927 22:45:05 INFO - PROCESS | 27222 | |2;jquery.html;364.64447164015087;367.79954924566107;374.32621281692957;380.41746335245386;386.61338661338664;15828.208589570519;16391.344346226153;16791.32834686611;16797.412090576847;16802.579935501588;15338.69322613547;15503.767443488357;15761.60595985098;15786.421357864208;16022.278997445113;5045.672031317962;5161.922571161435;5201.193814958688;5204.531592156705;5205.713685747282;3691.704663626917;3883.514560679915;3888.9805550972205;3889.533256009269;5106.157484015152;3999.540052893911;5916.645001299914;5921.940780592182;5926.111083337512;5931.436513531207;4881.170201065827;5736.282964629421;5883.470487656089;5884.087966365199;5896.705164741746;3378.5607870976614;5031.723255220962;5052.090623687772;5053.823116190915;5070.08738427083;11149.442527873654;14639.560813175516;18697.15862786178;19391.903040484707;19576.90211548933;1782.4118041046424;1791.9462416127537;1800.486861244552;1865.7387965684816;1885.8962757048357;8600.784980375478;8615.138486151398;8656.8701469478;8784.956075219647;8831.955840220822;1663.4427466798636;1663.542525805401;1699.702552053398;1713.9485815425558;1746.5371676505736;68982;69692;70456.6477167616;71010.99999999948;71395.64302178507;9117;9390.248780097576;9587.041295870496;9603.567839447242;9677.951610241904;13265;13310.267935263653;13314.600561983156;13330.400131994083;13358.064935454426;7324.414046876237;7406.111266648037;7469.1037075551285;7566.810829729191;7572.356349710336;7271.127464704269;7279.526830755984;7281.963590182015;7413.66638501258;7414.518056326321;3985.8405663773124;3997.700172487075;4030.8387664493093;4042.215835893347;4076.2662720710555;1799.3162598212596;1809.9457016289532;1824;1841.4475657302755;1908.3797765726194;777.6073083093002;879.4547380624055;918.0268914950174;921.6037104045325;946.4983558713893;15895.364185432452;16318.184090795412;16467.423640172536;16745.237035889186;17111.572210694583;879.6877108626345;880.8150288439372;884.4118661090303;895.7357579514058;958.2956526952685;9044.81910361789;9192.540372981324;9229.676961306322;9397.76505587352;9564.521773911416;300248;306377;385169;392565;394461;70381.64809175921;72091;73263.63368183232;73475.63262183654;74694.62652686702;948.3551185193996;960.3181740963994;988.5749127875083;989.0900371657948;994.9801003979879;15312.693746125238;15325.846741532889;15522;15561.066336019874;16035.759463607821;34099.829500852335;34147.48778768271;34228.82885585556;35436;35575.46636800502;47804.52195478001;48519.51480485291;48618;48701.512984869696;48714.512854871;7294.416446684359;7344.228855970046;7385.926140738524;7402.777916662509;7572.053493313336;11049.226554141133;11355.37545435009;11429.428528573371;11480.196386252883;11595.362255075714;10033.548490318099;10203.438810865473;10208.438535880598;10549.841752373874;10583.62957296491;10177.643782467578;10253.846192306972;10276.126529245097;10285.2800303981;10375.118114960313;10428.530716117944;10542.947285263524;10548.841767373342;10576.788464230825;10607.734806629896;7243.420526357984;7384.150822655463;7414.666340014604;7425.071866016748;7684.846303073796;9930.751731206778;10090.949545252226;10136;10153.289269751047;10309.381437113798 22:45:05 INFO - PROCESS | 27222 | |3;mootools.html;1311.4360824845312;1412.0821466047068;1463.4512057978259;1584.2870708181315;1776.1030679506848;6640.900386494201;7458.403327733775;7717.421193410502;7726.729564465245;7739.4969326993705;7411.258874112586;7655;7664.233576642333;7668.693252269916;7670.041244844395;1894.4979580411202;2126.436494329004;2139.711138996235;2183.727034120735;2204.0302267002467;2231.6987206727126;2254.571631390039;2255.8082562982167;2256.627656436694;2258.6837842702034;2146.2488129154826;2189.6824960380736;2190.3866917263113;2191.1564047841534;2192.6162921488676;2153.321703663341;2169.9457513562206;2171.0121894537947;2171.8262538997;2187.453136715821;2093.8324934005245;2098.25511943261;2098.9055492502875;2100.59038487495;2110.155937624947;7799;7812.335951444077;7877.842443151105;7878.212178782133;7878.842423151505;4558.77206139695;4687.22660760974;4695.88260293492;4722.95277047232;4725.291206319045;2882.423515296949;2891.5951766752673;2954.1432984434705;2962.3482833776534;2969.4506516294337;922.9492377919212;937.4422218779883;947.4930911962136;949.0651708067617;957.9233661307079;10463.79072418555;10625.149988001018;10643.84034239487;10678.145748340114;10705.732356691067;4030.1738143680477;4175.248455278079;4182.749035057906;4330.935035974463;4340.696151269444;9126.771830704152;9192.540372981324;9193.678221262224;9199.126083022102;9209.95395023034;4011.939820902689;4674.859754207379;4678.672492925531;4682.227432473672;4699.577038066591;3754.662080412776;3755.1738617504107;3755.5681096673684;3781.4516895050615;4040.151568170717;3710.8330125144435;3835.53973523179;3856.614338566177;3944.3097457944746;3971.3050216212623;1227.3985746983913;1265.911386202957;1268.4545645372577;1279.4754150798128;1283.9599924061354;1159.5477763672175;1177.5113327968797;1208.1965492947268;1231.4212320209488;1252.8684488128797;7046.964765176243;7137.2149063602965;7170.749023784142;7205.531640443354;7412.96293518529;1050.779336339362;1060.3054998975683;1076.5370890516997;1077.5420446310286;1089.1831126655009;5628.352739434936;5763.510101641407;5770.394108618619;5775.220345253421;5803;8893.377463577488;9170.908290917005;9502.144806967268;9502.572384242587;9646.662366817127;9661.516924153764;9756.512174391251;9777.951110244545;9789.804203916025;9857.753556161153;7102.147742270858;7323.816904577428;7410.258974102547;7411.1477180124975;7447.44144189188;7144.142702875688;7163.426925845815;7231.16841563227;7234.493585448968;7304.926950730424;8897.199252067345;8975.955120224357;9044.14080662336;9052.366334356531;9095.408798428081;8715.651373944971;8978.595963181802;9205.907940920504;9296.767580810534;9298.256139508958;5686.09022556389;6245.344238854855;6368.36316368378;6451.225852897683;6473.385028422293;7403.851922961619;7404.888926665996;7438.033055702724;7461.515001524884;7463.701451941862;6428.55000149985;6569.507286953402;6648.5678430901835;6693;6771.830704232433;6656.567323124175;6724.193096828412;6741.831454213488;6762.830929226612;6802;6966.442684585119;7039.612821294878;7074.823129421806;7109.715611375487;7109.893351599627;6472.449841763503;6475.190601174853;6487.772927947499;6488;6658.533902626769;6247.68761561911;6318.842028949313;6355.205599300088;6377.202849643794;6391.424771770563 22:45:05 INFO - PROCESS | 27222 | |4;prototype.html;309.86211136044454;312.2646168273715;314.16902293433884;315.8026233603998;316.26152932901704;4893.119238537062;4985.202367621181;5054.797808087681;5061.898762024762;5077.086124497589;4994.350734404522;5004.574611158056;5008.824691135802;5009.448960614339;5024.447310795809;3717.405215165574;3785.432185172219;3793.089658481972;3900.882973510785;3956.5845586213463;3917.3928041153667;3931.1499163106664;3936.8031598420107;3941.418370967007;3943.684505239574;3895.961040389588;3904.726669133162;3910.9804450977704;3923.4507168996365;3929.744566603176;3710.9072273193115;3761.511003569532;3837.597052309523;3921.2549615573234;3929.941050884239;3465.896023119285;3468.236987862666;3479.9478007829903;3489.057954352311;3496.30073985204;4785.593224575915;4794.208955522335;4795.472498025214;4805.783739731721;4807;4200.957990420087;4434;4443.777811109431;4444.2222611042935;4480.305552639346;5187.507186817246;5230.267762513251;5235.842924712265;5248.134057880445;5275.182346736262;3679.521662183926;3682.9263414731554;3683.723720720957;3688.188598508324;3697.759645623026;5179.585633149377;5471.890562188734;5528.6406383585345;5535.667859928417;5550.58370622205;3789.1095592536285;3812.599677033927;3825;3826.4069069294305;3827.4641550182996;3861.8069096545623;3862.2661694278;3862.729608927348;3876.302265592164;3891.9416208756893;4432.867013989586;4436.157130145262;4436.6672499562665;4448.5551444855255;4451.866444006685;5084.847454576368;5273.815416460406;5287.4448182941005;5289.312389389432;5316.129290183335;1309.3584143769485;1329.71411146602;1332.4536939854613;1333.2400531697033;1333.8599447058114;852.2074470742269;899.5637115998735;919.1865199298535;920.8066306075665;941.9717408477757;4551.95448045522;4578;4600.585947264695;4611.8847028823875;4612.308153776893;5383;5399.595030372738;5402.783888644411;5407.270018547446;5414.242006119146;4437.733735975852;4620.745858977789;4622.445306563234;4624.537546245416;4643.86068417948;2904.8983285584904;2921;2935.9266018349285;2936.9265768355535;2946.130891387003;5196.090684130338;5222.060029194781;5224.093205979866;5230.869228269324;5246.930545630772;5397.703126328011;5557.36090349615;5578.433920396582;5595.7481913313995;5627.662340259598;5170.121079416508;5205.167173252262;5215.113430716788;5216.50443207887;5219.164933610604;5479.75341109659;5497.47773961473;5498.367687715964;5505.311836020497;5505.779768809202;5097.464766199496;5349.839504814861;5375.139977603565;5379.4082650907585;5393;5176.188334083041;5191.143461328838;5230.869228269324;5235.633505654568;5239.711815850165;3845.0964023453907;3871.10964478166;3876.127871228951;3885.23221934025;3893;5263.947360526346;5511.200875872896;5512.428957747023;5522.668639881459;5541.778328866801;5258.815941442184;5285.392179899361;5298.125809241432;5304.230886521355;5307.275135580874;5211.482249481661;5323.414424413389;5336.279602253646;5344.812931547377;5355.250264962986;5228.921566176587;5246.658967167122;5252.711100889488;5252.763625636932;5257.5005374489365;5069.569086627678;5150.510701483353;5342.332208473941;5363.544098751494;5384.380796208329;5226.817061402832;5231.973840130775;5256.369235691742;5259.973700131475;5260.316158899319 22:45:05 INFO - PROCESS | 27222 | |5;yui.html;651.6155468273718;691.4917535611324;692.5083190934437;723.8950352198927;748.6631016042783;12066.27602343859;12070.577529786458;12182.634520964362;12200.633980980585;12278.877211227897;12202.145849790519;12234.93882530586;12300.938495307533;12309.938450307758;12327.506899724023;642.473171998961;776.2198990015027;794.9880751788713;807.6123460738819;810.7040930060544;798.3214267872291;802.7391097893179;803.7548547692951;804.7625950344633;804.851102546028;843.0810416645854;848.4697064334791;848.6011574559947;848.6478111583685;848.9575521223945;670.4200866250707;687.4843867099701;687.7524091327118;812.9227723366271;842.9283510901581;611.4222060153157;612.3876123876124;612.5926259037734;612.8835521250993;613.3988691082719;12716.809247861196;12737.108402411835;12791.5522956697;12801.679958001032;12805.48778048877;12623.431945562472;12858.614241572768;12876.80684789729;12888.484460621565;12928.224306541637;9691.176250018756;9862.704118876445;9956.103950644478;9986.650467233612;10240.231982601335;3306.1404034950847;3319.6514365991707;3356.2951780126205;3379.9493007604906;3412.129906873756;48465.515344846455;48617;48850.51149488495;49390.50609493859;49546.50453495455;9853.16248118918;9901.950490247647;9919.702408927744;9934.701958941243;9948.154406875352;17070;18604.697313977875;18775.624487510173;18847.151878165514;18849.717254241197;6655.900161497581;6797;6822.590644561342;6881.587104773729;7122.074130363019;3642.7814331139684;3664.8849176273675;3724.7578907370935;3733.9626603733614;3795.905102372463;2739.0960982875604;2829.8019138660507;2833.050927939122;2833.71662833715;2834.659840819115;495.23733450486566;499.20127795526867;501.1755661936095;504.47534564053706;506.6630690590716;605.6668832142304;621.8258887511504;622.4304761143503;634.2769243062912;643.1638869469671;7667.731629392944;7835;8134.349252059821;8393.202645748644;8464.492130472068;533.9225812257201;544.7358031354789;569.9829005129852;624.9281332646713;636.5416899832113;3613.2954073955325;3762.793046382475;3832.0419895026243;3850.249201405699;3901.328727875365;42150.367744483854;42676.78661606672;42745.145097097884;42848.357274640905;43013.56986430095;38647.806760966574;45008.77495612501;45815;46215.30677039847;46268;39418.211635767126;41227.381589276185;41470.37794433086;42529;42728.786356068646;7403.370713489198;7421.480496365202;7511.248875112445;7515.6242187891485;7520.135184453639;28286;28374.29064273327;28841.7115828839;29562.704372955995;29691.40617187601;34271.828640856635;34907;37953;38347.424788627635;38423.2315353697;9423.434593924112;9657.565409556446;9692.397270840538;9733.74895763008;9755.804883902425;10627.89372106269;10771.730706732395;10853.40306283162;11468.770624587629;11515.19393642437;9872.210223181984;9876.703698889045;9897.604095836374;9908.653197138066;10188.694339169837;10263.589456421958;10266.384016959006;10297.07326340633;10643.627473038407;10701.678949631523;9967;10017.198624109908;10090.445025523666;10216.438095904796;10249.590016399261;8339.708110216114;8452.830943381221;8474.067852536093;8831.779205519657;8932.419392739452;8511.574421279036;8566;8607.225349718556;8643.26532244741;8817 22:45:05 INFO - PROCESS | 27222 | __end_tp_report 22:45:05 INFO - PROCESS | 27222 | __start_cc_report 22:45:05 INFO - PROCESS | 27222 | _x_x_mozilla_cycle_collect,918 22:45:05 INFO - PROCESS | 27222 | __end_cc_report 22:45:05 INFO - PROCESS | 27222 | __startTimestamp1460094305742__endTimestamp 22:45:05 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | ------- Summary: start ------- 22:45:05 INFO - PROCESS | 27222 | Number of tests: 6 22:45:05 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | [#0] dojo.html Cycles:165 Average:4601.97 Median:4726.98 stddev:463.17 (9.8%) stddev-sans-first:437.23 22:45:05 INFO - PROCESS | 27222 | Values: 2602.7 2639.4 2677.5 2682.4 2688.3 4511.0 4594.5 4594.8 4664.0 4665.3 4587.9 4627.2 4698.8 4700.2 4702.4 4196.7 4223.6 4224.6 4240.6 4392.6 4309.2 4357.5 4402.0 4405.5 4408.1 4144.3 4221.4 4238.1 4269.0 4295.0 4260.6 4309.5 4318.8 4336.9 4365.5 4276.4 4292.1 4293.6 4338.1 4342.4 4439.3 4551.9 4605.3 4609.2 4611.2 5001.4 5028.5 5048.4 5086.8 5097.5 5007.1 5029.9 5045.5 5096.1 5099.3 4493.6 4590.6 4689.9 4698.7 4703.3 5004.1 5030.6 5032.1 5047.2 5082.6 4845.2 4846.4 4851.8 4855.2 4874.0 4848.9 4898.8 4936.3 4970.0 4983.4 4940.8 4949.2 4959.3 4971.4 4999.5 4934.9 4940.9 4942.4 4943.4 4980.9 4219.3 4301.0 4302.2 4303.3 4365.3 3725.8 3743.9 3747.7 3761.9 3768.1 4243.3 4248.9 4252.2 4263.6 4337.4 4906.1 4954.3 4955.1 4957.4 4985.9 4326.1 4340.0 4341.2 4342.9 4379.6 4438.5 4554.0 4564.8 4581.2 4622.4 4724.1 4733.4 4736.9 4773.7 4775.6 4927.0 4929.3 4958.5 4963.5 5011.9 4622.5 4692.0 4744.4 4770.8 4775.7 4844.9 4846.6 4851.9 4863.4 4908.0 4932.9 4935.2 4938.1 4940.4 4987.1 4624.2 4811.7 4848.8 4888.4 4902.2 4753.1 4769.3 4774.2 4776.8 4813.9 4618.5 4703.6 4719.3 4727.0 4752.6 4894.5 4916.1 4916.7 4960.0 4969.0 4730.3 4764.7 4772.1 4773.8 4821.7 22:45:05 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | [#1] ext.html Cycles:180 Average:45667.23 Median:35811.78 stddev:77825.59 (217.3%) stddev-sans-first:77970.32 22:45:05 INFO - PROCESS | 27222 | Values: 591.2 612.8 617.7 628.5 644.5 33589.2 34646.7 34682.3 34690.5 34708.8 35943.5 36681.8 36875.6 36877.1 36934.0 7671.4 7873.3 7876.3 7880.5 7882.6 7797.7 7926.9 7930.2 7931.6 7932.3 7873.1 7970.2 7971.0 7971.0 7975.7 7839.6 7927.4 7935.4 7936.2 7938.2 7782.4 7822.6 7826.0 7880.3 7880.5 37392.6 37760.2 37962.8 38028.6 38167.8 3103.8 3183.4 3210.5 3225.7 3325.9 27872.0 28085.9 28156.6 28350.0 28492.4 3208.6 3258.8 3278.5 3288.3 3309.0 230828.0 231290.8 231747.0 231826.0 231876.0 51616.5 52364.7 52412.5 52456.7 52457.2 58845.4 60488.0 60550.0 60558.0 60783.4 15155.2 15330.8 15392.5 15395.5 15401.3 11413.7 11478.2 11484.3 11485.1 11491.9 17800.4 18026.4 18039.3 18583.4 18704.2 6746.2 6869.9 7005.5 7013.0 7212.4 896.0 929.2 933.7 954.7 1072.6 27630.7 28156.3 28429.0 28533.7 29110.7 1008.8 1015.5 1021.7 1096.9 1148.2 14752.9 15137.2 15172.3 15422.4 15432.2 333696.0 339357.0 340453.0 341735.0 342231.0 49151.0 49840.3 49976.3 50126.0 50236.0 1060.9 1161.9 1229.6 1272.6 1280.9 26884.5 27352.6 29527.7 29869.4 30162.1 42129.0 42701.4 43104.8 43152.6 43161.0 302581.0 310583.0 310958.0 311458.0 311565.0 32531.5 38397.8 41176.6 41826.4 42217.8 40605.2 41518.4 41584.2 41951.4 42229.8 34938.7 35680.1 36105.5 36123.6 36460.8 35550.5 36066.6 36117.6 36383.1 36385.8 35556.7 36153.1 36260.3 36471.5 36860.0 30444.7 32650.0 32882.5 33034.7 33089.3 25164.1 25497.0 25710.6 25853.2 26023.2 22:45:05 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | [#2] jquery.html Cycles:180 Average:22880.88 Median:3998.62 stddev:59337.76 (1484.0%) stddev-sans-first:59480.13 22:45:05 INFO - PROCESS | 27222 | Values: 364.6 367.8 374.3 380.4 386.6 15828.2 16391.3 16791.3 16797.4 16802.6 15338.7 15503.8 15761.6 15786.4 16022.3 5045.7 5161.9 5201.2 5204.5 5205.7 3691.7 3883.5 3889.0 3889.5 5106.2 3999.5 5916.6 5921.9 5926.1 5931.4 4881.2 5736.3 5883.5 5884.1 5896.7 3378.6 5031.7 5052.1 5053.8 5070.1 11149.4 14639.6 18697.2 19391.9 19576.9 1782.4 1791.9 1800.5 1865.7 1885.9 8600.8 8615.1 8656.9 8785.0 8832.0 1663.4 1663.5 1699.7 1713.9 1746.5 68982.0 69692.0 70456.6 71011.0 71395.6 9117.0 9390.2 9587.0 9603.6 9678.0 13265.0 13310.3 13314.6 13330.4 13358.1 7324.4 7406.1 7469.1 7566.8 7572.4 7271.1 7279.5 7282.0 7413.7 7414.5 3985.8 3997.7 4030.8 4042.2 4076.3 1799.3 1809.9 1824.0 1841.4 1908.4 777.6 879.5 918.0 921.6 946.5 15895.4 16318.2 16467.4 16745.2 17111.6 879.7 880.8 884.4 895.7 958.3 9044.8 9192.5 9229.7 9397.8 9564.5 300248.0 306377.0 385169.0 392565.0 394461.0 70381.6 72091.0 73263.6 73475.6 74694.6 948.4 960.3 988.6 989.1 995.0 15312.7 15325.8 15522.0 15561.1 16035.8 34099.8 34147.5 34228.8 35436.0 35575.5 47804.5 48519.5 48618.0 48701.5 48714.5 7294.4 7344.2 7385.9 7402.8 7572.1 11049.2 11355.4 11429.4 11480.2 11595.4 10033.5 10203.4 10208.4 10549.8 10583.6 10177.6 10253.8 10276.1 10285.3 10375.1 10428.5 10542.9 10548.8 10576.8 10607.7 7243.4 7384.2 7414.7 7425.1 7684.8 9930.8 10090.9 10136.0 10153.3 10309.4 22:45:05 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | [#3] mootools.html Cycles:180 Average:5423.98 Median:6372.78 stddev:2878.29 (45.2%) stddev-sans-first:2869.76 22:45:05 INFO - PROCESS | 27222 | Values: 1311.4 1412.1 1463.5 1584.3 1776.1 6640.9 7458.4 7717.4 7726.7 7739.5 7411.3 7655.0 7664.2 7668.7 7670.0 1894.5 2126.4 2139.7 2183.7 2204.0 2231.7 2254.6 2255.8 2256.6 2258.7 2146.2 2189.7 2190.4 2191.2 2192.6 2153.3 2169.9 2171.0 2171.8 2187.5 2093.8 2098.3 2098.9 2100.6 2110.2 7799.0 7812.3 7877.8 7878.2 7878.8 4558.8 4687.2 4695.9 4723.0 4725.3 2882.4 2891.6 2954.1 2962.3 2969.5 922.9 937.4 947.5 949.1 957.9 10463.8 10625.1 10643.8 10678.1 10705.7 4030.2 4175.2 4182.7 4330.9 4340.7 9126.8 9192.5 9193.7 9199.1 9210.0 4011.9 4674.9 4678.7 4682.2 4699.6 3754.7 3755.2 3755.6 3781.5 4040.2 3710.8 3835.5 3856.6 3944.3 3971.3 1227.4 1265.9 1268.5 1279.5 1284.0 1159.5 1177.5 1208.2 1231.4 1252.9 7047.0 7137.2 7170.7 7205.5 7413.0 1050.8 1060.3 1076.5 1077.5 1089.2 5628.4 5763.5 5770.4 5775.2 5803.0 8893.4 9170.9 9502.1 9502.6 9646.7 9661.5 9756.5 9778.0 9789.8 9857.8 7102.1 7323.8 7410.3 7411.1 7447.4 7144.1 7163.4 7231.2 7234.5 7304.9 8897.2 8976.0 9044.1 9052.4 9095.4 8715.7 8978.6 9205.9 9296.8 9298.3 5686.1 6245.3 6368.4 6451.2 6473.4 7403.9 7404.9 7438.0 7461.5 7463.7 6428.6 6569.5 6648.6 6693.0 6771.8 6656.6 6724.2 6741.8 6762.8 6802.0 6966.4 7039.6 7074.8 7109.7 7109.9 6472.4 6475.2 6487.8 6488.0 6658.5 6247.7 6318.8 6355.2 6377.2 6391.4 22:45:05 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | [#4] prototype.html Cycles:180 Average:4381.72 Median:5016.95 stddev:1281.53 (25.5%) stddev-sans-first:1248.15 22:45:05 INFO - PROCESS | 27222 | Values: 309.9 312.3 314.2 315.8 316.3 4893.1 4985.2 5054.8 5061.9 5077.1 4994.4 5004.6 5008.8 5009.4 5024.4 3717.4 3785.4 3793.1 3900.9 3956.6 3917.4 3931.1 3936.8 3941.4 3943.7 3896.0 3904.7 3911.0 3923.5 3929.7 3710.9 3761.5 3837.6 3921.3 3929.9 3465.9 3468.2 3479.9 3489.1 3496.3 4785.6 4794.2 4795.5 4805.8 4807.0 4201.0 4434.0 4443.8 4444.2 4480.3 5187.5 5230.3 5235.8 5248.1 5275.2 3679.5 3682.9 3683.7 3688.2 3697.8 5179.6 5471.9 5528.6 5535.7 5550.6 3789.1 3812.6 3825.0 3826.4 3827.5 3861.8 3862.3 3862.7 3876.3 3891.9 4432.9 4436.2 4436.7 4448.6 4451.9 5084.8 5273.8 5287.4 5289.3 5316.1 1309.4 1329.7 1332.5 1333.2 1333.9 852.2 899.6 919.2 920.8 942.0 4552.0 4578.0 4600.6 4611.9 4612.3 5383.0 5399.6 5402.8 5407.3 5414.2 4437.7 4620.7 4622.4 4624.5 4643.9 2904.9 2921.0 2935.9 2936.9 2946.1 5196.1 5222.1 5224.1 5230.9 5246.9 5397.7 5557.4 5578.4 5595.7 5627.7 5170.1 5205.2 5215.1 5216.5 5219.2 5479.8 5497.5 5498.4 5505.3 5505.8 5097.5 5349.8 5375.1 5379.4 5393.0 5176.2 5191.1 5230.9 5235.6 5239.7 3845.1 3871.1 3876.1 3885.2 3893.0 5263.9 5511.2 5512.4 5522.7 5541.8 5258.8 5285.4 5298.1 5304.2 5307.3 5211.5 5323.4 5336.3 5344.8 5355.3 5228.9 5246.7 5252.7 5252.8 5257.5 5069.6 5150.5 5342.3 5363.5 5384.4 5226.8 5232.0 5256.4 5260.0 5260.3 22:45:05 INFO - PROCESS | 27222 | 22:45:05 INFO - PROCESS | 27222 | [#5] yui.html Cycles:180 Average:12286.01 Median:25020.87 stddev:13721.13 (54.8%) stddev-sans-first:13731.80 22:45:05 INFO - PROCESS | 27222 | Values: 651.6 691.5 692.5 723.9 748.7 12066.3 12070.6 12182.6 12200.6 12278.9 12202.1 12234.9 12300.9 12309.9 12327.5 642.5 776.2 795.0 807.6 810.7 798.3 802.7 803.8 804.8 804.9 843.1 848.5 848.6 848.6 849.0 670.4 687.5 687.8 812.9 842.9 611.4 612.4 612.6 612.9 613.4 12716.8 12737.1 12791.6 12801.7 12805.5 12623.4 12858.6 12876.8 12888.5 12928.2 9691.2 9862.7 9956.1 9986.7 10240.2 3306.1 3319.7 3356.3 3379.9 3412.1 48465.5 48617.0 48850.5 49390.5 49546.5 9853.2 9902.0 9919.7 9934.7 9948.2 17070.0 18604.7 18775.6 18847.2 18849.7 6655.9 6797.0 6822.6 6881.6 7122.1 3642.8 3664.9 3724.8 3734.0 3795.9 2739.1 2829.8 2833.1 2833.7 2834.7 495.2 499.2 501.2 504.5 506.7 605.7 621.8 622.4 634.3 643.2 7667.7 7835.0 8134.3 8393.2 8464.5 533.9 544.7 570.0 624.9 636.5 3613.3 3762.8 3832.0 3850.2 3901.3 42150.4 42676.8 42745.1 42848.4 43013.6 38647.8 45008.8 45815.0 46215.3 46268.0 39418.2 41227.4 41470.4 42529.0 42728.8 7403.4 7421.5 7511.2 7515.6 7520.1 28286.0 28374.3 28841.7 29562.7 29691.4 34271.8 34907.0 37953.0 38347.4 38423.2 9423.4 9657.6 9692.4 9733.7 9755.8 10627.9 10771.7 10853.4 11468.8 11515.2 9872.2 9876.7 9897.6 9908.7 10188.7 10263.6 10266.4 10297.1 10643.6 10701.7 9967.0 10017.2 10090.4 10216.4 10249.6 8339.7 8452.8 8474.1 8831.8 8932.4 8511.6 8566.0 8607.2 8643.3 8817.0 22:45:05 INFO - PROCESS | 27222 | -------- Summary: end -------- 22:45:05 INFO - PROCESS | 27222 | 22:45:06 INFO - TEST-INFO | 27222: exit 0 22:45:06 INFO - TEST-OK | dromaeo_css | took 1117957ms 22:45:06 INFO - TEST-START | kraken 22:45:06 INFO - operating with platform_type : linux_ 22:45:06 INFO - Initialising browser for kraken test... 22:45:06 INFO - TEST-INFO | started process 27398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd6eXwx/profile http://localhost:40234/getInfo.html) 22:45:10 INFO - PROCESS | 27398 | __metrics Screen width/height:1600/1200 22:45:10 INFO - PROCESS | 27398 | colorDepth:24 22:45:10 INFO - PROCESS | 27398 | Browser inner width/height: 1024/697 22:45:10 INFO - PROCESS | 27398 | __metrics 22:45:11 ERROR - PROCESS | 27398 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:45:12 INFO - TEST-INFO | 27398: exit 0 22:45:12 INFO - Browser initialized. 22:45:12 INFO - Running cycle 1/1 for kraken test... 22:45:12 INFO - TEST-INFO | started process 27477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd6eXwx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:45:24 INFO - PROCESS | 27477 | RSS: Main: 154529792 22:45:24 INFO - PROCESS | 27477 | 22:45:27 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40234/tests/kraken/driver.html?testName=audio-beat-detection) 22:45:27 INFO - PROCESS | 27477 | RSS: Main: 195178496 22:45:27 INFO - PROCESS | 27477 | 22:45:30 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40234/tests/kraken/driver.html?testName=audio-dft) 22:45:30 INFO - PROCESS | 27477 | RSS: Main: 184725504 22:45:30 INFO - PROCESS | 27477 | 22:45:34 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40234/tests/kraken/driver.html?testName=audio-fft) 22:45:34 INFO - PROCESS | 27477 | RSS: Main: 170459136 22:45:34 INFO - PROCESS | 27477 | 22:45:36 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40234/tests/kraken/driver.html?testName=audio-oscillator) 22:45:37 INFO - PROCESS | 27477 | RSS: Main: 172445696 22:45:37 INFO - PROCESS | 27477 | 22:45:39 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:45:40 INFO - PROCESS | 27477 | RSS: Main: 173740032 22:45:40 INFO - PROCESS | 27477 | 22:45:43 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40234/tests/kraken/driver.html?testName=imaging-darkroom) 22:45:43 INFO - PROCESS | 27477 | RSS: Main: 174034944 22:45:43 INFO - PROCESS | 27477 | 22:45:47 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40234/tests/kraken/driver.html?testName=imaging-desaturate) 22:45:47 INFO - PROCESS | 27477 | RSS: Main: 174780416 22:45:47 INFO - PROCESS | 27477 | 22:45:50 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40234/tests/kraken/driver.html?testName=json-parse-financial) 22:45:51 INFO - PROCESS | 27477 | RSS: Main: 174399488 22:45:51 INFO - PROCESS | 27477 | 22:45:53 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:45:53 INFO - PROCESS | 27477 | RSS: Main: 183922688 22:45:53 INFO - PROCESS | 27477 | 22:45:55 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40234/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:45:56 INFO - PROCESS | 27477 | RSS: Main: 182034432 22:45:56 INFO - PROCESS | 27477 | 22:45:58 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:45:58 INFO - PROCESS | 27477 | RSS: Main: 193404928 22:45:58 INFO - PROCESS | 27477 | 22:46:01 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:46:02 INFO - PROCESS | 27477 | RSS: Main: 200142848 22:46:02 INFO - PROCESS | 27477 | 22:46:05 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:46:05 INFO - PROCESS | 27477 | RSS: Main: 199573504 22:46:05 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | Cycle 1(1): loaded http://localhost:40234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40234/tests/kraken/driver.html?testName=ai-astar) 22:46:07 INFO - PROCESS | 27477 | RSS: Main: 263135232 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | __start_tp_report 22:46:07 INFO - PROCESS | 27477 | _x_x_mozilla_page_load 22:46:07 INFO - PROCESS | 27477 | _x_x_mozilla_page_load_details 22:46:07 INFO - PROCESS | 27477 | |i|pagename|runs| 22:46:07 INFO - PROCESS | 27477 | |0;ai-astar;115;111;114;114;114;112;119;113;113;112 22:46:07 INFO - PROCESS | 27477 | |1;audio-beat-detection;164;132;155;185;143;154;163;140;180;132 22:46:07 INFO - PROCESS | 27477 | |2;audio-dft;162;161;160;162;161;161;161;160;162;161 22:46:07 INFO - PROCESS | 27477 | |3;audio-fft;79;74;97;110;77;73;75;135;98;74 22:46:07 INFO - PROCESS | 27477 | |4;audio-oscillator;93;93;144;93;93;94;146;93;94;146 22:46:07 INFO - PROCESS | 27477 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 22:46:07 INFO - PROCESS | 27477 | |6;imaging-darkroom;146;146;145;146;146;145;146;146;145;145 22:46:07 INFO - PROCESS | 27477 | |7;imaging-desaturate;94;95;95;94;95;95;94;95;95;94 22:46:07 INFO - PROCESS | 27477 | |8;json-parse-financial;64;65;65;64;65;65;65;79;63;62 22:46:07 INFO - PROCESS | 27477 | |9;json-stringify-tinderbox;64;64;64;63;64;64;64;64;64;64 22:46:07 INFO - PROCESS | 27477 | |10;stanford-crypto-aes;90;95;87;83;86;84;84;84;84;91 22:46:07 INFO - PROCESS | 27477 | |11;stanford-crypto-ccm;143;139;138;149;149;150;147;139;140;142 22:46:07 INFO - PROCESS | 27477 | |12;stanford-crypto-pbkdf2;171;170;173;170;172;175;170;172;174;172 22:46:07 INFO - PROCESS | 27477 | |13;stanford-crypto-sha256-iterative;72;73;72;72;71;72;71;72;71;70 22:46:07 INFO - PROCESS | 27477 | __end_tp_report 22:46:07 INFO - PROCESS | 27477 | __start_cc_report 22:46:07 INFO - PROCESS | 27477 | _x_x_mozilla_cycle_collect,1172 22:46:07 INFO - PROCESS | 27477 | __end_cc_report 22:46:07 INFO - PROCESS | 27477 | __startTimestamp1460094367879__endTimestamp 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | ------- Summary: start ------- 22:46:07 INFO - PROCESS | 27477 | Number of tests: 14 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:2.21 (1.9%) stddev-sans-first:2.30 22:46:07 INFO - PROCESS | 27477 | Values: 115.0 111.0 114.0 114.0 114.0 112.0 119.0 113.0 113.0 112.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:159.00 stddev:18.55 (11.7%) stddev-sans-first:19.38 22:46:07 INFO - PROCESS | 27477 | Values: 164.0 132.0 155.0 185.0 143.0 154.0 163.0 140.0 180.0 132.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 22:46:07 INFO - PROCESS | 27477 | Values: 162.0 161.0 160.0 162.0 161.0 161.0 161.0 160.0 162.0 161.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#3] audio-fft Cycles:10 Average:89.20 Median:76.00 stddev:20.68 (27.2%) stddev-sans-first:21.60 22:46:07 INFO - PROCESS | 27477 | Values: 79.0 74.0 97.0 110.0 77.0 73.0 75.0 135.0 98.0 74.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:25.15 (27.0%) stddev-sans-first:26.01 22:46:07 INFO - PROCESS | 27477 | Values: 93.0 93.0 144.0 93.0 93.0 94.0 146.0 93.0 94.0 146.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:46:07 INFO - PROCESS | 27477 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:46:07 INFO - PROCESS | 27477 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:46:07 INFO - PROCESS | 27477 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:4.79 (7.4%) stddev-sans-first:5.04 22:46:07 INFO - PROCESS | 27477 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 65.0 79.0 63.0 62.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 22:46:07 INFO - PROCESS | 27477 | Values: 64.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:3.97 (4.6%) stddev-sans-first:4.03 22:46:07 INFO - PROCESS | 27477 | Values: 90.0 95.0 87.0 83.0 86.0 84.0 84.0 84.0 84.0 91.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:145.00 stddev:4.72 (3.3%) stddev-sans-first:5.00 22:46:07 INFO - PROCESS | 27477 | Values: 143.0 139.0 138.0 149.0 149.0 150.0 147.0 139.0 140.0 142.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.00 stddev:1.73 (1.0%) stddev-sans-first:1.80 22:46:07 INFO - PROCESS | 27477 | Values: 171.0 170.0 173.0 170.0 172.0 175.0 170.0 172.0 174.0 172.0 22:46:07 INFO - PROCESS | 27477 | 22:46:07 INFO - PROCESS | 27477 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 22:46:07 INFO - PROCESS | 27477 | Values: 72.0 73.0 72.0 72.0 71.0 72.0 71.0 72.0 71.0 70.0 22:46:07 INFO - PROCESS | 27477 | -------- Summary: end -------- 22:46:07 INFO - PROCESS | 27477 | 22:46:08 INFO - TEST-INFO | 27477: exit 0 22:46:08 INFO - TEST-OK | kraken | took 62413ms 22:46:08 INFO - SUITE-END | took 1180s 22:46:09 INFO - Completed test suite (00:19:40) 22:46:09 INFO - javascript benchmark 22:46:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.726713695062, 2639.3929396238855, 2677.4645070985794, 2682.3562345037185, 2688.3144798076487, 4510.954890451103, 4594.494605593391, 4594.8391806286745, 4663.976680116599, 4665.253559430492, 4587.90824183517, 4627.190241707704, 4698.835540756074, 4700.177468942929, 4702.412198475191, 4196.706230563862, 4223.577642235775, 4224.61978421942, 4240.639545638609, 4392.582704643054, 4309.224339618867, 4357.542458041908, 4402.031553058322, 4405.537418571052, 4408.052268762215, 4144.336906095041, 4221.409002739619, 4238.0888109056705, 4268.9786551067355, 4294.978525107385, 4260.552641972579, 4309.547497512779, 4318.762468064255, 4336.891577710551, 4365.454318210223, 4276.358546218092, 4292.098659281554, 4293.635041021517, 4338.110687309126, 4342.392065110887, 4439.334099885011, 4551.908961820745, 4605.332226827091, 4609.170349337118, 4611.169989401907, 5001.44984051754, 5028.4971502849785, 5048.419431765357, 5086.847394578169, 5097.541221290065, 5007.148784706608, 5029.924551131736, 5045.520675535819, 5096.057229412533, 5099.33708617881, 4493.618042466427, 4590.632749380042, 4689.929651055237, 4698.671093023524, 4703.318018887242, 5004.099262132779, 5030.597552195815, 5032.094223039888, 5047.16721740916, 5082.618803589671, 4845.224764037737, 4846.39420072491, 4851.781669824796, 4855.247436647325, 4873.975630121827, 4848.927266091011, 4898.828541001048, 4936.333594964633, 4969.950300496948, 4983.377077865267, 4940.75296235194, 4949.232868905326, 4959.305697202394, 4971.353724015927, 4999.500049995044, 4934.8766280843265, 4940.851774446773, 4942.357493525818, 4943.406791185009, 4980.900381992412, 4219.303814870512, 4300.956990430118, 4302.161078589645, 4303.311470164758, 4365.279728844768, 3725.7578257413184, 3743.8689645862264, 3747.737658363943, 3761.9059523512133, 3768.1144930941205, 4243.342281946241, 4248.91502169961, 4252.192083504125, 4263.59495847894, 4337.436133302651, 4906.067847109038, 4954.3063971044085, 4955.058538877602, 4957.380327459067, 4985.875353116201, 4326.091520780671, 4340.045190058182, 4341.218580655449, 4342.891427714332, 4379.627731642846, 4438.467383913951, 4554.0, 4564.794584243717, 4581.2440947243995, 4622.352870598119, 4724.149653062344, 4733.408323959505, 4736.881577960441, 4773.689710168828, 4775.617950563947, 4926.989967056673, 4929.285253638274, 4958.528939750718, 4963.528464795839, 5011.874703132451, 4622.537746225351, 4691.953080469289, 4744.359511465908, 4770.785314660918, 4775.71345719258, 4844.903101938012, 4846.5638092570425, 4851.854444366674, 4863.367762190893, 4907.975460122677, 4932.8520144395725, 4935.16102262609, 4938.111139994836, 4940.407151141886, 4987.10232158215, 4624.237000894815, 4811.735354555533, 4848.80604775805, 4888.413390393175, 4902.2156454967035, 4753.120672675566, 4769.332293478985, 4774.164521208844, 4776.832810851603, 4813.879653008563, 4618.468876079294, 4703.60019398355, 4719.268513380432, 4726.976365118152, 4752.619790416689, 4894.486078961658, 4916.139675556692, 4916.680415772963, 4959.950400495949, 4968.950310496849, 4730.266808644666, 4764.690295130806, 4772.117158325721, 4773.785179666854, 4821.7348045856415], "value": 4573.724201233339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.2373038779973, 612.83147134538, 617.7127635649422, 628.4658040665435, 644.4779728419983, 33589.160270993234, 34646.653533464654, 34682.30635387294, 34690.47964280538, 34708.82645586768, 35943.4608480873, 36681.81659091707, 36875.63124368755, 36877.078073048186, 36934.0139081224, 7671.424643151758, 7873.330766884822, 7876.291133797957, 7880.487768295071, 7882.60586970652, 7797.727079552217, 7926.9207307927045, 7930.206979302053, 7931.643076061591, 7932.286094251516, 7873.133955264916, 7970.163132871052, 7971.0, 7971.043474783034, 7975.7208497702595, 7839.608019599026, 7927.3658107351275, 7935.365170786324, 7936.166702496213, 7938.245866642688, 7782.377409807202, 7822.569758663271, 7826.0, 7880.330171935392, 7880.527168369858, 37392.626073739186, 37760.24479510394, 37962.81018594917, 38028.619713802786, 38167.80916095402, 3103.767217458677, 3183.363327334542, 3210.5184222366597, 3225.741940644766, 3325.933481330384, 27872.0, 28085.85957070222, 28156.577651335247, 28350.0, 28492.428704045742, 3208.6470488246273, 3258.804471731704, 3278.4918337657464, 3288.342331533679, 3309.040378290293, 230828.0, 231290.84354578287, 231747.0, 231826.0, 231876.0, 51616.48383516117, 52364.73817630888, 52412.47587524152, 52456.73771631194, 52457.2131418029, 58845.411545883995, 60488.0, 60550.0, 60558.0, 60783.39216607866, 15155.242237888062, 15330.846691532943, 15392.461263855712, 15395.538133856002, 15401.306941187673, 11413.657590272305, 11478.19652624325, 11484.253523520945, 11485.138614603939, 11491.942540287246, 17800.3769868054, 18026.3690770825, 18039.278428862697, 18583.44249672512, 18704.15831287568, 6746.190457145174, 6869.931300686929, 7005.493818828976, 7013.001294631005, 7212.350888420067, 895.9865602015975, 929.1823195587974, 933.6545478173119, 954.7183580843667, 1072.6406653770919, 27630.723692762815, 28156.29609259744, 28429.0, 28533.71466285352, 29110.7088929108, 1008.8032833597525, 1015.4719545836124, 1021.7315974456681, 1096.8683757949098, 1148.190525679394, 14752.852471475147, 15137.243137843065, 15172.317245723749, 15422.383104675688, 15432.15123168214, 333696.0, 339357.0, 340453.0, 341735.0, 342231.0, 49151.0, 49840.252396214084, 49976.25035624469, 50126.0, 50236.0, 1060.8886066962857, 1161.895429411357, 1229.6126720083146, 1272.5991312736458, 1280.8847203751707, 26884.462310753283, 27352.639864071523, 29527.704722952494, 29869.402611948073, 30162.09513714592, 42129.0, 42701.35947960721, 43104.78447607742, 43152.56847431611, 43161.0, 302581.0, 310583.0, 310958.0, 311458.0, 311565.0, 32531.512027319135, 38397.808010959765, 41176.58823411848, 41826.372604410346, 42217.78891105648, 40605.1878962425, 41518.37722434106, 41584.1683166341, 41951.37072943847, 42229.78885105555, 34938.65061349456, 35680.10799730028, 36105.45841812322, 36123.63876361203, 36460.81769591135, 35550.46674299836, 36066.639333607374, 36117.63882361143, 36383.09042273858, 36385.818070909474, 35556.746138047914, 36153.096172594844, 36260.27479450449, 36471.45292820663, 36860.0, 30444.695553044185, 32650.0, 32882.5067623981, 33034.66965330412, 33089.33821323608, 25164.119255826692, 25497.0, 25710.61434078453, 25853.224403267934, 26023.219303420927], "value": 17754.20005384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.64447164015087, 367.79954924566107, 374.32621281692957, 380.41746335245386, 386.61338661338664, 15828.208589570519, 16391.344346226153, 16791.32834686611, 16797.412090576847, 16802.579935501588, 15338.69322613547, 15503.767443488357, 15761.60595985098, 15786.421357864208, 16022.278997445113, 5045.672031317962, 5161.922571161435, 5201.193814958688, 5204.531592156705, 5205.713685747282, 3691.704663626917, 3883.514560679915, 3888.9805550972205, 3889.533256009269, 5106.157484015152, 3999.540052893911, 5916.645001299914, 5921.940780592182, 5926.111083337512, 5931.436513531207, 4881.170201065827, 5736.282964629421, 5883.470487656089, 5884.087966365199, 5896.705164741746, 3378.5607870976614, 5031.723255220962, 5052.090623687772, 5053.823116190915, 5070.08738427083, 11149.442527873654, 14639.560813175516, 18697.15862786178, 19391.903040484707, 19576.90211548933, 1782.4118041046424, 1791.9462416127537, 1800.486861244552, 1865.7387965684816, 1885.8962757048357, 8600.784980375478, 8615.138486151398, 8656.8701469478, 8784.956075219647, 8831.955840220822, 1663.4427466798636, 1663.542525805401, 1699.702552053398, 1713.9485815425558, 1746.5371676505736, 68982.0, 69692.0, 70456.6477167616, 71010.99999999948, 71395.64302178507, 9117.0, 9390.248780097576, 9587.041295870496, 9603.567839447242, 9677.951610241904, 13265.0, 13310.267935263653, 13314.600561983156, 13330.400131994083, 13358.064935454426, 7324.414046876237, 7406.111266648037, 7469.1037075551285, 7566.810829729191, 7572.356349710336, 7271.127464704269, 7279.526830755984, 7281.963590182015, 7413.66638501258, 7414.518056326321, 3985.8405663773124, 3997.700172487075, 4030.8387664493093, 4042.215835893347, 4076.2662720710555, 1799.3162598212596, 1809.9457016289532, 1824.0, 1841.4475657302755, 1908.3797765726194, 777.6073083093002, 879.4547380624055, 918.0268914950174, 921.6037104045325, 946.4983558713893, 15895.364185432452, 16318.184090795412, 16467.423640172536, 16745.237035889186, 17111.572210694583, 879.6877108626345, 880.8150288439372, 884.4118661090303, 895.7357579514058, 958.2956526952685, 9044.81910361789, 9192.540372981324, 9229.676961306322, 9397.76505587352, 9564.521773911416, 300248.0, 306377.0, 385169.0, 392565.0, 394461.0, 70381.64809175921, 72091.0, 73263.63368183232, 73475.63262183654, 74694.62652686702, 948.3551185193996, 960.3181740963994, 988.5749127875083, 989.0900371657948, 994.9801003979879, 15312.693746125238, 15325.846741532889, 15522.0, 15561.066336019874, 16035.759463607821, 34099.829500852335, 34147.48778768271, 34228.82885585556, 35436.0, 35575.46636800502, 47804.52195478001, 48519.51480485291, 48618.0, 48701.512984869696, 48714.512854871, 7294.416446684359, 7344.228855970046, 7385.926140738524, 7402.777916662509, 7572.053493313336, 11049.226554141133, 11355.37545435009, 11429.428528573371, 11480.196386252883, 11595.362255075714, 10033.548490318099, 10203.438810865473, 10208.438535880598, 10549.841752373874, 10583.62957296491, 10177.643782467578, 10253.846192306972, 10276.126529245097, 10285.2800303981, 10375.118114960313, 10428.530716117944, 10542.947285263524, 10548.841767373342, 10576.788464230825, 10607.734806629896, 7243.420526357984, 7384.150822655463, 7414.666340014604, 7425.071866016748, 7684.846303073796, 9930.751731206778, 10090.949545252226, 10136.0, 10153.289269751047, 10309.381437113798], "value": 7969.451974791105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.4360824845312, 1412.0821466047068, 1463.4512057978259, 1584.2870708181315, 1776.1030679506848, 6640.900386494201, 7458.403327733775, 7717.421193410502, 7726.729564465245, 7739.4969326993705, 7411.258874112586, 7655.0, 7664.233576642333, 7668.693252269916, 7670.041244844395, 1894.4979580411202, 2126.436494329004, 2139.711138996235, 2183.727034120735, 2204.0302267002467, 2231.6987206727126, 2254.571631390039, 2255.8082562982167, 2256.627656436694, 2258.6837842702034, 2146.2488129154826, 2189.6824960380736, 2190.3866917263113, 2191.1564047841534, 2192.6162921488676, 2153.321703663341, 2169.9457513562206, 2171.0121894537947, 2171.8262538997, 2187.453136715821, 2093.8324934005245, 2098.25511943261, 2098.9055492502875, 2100.59038487495, 2110.155937624947, 7799.0, 7812.335951444077, 7877.842443151105, 7878.212178782133, 7878.842423151505, 4558.77206139695, 4687.22660760974, 4695.88260293492, 4722.95277047232, 4725.291206319045, 2882.423515296949, 2891.5951766752673, 2954.1432984434705, 2962.3482833776534, 2969.4506516294337, 922.9492377919212, 937.4422218779883, 947.4930911962136, 949.0651708067617, 957.9233661307079, 10463.79072418555, 10625.149988001018, 10643.84034239487, 10678.145748340114, 10705.732356691067, 4030.1738143680477, 4175.248455278079, 4182.749035057906, 4330.935035974463, 4340.696151269444, 9126.771830704152, 9192.540372981324, 9193.678221262224, 9199.126083022102, 9209.95395023034, 4011.939820902689, 4674.859754207379, 4678.672492925531, 4682.227432473672, 4699.577038066591, 3754.662080412776, 3755.1738617504107, 3755.5681096673684, 3781.4516895050615, 4040.151568170717, 3710.8330125144435, 3835.53973523179, 3856.614338566177, 3944.3097457944746, 3971.3050216212623, 1227.3985746983913, 1265.911386202957, 1268.4545645372577, 1279.4754150798128, 1283.9599924061354, 1159.5477763672175, 1177.5113327968797, 1208.1965492947268, 1231.4212320209488, 1252.8684488128797, 7046.964765176243, 7137.2149063602965, 7170.749023784142, 7205.531640443354, 7412.96293518529, 1050.779336339362, 1060.3054998975683, 1076.5370890516997, 1077.5420446310286, 1089.1831126655009, 5628.352739434936, 5763.510101641407, 5770.394108618619, 5775.220345253421, 5803.0, 8893.377463577488, 9170.908290917005, 9502.144806967268, 9502.572384242587, 9646.662366817127, 9661.516924153764, 9756.512174391251, 9777.951110244545, 9789.804203916025, 9857.753556161153, 7102.147742270858, 7323.816904577428, 7410.258974102547, 7411.1477180124975, 7447.44144189188, 7144.142702875688, 7163.426925845815, 7231.16841563227, 7234.493585448968, 7304.926950730424, 8897.199252067345, 8975.955120224357, 9044.14080662336, 9052.366334356531, 9095.408798428081, 8715.651373944971, 8978.595963181802, 9205.907940920504, 9296.767580810534, 9298.256139508958, 5686.09022556389, 6245.344238854855, 6368.36316368378, 6451.225852897683, 6473.385028422293, 7403.851922961619, 7404.888926665996, 7438.033055702724, 7461.515001524884, 7463.701451941862, 6428.55000149985, 6569.507286953402, 6648.5678430901835, 6693.0, 6771.830704232433, 6656.567323124175, 6724.193096828412, 6741.831454213488, 6762.830929226612, 6802.0, 6966.442684585119, 7039.612821294878, 7074.823129421806, 7109.715611375487, 7109.893351599627, 6472.449841763503, 6475.190601174853, 6487.772927947499, 6488.0, 6658.533902626769, 6247.68761561911, 6318.842028949313, 6355.205599300088, 6377.202849643794, 6391.424771770563], "value": 4428.286682094907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.86211136044454, 312.2646168273715, 314.16902293433884, 315.8026233603998, 316.26152932901704, 4893.119238537062, 4985.202367621181, 5054.797808087681, 5061.898762024762, 5077.086124497589, 4994.350734404522, 5004.574611158056, 5008.824691135802, 5009.448960614339, 5024.447310795809, 3717.405215165574, 3785.432185172219, 3793.089658481972, 3900.882973510785, 3956.5845586213463, 3917.3928041153667, 3931.1499163106664, 3936.8031598420107, 3941.418370967007, 3943.684505239574, 3895.961040389588, 3904.726669133162, 3910.9804450977704, 3923.4507168996365, 3929.744566603176, 3710.9072273193115, 3761.511003569532, 3837.597052309523, 3921.2549615573234, 3929.941050884239, 3465.896023119285, 3468.236987862666, 3479.9478007829903, 3489.057954352311, 3496.30073985204, 4785.593224575915, 4794.208955522335, 4795.472498025214, 4805.783739731721, 4807.0, 4200.957990420087, 4434.0, 4443.777811109431, 4444.2222611042935, 4480.305552639346, 5187.507186817246, 5230.267762513251, 5235.842924712265, 5248.134057880445, 5275.182346736262, 3679.521662183926, 3682.9263414731554, 3683.723720720957, 3688.188598508324, 3697.759645623026, 5179.585633149377, 5471.890562188734, 5528.6406383585345, 5535.667859928417, 5550.58370622205, 3789.1095592536285, 3812.599677033927, 3825.0, 3826.4069069294305, 3827.4641550182996, 3861.8069096545623, 3862.2661694278, 3862.729608927348, 3876.302265592164, 3891.9416208756893, 4432.867013989586, 4436.157130145262, 4436.6672499562665, 4448.5551444855255, 4451.866444006685, 5084.847454576368, 5273.815416460406, 5287.4448182941005, 5289.312389389432, 5316.129290183335, 1309.3584143769485, 1329.71411146602, 1332.4536939854613, 1333.2400531697033, 1333.8599447058114, 852.2074470742269, 899.5637115998735, 919.1865199298535, 920.8066306075665, 941.9717408477757, 4551.95448045522, 4578.0, 4600.585947264695, 4611.8847028823875, 4612.308153776893, 5383.0, 5399.595030372738, 5402.783888644411, 5407.270018547446, 5414.242006119146, 4437.733735975852, 4620.745858977789, 4622.445306563234, 4624.537546245416, 4643.86068417948, 2904.8983285584904, 2921.0, 2935.9266018349285, 2936.9265768355535, 2946.130891387003, 5196.090684130338, 5222.060029194781, 5224.093205979866, 5230.869228269324, 5246.930545630772, 5397.703126328011, 5557.36090349615, 5578.433920396582, 5595.7481913313995, 5627.662340259598, 5170.121079416508, 5205.167173252262, 5215.113430716788, 5216.50443207887, 5219.164933610604, 5479.75341109659, 5497.47773961473, 5498.367687715964, 5505.311836020497, 5505.779768809202, 5097.464766199496, 5349.839504814861, 5375.139977603565, 5379.4082650907585, 5393.0, 5176.188334083041, 5191.143461328838, 5230.869228269324, 5235.633505654568, 5239.711815850165, 3845.0964023453907, 3871.10964478166, 3876.127871228951, 3885.23221934025, 3893.0, 5263.947360526346, 5511.200875872896, 5512.428957747023, 5522.668639881459, 5541.778328866801, 5258.815941442184, 5285.392179899361, 5298.125809241432, 5304.230886521355, 5307.275135580874, 5211.482249481661, 5323.414424413389, 5336.279602253646, 5344.812931547377, 5355.250264962986, 5228.921566176587, 5246.658967167122, 5252.711100889488, 5252.763625636932, 5257.5005374489365, 5069.569086627678, 5150.510701483353, 5342.332208473941, 5363.544098751494, 5384.380796208329, 5226.817061402832, 5231.973840130775, 5256.369235691742, 5259.973700131475, 5260.316158899319], "value": 3975.747629588765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.6155468273718, 691.4917535611324, 692.5083190934437, 723.8950352198927, 748.6631016042783, 12066.27602343859, 12070.577529786458, 12182.634520964362, 12200.633980980585, 12278.877211227897, 12202.145849790519, 12234.93882530586, 12300.938495307533, 12309.938450307758, 12327.506899724023, 642.473171998961, 776.2198990015027, 794.9880751788713, 807.6123460738819, 810.7040930060544, 798.3214267872291, 802.7391097893179, 803.7548547692951, 804.7625950344633, 804.851102546028, 843.0810416645854, 848.4697064334791, 848.6011574559947, 848.6478111583685, 848.9575521223945, 670.4200866250707, 687.4843867099701, 687.7524091327118, 812.9227723366271, 842.9283510901581, 611.4222060153157, 612.3876123876124, 612.5926259037734, 612.8835521250993, 613.3988691082719, 12716.809247861196, 12737.108402411835, 12791.5522956697, 12801.679958001032, 12805.48778048877, 12623.431945562472, 12858.614241572768, 12876.80684789729, 12888.484460621565, 12928.224306541637, 9691.176250018756, 9862.704118876445, 9956.103950644478, 9986.650467233612, 10240.231982601335, 3306.1404034950847, 3319.6514365991707, 3356.2951780126205, 3379.9493007604906, 3412.129906873756, 48465.515344846455, 48617.0, 48850.51149488495, 49390.50609493859, 49546.50453495455, 9853.16248118918, 9901.950490247647, 9919.702408927744, 9934.701958941243, 9948.154406875352, 17070.0, 18604.697313977875, 18775.624487510173, 18847.151878165514, 18849.717254241197, 6655.900161497581, 6797.0, 6822.590644561342, 6881.587104773729, 7122.074130363019, 3642.7814331139684, 3664.8849176273675, 3724.7578907370935, 3733.9626603733614, 3795.905102372463, 2739.0960982875604, 2829.8019138660507, 2833.050927939122, 2833.71662833715, 2834.659840819115, 495.23733450486566, 499.20127795526867, 501.1755661936095, 504.47534564053706, 506.6630690590716, 605.6668832142304, 621.8258887511504, 622.4304761143503, 634.2769243062912, 643.1638869469671, 7667.731629392944, 7835.0, 8134.349252059821, 8393.202645748644, 8464.492130472068, 533.9225812257201, 544.7358031354789, 569.9829005129852, 624.9281332646713, 636.5416899832113, 3613.2954073955325, 3762.793046382475, 3832.0419895026243, 3850.249201405699, 3901.328727875365, 42150.367744483854, 42676.78661606672, 42745.145097097884, 42848.357274640905, 43013.56986430095, 38647.806760966574, 45008.77495612501, 45815.0, 46215.30677039847, 46268.0, 39418.211635767126, 41227.381589276185, 41470.37794433086, 42529.0, 42728.786356068646, 7403.370713489198, 7421.480496365202, 7511.248875112445, 7515.6242187891485, 7520.135184453639, 28286.0, 28374.29064273327, 28841.7115828839, 29562.704372955995, 29691.40617187601, 34271.828640856635, 34907.0, 37953.0, 38347.424788627635, 38423.2315353697, 9423.434593924112, 9657.565409556446, 9692.397270840538, 9733.74895763008, 9755.804883902425, 10627.89372106269, 10771.730706732395, 10853.40306283162, 11468.770624587629, 11515.19393642437, 9872.210223181984, 9876.703698889045, 9897.604095836374, 9908.653197138066, 10188.694339169837, 10263.589456421958, 10266.384016959006, 10297.07326340633, 10643.627473038407, 10701.678949631523, 9967.0, 10017.198624109908, 10090.445025523666, 10216.438095904796, 10249.590016399261, 8339.708110216114, 8452.830943381221, 8474.067852536093, 8831.779205519657, 8932.419392739452, 8511.574421279036, 8566.0, 8607.225349718556, 8643.26532244741, 8817.0], "value": 5771.866540682589, "unit": "score"}], "name": "dromaeo_css", "value": 6353.349954479249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 114.0, 114.0, 114.0, 112.0, 119.0, 113.0, 113.0, 112.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 155.0, 185.0, 143.0, 154.0, 163.0, 140.0, 180.0, 132.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 97.0, 110.0, 77.0, 73.0, 75.0, 135.0, 98.0, 74.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 144.0, 93.0, 93.0, 94.0, 146.0, 93.0, 94.0, 146.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 79.0, 63.0, 62.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 87.0, 83.0, 86.0, 84.0, 84.0, 84.0, 84.0, 91.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 139.0, 138.0, 149.0, 149.0, 150.0, 147.0, 139.0, 140.0, 142.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 173.0, 170.0, 172.0, 175.0, 170.0, 172.0, 174.0, 172.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 71.0, 72.0, 71.0, 72.0, 71.0, 70.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1588.2, "alertThreshold": 2.0}]} 22:46:09 INFO - Return code: 0 22:46:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:46:09 ERROR - # TBPL SUCCESS # 22:46:09 INFO - Running post-action listener: _resource_record_post_action 22:46:09 INFO - Running post-run listener: _resource_record_post_run 22:46:10 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 518701056; Read time: 0; Write time: 422412 22:46:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 169955328; Read time: 0; Write time: 160936 22:46:10 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 285495296; Read time: 0; Write time: 203824 22:46:10 INFO - Running post-run listener: _upload_blobber_files 22:46:10 INFO - Blob upload gear active. 22:46:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:46:10 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 22:46:10 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'] 22:46:10 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 22:46:10 INFO - (blobuploader) - INFO - Open directory for files ... 22:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:11 INFO - (blobuploader) - INFO - Done attempting. 22:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:12 INFO - (blobuploader) - INFO - Done attempting. 22:46:12 INFO - (blobuploader) - INFO - Iteration through files over. 22:46:12 INFO - Return code: 0 22:46:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:46:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:46:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb23f2eeefefdc12c5c87228eb18d2752d55197f85a25582190eb754c4cffd3cc927ae56dc4432c4d719bad4020ede84931c17a2c477b8cf7aa5f9be87121013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1d2a34ecede81cb250d74f8f63159505284f4f05e6ec8cd366422db842a5c10ec99df499838219952902faaf8483b60edb3980fbfb09bf613a6578ee9cae57c"} 22:46:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:46:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:46:12 INFO - Contents: 22:46:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb23f2eeefefdc12c5c87228eb18d2752d55197f85a25582190eb754c4cffd3cc927ae56dc4432c4d719bad4020ede84931c17a2c477b8cf7aa5f9be87121013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1d2a34ecede81cb250d74f8f63159505284f4f05e6ec8cd366422db842a5c10ec99df499838219952902faaf8483b60edb3980fbfb09bf613a6578ee9cae57c"} 22:46:12 INFO - Running post-run listener: copy_logs_to_upload_dir 22:46:12 INFO - Copying logs to upload dir... 22:46:12 INFO - mkdir: /builds/slave/test/build/upload/logs 22:46:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.118934 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-07 22:46:11.900764) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 22:46:11.904640) ========= 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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb23f2eeefefdc12c5c87228eb18d2752d55197f85a25582190eb754c4cffd3cc927ae56dc4432c4d719bad4020ede84931c17a2c477b8cf7aa5f9be87121013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1d2a34ecede81cb250d74f8f63159505284f4f05e6ec8cd366422db842a5c10ec99df499838219952902faaf8483b60edb3980fbfb09bf613a6578ee9cae57c"} build_url:https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb23f2eeefefdc12c5c87228eb18d2752d55197f85a25582190eb754c4cffd3cc927ae56dc4432c4d719bad4020ede84931c17a2c477b8cf7aa5f9be87121013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1d2a34ecede81cb250d74f8f63159505284f4f05e6ec8cd366422db842a5c10ec99df499838219952902faaf8483b60edb3980fbfb09bf613a6578ee9cae57c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 22:46:11.932346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:46:11.933164) ========= 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=ed14279e38b05397cf4aa391000001a4-1460090628.899621-575121974 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:46:12.013640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 22:46:12.014026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 22:46:12.014385) ========= ========= Total master_lag: 0.29 =========