builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1458007344.69 results: success (0) buildid: 20160314175740 builduid: 728c56d2fcec459ab227e39d174c2ad1 revision: d6ee82b9a74155b6bfd544166f036fc572ae8c56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.687480) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.688149) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.688503) ========= 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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006507 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.716349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.716696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.730409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.730835) ========= 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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005339 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.781311) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.781647) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.782086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.782394) ========= 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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 19:02:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-03-14 19:02:25 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.950831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:24.951214) ========= 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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016332 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:25.000766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 19:02:25.001137) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d6ee82b9a74155b6bfd544166f036fc572ae8c56 --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 d6ee82b9a74155b6bfd544166f036fc572ae8c56 --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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 19:02:25,490 truncating revision to first 12 chars 2016-03-14 19:02:25,490 Setting DEBUG logging. 2016-03-14 19:02:25,490 attempt 1/10 2016-03-14 19:02:25,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d6ee82b9a741?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 19:02:26,176 unpacking tar archive at: fx-team-d6ee82b9a741/testing/mozharness/ program finished with exit code 0 elapsedTime=0.989008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 19:02:26.004010) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:26.004410) ========= echo d6ee82b9a74155b6bfd544166f036fc572ae8c56 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6ee82b9a74155b6bfd544166f036fc572ae8c56'] 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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6ee82b9a74155b6bfd544166f036fc572ae8c56 program finished with exit code 0 elapsedTime=0.004635 script_repo_revision: 'd6ee82b9a74155b6bfd544166f036fc572ae8c56' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:26.056194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:26.056572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 19:02:26.066997) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-14 19:02:26.067325) ========= /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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:02:26 INFO - MultiFileLogger online at 20160314 19:02:26 in /builds/slave/test 19:02:26 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 19:02:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:02:26 INFO - {'append_to_log': False, 19:02:26 INFO - 'base_work_dir': '/builds/slave/test', 19:02:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:02:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:02:26 INFO - 'branch': 'Fx-Team-Non-PGO', 19:02:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:02:26 INFO - 'config_files': ('talos/linux_config.py',), 19:02:26 INFO - 'default_actions': ('clobber', 19:02:26 INFO - 'read-buildbot-config', 19:02:26 INFO - 'download-and-extract', 19:02:26 INFO - 'populate-webroot', 19:02:26 INFO - 'create-virtualenv', 19:02:26 INFO - 'install', 19:02:26 INFO - 'run-tests'), 19:02:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:02:26 INFO - 'download_minidump_stackwalk': True, 19:02:26 INFO - 'download_symbols': 'ondemand', 19:02:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:02:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:02:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:02:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:02:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:02:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:02:26 INFO - 'installer_path': 'installer.exe', 19:02:26 INFO - 'log_level': 'info', 19:02:26 INFO - 'log_name': 'talos', 19:02:26 INFO - 'log_to_console': True, 19:02:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:02:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:02:26 INFO - 'opt_config_files': (), 19:02:26 INFO - 'pip_index': False, 19:02:26 INFO - 'sps_profile': False, 19:02:26 INFO - 'sps_profile_interval': 0, 19:02:26 INFO - 'suite': 'dromaeojs', 19:02:26 INFO - 'system_bits': '32', 19:02:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:02:26 INFO - 'title': 'talos-linux64-ix-053', 19:02:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:02:26 INFO - 'use_talos_json': True, 19:02:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:02:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:02:26 INFO - 'work_dir': 'build'} 19:02:26 INFO - ##### 19:02:26 INFO - ##### Running clobber step. 19:02:26 INFO - ##### 19:02:26 INFO - Running pre-action listener: _resource_record_pre_action 19:02:26 INFO - Running main action method: clobber 19:02:26 INFO - rmtree: /builds/slave/test/build 19:02:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:02:27 INFO - Running post-action listener: _resource_record_post_action 19:02:27 INFO - ##### 19:02:27 INFO - ##### Running read-buildbot-config step. 19:02:27 INFO - ##### 19:02:27 INFO - Running pre-action listener: _resource_record_pre_action 19:02:27 INFO - Running main action method: read_buildbot_config 19:02:27 INFO - Using buildbot properties: 19:02:27 INFO - { 19:02:27 INFO - "project": "", 19:02:27 INFO - "product": "firefox", 19:02:27 INFO - "script_repo_revision": "production", 19:02:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:02:27 INFO - "repository": "", 19:02:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:02:27 INFO - "buildid": "20160314175740", 19:02:27 INFO - "pgo_build": "False", 19:02:27 INFO - "basedir": "/builds/slave/test", 19:02:27 INFO - "buildnumber": 1446, 19:02:27 INFO - "slavename": "talos-linux64-ix-053", 19:02:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:02:27 INFO - "platform": "ubuntu64_hw", 19:02:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:02:27 INFO - "branch": "fx-team", 19:02:27 INFO - "repo_path": "integration/fx-team", 19:02:27 INFO - "revision": "d6ee82b9a74155b6bfd544166f036fc572ae8c56", 19:02:27 INFO - "stage_platform": "linux64", 19:02:27 INFO - "builduid": "728c56d2fcec459ab227e39d174c2ad1", 19:02:27 INFO - "slavebuilddir": "test" 19:02:27 INFO - } 19:02:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:02:27 INFO - Running post-action listener: _resource_record_post_action 19:02:27 INFO - ##### 19:02:27 INFO - ##### Running download-and-extract step. 19:02:27 INFO - ##### 19:02:27 INFO - Running pre-action listener: _resource_record_pre_action 19:02:27 INFO - Running main action method: download_and_extract 19:02:27 INFO - mkdir: /builds/slave/test/build/tests 19:02: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')]} 19:02:27 INFO - https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:02:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:02:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:02:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:28 INFO - Downloaded 1361 bytes. 19:02:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:02:28 INFO - Using the following test package requirements: 19:02:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:02:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:02:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:02:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:02:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:02:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:02:28 INFO - u'jsshell-linux-x86_64.zip'], 19:02:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:02:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:02:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:02:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:02:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:02:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:02:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:02:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:02:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:02:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:02:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:02:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:28 INFO - https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:29 INFO - Downloaded 21990961 bytes. 19:02:29 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'] 19:02:29 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 19:02:30 INFO - Return code: 0 19:02:30 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 19:02: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')]} 19:02:30 INFO - https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:02:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:02:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:02:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:32 INFO - Downloaded 21990961 bytes. 19:02:32 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'] 19:02:32 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 19:02:33 INFO - Return code: 0 19:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:33 INFO - https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:02:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:02:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:02:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:34 INFO - Downloaded 10845263 bytes. 19:02:34 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'] 19:02:34 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 19:02:34 INFO - Return code: 0 19:02:34 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')]} 19:02:34 INFO - https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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 19:02:36 INFO - Downloaded 54147035 bytes. 19:02:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:02:36 INFO - mkdir: /builds/slave/test/properties 19:02:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:02:36 INFO - Writing to file /builds/slave/test/properties/build_url 19:02:36 INFO - Contents: 19:02:36 INFO - build_url:https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:02:37 INFO - Running post-action listener: _resource_record_post_action 19:02:37 INFO - Running post-action listener: set_extra_try_arguments 19:02:37 INFO - ##### 19:02:37 INFO - ##### Running populate-webroot step. 19:02:37 INFO - ##### 19:02:37 INFO - Running pre-action listener: _resource_record_pre_action 19:02:37 INFO - Running main action method: populate_webroot 19:02:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:02:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:02:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:02:37 INFO - '--tppagecycles', 19:02:37 INFO - '7'], 19:02:37 INFO - 'tests': ['tsvgm']}}, 19:02:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:02:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:02:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:02:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:02:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:37 INFO - 'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:37 INFO - 'tests': ['damp', 'tps']}, 19:02:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:37 INFO - 'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['damp', 'tps']}, 19:02:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:02:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:02:37 INFO - 'other': {'tests': ['a11yr', 19:02:37 INFO - 'ts_paint', 19:02:37 INFO - 'tpaint', 19:02:37 INFO - 'sessionrestore', 19:02:37 INFO - 'sessionrestore_no_auto_restore', 19:02:37 INFO - 'tabpaint']}, 19:02:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['a11yr', 19:02:37 INFO - 'ts_paint', 19:02:37 INFO - 'tpaint', 19:02:37 INFO - 'sessionrestore', 19:02:37 INFO - 'sessionrestore_no_auto_restore', 19:02:37 INFO - 'tabpaint']}, 19:02:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['a11yr', 19:02:37 INFO - 'ts_paint', 19:02:37 INFO - 'tpaint', 19:02:37 INFO - 'sessionrestore', 19:02:37 INFO - 'sessionrestore_no_auto_restore', 19:02:37 INFO - 'tabpaint']}, 19:02:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['a11yr', 19:02:37 INFO - 'ts_paint', 19:02:37 INFO - 'tpaint', 19:02:37 INFO - 'sessionrestore', 19:02:37 INFO - 'sessionrestore_no_auto_restore', 19:02:37 INFO - 'tabpaint']}, 19:02:37 INFO - 'other_l64': {'tests': ['a11yr', 19:02:37 INFO - 'ts_paint', 19:02:37 INFO - 'tpaint', 19:02:37 INFO - 'sessionrestore', 19:02:37 INFO - 'sessionrestore_no_auto_restore', 19:02:37 INFO - 'tabpaint']}, 19:02:37 INFO - 'other_nol64': {'tests': ['a11yr', 19:02:37 INFO - 'ts_paint', 19:02:37 INFO - 'tpaint', 19:02:37 INFO - 'sessionrestore', 19:02:37 INFO - 'sessionrestore_no_auto_restore', 19:02:37 INFO - 'tabpaint']}, 19:02:37 INFO - 'svgr': {'tests': ['tsvgx', 19:02:37 INFO - 'tsvgr_opacity', 19:02:37 INFO - 'tart', 19:02:37 INFO - 'tscrollx', 19:02:37 INFO - 'cart']}, 19:02:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['tsvgx', 19:02:37 INFO - 'tsvgr_opacity', 19:02:37 INFO - 'tart', 19:02:37 INFO - 'tscrollx', 19:02:37 INFO - 'cart']}, 19:02:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:37 INFO - 'tests': ['tp5o']}, 19:02:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:37 INFO - 'talos_options': ['--e10s'], 19:02:37 INFO - 'tests': ['tp5o']}, 19:02:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:37 INFO - 'talos_options': ['--xperf_path', 19:02:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:37 INFO - 'tests': ['tp5n']}, 19:02:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:37 INFO - 'talos_options': ['--e10s', 19:02:37 INFO - '--xperf_path', 19:02:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:37 INFO - 'tests': ['tp5n']}}, 19:02:37 INFO - 'talos.zip': {'path': '', 19:02:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:02:37 INFO - Running post-action listener: _resource_record_post_action 19:02:37 INFO - ##### 19:02:37 INFO - ##### Running create-virtualenv step. 19:02:37 INFO - ##### 19:02:37 INFO - Running pre-action listener: _resource_record_pre_action 19:02:37 INFO - Running main action method: create_virtualenv 19:02:37 INFO - Creating virtualenv /builds/slave/test/build/venv 19:02:37 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 19:02:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:02:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:02:37 INFO - Using real prefix '/usr' 19:02:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:02:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:02:39 INFO - Installing pip.................done. 19:02:39 INFO - Return code: 0 19:02:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:02:39 INFO - Using env: {'DISPLAY': ':0', 19:02:39 INFO - 'HOME': '/home/cltbld', 19:02:39 INFO - 'LANG': 'en_US.UTF-8', 19:02:39 INFO - 'LANGUAGE': 'en_US:en', 19:02:39 INFO - 'LOGNAME': 'cltbld', 19:02:39 INFO - 'MAIL': '/var/mail/cltbld', 19:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:39 INFO - 'MOZ_NO_REMOTE': '1', 19:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:39 INFO - 'NO_EM_RESTART': '1', 19:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:39 INFO - 'PWD': '/builds/slave/test', 19:02:39 INFO - 'SHELL': '/bin/bash', 19:02:39 INFO - 'SHLVL': '1', 19:02:39 INFO - 'TERM': 'linux', 19:02:39 INFO - 'TMOUT': '86400', 19:02:39 INFO - 'USER': 'cltbld', 19:02:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:39 INFO - '_': '/tools/buildbot/bin/python'} 19:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:39 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 19:02:39 INFO - Cleaning up... 19:02:39 INFO - Return code: 0 19:02:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:02:39 INFO - Using env: {'DISPLAY': ':0', 19:02:39 INFO - 'HOME': '/home/cltbld', 19:02:39 INFO - 'LANG': 'en_US.UTF-8', 19:02:39 INFO - 'LANGUAGE': 'en_US:en', 19:02:39 INFO - 'LOGNAME': 'cltbld', 19:02:39 INFO - 'MAIL': '/var/mail/cltbld', 19:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:39 INFO - 'MOZ_NO_REMOTE': '1', 19:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:39 INFO - 'NO_EM_RESTART': '1', 19:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:39 INFO - 'PWD': '/builds/slave/test', 19:02:39 INFO - 'SHELL': '/bin/bash', 19:02:39 INFO - 'SHLVL': '1', 19:02:39 INFO - 'TERM': 'linux', 19:02:39 INFO - 'TMOUT': '86400', 19:02:39 INFO - 'USER': 'cltbld', 19:02:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:39 INFO - '_': '/tools/buildbot/bin/python'} 19:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:40 INFO - Downloading/unpacking psutil>=0.7.1 19:02:40 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 19:02:40 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 19:02:40 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 19:02:40 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 19:02:40 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 19:02:40 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 19:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:41 INFO - Installing collected packages: psutil 19:02:41 INFO - Running setup.py install for psutil 19:02:42 INFO - building 'psutil._psutil_linux' extension 19:02:42 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 19:02:42 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 19:02:42 INFO - building 'psutil._psutil_posix' extension 19:02:42 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 19:02:42 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 19:02:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:42 INFO - Successfully installed psutil 19:02:42 INFO - Cleaning up... 19:02:42 INFO - Return code: 0 19:02:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:42 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 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:42 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 19:02:42 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 19:02:42 INFO - Using env: {'DISPLAY': ':0', 19:02:42 INFO - 'HOME': '/home/cltbld', 19:02:42 INFO - 'LANG': 'en_US.UTF-8', 19:02:42 INFO - 'LANGUAGE': 'en_US:en', 19:02:42 INFO - 'LOGNAME': 'cltbld', 19:02:42 INFO - 'MAIL': '/var/mail/cltbld', 19:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:42 INFO - 'MOZ_NO_REMOTE': '1', 19:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:42 INFO - 'NO_EM_RESTART': '1', 19:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:42 INFO - 'PWD': '/builds/slave/test', 19:02:42 INFO - 'SHELL': '/bin/bash', 19:02:42 INFO - 'SHLVL': '1', 19:02:42 INFO - 'TERM': 'linux', 19:02:42 INFO - 'TMOUT': '86400', 19:02:42 INFO - 'USER': 'cltbld', 19:02:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:42 INFO - '_': '/tools/buildbot/bin/python'} 19:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:02:42 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 19:02:42 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 19:02:42 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 19:02:42 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 19:02:42 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 19:02:42 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 19:02:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:02:44 INFO - Installing collected packages: mozsystemmonitor 19:02:44 INFO - Running setup.py install for mozsystemmonitor 19:02:44 INFO - Successfully installed mozsystemmonitor 19:02:44 INFO - Cleaning up... 19:02:44 INFO - Return code: 0 19:02:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:02:44 INFO - Using env: {'DISPLAY': ':0', 19:02:44 INFO - 'HOME': '/home/cltbld', 19:02:44 INFO - 'LANG': 'en_US.UTF-8', 19:02:44 INFO - 'LANGUAGE': 'en_US:en', 19:02:44 INFO - 'LOGNAME': 'cltbld', 19:02:44 INFO - 'MAIL': '/var/mail/cltbld', 19:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:44 INFO - 'MOZ_NO_REMOTE': '1', 19:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:44 INFO - 'NO_EM_RESTART': '1', 19:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:44 INFO - 'PWD': '/builds/slave/test', 19:02:44 INFO - 'SHELL': '/bin/bash', 19:02:44 INFO - 'SHLVL': '1', 19:02:44 INFO - 'TERM': 'linux', 19:02:44 INFO - 'TMOUT': '86400', 19:02:44 INFO - 'USER': 'cltbld', 19:02:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:44 INFO - '_': '/tools/buildbot/bin/python'} 19:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:44 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:47 INFO - Downloading blobuploader-1.2.4.tar.gz 19:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:02:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:02:47 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 19:02:47 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 19:02:47 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 19:02:47 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 19:02:47 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 19:02:47 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 19:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:02:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:02:48 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 19:02:48 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 19:02:48 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 19:02:48 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 19:02:48 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 19:02:48 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 19:02:48 INFO - Downloading docopt-0.6.1.tar.gz 19:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:02:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:02:48 INFO - Running setup.py install for blobuploader 19:02:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:02:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:02:48 INFO - Running setup.py install for requests 19:02:48 INFO - Running setup.py install for docopt 19:02:49 INFO - Successfully installed blobuploader requests docopt 19:02:49 INFO - Cleaning up... 19:02:49 INFO - Return code: 0 19:02:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:49 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 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:49 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 19:02:49 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 19:02:49 INFO - Using env: {'DISPLAY': ':0', 19:02:49 INFO - 'HOME': '/home/cltbld', 19:02:49 INFO - 'LANG': 'en_US.UTF-8', 19:02:49 INFO - 'LANGUAGE': 'en_US:en', 19:02:49 INFO - 'LOGNAME': 'cltbld', 19:02:49 INFO - 'MAIL': '/var/mail/cltbld', 19:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:49 INFO - 'MOZ_NO_REMOTE': '1', 19:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:49 INFO - 'NO_EM_RESTART': '1', 19:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:49 INFO - 'PWD': '/builds/slave/test', 19:02:49 INFO - 'SHELL': '/bin/bash', 19:02:49 INFO - 'SHLVL': '1', 19:02:49 INFO - 'TERM': 'linux', 19:02:49 INFO - 'TMOUT': '86400', 19:02:49 INFO - 'USER': 'cltbld', 19:02:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:49 INFO - '_': '/tools/buildbot/bin/python'} 19:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:49 INFO - Running setup.py (path:/tmp/pip-2r7rcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:49 INFO - Running setup.py (path:/tmp/pip-T5nmw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:49 INFO - Running setup.py (path:/tmp/pip-CHKBem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:49 INFO - Running setup.py (path:/tmp/pip-WEY7nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:49 INFO - Running setup.py (path:/tmp/pip-H74rpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:49 INFO - Running setup.py (path:/tmp/pip-3X2XFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:49 INFO - Running setup.py (path:/tmp/pip-GNDTEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:49 INFO - Running setup.py (path:/tmp/pip-BvI7s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:49 INFO - Running setup.py (path:/tmp/pip-yvPt9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:49 INFO - Running setup.py (path:/tmp/pip-SqfocP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:50 INFO - Running setup.py (path:/tmp/pip-5DtObd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:50 INFO - Running setup.py (path:/tmp/pip-EA9VNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:50 INFO - Running setup.py (path:/tmp/pip-5GDaKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:50 INFO - Running setup.py (path:/tmp/pip-r3inyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:50 INFO - Running setup.py (path:/tmp/pip-8DVIpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:50 INFO - Running setup.py (path:/tmp/pip-DU5aHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:50 INFO - Running setup.py (path:/tmp/pip-Fz94Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:50 INFO - Running setup.py install for manifestparser 19:02:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:02:50 INFO - Running setup.py install for mozcrash 19:02:50 INFO - Running setup.py install for mozdebug 19:02:50 INFO - Running setup.py install for mozdevice 19:02:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:02:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:02:50 INFO - Running setup.py install for mozfile 19:02:51 INFO - Running setup.py install for mozhttpd 19:02:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozinfo 19:02:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozInstall 19:02:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozleak 19:02:51 INFO - Running setup.py install for mozlog 19:02:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for moznetwork 19:02:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozprocess 19:02:51 INFO - Running setup.py install for mozprofile 19:02:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozrunner 19:02:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:02:52 INFO - Running setup.py install for mozscreenshot 19:02:52 INFO - Running setup.py install for moztest 19:02:52 INFO - Running setup.py install for mozversion 19:02:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:02:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:02:52 INFO - Cleaning up... 19:02:52 INFO - Return code: 0 19:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:52 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 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:52 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 19:02:52 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 19:02:52 INFO - Using env: {'DISPLAY': ':0', 19:02:52 INFO - 'HOME': '/home/cltbld', 19:02:52 INFO - 'LANG': 'en_US.UTF-8', 19:02:52 INFO - 'LANGUAGE': 'en_US:en', 19:02:52 INFO - 'LOGNAME': 'cltbld', 19:02:52 INFO - 'MAIL': '/var/mail/cltbld', 19:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:52 INFO - 'MOZ_NO_REMOTE': '1', 19:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:52 INFO - 'NO_EM_RESTART': '1', 19:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:52 INFO - 'PWD': '/builds/slave/test', 19:02:52 INFO - 'SHELL': '/bin/bash', 19:02:52 INFO - 'SHLVL': '1', 19:02:52 INFO - 'TERM': 'linux', 19:02:52 INFO - 'TMOUT': '86400', 19:02:52 INFO - 'USER': 'cltbld', 19:02:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:52 INFO - '_': '/tools/buildbot/bin/python'} 19:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:52 INFO - Running setup.py (path:/tmp/pip-2wKAmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:52 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)) 19:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:52 INFO - Running setup.py (path:/tmp/pip-myCkR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:52 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)) 19:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:52 INFO - Running setup.py (path:/tmp/pip-LAxlmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:52 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)) 19:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:52 INFO - Running setup.py (path:/tmp/pip-4vLvSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:52 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)) 19:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:52 INFO - Running setup.py (path:/tmp/pip-G4iMie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:52 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)) 19:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:52 INFO - Running setup.py (path:/tmp/pip-olclTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:53 INFO - Running setup.py (path:/tmp/pip-C2R_fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:53 INFO - Running setup.py (path:/tmp/pip-ILNJoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:53 INFO - Running setup.py (path:/tmp/pip-EQ7eqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:53 INFO - Running setup.py (path:/tmp/pip-tg4w7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:53 INFO - Running setup.py (path:/tmp/pip-Mxieko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:53 INFO - Running setup.py (path:/tmp/pip-fkG9vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:53 INFO - Running setup.py (path:/tmp/pip-rTRjo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:53 INFO - Running setup.py (path:/tmp/pip-8ih0XG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:53 INFO - Running setup.py (path:/tmp/pip-K5fSKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:53 INFO - Running setup.py (path:/tmp/pip-HbqHgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:53 INFO - Running setup.py (path:/tmp/pip-j9KVp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:53 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)) 19:02:53 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)) 19:02:53 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)) 19:02:53 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)) 19:02:53 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)) 19:02:53 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)) 19:02:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:55 INFO - Downloading blessings-1.6.tar.gz 19:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:02:55 INFO - Installing collected packages: blessings 19:02:55 INFO - Running setup.py install for blessings 19:02:55 INFO - Successfully installed blessings 19:02:55 INFO - Cleaning up... 19:02:55 INFO - Return code: 0 19:02:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:02:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:56 INFO - Reading from file tmpfile_stdout 19:02:56 INFO - Current package versions: 19:02:56 INFO - argparse == 1.2.1 19:02:56 INFO - blessings == 1.6 19:02:56 INFO - blobuploader == 1.2.4 19:02:56 INFO - docopt == 0.6.1 19:02:56 INFO - manifestparser == 1.1 19:02:56 INFO - mozInstall == 1.12 19:02:56 INFO - mozcrash == 0.17 19:02:56 INFO - mozdebug == 0.1 19:02:56 INFO - mozdevice == 0.48 19:02:56 INFO - mozfile == 1.2 19:02:56 INFO - mozhttpd == 0.7 19:02:56 INFO - mozinfo == 0.9 19:02:56 INFO - mozleak == 0.1 19:02:56 INFO - mozlog == 3.1 19:02:56 INFO - moznetwork == 0.27 19:02:56 INFO - mozprocess == 0.22 19:02:56 INFO - mozprofile == 0.28 19:02:56 INFO - mozrunner == 6.11 19:02:56 INFO - mozscreenshot == 0.1 19:02:56 INFO - mozsystemmonitor == 0.0 19:02:56 INFO - moztest == 0.7 19:02:56 INFO - mozversion == 1.4 19:02:56 INFO - psutil == 3.1.1 19:02:56 INFO - requests == 1.2.3 19:02:56 INFO - wsgiref == 0.1.2 19:02:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:56 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')]} 19:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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')]} 19:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:56 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 19:02:56 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 19:02:56 INFO - Using env: {'DISPLAY': ':0', 19:02:56 INFO - 'HOME': '/home/cltbld', 19:02:56 INFO - 'LANG': 'en_US.UTF-8', 19:02:56 INFO - 'LANGUAGE': 'en_US:en', 19:02:56 INFO - 'LOGNAME': 'cltbld', 19:02:56 INFO - 'MAIL': '/var/mail/cltbld', 19:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:56 INFO - 'MOZ_NO_REMOTE': '1', 19:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:56 INFO - 'NO_EM_RESTART': '1', 19:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:56 INFO - 'PWD': '/builds/slave/test', 19:02:56 INFO - 'SHELL': '/bin/bash', 19:02:56 INFO - 'SHLVL': '1', 19:02:56 INFO - 'TERM': 'linux', 19:02:56 INFO - 'TMOUT': '86400', 19:02:56 INFO - 'USER': 'cltbld', 19:02:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:56 INFO - '_': '/tools/buildbot/bin/python'} 19:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 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)) 19:02:56 INFO - Cleaning up... 19:02:56 INFO - Return code: 0 19:02:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:02:56 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')]} 19:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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')]} 19:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:56 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 19:02:56 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 19:02:56 INFO - Using env: {'DISPLAY': ':0', 19:02:56 INFO - 'HOME': '/home/cltbld', 19:02:56 INFO - 'LANG': 'en_US.UTF-8', 19:02:56 INFO - 'LANGUAGE': 'en_US:en', 19:02:56 INFO - 'LOGNAME': 'cltbld', 19:02:56 INFO - 'MAIL': '/var/mail/cltbld', 19:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:56 INFO - 'MOZ_NO_REMOTE': '1', 19:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:56 INFO - 'NO_EM_RESTART': '1', 19:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:56 INFO - 'PWD': '/builds/slave/test', 19:02:56 INFO - 'SHELL': '/bin/bash', 19:02:56 INFO - 'SHLVL': '1', 19:02:56 INFO - 'TERM': 'linux', 19:02:56 INFO - 'TMOUT': '86400', 19:02:56 INFO - 'USER': 'cltbld', 19:02:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:56 INFO - '_': '/tools/buildbot/bin/python'} 19:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:56 INFO - Downloading/unpacking jsonschema 19:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:02:58 INFO - Downloading/unpacking functools32 (from jsonschema) 19:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:58 INFO - Downloading functools32-3.2.3-2.tar.gz 19:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:02:58 INFO - warning: no files found matching '*.txt' 19:02:58 INFO - no previously-included directories found matching 'build' 19:02:58 INFO - no previously-included directories found matching 'dist' 19:02:58 INFO - no previously-included directories found matching '.git*' 19:02:58 INFO - Installing collected packages: jsonschema, functools32 19:02:58 INFO - Running setup.py install for functools32 19:02:58 INFO - warning: no files found matching '*.txt' 19:02:58 INFO - no previously-included directories found matching 'build' 19:02:58 INFO - no previously-included directories found matching 'dist' 19:02:58 INFO - no previously-included directories found matching '.git*' 19:02:58 INFO - Successfully installed jsonschema functools32 19:02:58 INFO - Cleaning up... 19:02:58 INFO - Return code: 0 19:02:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:58 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 0x7fd90ed1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, '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': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', '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 19:02:58 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 19:02:58 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 19:02:58 INFO - Using env: {'DISPLAY': ':0', 19:02:58 INFO - 'HOME': '/home/cltbld', 19:02:58 INFO - 'LANG': 'en_US.UTF-8', 19:02:58 INFO - 'LANGUAGE': 'en_US:en', 19:02:58 INFO - 'LOGNAME': 'cltbld', 19:02:58 INFO - 'MAIL': '/var/mail/cltbld', 19:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:58 INFO - 'MOZ_NO_REMOTE': '1', 19:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:58 INFO - 'NO_EM_RESTART': '1', 19:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:58 INFO - 'PWD': '/builds/slave/test', 19:02:58 INFO - 'SHELL': '/bin/bash', 19:02:58 INFO - 'SHLVL': '1', 19:02:58 INFO - 'TERM': 'linux', 19:02:58 INFO - 'TMOUT': '86400', 19:02:58 INFO - 'USER': 'cltbld', 19:02:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:58 INFO - '_': '/tools/buildbot/bin/python'} 19:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:59 INFO - Downloading/unpacking flake8 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:03:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:03:00 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 19:03:00 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 19:03:00 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 19:03:00 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 19:03:00 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 19:03:00 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 19:03:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:03:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:03:01 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 19:03:01 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 19:03:01 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 19:03:01 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 19:03:01 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 19:03:01 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 19:03:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:03:01 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 19:03:01 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 19:03:01 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 19:03:01 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 19:03:01 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 19:03:01 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 19:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:03:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:03:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:03:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:03:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:03:01 INFO - no previously-included directories found matching 'docs/_build' 19:03:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:03:01 INFO - Running setup.py install for pep8 19:03:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:03:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:03:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:03:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:03:01 INFO - no previously-included directories found matching 'docs/_build' 19:03:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:03:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:03:01 INFO - Cleaning up... 19:03:01 INFO - Return code: 0 19:03:01 INFO - Running post-action listener: _resource_record_post_action 19:03:01 INFO - Running post-action listener: _start_resource_monitoring 19:03:01 INFO - Starting resource monitoring. 19:03:01 INFO - ##### 19:03:01 INFO - ##### Running install step. 19:03:01 INFO - ##### 19:03:01 INFO - Running pre-action listener: _resource_record_pre_action 19:03:01 INFO - Running main action method: install 19:03:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:02 INFO - Reading from file tmpfile_stdout 19:03:02 INFO - Detecting whether we're running mozinstall >=1.0... 19:03:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:03:02 INFO - Reading from file tmpfile_stdout 19:03:02 INFO - Output received: 19:03:02 INFO - Usage: mozinstall [options] installer 19:03:02 INFO - Options: 19:03:02 INFO - -h, --help show this help message and exit 19:03:02 INFO - -d DEST, --destination=DEST 19:03:02 INFO - Directory to install application into. [default: 19:03:02 INFO - "/builds/slave/test"] 19:03:02 INFO - --app=APP Application being installed. [default: firefox] 19:03:02 INFO - mkdir: /builds/slave/test/build/application 19:03:02 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'] 19:03:02 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 19:03:17 INFO - Reading from file tmpfile_stdout 19:03:17 INFO - Output received: 19:03:17 INFO - /builds/slave/test/build/application/firefox/firefox 19:03:17 INFO - Running post-action listener: _resource_record_post_action 19:03:17 INFO - ##### 19:03:17 INFO - ##### Running run-tests step. 19:03:17 INFO - ##### 19:03:17 INFO - Running pre-action listener: _resource_record_pre_action 19:03:17 INFO - Running main action method: run_tests 19:03:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:03:17 INFO - Python 2.7.3 19:03:17 INFO - Return code: 0 19:03:17 INFO - grabbing minidump binary from tooltool 19:03:17 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')]} 19:03:17 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 0x2788160>, '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 0x2789060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27894f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:03:17 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 19:03:17 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 19:03:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:03:17 INFO - Return code: 0 19:03:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:03:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:03:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:03:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:03:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:03:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:03:18 INFO - Return code: 0 19:03:18 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/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 19:03:18 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/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 19:03:18 INFO - Using env: {'DISPLAY': ':0', 19:03:18 INFO - 'HOME': '/home/cltbld', 19:03:18 INFO - 'LANG': 'en_US.UTF-8', 19:03:18 INFO - 'LANGUAGE': 'en_US:en', 19:03:18 INFO - 'LOGNAME': 'cltbld', 19:03:18 INFO - 'MAIL': '/var/mail/cltbld', 19:03:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:03:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:18 INFO - 'MOZ_NO_REMOTE': '1', 19:03:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:18 INFO - 'NO_EM_RESTART': '1', 19:03:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:18 INFO - 'PWD': '/builds/slave/test', 19:03:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:03:18 INFO - 'SHELL': '/bin/bash', 19:03:18 INFO - 'SHLVL': '1', 19:03:18 INFO - 'TERM': 'linux', 19:03:18 INFO - 'TMOUT': '86400', 19:03:18 INFO - 'USER': 'cltbld', 19:03:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972', 19:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:18 INFO - '_': '/tools/buildbot/bin/python'} 19:03:18 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/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 19:03:19 INFO - mozversion application_buildid: 20160314175740 19:03:19 INFO - mozversion application_changeset: d6ee82b9a74155b6bfd544166f036fc572ae8c56 19:03:19 INFO - mozversion application_display_name: Nightly 19:03:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:03:19 INFO - mozversion application_name: Firefox 19:03:19 INFO - mozversion application_remotingname: firefox 19:03:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:03:19 INFO - mozversion application_vendor: Mozilla 19:03:19 INFO - mozversion application_version: 48.0a1 19:03:19 INFO - mozversion platform_buildid: 20160314175740 19:03:19 INFO - mozversion platform_changeset: d6ee82b9a74155b6bfd544166f036fc572ae8c56 19:03:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:03:19 INFO - mozversion platform_version: 48.0a1 19:03:19 INFO - using testdate: 1458007399 19:03:19 INFO - actual date: 1458007399 19:03:19 INFO - starting webserver on 'localhost:42708' 19:03:19 INFO - SUITE-START | Running 2 tests 19:03:19 INFO - TEST-START | dromaeo_css 19:03:19 INFO - operating with platform_type : linux_ 19:03:19 INFO - Initialising browser for dromaeo_css test... 19:03:19 INFO - TEST-INFO | started process 3501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVHLtBX/profile http://localhost:42708/getInfo.html) 19:03:23 INFO - PROCESS | 3501 | __metrics Screen width/height:1600/1200 19:03:23 INFO - PROCESS | 3501 | colorDepth:24 19:03:23 INFO - PROCESS | 3501 | Browser inner width/height: 1024/697 19:03:23 INFO - PROCESS | 3501 | __metrics 19:03:24 ERROR - PROCESS | 3501 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:03:24 INFO - PROCESS | 3501 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:03:25 INFO - TEST-INFO | 3501: exit 0 19:03:25 INFO - Browser initialized. 19:03:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:03:25 INFO - TEST-INFO | started process 3595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVHLtBX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:37 INFO - PROCESS | 3595 | RSS: Main: 153751552 19:03:37 INFO - PROCESS | 3595 | 19:04:28 INFO - PROCESS | 3595 | 1458007468602 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] 19:06:40 INFO - PROCESS | 3595 | Cycle 1(1): loaded http://localhost:42708/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42708/tests/dromaeo/cssquery-ext.html) 19:06:41 INFO - PROCESS | 3595 | RSS: Main: 243650560 19:06:41 INFO - PROCESS | 3595 | 19:09:43 INFO - PROCESS | 3595 | Cycle 1(1): loaded http://localhost:42708/tests/dromaeo/cssquery-ext.html (next: http://localhost:42708/tests/dromaeo/cssquery-jquery.html) 19:09:43 INFO - PROCESS | 3595 | RSS: Main: 241541120 19:09:43 INFO - PROCESS | 3595 | 19:12:45 INFO - PROCESS | 3595 | Cycle 1(1): loaded http://localhost:42708/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42708/tests/dromaeo/cssquery-mootools.html) 19:12:46 INFO - PROCESS | 3595 | RSS: Main: 229605376 19:12:46 INFO - PROCESS | 3595 | 19:15:48 INFO - PROCESS | 3595 | Cycle 1(1): loaded http://localhost:42708/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42708/tests/dromaeo/cssquery-prototype.html) 19:15:48 INFO - PROCESS | 3595 | RSS: Main: 203948032 19:15:48 INFO - PROCESS | 3595 | 19:18:51 INFO - PROCESS | 3595 | Cycle 1(1): loaded http://localhost:42708/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42708/tests/dromaeo/cssquery-yui.html) 19:18:52 INFO - PROCESS | 3595 | RSS: Main: 202481664 19:18:52 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | Cycle 1(1): loaded http://localhost:42708/tests/dromaeo/cssquery-yui.html (next: http://localhost:42708/tests/dromaeo/cssquery-dojo.html) 19:21:55 INFO - PROCESS | 3595 | RSS: Main: 279425024 19:21:55 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | __start_tp_report 19:21:55 INFO - PROCESS | 3595 | _x_x_mozilla_page_load 19:21:55 INFO - PROCESS | 3595 | _x_x_mozilla_page_load_details 19:21:55 INFO - PROCESS | 3595 | |i|pagename|runs| 19:21:55 INFO - PROCESS | 3595 | |0;dojo.html;2614.777743891769;2666.043263515496;2678.6116013178075;2683.476722039203;2703.689075756288;4634.8841278968;4668.066386722657;4671.20589499785;4681.648876334271;4752.857414277569;4726.0784147091335;4740.810367585301;4748.2165442702;4756.143894099061;4792.784324705388;4313.892152696192;4400.6919515634;4442.466903971528;4475.776211189427;4490.438695163105;4309.849155279566;4388.473383194021;4443.666724995622;4451.643868490513;4463.040446304044;4274.97862510687;4319.416878721364;4322.546132656057;4366.628836548897;4368.475782906072;4301.247281725686;4311.956880431187;4313.266744653385;4343.435353404069;4344.370066340363;4282.229198744225;4303.612674859246;4307.440032795748;4348.978255108705;4353.412289340962;4602.654800889946;4681.508441613616;4681.5318468153255;4693.741844198567;4731.976340118312;5112.897742045176;5116.795328186868;5118.2834403183215;5118.59051275897;5119.846404607868;5049.84850454487;5079.085764562377;5132.1275383184575;5133.435322114565;5148.0476111919415;4780.11567859947;4795.064962332312;4796.976015119972;4806.519348065235;4835.323054772335;5247.527722504993;5251.711155886463;5252.05463016653;5257.342832145981;5310.017646735367;4875.68308059975;4994.425641051253;4997.9750101249265;5035.496450354935;5090.796368145307;5117.616178786606;5122.948770512322;5132.666376685504;5136.280920671109;5146.948530514722;5097.617678674114;5100.362454693163;5102.668326558836;5105.923411148761;5130.717810520383;4933.45731969483;4997.800087996512;5092.363454568179;5132.9743351283005;5144.38267407906;4337.479502459725;4358.193734159191;4361.258586040381;4367.388565600755;4404.317330813729;3762.2287431076566;3796.8291426885858;3804.7907365094634;3832.0994566276904;3871.1289959759392;4297.462817147856;4321.546237645065;4324.308110702273;4364.8908777280185;4366.214081465367;5066.240063990431;5074.391073071181;5095.337606111182;5101.923471147936;5140.820071297487;4251.149770046003;4322.71902326354;4330.415393921843;4333.848315308949;4377.102693947797;4588.95411045892;4607.976960115245;4637.86086417408;4659.976700116477;4663.953360466352;4751.287306903992;4789.137955168034;4802.111609352281;4808.735519546459;4859.757012149307;5062.417821950523;5101.056304583515;5105.285260063668;5111.514406131411;5124.641275110706;4740.454847692422;4770.952290477051;4793.976030119827;4842.7336496491625;4846.61227101824;4939.431965324034;4968.652194346361;4971.279164521052;4973.229149481836;5022.623303252198;5030.044291584587;5032.194848824171;5042.420121686053;5055.721935293447;5102.489751025017;4899.289603007615;4920.975395123001;4924.556789888928;4931.432885218246;4986.700797952134;4897.510248975074;4911.926321105258;4918.114739346952;4920.778564964514;4921;4764.118638051971;4769.737664428351;4854.679016288664;4867.610591152628;4914.827981020647;4913.091078150554;4934.319734801407;4934.358533390637;4936.062148191832;4982.850514484571;4837.250226214942;4840.104580652591;4843;4844.2007068833245;4895.6817806843865 19:21:55 INFO - PROCESS | 3595 | |1;ext.html;492.79548987170324;524.514823787996;534.4495169974927;543.4456854008911;558.9888202235956;26892.058777942777;27434.314142146457;27455.450890982167;27470.17589472319;27486.86256568719;27481.450370992567;35180.648193518056;35775.82112089443;35825.41745825416;35867.4619880702;7574.128975167871;7670.463067585271;7674.654640541161;7675;7677.500962437452;7611.391088712918;7722.498037627564;7736.806579835493;7741;7743.806404839867;7736.226377362275;7805.219478052206;7810.297073263405;7812.648430820598;8018.077921039067;7857.607119643995;7930.444868859182;7933.722319718782;7970;7977.401694872879;7845.882311765328;7955.8408831823035;7968.163342848975;7968.243016913384;7970.960145199295;38761;39133.60866391357;39216.41175382372;39307.803460982796;39312.606873931465;3199.8240096794666;3257.527658489506;3310.337932413503;3361.210115622851;3512.227309991798;28830.71169288301;28965.42069158605;29403.11790646284;29727.554086688717;29781.404371912442;3130.4052230076213;3138.8587513561943;3157.3053928135773;3215.5980502437196;3236.3689080629288;249518;249788;249936;250242;250322;42624.36063459051;56140.71929640407;56303;56757.14864277039;56775.43224567702;42314.365284520754;42588;42629.57370426318;42651.78674106672;42682.57317426848;13513.932430337982;13780.10429322091;13807;13880.722385552232;13923.86076139246;10465.162786977024;10492.73768155787;10523.26337156407;10523.84214236787;10559.894401056044;14230.715385692436;14404.639884002983;14594.635134121732;14668.486602968846;14848.92575537137;5878.412158784087;5915.674637894957;5956.791512297049;5967.761289548456;5974.103884417372;883.823235352932;928.7956649537091;945.6170251048336;1032.4270030133348;1035.808375450529;26788;28247.361869960543;30891.38217235643;31877.840610796797;33165.17087072794;1003.5985605757755;1014.0771897573173;1027.2860362048455;1060.7772367802693;1097.8737445193744;14020.509282175279;14397.280135993158;14749.631259218606;14776.778348324784;14811.111333320036;180606;419072;426431;426658;427665;46936;47216.29175562301;47532.28701569479;47549.76225118921;47582.76208619004;1088.9183311251688;1209.6008317255285;1267.1953309648256;1290.3612711707765;1307.8169056332122;25689.87155064213;27721.861390692917;27744.167674969784;27884.30289242704;27997.300067498476;34546.65453345434;34975.65024349724;35342.82328588341;35721.64278357287;35723.46414803728;181178;183680;183966;184125;184640;26904.865475672497;29827.10518684443;31217.843910780302;31634;31692.683073169894;34359;34370.82814585911;35106.64893351034;35158.29683406369;35417.114572135906;30676.539851902686;30937.8453107733;31617.8419107903;33129.17177070593;33813;33160.668393315755;33229.66770332266;33585.83207083949;33628.663713362555;33789.32421351608;33220.66779332176;33239;33498.66501334956;33516.66483335135;33532.83233583914;29196.416071678872;30073.54889676613;30241.395172096876;30300.090997270116;30326.815684353707;23778.286651400485;23843.165489208488;23857.761422385553;24029.51940961136;24115.758842411353 19:21:55 INFO - PROCESS | 3595 | |2;jquery.html;350.7106637024454;353.29341317365277;355.2132027558956;358.08866434923124;363.93994990826513;10645.946770266148;11132.721681957955;11136.164787640919;15623.84376156238;16103.436379726712;16600.58498537537;16939.322427102932;17345.479635610922;17771.73342399862;17776.46670599881;5517.944820551783;5615.354234263071;5642.266505354298;5672.205891175238;5676.602637815355;5514.5864060195445;5602.38373778884;5626.662400255977;5672.744726487318;5675.489205971462;5485.341758988927;5719.227904232937;5727.083666613343;5730.742116604742;5731.942680573204;5617.101263797773;5646.350669672978;5654.6324488908085;5660.179274005267;5662.320521537421;5406.810761623364;5493.285872836505;5500.477454641843;5501.762103526715;5503.257060296849;21864.890675546678;22185.77978211214;22701.09195632173;22944;22950.540989180125;2084.3017589107667;2129.127057906251;2152.13914434226;2163.4579666070604;2220.4448887778058;6429.4534964528075;6471.579347342455;8875.467471951704;12799.360031998363;14072.366743496566;1845.5386153461634;1852.2128095559333;1888.6789245828243;1927.6530224559574;1938.6316599846125;63529.999999999534;64960.350396496375;66358.00462993108;67466;72522.63738681325;16010;16760;16853.747193791856;16869.24088416024;16923.238454269587;25761.61357579638;25774.613380799303;25945.09192178265;25964.740352596233;26006.86996565043;9285.535723213812;9612.510060940565;9676.322657414054;9758.75603109928;9780.55987480565;8082.474639148437;8168.183181681903;8182;8224.588770561568;8331.708390206313;8299.253067223979;8359.868233600393;8428.072911979678;8484.109168537338;8552.828943421096;3100.8759649614212;3136.976650060698;3162.968370316313;3251.447253966784;3301.7028467438045;871.1332224436726;879.8900137482815;895.6775560798108;958.9856152157723;959.6209497248688;15959.122248276224;15959.68080638404;16258.75611865823;16453.341866325452;16494.917525412297;855.0841630041529;878.9296856251484;889.1508609278123;928.8606708993705;941.0495399646406;9106.726798196065;9158.542072896329;9402.48286344244;9454.290928180413;9595.13643772064;410953;416368;435101;441582;446523.34766523086;50975;67281;67471.66264168647;72908.27091729121;73842.6307868468;981.2738573455591;992.6823416506793;1008.7074748322905;1009.8131845608586;1012.6455740490769;12151.75696486083;14394.424223030961;14874.330655120762;14884;15189.92405038012;30147.397052059274;30304.242393940327;31450.37099258048;31467.685323146474;34558.827205864814;41680;41996.580034199265;42112.789436052626;42323.7883810579;42587;7596.354309883501;7624.80937976555;7652.846943061219;7758.9612051939375;7773.611319433892;8484.703035393732;11457.369844658291;11526;11657.708557286136;11938.343391113225;9376.531173441437;9428.387154834914;9458.33791634579;9850.113489785666;9955.800883982425;9976.15202707778;10362.585496580052;10389.53247103867;10433.582656693647;10452.790944180922;9437.136509996646;9465.95267023688;9969.30214884951;10194.643187488402;10220.233482488991;7315.414766818535;7688.577128258;7741.690332386642;7745.845083098419;7930.920690793018;9414.435133891988;9491.240700743785;9683.128518433376;9748.756281092747;10083.193344532274 19:21:55 INFO - PROCESS | 3595 | |3;mootools.html;1322.8346456692914;1381.088481602142;1393.874551290384;1496.311696619555;1697.5331783759473;6593.241777195624;7313.963430182848;7552.8867066994035;7554.131274903388;7561.697532098709;7318.048653675028;7478.06524184477;7479.813004674886;7497.2877576630135;7501.662425190866;1947.376839411389;1996.331229038274;2251.324602619216;2271.8636881787106;2285.851419657717;2315.6642286868396;2361.527694461106;2362.4212068043353;2362.9881850590723;2363.09021026905;2256.537409830981;2289.553537060274;2302.4013756423365;2308.4459729664845;2309.0186670664984;1944.2903340280836;2113.756917954432;2125.4580082079046;2222.733272007353;2263.660450932357;2201.2075652764993;2242.573910956913;2244.55108978205;2245.854019488744;2248.37045627223;7242.601656908868;7324.597147156905;7328;7331.78004659861;7344.228855970153;4525.502194758574;4646.744429056401;4649.349091127245;4665.2535594304745;4675.368825208588;2947.336849208932;3006.2183832203787;3140.607424071991;3155.605549306337;3180.6978337057944;920.4799288402031;937.4515908193715;940.9482478463682;943.0852073488774;952.4380615436856;10431.634892778717;10675.519601617945;10687.679369618923;10710.946445267724;10718.946405267923;4216.072464057902;4262.744235345827;4379.189849877783;4387.4954380246045;4462.955370446319;9123.908760912438;9154.725358239264;9164.037776033421;9174.128457796633;9176.35765496409;4747.169245382044;4752.643551733634;4792.281157826354;4798.352222449925;4799.904001919942;3722.925541489209;3776.6412190841825;3807.124361396894;4124.1957818225155;4334.046509767846;3764.0966168120003;3806.1816709407058;3832.827522761482;3860.536735591691;3880.165764360676;1231.6305108467425;1259.0808709642013;1264.5700461843016;1265.9050571207013;1272.9936350318374;1011.6813203840767;1028.6194108179873;1033.3076838518211;1097.8353247013013;1218.0742635596832;7076;7123.82190445243;7131.500794944304;7216.458765592602;7276.05411296528;1130.7455822439886;1159.4202898550725;1165.091228841505;1198.6344165029575;1199.2504684572143;5576;5598.692071936082;5651.011073062197;5653.067243904792;5654.85862853432;8665.133486651284;8776.517291549026;9004.279657627374;9012.504312262889;9027.774305642411;8911.955440222757;8980.685676001309;9001.504917229484;9015.188633023059;9020.954895225614;6850.143732033496;7042.6830792614455;7058.505904586732;7208.423326133897;7225.349718525358;6976.546524476096;6992;7003.649817509002;7026.789196324118;7085.362317391459;7639.541627502367;7918.406119540942;7930.524168549906;8143.83712325762;8157.632906519102;8056.355491560778;8377.329813615019;8380.413371063967;8380.790480238044;8393.748187554384;5905.911411328748;6422.3577642235405;6493.383128602775;6516.674166291761;6655.001749737385;7045.084139061889;7046.718131274896;7126.572405655677;7135.357817796424;7137.750178743719;6131.754729810757;6456.38664326907;6480.287168411565;6500.154979852778;6563.540552161494;6305.96847015762;6320.209973753281;6339.207599050119;6373.553851230555;6426.389492998158;6694.163229596301;6705.597664140168;6736.629485378156;6847.109875716125;6887.896681549681;6136.417040381157;6138.07928810682;6156;6189.381061893955;6234.719437625408;6165.106059621419;6166.167567378347;6206.844828879314;6208.348123447154;6238.064290356483 19:21:55 INFO - PROCESS | 3595 | |4;prototype.html;315.29846092444313;320.50322000898603;323.2936034764041;323.8422639065342;325.6222781573375;5380.650257733249;5391.353037635479;5424.077906755856;5437.864053398662;5438.6736795792185;5355.812546560871;5412.188171774236;5413.458654134584;5416.07926652469;5424.9186262206;4001.8799436016966;4104.117614712836;4232.217039847623;4246.57534246576;4247.065645557972;4236.978815105936;4241.512226094008;4241.830326786925;4242.724222925515;4251.829926802924;4193.056562273495;4194.958050419503;4196.727212731178;4198.454200953872;4199.286121359361;3977.681785457171;4085.20338533986;4177.4569305990335;4183.958160418388;4200.642945349649;3680.355937710917;3680.355937710917;3688.686461650763;3690.7047436205307;3690.7785532867847;5132.153194722866;5138.46046165151;5138.537531622134;5139.743012849342;5145.434002259748;4854.854354369375;4873.390826146731;4873.902521949542;4876.634252431047;4885.364902562644;5696.259486266758;5697.943020569783;5701.287339082614;5702.3157221133315;5708.885822283572;4113.136241389312;4113.197926404352;4113.197926404352;4115.032967252693;4116.485439320085;5807.709614519257;5995.1906492623375;5999.610025348338;6003.789867354665;6006.699665016732;4169.60388763067;4199.160167966419;4205.726627769185;4210.663146948237;4211.494620645481;4234.6823988201;4269.146170765859;4273.102648443862;4289.635380992589;4291.227579035741;4859.878503037452;4860.562549370503;4864.318995340655;4871.732054736953;4873.41519017713;5751.6549007058875;5754.309482862;5763.991301522216;5764.7117644117625;5765.509931655856;1483.8961272711022;1516.8331483536801;1519.7340465418729;1520.445037561282;1521.6880539489377;877.526135886614;953.6280850468323;983.3657291047234;989.2036910287144;999.2954966748425;4858;4932.334134891744;4939.728314942713;4950.133726597831;4954.826581069645;5891.734871930774;5906.350301466835;5912.142739302777;5914.378990205966;5917.55618328627;4886.511348865156;4893.314935908976;4922.606191504671;4930;4931.161702510582;3167.1448708848484;3226.064441311993;3237.3039796443877;3240.2223466368373;3242.4487837067754;5575.275214222206;5598.076317407664;5602.243697100839;5606.046972014768;5609.523190528851;5963.522918166536;6147.262328520606;6157.6613286269685;6161.599496032743;6165.260168779685;5557.083081291623;5577.442255774471;5589.301337332833;5590.049691552445;5598.776048958078;5943.7028148591535;5970.253718285215;5991.910121348096;5994.820155395345;5998.890205312031;5855.736491857791;5856.238688970577;5859.355470898113;5862.677552734641;5873.177755114373;5434.538064264424;5571.331440227199;5572.554195664418;5573.7459071708545;5576.581756368208;4101.712880098365;4107.507099148122;4109.0549173690815;4109.3425051991535;4113.424120623055;5927.525797936241;5967.433093856077;5969.880602388015;5973;5973.193618861572;5738.282714660668;5744.942550574441;5746.942530574641;5747.19539264495;5749.252597162342;5740.339860916049;5748.482636562562;5754.482096611325;5756.798512052058;5757.596968212185;5422.8373148805595;5655.802046928337;5669.121286200645;5674;5675.460831221028;5657.8019769307875;5670.858228544319;5699.145128230799;5700.486956173964;5703.7433315500075;5541.251930989265;5652.6043176978865;5656.830295091154;5657.3776884543495;5658.377578466448 19:21:55 INFO - PROCESS | 3595 | |5;yui.html;614.8063360041588;648.7210499485222;660.2605082307814;665.2216906219726;744.6649007946426;12195.329256890878;12532;12571.622851314452;12591.811122833165;12607.558735444261;11442.7139321517;11703.473343699532;11714.824277635842;11749.060075193986;11780.823287650692;660.4419265720459;816.8733846253825;817.65249768848;833.2958649940821;835.381817455085;836.1471299274737;840.4789030800912;841.0202114536588;842.5071333270045;842.6755699055847;875.9649614015464;876.2508055612456;876.408424313589;877;878.5387671472464;693.5699866083036;861.4142383179435;872.6378552900538;873.3624454148508;874.3879284500874;629.5687454093915;631.1668597451365;631.9210098737658;632.0361448790585;632.3865850125371;12927.612171634866;12949.223046617139;12959.546415875398;13002.934985325108;13073.934630326883;12457.75084498314;12631.115821892472;12647.620571382873;12679.302638354888;12764.87235127646;9707.805843883154;9734.853977190278;9778.559964801601;9872.802543949081;10209.2343074269;3234.3531293741344;3299.3236386540702;3316.2704205074847;3357.6978071973394;3452.689257966795;42055.579444205476;42586.57413425857;42646;42733.35899961503;42810.35784463236;9150;9339.392939458914;9704.320697551244;9752.366096203725;10028.498575071217;16681.83318166827;16684.58288542796;16716.498505044867;16725.665486690443;16733;6516.706748196342;6604.2074951005225;6720.428763555153;6762.526623136431;6876.724931002804;3661.5468328757847;3849.6920246380223;3924.843006279717;3925.116848709075;4014.3175660137845;2973.9553906691417;2994.5508173773674;2995.7453616442845;2995.8801647933838;3003.654579723316;498.220285253577;503.79344468768363;523.0950455711564;525.5007742644503;541.2719891745596;468.39810843066493;537.6988886223727;537.8144540133648;587.759018802289;596.5406636889571;7752.883706744404;7759.262870027338;7824.139344672081;7987.640556174986;8042.597870106471;504.3418339067552;528.183955788308;545.4872419925258;546.6638017619135;559.0663591801701;3761.887143385703;3763.6236376362144;3852.210296889131;3873.4770805941403;3962.821673024721;50429.74785126051;50521.74739126281;50690.23964640533;50800.491995079574;50806.49193508018;46397.07205855864;47608.285875711896;48443;51578.74210628923;52440.737796311536;41186;41453.58546414497;41770.791146044685;44653.10693786171;44752.77623611861;8881.111888811067;9020.233280170996;9039.954800225956;9166.17504424605;9180.44917304964;32004.35991280208;32142.35715285728;32602.83698581492;32949;33245.83377083196;40371.79814100911;40695.59304406918;41331.7933410331;41770.164596708506;41924;11029;11245.831312530483;11309.290377025922;11646.70883227926;11768.52925882955;11558.595449159238;12018.158728888893;12119.697007574881;12146;12178.147529672839;11610.94194529022;11644.301341919512;11654.825177622512;12143.939280303543;12235.204711694067;11388.145889058189;11589.6523104307;11949.22330048544;12016.519339226683;12081.697957551132;11038.44807759625;11300.717482063013;11522.942385288356;11573.942130289295;11955.222910510789;9687.176589989647;9948.35335703177;9974.301798874008;10009.399436033862;10151.17278889807;8756.168164024408;8840.513771742615;9495.525223738923;9974.850377244202;10090.477380654836 19:21:55 INFO - PROCESS | 3595 | __end_tp_report 19:21:55 INFO - PROCESS | 3595 | __start_cc_report 19:21:55 INFO - PROCESS | 3595 | _x_x_mozilla_cycle_collect,852 19:21:55 INFO - PROCESS | 3595 | __end_cc_report 19:21:55 INFO - PROCESS | 3595 | __startTimestamp1458008515461__endTimestamp 19:21:55 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | ------- Summary: start ------- 19:21:55 INFO - PROCESS | 3595 | Number of tests: 6 19:21:55 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | [#0] dojo.html Cycles:165 Average:4695.39 Median:4808.74 stddev:491.03 (10.2%) stddev-sans-first:464.62 19:21:55 INFO - PROCESS | 3595 | Values: 2614.8 2666.0 2678.6 2683.5 2703.7 4634.9 4668.1 4671.2 4681.6 4752.9 4726.1 4740.8 4748.2 4756.1 4792.8 4313.9 4400.7 4442.5 4475.8 4490.4 4309.8 4388.5 4443.7 4451.6 4463.0 4275.0 4319.4 4322.5 4366.6 4368.5 4301.2 4312.0 4313.3 4343.4 4344.4 4282.2 4303.6 4307.4 4349.0 4353.4 4602.7 4681.5 4681.5 4693.7 4732.0 5112.9 5116.8 5118.3 5118.6 5119.8 5049.8 5079.1 5132.1 5133.4 5148.0 4780.1 4795.1 4797.0 4806.5 4835.3 5247.5 5251.7 5252.1 5257.3 5310.0 4875.7 4994.4 4998.0 5035.5 5090.8 5117.6 5122.9 5132.7 5136.3 5146.9 5097.6 5100.4 5102.7 5105.9 5130.7 4933.5 4997.8 5092.4 5133.0 5144.4 4337.5 4358.2 4361.3 4367.4 4404.3 3762.2 3796.8 3804.8 3832.1 3871.1 4297.5 4321.5 4324.3 4364.9 4366.2 5066.2 5074.4 5095.3 5101.9 5140.8 4251.1 4322.7 4330.4 4333.8 4377.1 4589.0 4608.0 4637.9 4660.0 4664.0 4751.3 4789.1 4802.1 4808.7 4859.8 5062.4 5101.1 5105.3 5111.5 5124.6 4740.5 4771.0 4794.0 4842.7 4846.6 4939.4 4968.7 4971.3 4973.2 5022.6 5030.0 5032.2 5042.4 5055.7 5102.5 4899.3 4921.0 4924.6 4931.4 4986.7 4897.5 4911.9 4918.1 4920.8 4921.0 4764.1 4769.7 4854.7 4867.6 4914.8 4913.1 4934.3 4934.4 4936.1 4982.9 4837.3 4840.1 4843.0 4844.2 4895.7 19:21:55 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | [#1] ext.html Cycles:180 Average:41739.93 Median:33162.92 stddev:75967.47 (229.1%) stddev-sans-first:76117.45 19:21:55 INFO - PROCESS | 3595 | Values: 492.8 524.5 534.4 543.4 559.0 26892.1 27434.3 27455.5 27470.2 27486.9 27481.5 35180.6 35775.8 35825.4 35867.5 7574.1 7670.5 7674.7 7675.0 7677.5 7611.4 7722.5 7736.8 7741.0 7743.8 7736.2 7805.2 7810.3 7812.6 8018.1 7857.6 7930.4 7933.7 7970.0 7977.4 7845.9 7955.8 7968.2 7968.2 7971.0 38761.0 39133.6 39216.4 39307.8 39312.6 3199.8 3257.5 3310.3 3361.2 3512.2 28830.7 28965.4 29403.1 29727.6 29781.4 3130.4 3138.9 3157.3 3215.6 3236.4 249518.0 249788.0 249936.0 250242.0 250322.0 42624.4 56140.7 56303.0 56757.1 56775.4 42314.4 42588.0 42629.6 42651.8 42682.6 13513.9 13780.1 13807.0 13880.7 13923.9 10465.2 10492.7 10523.3 10523.8 10559.9 14230.7 14404.6 14594.6 14668.5 14848.9 5878.4 5915.7 5956.8 5967.8 5974.1 883.8 928.8 945.6 1032.4 1035.8 26788.0 28247.4 30891.4 31877.8 33165.2 1003.6 1014.1 1027.3 1060.8 1097.9 14020.5 14397.3 14749.6 14776.8 14811.1 180606.0 419072.0 426431.0 426658.0 427665.0 46936.0 47216.3 47532.3 47549.8 47582.8 1088.9 1209.6 1267.2 1290.4 1307.8 25689.9 27721.9 27744.2 27884.3 27997.3 34546.7 34975.7 35342.8 35721.6 35723.5 181178.0 183680.0 183966.0 184125.0 184640.0 26904.9 29827.1 31217.8 31634.0 31692.7 34359.0 34370.8 35106.6 35158.3 35417.1 30676.5 30937.8 31617.8 33129.2 33813.0 33160.7 33229.7 33585.8 33628.7 33789.3 33220.7 33239.0 33498.7 33516.7 33532.8 29196.4 30073.5 30241.4 30300.1 30326.8 23778.3 23843.2 23857.8 24029.5 24115.8 19:21:55 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | [#2] jquery.html Cycles:180 Average:25354.54 Median:5501.12 stddev:70400.67 (1279.8%) stddev-sans-first:70573.13 19:21:55 INFO - PROCESS | 3595 | Values: 350.7 353.3 355.2 358.1 363.9 10645.9 11132.7 11136.2 15623.8 16103.4 16600.6 16939.3 17345.5 17771.7 17776.5 5517.9 5615.4 5642.3 5672.2 5676.6 5514.6 5602.4 5626.7 5672.7 5675.5 5485.3 5719.2 5727.1 5730.7 5731.9 5617.1 5646.4 5654.6 5660.2 5662.3 5406.8 5493.3 5500.5 5501.8 5503.3 21864.9 22185.8 22701.1 22944.0 22950.5 2084.3 2129.1 2152.1 2163.5 2220.4 6429.5 6471.6 8875.5 12799.4 14072.4 1845.5 1852.2 1888.7 1927.7 1938.6 63530.0 64960.4 66358.0 67466.0 72522.6 16010.0 16760.0 16853.7 16869.2 16923.2 25761.6 25774.6 25945.1 25964.7 26006.9 9285.5 9612.5 9676.3 9758.8 9780.6 8082.5 8168.2 8182.0 8224.6 8331.7 8299.3 8359.9 8428.1 8484.1 8552.8 3100.9 3137.0 3163.0 3251.4 3301.7 871.1 879.9 895.7 959.0 959.6 15959.1 15959.7 16258.8 16453.3 16494.9 855.1 878.9 889.2 928.9 941.0 9106.7 9158.5 9402.5 9454.3 9595.1 410953.0 416368.0 435101.0 441582.0 446523.3 50975.0 67281.0 67471.7 72908.3 73842.6 981.3 992.7 1008.7 1009.8 1012.6 12151.8 14394.4 14874.3 14884.0 15189.9 30147.4 30304.2 31450.4 31467.7 34558.8 41680.0 41996.6 42112.8 42323.8 42587.0 7596.4 7624.8 7652.8 7759.0 7773.6 8484.7 11457.4 11526.0 11657.7 11938.3 9376.5 9428.4 9458.3 9850.1 9955.8 9976.2 10362.6 10389.5 10433.6 10452.8 9437.1 9466.0 9969.3 10194.6 10220.2 7315.4 7688.6 7741.7 7745.8 7930.9 9414.4 9491.2 9683.1 9748.8 10083.2 19:21:55 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | [#3] mootools.html Cycles:180 Average:5278.97 Median:6165.64 stddev:2706.30 (43.9%) stddev-sans-first:2697.55 19:21:55 INFO - PROCESS | 3595 | Values: 1322.8 1381.1 1393.9 1496.3 1697.5 6593.2 7314.0 7552.9 7554.1 7561.7 7318.0 7478.1 7479.8 7497.3 7501.7 1947.4 1996.3 2251.3 2271.9 2285.9 2315.7 2361.5 2362.4 2363.0 2363.1 2256.5 2289.6 2302.4 2308.4 2309.0 1944.3 2113.8 2125.5 2222.7 2263.7 2201.2 2242.6 2244.6 2245.9 2248.4 7242.6 7324.6 7328.0 7331.8 7344.2 4525.5 4646.7 4649.3 4665.3 4675.4 2947.3 3006.2 3140.6 3155.6 3180.7 920.5 937.5 940.9 943.1 952.4 10431.6 10675.5 10687.7 10710.9 10718.9 4216.1 4262.7 4379.2 4387.5 4463.0 9123.9 9154.7 9164.0 9174.1 9176.4 4747.2 4752.6 4792.3 4798.4 4799.9 3722.9 3776.6 3807.1 4124.2 4334.0 3764.1 3806.2 3832.8 3860.5 3880.2 1231.6 1259.1 1264.6 1265.9 1273.0 1011.7 1028.6 1033.3 1097.8 1218.1 7076.0 7123.8 7131.5 7216.5 7276.1 1130.7 1159.4 1165.1 1198.6 1199.3 5576.0 5598.7 5651.0 5653.1 5654.9 8665.1 8776.5 9004.3 9012.5 9027.8 8912.0 8980.7 9001.5 9015.2 9021.0 6850.1 7042.7 7058.5 7208.4 7225.3 6976.5 6992.0 7003.6 7026.8 7085.4 7639.5 7918.4 7930.5 8143.8 8157.6 8056.4 8377.3 8380.4 8380.8 8393.7 5905.9 6422.4 6493.4 6516.7 6655.0 7045.1 7046.7 7126.6 7135.4 7137.8 6131.8 6456.4 6480.3 6500.2 6563.5 6306.0 6320.2 6339.2 6373.6 6426.4 6694.2 6705.6 6736.6 6847.1 6887.9 6136.4 6138.1 6156.0 6189.4 6234.7 6165.1 6166.2 6206.8 6208.3 6238.1 19:21:55 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | [#4] prototype.html Cycles:180 Average:4752.27 Median:5419.46 stddev:1388.29 (25.6%) stddev-sans-first:1351.65 19:21:55 INFO - PROCESS | 3595 | Values: 315.3 320.5 323.3 323.8 325.6 5380.7 5391.4 5424.1 5437.9 5438.7 5355.8 5412.2 5413.5 5416.1 5424.9 4001.9 4104.1 4232.2 4246.6 4247.1 4237.0 4241.5 4241.8 4242.7 4251.8 4193.1 4195.0 4196.7 4198.5 4199.3 3977.7 4085.2 4177.5 4184.0 4200.6 3680.4 3680.4 3688.7 3690.7 3690.8 5132.2 5138.5 5138.5 5139.7 5145.4 4854.9 4873.4 4873.9 4876.6 4885.4 5696.3 5697.9 5701.3 5702.3 5708.9 4113.1 4113.2 4113.2 4115.0 4116.5 5807.7 5995.2 5999.6 6003.8 6006.7 4169.6 4199.2 4205.7 4210.7 4211.5 4234.7 4269.1 4273.1 4289.6 4291.2 4859.9 4860.6 4864.3 4871.7 4873.4 5751.7 5754.3 5764.0 5764.7 5765.5 1483.9 1516.8 1519.7 1520.4 1521.7 877.5 953.6 983.4 989.2 999.3 4858.0 4932.3 4939.7 4950.1 4954.8 5891.7 5906.4 5912.1 5914.4 5917.6 4886.5 4893.3 4922.6 4930.0 4931.2 3167.1 3226.1 3237.3 3240.2 3242.4 5575.3 5598.1 5602.2 5606.0 5609.5 5963.5 6147.3 6157.7 6161.6 6165.3 5557.1 5577.4 5589.3 5590.0 5598.8 5943.7 5970.3 5991.9 5994.8 5998.9 5855.7 5856.2 5859.4 5862.7 5873.2 5434.5 5571.3 5572.6 5573.7 5576.6 4101.7 4107.5 4109.1 4109.3 4113.4 5927.5 5967.4 5969.9 5973.0 5973.2 5738.3 5744.9 5746.9 5747.2 5749.3 5740.3 5748.5 5754.5 5756.8 5757.6 5422.8 5655.8 5669.1 5674.0 5675.5 5657.8 5670.9 5699.1 5700.5 5703.7 5541.3 5652.6 5656.8 5657.4 5658.4 19:21:55 INFO - PROCESS | 3595 | 19:21:55 INFO - PROCESS | 3595 | [#5] yui.html Cycles:180 Average:12969.04 Median:42689.68 stddev:14529.61 (34.0%) stddev-sans-first:14540.74 19:21:55 INFO - PROCESS | 3595 | Values: 614.8 648.7 660.3 665.2 744.7 12195.3 12532.0 12571.6 12591.8 12607.6 11442.7 11703.5 11714.8 11749.1 11780.8 660.4 816.9 817.7 833.3 835.4 836.1 840.5 841.0 842.5 842.7 876.0 876.3 876.4 877.0 878.5 693.6 861.4 872.6 873.4 874.4 629.6 631.2 631.9 632.0 632.4 12927.6 12949.2 12959.5 13002.9 13073.9 12457.8 12631.1 12647.6 12679.3 12764.9 9707.8 9734.9 9778.6 9872.8 10209.2 3234.4 3299.3 3316.3 3357.7 3452.7 42055.6 42586.6 42646.0 42733.4 42810.4 9150.0 9339.4 9704.3 9752.4 10028.5 16681.8 16684.6 16716.5 16725.7 16733.0 6516.7 6604.2 6720.4 6762.5 6876.7 3661.5 3849.7 3924.8 3925.1 4014.3 2974.0 2994.6 2995.7 2995.9 3003.7 498.2 503.8 523.1 525.5 541.3 468.4 537.7 537.8 587.8 596.5 7752.9 7759.3 7824.1 7987.6 8042.6 504.3 528.2 545.5 546.7 559.1 3761.9 3763.6 3852.2 3873.5 3962.8 50429.7 50521.7 50690.2 50800.5 50806.5 46397.1 47608.3 48443.0 51578.7 52440.7 41186.0 41453.6 41770.8 44653.1 44752.8 8881.1 9020.2 9040.0 9166.2 9180.4 32004.4 32142.4 32602.8 32949.0 33245.8 40371.8 40695.6 41331.8 41770.2 41924.0 11029.0 11245.8 11309.3 11646.7 11768.5 11558.6 12018.2 12119.7 12146.0 12178.1 11610.9 11644.3 11654.8 12143.9 12235.2 11388.1 11589.7 11949.2 12016.5 12081.7 11038.4 11300.7 11522.9 11573.9 11955.2 9687.2 9948.4 9974.3 10009.4 10151.2 8756.2 8840.5 9495.5 9974.9 10090.5 19:21:55 INFO - PROCESS | 3595 | -------- Summary: end -------- 19:21:55 INFO - PROCESS | 3595 | 19:21:56 INFO - TEST-INFO | 3595: exit 0 19:21:56 INFO - TEST-OK | dromaeo_css | took 1117059ms 19:21:56 INFO - TEST-START | kraken 19:21:56 INFO - operating with platform_type : linux_ 19:21:56 INFO - Initialising browser for kraken test... 19:21:56 INFO - TEST-INFO | started process 3779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpol_6SX/profile http://localhost:42708/getInfo.html) 19:22:00 INFO - PROCESS | 3779 | __metrics Screen width/height:1600/1200 19:22:00 INFO - PROCESS | 3779 | colorDepth:24 19:22:00 INFO - PROCESS | 3779 | Browser inner width/height: 1024/697 19:22:00 INFO - PROCESS | 3779 | __metrics 19:22:01 ERROR - PROCESS | 3779 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:22:01 INFO - PROCESS | 3779 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:22:02 INFO - TEST-INFO | 3779: exit 0 19:22:02 INFO - Browser initialized. 19:22:02 INFO - Running cycle 1/1 for kraken test... 19:22:02 INFO - TEST-INFO | started process 3860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpol_6SX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:14 INFO - PROCESS | 3860 | RSS: Main: 153927680 19:22:14 INFO - PROCESS | 3860 | 19:22:17 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42708/tests/kraken/driver.html?testName=audio-beat-detection) 19:22:17 INFO - PROCESS | 3860 | RSS: Main: 196231168 19:22:17 INFO - PROCESS | 3860 | 19:22:20 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42708/tests/kraken/driver.html?testName=audio-dft) 19:22:21 INFO - PROCESS | 3860 | RSS: Main: 186400768 19:22:21 INFO - PROCESS | 3860 | 19:22:26 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42708/tests/kraken/driver.html?testName=audio-fft) 19:22:27 INFO - PROCESS | 3860 | RSS: Main: 171823104 19:22:27 INFO - PROCESS | 3860 | 19:22:29 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42708/tests/kraken/driver.html?testName=audio-oscillator) 19:22:29 INFO - PROCESS | 3860 | RSS: Main: 172527616 19:22:29 INFO - PROCESS | 3860 | 19:22:31 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42708/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:22:32 INFO - PROCESS | 3860 | RSS: Main: 175267840 19:22:32 INFO - PROCESS | 3860 | 19:22:35 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42708/tests/kraken/driver.html?testName=imaging-darkroom) 19:22:36 INFO - PROCESS | 3860 | RSS: Main: 176504832 19:22:36 INFO - PROCESS | 3860 | 19:22:40 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42708/tests/kraken/driver.html?testName=imaging-desaturate) 19:22:40 INFO - PROCESS | 3860 | RSS: Main: 173322240 19:22:40 INFO - PROCESS | 3860 | 19:22:43 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42708/tests/kraken/driver.html?testName=json-parse-financial) 19:22:44 INFO - PROCESS | 3860 | RSS: Main: 173293568 19:22:44 INFO - PROCESS | 3860 | 19:22:45 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42708/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:22:46 INFO - PROCESS | 3860 | RSS: Main: 186494976 19:22:46 INFO - PROCESS | 3860 | 19:22:48 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42708/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:22:48 INFO - PROCESS | 3860 | RSS: Main: 183037952 19:22:48 INFO - PROCESS | 3860 | 19:22:51 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42708/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:22:51 INFO - PROCESS | 3860 | RSS: Main: 190525440 19:22:51 INFO - PROCESS | 3860 | 19:22:54 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:22:54 INFO - PROCESS | 3860 | RSS: Main: 197767168 19:22:54 INFO - PROCESS | 3860 | 19:22:57 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:22:57 INFO - PROCESS | 3860 | RSS: Main: 196214784 19:22:57 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | Cycle 1(1): loaded http://localhost:42708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42708/tests/kraken/driver.html?testName=ai-astar) 19:22:59 INFO - PROCESS | 3860 | RSS: Main: 256053248 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | __start_tp_report 19:22:59 INFO - PROCESS | 3860 | _x_x_mozilla_page_load 19:22:59 INFO - PROCESS | 3860 | _x_x_mozilla_page_load_details 19:22:59 INFO - PROCESS | 3860 | |i|pagename|runs| 19:22:59 INFO - PROCESS | 3860 | |0;ai-astar;111;112;106;113;112;112;102;112;110;112 19:22:59 INFO - PROCESS | 3860 | |1;audio-beat-detection;154;130;158;173;131;159;158;131;165;131 19:22:59 INFO - PROCESS | 3860 | |2;audio-dft;383;384;383;383;384;385;385;384;385;384 19:22:59 INFO - PROCESS | 3860 | |3;audio-fft;77;75;99;99;74;74;75;111;99;73 19:22:59 INFO - PROCESS | 3860 | |4;audio-oscillator;94;94;151;93;94;93;136;93;94;137 19:22:59 INFO - PROCESS | 3860 | |5;imaging-gaussian-blur;116;117;117;116;117;117;116;117;117;117 19:22:59 INFO - PROCESS | 3860 | |6;imaging-darkroom;193;192;193;193;193;193;193;193;194;193 19:22:59 INFO - PROCESS | 3860 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 19:22:59 INFO - PROCESS | 3860 | |8;json-parse-financial;64;63;64;64;64;64;64;64;64;64 19:22:59 INFO - PROCESS | 3860 | |9;json-stringify-tinderbox;63;63;64;64;64;64;64;64;64;65 19:22:59 INFO - PROCESS | 3860 | |10;stanford-crypto-aes;81;90;82;83;82;80;84;82;93;87 19:22:59 INFO - PROCESS | 3860 | |11;stanford-crypto-ccm;114;126;121;131;121;116;116;114;117;123 19:22:59 INFO - PROCESS | 3860 | |12;stanford-crypto-pbkdf2;140;143;138;139;139;128;140;138;137;138 19:22:59 INFO - PROCESS | 3860 | |13;stanford-crypto-sha256-iterative;66;67;68;64;68;65;66;67;66;67 19:22:59 INFO - PROCESS | 3860 | __end_tp_report 19:22:59 INFO - PROCESS | 3860 | __start_cc_report 19:22:59 INFO - PROCESS | 3860 | _x_x_mozilla_cycle_collect,1107 19:22:59 INFO - PROCESS | 3860 | __end_cc_report 19:22:59 INFO - PROCESS | 3860 | __startTimestamp1458008579829__endTimestamp 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | ------- Summary: start ------- 19:22:59 INFO - PROCESS | 3860 | Number of tests: 14 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.49 (3.1%) stddev-sans-first:3.69 19:22:59 INFO - PROCESS | 3860 | Values: 111.0 112.0 106.0 113.0 112.0 112.0 102.0 112.0 110.0 112.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:158.00 stddev:16.51 (10.4%) stddev-sans-first:17.41 19:22:59 INFO - PROCESS | 3860 | Values: 154.0 130.0 158.0 173.0 131.0 159.0 158.0 131.0 165.0 131.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#2] audio-dft Cycles:10 Average:384.00 Median:384.00 stddev:0.82 (0.2%) stddev-sans-first:0.78 19:22:59 INFO - PROCESS | 3860 | Values: 383.0 384.0 383.0 383.0 384.0 385.0 385.0 384.0 385.0 384.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#3] audio-fft Cycles:10 Average:85.60 Median:76.00 stddev:14.57 (19.2%) stddev-sans-first:15.12 19:22:59 INFO - PROCESS | 3860 | Values: 77.0 75.0 99.0 99.0 74.0 74.0 75.0 111.0 99.0 73.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.50 stddev:23.41 (25.0%) stddev-sans-first:24.29 19:22:59 INFO - PROCESS | 3860 | Values: 94.0 94.0 151.0 93.0 94.0 93.0 136.0 93.0 94.0 137.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:22:59 INFO - PROCESS | 3860 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#6] imaging-darkroom Cycles:10 Average:193.00 Median:193.00 stddev:0.47 (0.2%) stddev-sans-first:0.50 19:22:59 INFO - PROCESS | 3860 | Values: 193.0 192.0 193.0 193.0 193.0 193.0 193.0 193.0 194.0 193.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 19:22:59 INFO - PROCESS | 3860 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 19:22:59 INFO - PROCESS | 3860 | Values: 64.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 19:22:59 INFO - PROCESS | 3860 | Values: 63.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.50 stddev:4.25 (5.1%) stddev-sans-first:4.32 19:22:59 INFO - PROCESS | 3860 | Values: 81.0 90.0 82.0 83.0 82.0 80.0 84.0 82.0 93.0 87.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.00 stddev:5.59 (4.6%) stddev-sans-first:5.50 19:22:59 INFO - PROCESS | 3860 | Values: 114.0 126.0 121.0 131.0 121.0 116.0 116.0 114.0 117.0 123.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.00 Median:139.00 stddev:3.89 (2.8%) stddev-sans-first:4.06 19:22:59 INFO - PROCESS | 3860 | Values: 140.0 143.0 138.0 139.0 139.0 128.0 140.0 138.0 137.0 138.0 19:22:59 INFO - PROCESS | 3860 | 19:22:59 INFO - PROCESS | 3860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 19:22:59 INFO - PROCESS | 3860 | Values: 66.0 67.0 68.0 64.0 68.0 65.0 66.0 67.0 66.0 67.0 19:22:59 INFO - PROCESS | 3860 | -------- Summary: end -------- 19:22:59 INFO - PROCESS | 3860 | 19:23:00 INFO - TEST-INFO | 3860: exit 0 19:23:00 INFO - TEST-OK | kraken | took 64724ms 19:23:00 INFO - SUITE-END | took 1181s 19:23:00 INFO - Completed test suite (00:19:41) 19:23:00 INFO - javascript benchmark 19:23:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.777743891769, 2666.043263515496, 2678.6116013178075, 2683.476722039203, 2703.689075756288, 4634.8841278968, 4668.066386722657, 4671.20589499785, 4681.648876334271, 4752.857414277569, 4726.0784147091335, 4740.810367585301, 4748.2165442702, 4756.143894099061, 4792.784324705388, 4313.892152696192, 4400.6919515634, 4442.466903971528, 4475.776211189427, 4490.438695163105, 4309.849155279566, 4388.473383194021, 4443.666724995622, 4451.643868490513, 4463.040446304044, 4274.97862510687, 4319.416878721364, 4322.546132656057, 4366.628836548897, 4368.475782906072, 4301.247281725686, 4311.956880431187, 4313.266744653385, 4343.435353404069, 4344.370066340363, 4282.229198744225, 4303.612674859246, 4307.440032795748, 4348.978255108705, 4353.412289340962, 4602.654800889946, 4681.508441613616, 4681.5318468153255, 4693.741844198567, 4731.976340118312, 5112.897742045176, 5116.795328186868, 5118.2834403183215, 5118.59051275897, 5119.846404607868, 5049.84850454487, 5079.085764562377, 5132.1275383184575, 5133.435322114565, 5148.0476111919415, 4780.11567859947, 4795.064962332312, 4796.976015119972, 4806.519348065235, 4835.323054772335, 5247.527722504993, 5251.711155886463, 5252.05463016653, 5257.342832145981, 5310.017646735367, 4875.68308059975, 4994.425641051253, 4997.9750101249265, 5035.496450354935, 5090.796368145307, 5117.616178786606, 5122.948770512322, 5132.666376685504, 5136.280920671109, 5146.948530514722, 5097.617678674114, 5100.362454693163, 5102.668326558836, 5105.923411148761, 5130.717810520383, 4933.45731969483, 4997.800087996512, 5092.363454568179, 5132.9743351283005, 5144.38267407906, 4337.479502459725, 4358.193734159191, 4361.258586040381, 4367.388565600755, 4404.317330813729, 3762.2287431076566, 3796.8291426885858, 3804.7907365094634, 3832.0994566276904, 3871.1289959759392, 4297.462817147856, 4321.546237645065, 4324.308110702273, 4364.8908777280185, 4366.214081465367, 5066.240063990431, 5074.391073071181, 5095.337606111182, 5101.923471147936, 5140.820071297487, 4251.149770046003, 4322.71902326354, 4330.415393921843, 4333.848315308949, 4377.102693947797, 4588.95411045892, 4607.976960115245, 4637.86086417408, 4659.976700116477, 4663.953360466352, 4751.287306903992, 4789.137955168034, 4802.111609352281, 4808.735519546459, 4859.757012149307, 5062.417821950523, 5101.056304583515, 5105.285260063668, 5111.514406131411, 5124.641275110706, 4740.454847692422, 4770.952290477051, 4793.976030119827, 4842.7336496491625, 4846.61227101824, 4939.431965324034, 4968.652194346361, 4971.279164521052, 4973.229149481836, 5022.623303252198, 5030.044291584587, 5032.194848824171, 5042.420121686053, 5055.721935293447, 5102.489751025017, 4899.289603007615, 4920.975395123001, 4924.556789888928, 4931.432885218246, 4986.700797952134, 4897.510248975074, 4911.926321105258, 4918.114739346952, 4920.778564964514, 4921.0, 4764.118638051971, 4769.737664428351, 4854.679016288664, 4867.610591152628, 4914.827981020647, 4913.091078150554, 4934.319734801407, 4934.358533390637, 4936.062148191832, 4982.850514484571, 4837.250226214942, 4840.104580652591, 4843.0, 4844.2007068833245, 4895.6817806843865], "unit": "score", "name": "dojo.html", "value": 4664.228901265337}, {"lowerIsBetter": false, "replicates": [492.79548987170324, 524.514823787996, 534.4495169974927, 543.4456854008911, 558.9888202235956, 26892.058777942777, 27434.314142146457, 27455.450890982167, 27470.17589472319, 27486.86256568719, 27481.450370992567, 35180.648193518056, 35775.82112089443, 35825.41745825416, 35867.4619880702, 7574.128975167871, 7670.463067585271, 7674.654640541161, 7675.0, 7677.500962437452, 7611.391088712918, 7722.498037627564, 7736.806579835493, 7741.0, 7743.806404839867, 7736.226377362275, 7805.219478052206, 7810.297073263405, 7812.648430820598, 8018.077921039067, 7857.607119643995, 7930.444868859182, 7933.722319718782, 7970.0, 7977.401694872879, 7845.882311765328, 7955.8408831823035, 7968.163342848975, 7968.243016913384, 7970.960145199295, 38761.0, 39133.60866391357, 39216.41175382372, 39307.803460982796, 39312.606873931465, 3199.8240096794666, 3257.527658489506, 3310.337932413503, 3361.210115622851, 3512.227309991798, 28830.71169288301, 28965.42069158605, 29403.11790646284, 29727.554086688717, 29781.404371912442, 3130.4052230076213, 3138.8587513561943, 3157.3053928135773, 3215.5980502437196, 3236.3689080629288, 249518.0, 249788.0, 249936.0, 250242.0, 250322.0, 42624.36063459051, 56140.71929640407, 56303.0, 56757.14864277039, 56775.43224567702, 42314.365284520754, 42588.0, 42629.57370426318, 42651.78674106672, 42682.57317426848, 13513.932430337982, 13780.10429322091, 13807.0, 13880.722385552232, 13923.86076139246, 10465.162786977024, 10492.73768155787, 10523.26337156407, 10523.84214236787, 10559.894401056044, 14230.715385692436, 14404.639884002983, 14594.635134121732, 14668.486602968846, 14848.92575537137, 5878.412158784087, 5915.674637894957, 5956.791512297049, 5967.761289548456, 5974.103884417372, 883.823235352932, 928.7956649537091, 945.6170251048336, 1032.4270030133348, 1035.808375450529, 26788.0, 28247.361869960543, 30891.38217235643, 31877.840610796797, 33165.17087072794, 1003.5985605757755, 1014.0771897573173, 1027.2860362048455, 1060.7772367802693, 1097.8737445193744, 14020.509282175279, 14397.280135993158, 14749.631259218606, 14776.778348324784, 14811.111333320036, 180606.0, 419072.0, 426431.0, 426658.0, 427665.0, 46936.0, 47216.29175562301, 47532.28701569479, 47549.76225118921, 47582.76208619004, 1088.9183311251688, 1209.6008317255285, 1267.1953309648256, 1290.3612711707765, 1307.8169056332122, 25689.87155064213, 27721.861390692917, 27744.167674969784, 27884.30289242704, 27997.300067498476, 34546.65453345434, 34975.65024349724, 35342.82328588341, 35721.64278357287, 35723.46414803728, 181178.0, 183680.0, 183966.0, 184125.0, 184640.0, 26904.865475672497, 29827.10518684443, 31217.843910780302, 31634.0, 31692.683073169894, 34359.0, 34370.82814585911, 35106.64893351034, 35158.29683406369, 35417.114572135906, 30676.539851902686, 30937.8453107733, 31617.8419107903, 33129.17177070593, 33813.0, 33160.668393315755, 33229.66770332266, 33585.83207083949, 33628.663713362555, 33789.32421351608, 33220.66779332176, 33239.0, 33498.66501334956, 33516.66483335135, 33532.83233583914, 29196.416071678872, 30073.54889676613, 30241.395172096876, 30300.090997270116, 30326.815684353707, 23778.286651400485, 23843.165489208488, 23857.761422385553, 24029.51940961136, 24115.758842411353], "unit": "score", "name": "ext.html", "value": 16435.772334494635}, {"lowerIsBetter": false, "replicates": [350.7106637024454, 353.29341317365277, 355.2132027558956, 358.08866434923124, 363.93994990826513, 10645.946770266148, 11132.721681957955, 11136.164787640919, 15623.84376156238, 16103.436379726712, 16600.58498537537, 16939.322427102932, 17345.479635610922, 17771.73342399862, 17776.46670599881, 5517.944820551783, 5615.354234263071, 5642.266505354298, 5672.205891175238, 5676.602637815355, 5514.5864060195445, 5602.38373778884, 5626.662400255977, 5672.744726487318, 5675.489205971462, 5485.341758988927, 5719.227904232937, 5727.083666613343, 5730.742116604742, 5731.942680573204, 5617.101263797773, 5646.350669672978, 5654.6324488908085, 5660.179274005267, 5662.320521537421, 5406.810761623364, 5493.285872836505, 5500.477454641843, 5501.762103526715, 5503.257060296849, 21864.890675546678, 22185.77978211214, 22701.09195632173, 22944.0, 22950.540989180125, 2084.3017589107667, 2129.127057906251, 2152.13914434226, 2163.4579666070604, 2220.4448887778058, 6429.4534964528075, 6471.579347342455, 8875.467471951704, 12799.360031998363, 14072.366743496566, 1845.5386153461634, 1852.2128095559333, 1888.6789245828243, 1927.6530224559574, 1938.6316599846125, 63529.999999999534, 64960.350396496375, 66358.00462993108, 67466.0, 72522.63738681325, 16010.0, 16760.0, 16853.747193791856, 16869.24088416024, 16923.238454269587, 25761.61357579638, 25774.613380799303, 25945.09192178265, 25964.740352596233, 26006.86996565043, 9285.535723213812, 9612.510060940565, 9676.322657414054, 9758.75603109928, 9780.55987480565, 8082.474639148437, 8168.183181681903, 8182.0, 8224.588770561568, 8331.708390206313, 8299.253067223979, 8359.868233600393, 8428.072911979678, 8484.109168537338, 8552.828943421096, 3100.8759649614212, 3136.976650060698, 3162.968370316313, 3251.447253966784, 3301.7028467438045, 871.1332224436726, 879.8900137482815, 895.6775560798108, 958.9856152157723, 959.6209497248688, 15959.122248276224, 15959.68080638404, 16258.75611865823, 16453.341866325452, 16494.917525412297, 855.0841630041529, 878.9296856251484, 889.1508609278123, 928.8606708993705, 941.0495399646406, 9106.726798196065, 9158.542072896329, 9402.48286344244, 9454.290928180413, 9595.13643772064, 410953.0, 416368.0, 435101.0, 441582.0, 446523.34766523086, 50975.0, 67281.0, 67471.66264168647, 72908.27091729121, 73842.6307868468, 981.2738573455591, 992.6823416506793, 1008.7074748322905, 1009.8131845608586, 1012.6455740490769, 12151.75696486083, 14394.424223030961, 14874.330655120762, 14884.0, 15189.92405038012, 30147.397052059274, 30304.242393940327, 31450.37099258048, 31467.685323146474, 34558.827205864814, 41680.0, 41996.580034199265, 42112.789436052626, 42323.7883810579, 42587.0, 7596.354309883501, 7624.80937976555, 7652.846943061219, 7758.9612051939375, 7773.611319433892, 8484.703035393732, 11457.369844658291, 11526.0, 11657.708557286136, 11938.343391113225, 9376.531173441437, 9428.387154834914, 9458.33791634579, 9850.113489785666, 9955.800883982425, 9976.15202707778, 10362.585496580052, 10389.53247103867, 10433.582656693647, 10452.790944180922, 9437.136509996646, 9465.95267023688, 9969.30214884951, 10194.643187488402, 10220.233482488991, 7315.414766818535, 7688.577128258, 7741.690332386642, 7745.845083098419, 7930.920690793018, 9414.435133891988, 9491.240700743785, 9683.128518433376, 9748.756281092747, 10083.193344532274], "unit": "score", "name": "jquery.html", "value": 8802.871980741375}, {"lowerIsBetter": false, "replicates": [1322.8346456692914, 1381.088481602142, 1393.874551290384, 1496.311696619555, 1697.5331783759473, 6593.241777195624, 7313.963430182848, 7552.8867066994035, 7554.131274903388, 7561.697532098709, 7318.048653675028, 7478.06524184477, 7479.813004674886, 7497.2877576630135, 7501.662425190866, 1947.376839411389, 1996.331229038274, 2251.324602619216, 2271.8636881787106, 2285.851419657717, 2315.6642286868396, 2361.527694461106, 2362.4212068043353, 2362.9881850590723, 2363.09021026905, 2256.537409830981, 2289.553537060274, 2302.4013756423365, 2308.4459729664845, 2309.0186670664984, 1944.2903340280836, 2113.756917954432, 2125.4580082079046, 2222.733272007353, 2263.660450932357, 2201.2075652764993, 2242.573910956913, 2244.55108978205, 2245.854019488744, 2248.37045627223, 7242.601656908868, 7324.597147156905, 7328.0, 7331.78004659861, 7344.228855970153, 4525.502194758574, 4646.744429056401, 4649.349091127245, 4665.2535594304745, 4675.368825208588, 2947.336849208932, 3006.2183832203787, 3140.607424071991, 3155.605549306337, 3180.6978337057944, 920.4799288402031, 937.4515908193715, 940.9482478463682, 943.0852073488774, 952.4380615436856, 10431.634892778717, 10675.519601617945, 10687.679369618923, 10710.946445267724, 10718.946405267923, 4216.072464057902, 4262.744235345827, 4379.189849877783, 4387.4954380246045, 4462.955370446319, 9123.908760912438, 9154.725358239264, 9164.037776033421, 9174.128457796633, 9176.35765496409, 4747.169245382044, 4752.643551733634, 4792.281157826354, 4798.352222449925, 4799.904001919942, 3722.925541489209, 3776.6412190841825, 3807.124361396894, 4124.1957818225155, 4334.046509767846, 3764.0966168120003, 3806.1816709407058, 3832.827522761482, 3860.536735591691, 3880.165764360676, 1231.6305108467425, 1259.0808709642013, 1264.5700461843016, 1265.9050571207013, 1272.9936350318374, 1011.6813203840767, 1028.6194108179873, 1033.3076838518211, 1097.8353247013013, 1218.0742635596832, 7076.0, 7123.82190445243, 7131.500794944304, 7216.458765592602, 7276.05411296528, 1130.7455822439886, 1159.4202898550725, 1165.091228841505, 1198.6344165029575, 1199.2504684572143, 5576.0, 5598.692071936082, 5651.011073062197, 5653.067243904792, 5654.85862853432, 8665.133486651284, 8776.517291549026, 9004.279657627374, 9012.504312262889, 9027.774305642411, 8911.955440222757, 8980.685676001309, 9001.504917229484, 9015.188633023059, 9020.954895225614, 6850.143732033496, 7042.6830792614455, 7058.505904586732, 7208.423326133897, 7225.349718525358, 6976.546524476096, 6992.0, 7003.649817509002, 7026.789196324118, 7085.362317391459, 7639.541627502367, 7918.406119540942, 7930.524168549906, 8143.83712325762, 8157.632906519102, 8056.355491560778, 8377.329813615019, 8380.413371063967, 8380.790480238044, 8393.748187554384, 5905.911411328748, 6422.3577642235405, 6493.383128602775, 6516.674166291761, 6655.001749737385, 7045.084139061889, 7046.718131274896, 7126.572405655677, 7135.357817796424, 7137.750178743719, 6131.754729810757, 6456.38664326907, 6480.287168411565, 6500.154979852778, 6563.540552161494, 6305.96847015762, 6320.209973753281, 6339.207599050119, 6373.553851230555, 6426.389492998158, 6694.163229596301, 6705.597664140168, 6736.629485378156, 6847.109875716125, 6887.896681549681, 6136.417040381157, 6138.07928810682, 6156.0, 6189.381061893955, 6234.719437625408, 6165.106059621419, 6166.167567378347, 6206.844828879314, 6208.348123447154, 6238.064290356483], "unit": "score", "name": "mootools.html", "value": 4362.519821116373}, {"lowerIsBetter": false, "replicates": [315.29846092444313, 320.50322000898603, 323.2936034764041, 323.8422639065342, 325.6222781573375, 5380.650257733249, 5391.353037635479, 5424.077906755856, 5437.864053398662, 5438.6736795792185, 5355.812546560871, 5412.188171774236, 5413.458654134584, 5416.07926652469, 5424.9186262206, 4001.8799436016966, 4104.117614712836, 4232.217039847623, 4246.57534246576, 4247.065645557972, 4236.978815105936, 4241.512226094008, 4241.830326786925, 4242.724222925515, 4251.829926802924, 4193.056562273495, 4194.958050419503, 4196.727212731178, 4198.454200953872, 4199.286121359361, 3977.681785457171, 4085.20338533986, 4177.4569305990335, 4183.958160418388, 4200.642945349649, 3680.355937710917, 3680.355937710917, 3688.686461650763, 3690.7047436205307, 3690.7785532867847, 5132.153194722866, 5138.46046165151, 5138.537531622134, 5139.743012849342, 5145.434002259748, 4854.854354369375, 4873.390826146731, 4873.902521949542, 4876.634252431047, 4885.364902562644, 5696.259486266758, 5697.943020569783, 5701.287339082614, 5702.3157221133315, 5708.885822283572, 4113.136241389312, 4113.197926404352, 4113.197926404352, 4115.032967252693, 4116.485439320085, 5807.709614519257, 5995.1906492623375, 5999.610025348338, 6003.789867354665, 6006.699665016732, 4169.60388763067, 4199.160167966419, 4205.726627769185, 4210.663146948237, 4211.494620645481, 4234.6823988201, 4269.146170765859, 4273.102648443862, 4289.635380992589, 4291.227579035741, 4859.878503037452, 4860.562549370503, 4864.318995340655, 4871.732054736953, 4873.41519017713, 5751.6549007058875, 5754.309482862, 5763.991301522216, 5764.7117644117625, 5765.509931655856, 1483.8961272711022, 1516.8331483536801, 1519.7340465418729, 1520.445037561282, 1521.6880539489377, 877.526135886614, 953.6280850468323, 983.3657291047234, 989.2036910287144, 999.2954966748425, 4858.0, 4932.334134891744, 4939.728314942713, 4950.133726597831, 4954.826581069645, 5891.734871930774, 5906.350301466835, 5912.142739302777, 5914.378990205966, 5917.55618328627, 4886.511348865156, 4893.314935908976, 4922.606191504671, 4930.0, 4931.161702510582, 3167.1448708848484, 3226.064441311993, 3237.3039796443877, 3240.2223466368373, 3242.4487837067754, 5575.275214222206, 5598.076317407664, 5602.243697100839, 5606.046972014768, 5609.523190528851, 5963.522918166536, 6147.262328520606, 6157.6613286269685, 6161.599496032743, 6165.260168779685, 5557.083081291623, 5577.442255774471, 5589.301337332833, 5590.049691552445, 5598.776048958078, 5943.7028148591535, 5970.253718285215, 5991.910121348096, 5994.820155395345, 5998.890205312031, 5855.736491857791, 5856.238688970577, 5859.355470898113, 5862.677552734641, 5873.177755114373, 5434.538064264424, 5571.331440227199, 5572.554195664418, 5573.7459071708545, 5576.581756368208, 4101.712880098365, 4107.507099148122, 4109.0549173690815, 4109.3425051991535, 4113.424120623055, 5927.525797936241, 5967.433093856077, 5969.880602388015, 5973.0, 5973.193618861572, 5738.282714660668, 5744.942550574441, 5746.942530574641, 5747.19539264495, 5749.252597162342, 5740.339860916049, 5748.482636562562, 5754.482096611325, 5756.798512052058, 5757.596968212185, 5422.8373148805595, 5655.802046928337, 5669.121286200645, 5674.0, 5675.460831221028, 5657.8019769307875, 5670.858228544319, 5699.145128230799, 5700.486956173964, 5703.7433315500075, 5541.251930989265, 5652.6043176978865, 5656.830295091154, 5657.3776884543495, 5658.377578466448], "unit": "score", "name": "prototype.html", "value": 4307.652290960841}, {"lowerIsBetter": false, "replicates": [614.8063360041588, 648.7210499485222, 660.2605082307814, 665.2216906219726, 744.6649007946426, 12195.329256890878, 12532.0, 12571.622851314452, 12591.811122833165, 12607.558735444261, 11442.7139321517, 11703.473343699532, 11714.824277635842, 11749.060075193986, 11780.823287650692, 660.4419265720459, 816.8733846253825, 817.65249768848, 833.2958649940821, 835.381817455085, 836.1471299274737, 840.4789030800912, 841.0202114536588, 842.5071333270045, 842.6755699055847, 875.9649614015464, 876.2508055612456, 876.408424313589, 877.0, 878.5387671472464, 693.5699866083036, 861.4142383179435, 872.6378552900538, 873.3624454148508, 874.3879284500874, 629.5687454093915, 631.1668597451365, 631.9210098737658, 632.0361448790585, 632.3865850125371, 12927.612171634866, 12949.223046617139, 12959.546415875398, 13002.934985325108, 13073.934630326883, 12457.75084498314, 12631.115821892472, 12647.620571382873, 12679.302638354888, 12764.87235127646, 9707.805843883154, 9734.853977190278, 9778.559964801601, 9872.802543949081, 10209.2343074269, 3234.3531293741344, 3299.3236386540702, 3316.2704205074847, 3357.6978071973394, 3452.689257966795, 42055.579444205476, 42586.57413425857, 42646.0, 42733.35899961503, 42810.35784463236, 9150.0, 9339.392939458914, 9704.320697551244, 9752.366096203725, 10028.498575071217, 16681.83318166827, 16684.58288542796, 16716.498505044867, 16725.665486690443, 16733.0, 6516.706748196342, 6604.2074951005225, 6720.428763555153, 6762.526623136431, 6876.724931002804, 3661.5468328757847, 3849.6920246380223, 3924.843006279717, 3925.116848709075, 4014.3175660137845, 2973.9553906691417, 2994.5508173773674, 2995.7453616442845, 2995.8801647933838, 3003.654579723316, 498.220285253577, 503.79344468768363, 523.0950455711564, 525.5007742644503, 541.2719891745596, 468.39810843066493, 537.6988886223727, 537.8144540133648, 587.759018802289, 596.5406636889571, 7752.883706744404, 7759.262870027338, 7824.139344672081, 7987.640556174986, 8042.597870106471, 504.3418339067552, 528.183955788308, 545.4872419925258, 546.6638017619135, 559.0663591801701, 3761.887143385703, 3763.6236376362144, 3852.210296889131, 3873.4770805941403, 3962.821673024721, 50429.74785126051, 50521.74739126281, 50690.23964640533, 50800.491995079574, 50806.49193508018, 46397.07205855864, 47608.285875711896, 48443.0, 51578.74210628923, 52440.737796311536, 41186.0, 41453.58546414497, 41770.791146044685, 44653.10693786171, 44752.77623611861, 8881.111888811067, 9020.233280170996, 9039.954800225956, 9166.17504424605, 9180.44917304964, 32004.35991280208, 32142.35715285728, 32602.83698581492, 32949.0, 33245.83377083196, 40371.79814100911, 40695.59304406918, 41331.7933410331, 41770.164596708506, 41924.0, 11029.0, 11245.831312530483, 11309.290377025922, 11646.70883227926, 11768.52925882955, 11558.595449159238, 12018.158728888893, 12119.697007574881, 12146.0, 12178.147529672839, 11610.94194529022, 11644.301341919512, 11654.825177622512, 12143.939280303543, 12235.204711694067, 11388.145889058189, 11589.6523104307, 11949.22330048544, 12016.519339226683, 12081.697957551132, 11038.44807759625, 11300.717482063013, 11522.942385288356, 11573.942130289295, 11955.222910510789, 9687.176589989647, 9948.35335703177, 9974.301798874008, 10009.399436033862, 10151.17278889807, 8756.168164024408, 8840.513771742615, 9495.525223738923, 9974.850377244202, 10090.477380654836], "unit": "score", "name": "yui.html", "value": 6005.478994124759}], "name": "dromaeo_css", "value": 6510.688193724688}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 113.0, 112.0, 112.0, 102.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 158.0, 173.0, 131.0, 159.0, 158.0, 131.0, 165.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [383.0, 384.0, 383.0, 383.0, 384.0, 385.0, 385.0, 384.0, 385.0, 384.0], "unit": "score", "name": "audio-dft", "value": 384.0}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 99.0, 99.0, 74.0, 74.0, 75.0, 111.0, 99.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 151.0, 93.0, 94.0, 93.0, 136.0, 93.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [193.0, 192.0, 193.0, 193.0, 193.0, 193.0, 193.0, 193.0, 194.0, 193.0], "unit": "score", "name": "imaging-darkroom", "value": 193.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 63.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [81.0, 90.0, 82.0, 83.0, 82.0, 80.0, 84.0, 82.0, 93.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [114.0, 126.0, 121.0, 131.0, 121.0, 116.0, 116.0, 114.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [140.0, 143.0, 138.0, 139.0, 139.0, 128.0, 140.0, 138.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 64.0, 68.0, 65.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1778.0000000000005}]} 19:23:01 INFO - Return code: 0 19:23:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:23:01 ERROR - # TBPL SUCCESS # 19:23:01 INFO - Running post-action listener: _resource_record_post_action 19:23:01 INFO - Running post-run listener: _resource_record_post_run 19:23:02 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 536657920; Read time: 0; Write time: 771620 19:23:02 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 245334016; Read time: 0; Write time: 431012 19:23:02 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 291323904; Read time: 0; Write time: 340608 19:23:02 INFO - Running post-run listener: _upload_blobber_files 19:23:02 INFO - Blob upload gear active. 19:23:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:23:02 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 19:23:02 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'] 19:23:02 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 19:23:02 INFO - (blobuploader) - INFO - Open directory for files ... 19:23:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:23:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:23:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:03 INFO - (blobuploader) - INFO - Done attempting. 19:23:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:23:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:23:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:04 INFO - (blobuploader) - INFO - Done attempting. 19:23:04 INFO - (blobuploader) - INFO - Iteration through files over. 19:23:04 INFO - Return code: 0 19:23:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:23:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:23:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8c1944876bf8d0dd841f9aeb9ce33ebea112058ee5c1ab01ac8ec72c0774379fb4ea881bd3c68a7084842d2b5ed83aa55733716593015ab4a75fd7f2b9ce482", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e855bbf5c21c908521680fadf2f64649088377b5cd7a77eb7144a11c25300c15313b093fa305ac70da70af813893b75671641cddd61e6f97806dfb9e52d4d70a"} 19:23:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:23:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:23:04 INFO - Contents: 19:23:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8c1944876bf8d0dd841f9aeb9ce33ebea112058ee5c1ab01ac8ec72c0774379fb4ea881bd3c68a7084842d2b5ed83aa55733716593015ab4a75fd7f2b9ce482", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e855bbf5c21c908521680fadf2f64649088377b5cd7a77eb7144a11c25300c15313b093fa305ac70da70af813893b75671641cddd61e6f97806dfb9e52d4d70a"} 19:23:04 INFO - Running post-run listener: copy_logs_to_upload_dir 19:23:04 INFO - Copying logs to upload dir... 19:23:04 INFO - mkdir: /builds/slave/test/build/upload/logs 19:23:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.787454 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-14 19:23:03.861564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 19:23:03.865549) ========= 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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 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/c8c1944876bf8d0dd841f9aeb9ce33ebea112058ee5c1ab01ac8ec72c0774379fb4ea881bd3c68a7084842d2b5ed83aa55733716593015ab4a75fd7f2b9ce482", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e855bbf5c21c908521680fadf2f64649088377b5cd7a77eb7144a11c25300c15313b093fa305ac70da70af813893b75671641cddd61e6f97806dfb9e52d4d70a"} build_url:https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/CrY3ZiTzSS2L1-pPLgyUcw/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/c8c1944876bf8d0dd841f9aeb9ce33ebea112058ee5c1ab01ac8ec72c0774379fb4ea881bd3c68a7084842d2b5ed83aa55733716593015ab4a75fd7f2b9ce482", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e855bbf5c21c908521680fadf2f64649088377b5cd7a77eb7144a11c25300c15313b093fa305ac70da70af813893b75671641cddd61e6f97806dfb9e52d4d70a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 19:23:03.891178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:23:03.891500) ========= 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=920470bf432669ad7e3a5387000001ca-1458007006.852683-49615972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:23:03.973821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 19:23:03.974142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 19:23:03.974442) ========= ========= Total master_lag: 0.27 =========