builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1457818864.39 results: success (0) buildid: 20160312122531 builduid: fe563c2014e344aea7b97b322d030e5c revision: d1d47ba19ce9d46222030d491f9fe28dbf80be12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.394377) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.394838) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.395181) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006443 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.429457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.430256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.503134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.503453) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004684 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.571696) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.572089) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.572506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.572856) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-12 13:41:04-- 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% 46.7M=0s 2016-03-12 13:41:04 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088330 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.687537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.687859) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015824 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.739095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:04.739508) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1d47ba19ce9d46222030d491f9fe28dbf80be12 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d1d47ba19ce9d46222030d491f9fe28dbf80be12 --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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-12 13:41:05,083 truncating revision to first 12 chars 2016-03-12 13:41:05,083 Setting DEBUG logging. 2016-03-12 13:41:05,083 attempt 1/10 2016-03-12 13:41:05,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1d47ba19ce9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-12 13:41:05,351 unpacking tar archive at: mozilla-central-d1d47ba19ce9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:05.314527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:05.314898) ========= echo d1d47ba19ce9d46222030d491f9fe28dbf80be12 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd1d47ba19ce9d46222030d491f9fe28dbf80be12'] 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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d1d47ba19ce9d46222030d491f9fe28dbf80be12 program finished with exit code 0 elapsedTime=0.003981 script_repo_revision: 'd1d47ba19ce9d46222030d491f9fe28dbf80be12' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:05.364167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:05.364547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 13:41:05.377123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-03-12 13:41:05.377455) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:41:05 INFO - MultiFileLogger online at 20160312 13:41:05 in /builds/slave/test 13:41:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:41:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:41:05 INFO - {'append_to_log': False, 13:41:05 INFO - 'base_work_dir': '/builds/slave/test', 13:41:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:41:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:41:05 INFO - 'branch': 'Firefox-Non-PGO', 13:41:05 INFO - 'buildbot_json_path': 'buildprops.json', 13:41:05 INFO - 'config_files': ('talos/linux_config.py',), 13:41:05 INFO - 'default_actions': ('clobber', 13:41:05 INFO - 'read-buildbot-config', 13:41:05 INFO - 'download-and-extract', 13:41:05 INFO - 'populate-webroot', 13:41:05 INFO - 'create-virtualenv', 13:41:05 INFO - 'install', 13:41:05 INFO - 'run-tests'), 13:41:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:41:05 INFO - 'download_minidump_stackwalk': True, 13:41:05 INFO - 'download_symbols': 'ondemand', 13:41:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:41:05 INFO - 'tooltool.py': '/tools/tooltool.py', 13:41:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:41:05 INFO - '/tools/misc-python/virtualenv.py')}, 13:41:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:41:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:41:05 INFO - 'installer_path': 'installer.exe', 13:41:05 INFO - 'log_level': 'info', 13:41:05 INFO - 'log_name': 'talos', 13:41:05 INFO - 'log_to_console': True, 13:41:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:41:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:41:05 INFO - 'opt_config_files': (), 13:41:05 INFO - 'pip_index': False, 13:41:05 INFO - 'sps_profile': False, 13:41:05 INFO - 'sps_profile_interval': 0, 13:41:05 INFO - 'suite': 'dromaeojs', 13:41:05 INFO - 'system_bits': '32', 13:41:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:41:05 INFO - 'title': 'talos-linux64-ix-022', 13:41:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:41:05 INFO - 'use_talos_json': True, 13:41:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:41:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:41:05 INFO - 'work_dir': 'build'} 13:41:05 INFO - ##### 13:41:05 INFO - ##### Running clobber step. 13:41:05 INFO - ##### 13:41:05 INFO - Running pre-action listener: _resource_record_pre_action 13:41:05 INFO - Running main action method: clobber 13:41:05 INFO - rmtree: /builds/slave/test/build 13:41:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:41:06 INFO - Running post-action listener: _resource_record_post_action 13:41:06 INFO - ##### 13:41:06 INFO - ##### Running read-buildbot-config step. 13:41:06 INFO - ##### 13:41:06 INFO - Running pre-action listener: _resource_record_pre_action 13:41:06 INFO - Running main action method: read_buildbot_config 13:41:06 INFO - Using buildbot properties: 13:41:06 INFO - { 13:41:06 INFO - "project": "", 13:41:06 INFO - "product": "firefox", 13:41:06 INFO - "script_repo_revision": "production", 13:41:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:41:06 INFO - "repository": "", 13:41:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:41:06 INFO - "buildid": "20160312122531", 13:41:06 INFO - "pgo_build": "False", 13:41:06 INFO - "basedir": "/builds/slave/test", 13:41:06 INFO - "buildnumber": 35, 13:41:06 INFO - "slavename": "talos-linux64-ix-022", 13:41:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:41:06 INFO - "platform": "ubuntu64_hw", 13:41:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:41:06 INFO - "branch": "mozilla-central", 13:41:06 INFO - "repo_path": "mozilla-central", 13:41:06 INFO - "revision": "d1d47ba19ce9d46222030d491f9fe28dbf80be12", 13:41:06 INFO - "stage_platform": "linux64", 13:41:06 INFO - "builduid": "fe563c2014e344aea7b97b322d030e5c", 13:41:06 INFO - "slavebuilddir": "test" 13:41:06 INFO - } 13:41:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:41:06 INFO - Running post-action listener: _resource_record_post_action 13:41:06 INFO - ##### 13:41:06 INFO - ##### Running download-and-extract step. 13:41:06 INFO - ##### 13:41:06 INFO - Running pre-action listener: _resource_record_pre_action 13:41:06 INFO - Running main action method: download_and_extract 13:41:06 INFO - mkdir: /builds/slave/test/build/tests 13:41:06 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')]} 13:41:06 INFO - https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:41:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:41:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:41:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:13 INFO - Downloaded 1361 bytes. 13:41:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:41:13 INFO - Using the following test package requirements: 13:41:13 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:41:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:41:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:41:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:13 INFO - u'jsshell-linux-x86_64.zip'], 13:41:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:41:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:41:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:41:13 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:41:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:41:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:41:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:41:13 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')]} 13:41:13 INFO - https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:41:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:41:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:41:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:14 INFO - Downloaded 21981050 bytes. 13:41:14 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'] 13:41:14 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 13:41:16 INFO - Return code: 0 13:41:16 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 13:41:16 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')]} 13:41:16 INFO - https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:41:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:41:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:41:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:19 INFO - Downloaded 21981050 bytes. 13:41:19 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'] 13:41:19 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 13:41:21 INFO - Return code: 0 13:41:21 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')]} 13:41:21 INFO - https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:41:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:41:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:41:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:21 INFO - Downloaded 10845263 bytes. 13:41:21 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'] 13:41:21 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 13:41:22 INFO - Return code: 0 13:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:22 INFO - https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:41:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:41:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:41:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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 13:41:23 INFO - Downloaded 54107521 bytes. 13:41:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:41:23 INFO - mkdir: /builds/slave/test/properties 13:41:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:41:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:41:23 INFO - Contents: 13:41:23 INFO - build_url:https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:41:24 INFO - Running post-action listener: _resource_record_post_action 13:41:24 INFO - Running post-action listener: set_extra_try_arguments 13:41:24 INFO - ##### 13:41:24 INFO - ##### Running populate-webroot step. 13:41:24 INFO - ##### 13:41:24 INFO - Running pre-action listener: _resource_record_pre_action 13:41:24 INFO - Running main action method: populate_webroot 13:41:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:41:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:41:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:41:24 INFO - '--tppagecycles', 13:41:24 INFO - '7'], 13:41:24 INFO - 'tests': ['tsvgm']}}, 13:41:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:41:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:41:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:41:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:41:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:41:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:24 INFO - 'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:41:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:24 INFO - 'tests': ['damp', 'tps']}, 13:41:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:24 INFO - 'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['damp', 'tps']}, 13:41:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:41:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:41:24 INFO - 'other': {'tests': ['a11yr', 13:41:24 INFO - 'ts_paint', 13:41:24 INFO - 'tpaint', 13:41:24 INFO - 'sessionrestore', 13:41:24 INFO - 'sessionrestore_no_auto_restore', 13:41:24 INFO - 'tabpaint']}, 13:41:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['a11yr', 13:41:24 INFO - 'ts_paint', 13:41:24 INFO - 'tpaint', 13:41:24 INFO - 'sessionrestore', 13:41:24 INFO - 'sessionrestore_no_auto_restore', 13:41:24 INFO - 'tabpaint']}, 13:41:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['a11yr', 13:41:24 INFO - 'ts_paint', 13:41:24 INFO - 'tpaint', 13:41:24 INFO - 'sessionrestore', 13:41:24 INFO - 'sessionrestore_no_auto_restore', 13:41:24 INFO - 'tabpaint']}, 13:41:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['a11yr', 13:41:24 INFO - 'ts_paint', 13:41:24 INFO - 'tpaint', 13:41:24 INFO - 'sessionrestore', 13:41:24 INFO - 'sessionrestore_no_auto_restore', 13:41:24 INFO - 'tabpaint']}, 13:41:24 INFO - 'other_l64': {'tests': ['a11yr', 13:41:24 INFO - 'ts_paint', 13:41:24 INFO - 'tpaint', 13:41:24 INFO - 'sessionrestore', 13:41:24 INFO - 'sessionrestore_no_auto_restore', 13:41:24 INFO - 'tabpaint']}, 13:41:24 INFO - 'other_nol64': {'tests': ['a11yr', 13:41:24 INFO - 'ts_paint', 13:41:24 INFO - 'tpaint', 13:41:24 INFO - 'sessionrestore', 13:41:24 INFO - 'sessionrestore_no_auto_restore', 13:41:24 INFO - 'tabpaint']}, 13:41:24 INFO - 'svgr': {'tests': ['tsvgx', 13:41:24 INFO - 'tsvgr_opacity', 13:41:24 INFO - 'tart', 13:41:24 INFO - 'tscrollx', 13:41:24 INFO - 'cart']}, 13:41:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['tsvgx', 13:41:24 INFO - 'tsvgr_opacity', 13:41:24 INFO - 'tart', 13:41:24 INFO - 'tscrollx', 13:41:24 INFO - 'cart']}, 13:41:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:24 INFO - 'tests': ['tp5o']}, 13:41:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:24 INFO - 'talos_options': ['--e10s'], 13:41:24 INFO - 'tests': ['tp5o']}, 13:41:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:24 INFO - 'talos_options': ['--xperf_path', 13:41:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:41:24 INFO - 'tests': ['tp5n']}, 13:41:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:24 INFO - 'talos_options': ['--e10s', 13:41:24 INFO - '--xperf_path', 13:41:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:41:24 INFO - 'tests': ['tp5n']}}, 13:41:24 INFO - 'talos.zip': {'path': '', 13:41:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:41:24 INFO - Running post-action listener: _resource_record_post_action 13:41:24 INFO - ##### 13:41:24 INFO - ##### Running create-virtualenv step. 13:41:24 INFO - ##### 13:41:24 INFO - Running pre-action listener: _resource_record_pre_action 13:41:24 INFO - Running main action method: create_virtualenv 13:41:24 INFO - Creating virtualenv /builds/slave/test/build/venv 13:41:24 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 13:41:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:41:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:41:24 INFO - Using real prefix '/usr' 13:41:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:41:24 INFO - Installing distribute.............................................................................................................................................................................................done. 13:41:26 INFO - Installing pip.................done. 13:41:26 INFO - Return code: 0 13:41:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:26 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 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41:26 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 13:41:26 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 13:41:26 INFO - Using env: {'DISPLAY': ':0', 13:41:26 INFO - 'HOME': '/home/cltbld', 13:41:26 INFO - 'LANG': 'en_US.UTF-8', 13:41:26 INFO - 'LANGUAGE': 'en_US:en', 13:41:26 INFO - 'LOGNAME': 'cltbld', 13:41:26 INFO - 'MAIL': '/var/mail/cltbld', 13:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:26 INFO - 'MOZ_NO_REMOTE': '1', 13:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:26 INFO - 'NO_EM_RESTART': '1', 13:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:26 INFO - 'PWD': '/builds/slave/test', 13:41:26 INFO - 'SHELL': '/bin/bash', 13:41:26 INFO - 'SHLVL': '1', 13:41:26 INFO - 'TERM': 'linux', 13:41:26 INFO - 'TMOUT': '86400', 13:41:26 INFO - 'USER': 'cltbld', 13:41:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:26 INFO - '_': '/tools/buildbot/bin/python'} 13:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:27 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 13:41:27 INFO - Cleaning up... 13:41:27 INFO - Return code: 0 13:41:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:41: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')]} 13:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41: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')]} 13:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:27 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 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41:27 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 13:41:27 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 13:41:27 INFO - Using env: {'DISPLAY': ':0', 13:41:27 INFO - 'HOME': '/home/cltbld', 13:41:27 INFO - 'LANG': 'en_US.UTF-8', 13:41:27 INFO - 'LANGUAGE': 'en_US:en', 13:41:27 INFO - 'LOGNAME': 'cltbld', 13:41:27 INFO - 'MAIL': '/var/mail/cltbld', 13:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:27 INFO - 'MOZ_NO_REMOTE': '1', 13:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:27 INFO - 'NO_EM_RESTART': '1', 13:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:27 INFO - 'PWD': '/builds/slave/test', 13:41:27 INFO - 'SHELL': '/bin/bash', 13:41:27 INFO - 'SHLVL': '1', 13:41:27 INFO - 'TERM': 'linux', 13:41:27 INFO - 'TMOUT': '86400', 13:41:27 INFO - 'USER': 'cltbld', 13:41:27 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:27 INFO - '_': '/tools/buildbot/bin/python'} 13:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:27 INFO - Downloading/unpacking psutil>=0.7.1 13:41:27 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 13:41:27 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 13:41:27 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 13:41:27 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 13:41:27 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 13:41:27 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 13:41:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:41:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:41:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:41:29 INFO - Installing collected packages: psutil 13:41:29 INFO - Running setup.py install for psutil 13:41:29 INFO - building 'psutil._psutil_linux' extension 13:41:29 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 13:41:29 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 13:41:29 INFO - building 'psutil._psutil_posix' extension 13:41:29 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 13:41:29 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 13:41:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:41:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:41:29 INFO - Successfully installed psutil 13:41:29 INFO - Cleaning up... 13:41:29 INFO - Return code: 0 13:41:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:29 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 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41:29 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 13:41:29 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 13:41:29 INFO - Using env: {'DISPLAY': ':0', 13:41:29 INFO - 'HOME': '/home/cltbld', 13:41:29 INFO - 'LANG': 'en_US.UTF-8', 13:41:29 INFO - 'LANGUAGE': 'en_US:en', 13:41:29 INFO - 'LOGNAME': 'cltbld', 13:41:29 INFO - 'MAIL': '/var/mail/cltbld', 13:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:29 INFO - 'MOZ_NO_REMOTE': '1', 13:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:29 INFO - 'NO_EM_RESTART': '1', 13:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:29 INFO - 'PWD': '/builds/slave/test', 13:41:29 INFO - 'SHELL': '/bin/bash', 13:41:29 INFO - 'SHLVL': '1', 13:41:29 INFO - 'TERM': 'linux', 13:41:29 INFO - 'TMOUT': '86400', 13:41:29 INFO - 'USER': 'cltbld', 13:41:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:29 INFO - '_': '/tools/buildbot/bin/python'} 13:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:41:29 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 13:41:29 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 13:41:29 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 13:41:29 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 13:41:29 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 13:41:29 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 13:41:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:41:31 INFO - Installing collected packages: mozsystemmonitor 13:41:31 INFO - Running setup.py install for mozsystemmonitor 13:41:31 INFO - Successfully installed mozsystemmonitor 13:41:31 INFO - Cleaning up... 13:41:31 INFO - Return code: 0 13:41:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:31 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 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41:31 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 13:41:31 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 13:41:31 INFO - Using env: {'DISPLAY': ':0', 13:41:31 INFO - 'HOME': '/home/cltbld', 13:41:31 INFO - 'LANG': 'en_US.UTF-8', 13:41:31 INFO - 'LANGUAGE': 'en_US:en', 13:41:31 INFO - 'LOGNAME': 'cltbld', 13:41:31 INFO - 'MAIL': '/var/mail/cltbld', 13:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:31 INFO - 'MOZ_NO_REMOTE': '1', 13:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:31 INFO - 'NO_EM_RESTART': '1', 13:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:31 INFO - 'PWD': '/builds/slave/test', 13:41:31 INFO - 'SHELL': '/bin/bash', 13:41:31 INFO - 'SHLVL': '1', 13:41:31 INFO - 'TERM': 'linux', 13:41:31 INFO - 'TMOUT': '86400', 13:41:31 INFO - 'USER': 'cltbld', 13:41:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:31 INFO - '_': '/tools/buildbot/bin/python'} 13:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:32 INFO - Downloading/unpacking blobuploader==1.2.4 13:41:32 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 13:41:32 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 13:41:32 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 13:41:32 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 13:41:32 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 13:41:32 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 13:41:33 INFO - Downloading blobuploader-1.2.4.tar.gz 13:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:41:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:41:34 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 13:41:34 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 13:41:34 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 13:41:34 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 13:41:34 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 13:41:34 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 13:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:41:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:41:34 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 13:41:34 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 13:41:34 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 13:41:34 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 13:41:34 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 13:41:34 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 13:41:34 INFO - Downloading docopt-0.6.1.tar.gz 13:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:41:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:41:34 INFO - Running setup.py install for blobuploader 13:41:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:41:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:41:34 INFO - Running setup.py install for requests 13:41:35 INFO - Running setup.py install for docopt 13:41:35 INFO - Successfully installed blobuploader requests docopt 13:41:35 INFO - Cleaning up... 13:41:35 INFO - Return code: 0 13:41:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:35 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 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41:35 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 13:41:35 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 13:41:35 INFO - Using env: {'DISPLAY': ':0', 13:41:35 INFO - 'HOME': '/home/cltbld', 13:41:35 INFO - 'LANG': 'en_US.UTF-8', 13:41:35 INFO - 'LANGUAGE': 'en_US:en', 13:41:35 INFO - 'LOGNAME': 'cltbld', 13:41:35 INFO - 'MAIL': '/var/mail/cltbld', 13:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:35 INFO - 'MOZ_NO_REMOTE': '1', 13:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:35 INFO - 'NO_EM_RESTART': '1', 13:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:35 INFO - 'PWD': '/builds/slave/test', 13:41:35 INFO - 'SHELL': '/bin/bash', 13:41:35 INFO - 'SHLVL': '1', 13:41:35 INFO - 'TERM': 'linux', 13:41:35 INFO - 'TMOUT': '86400', 13:41:35 INFO - 'USER': 'cltbld', 13:41:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:35 INFO - '_': '/tools/buildbot/bin/python'} 13:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:41:35 INFO - Running setup.py (path:/tmp/pip-hkpcdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:41:35 INFO - Running setup.py (path:/tmp/pip-LEKrWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:41:35 INFO - Running setup.py (path:/tmp/pip-XYoJP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:41:35 INFO - Running setup.py (path:/tmp/pip-uRr7In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:41:35 INFO - Running setup.py (path:/tmp/pip-cXwjmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:41:35 INFO - Running setup.py (path:/tmp/pip-ZYw5Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:41:35 INFO - Running setup.py (path:/tmp/pip-LqpQED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:41:36 INFO - Running setup.py (path:/tmp/pip-4Rvxdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:41:36 INFO - Running setup.py (path:/tmp/pip-dnqH0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:41:36 INFO - Running setup.py (path:/tmp/pip-IqVqiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:41:36 INFO - Running setup.py (path:/tmp/pip-cXEF6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:41:36 INFO - Running setup.py (path:/tmp/pip-Fr0UPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:41:36 INFO - Running setup.py (path:/tmp/pip-0yw9by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:41:36 INFO - Running setup.py (path:/tmp/pip-iGckrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:36 INFO - Running setup.py (path:/tmp/pip-3T6mZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:41:36 INFO - Running setup.py (path:/tmp/pip-aCKxoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:41:36 INFO - Running setup.py (path:/tmp/pip-ch6tVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:41:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:41:36 INFO - Running setup.py install for manifestparser 13:41:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:41:36 INFO - Running setup.py install for mozcrash 13:41:36 INFO - Running setup.py install for mozdebug 13:41:37 INFO - Running setup.py install for mozdevice 13:41:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Running setup.py install for mozfile 13:41:37 INFO - Running setup.py install for mozhttpd 13:41:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Running setup.py install for mozinfo 13:41:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Running setup.py install for mozInstall 13:41:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Running setup.py install for mozleak 13:41:37 INFO - Running setup.py install for mozlog 13:41:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Running setup.py install for moznetwork 13:41:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:41:37 INFO - Running setup.py install for mozprocess 13:41:37 INFO - Running setup.py install for mozprofile 13:41:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:41:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:41:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:41:38 INFO - Running setup.py install for mozrunner 13:41:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:41:38 INFO - Running setup.py install for mozscreenshot 13:41:38 INFO - Running setup.py install for moztest 13:41:38 INFO - Running setup.py install for mozversion 13:41:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:41:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:41:38 INFO - Cleaning up... 13:41:38 INFO - Return code: 0 13:41:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:38 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 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41:38 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 13:41:38 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 13:41:38 INFO - Using env: {'DISPLAY': ':0', 13:41:38 INFO - 'HOME': '/home/cltbld', 13:41:38 INFO - 'LANG': 'en_US.UTF-8', 13:41:38 INFO - 'LANGUAGE': 'en_US:en', 13:41:38 INFO - 'LOGNAME': 'cltbld', 13:41:38 INFO - 'MAIL': '/var/mail/cltbld', 13:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:38 INFO - 'MOZ_NO_REMOTE': '1', 13:41:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:38 INFO - 'NO_EM_RESTART': '1', 13:41:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:38 INFO - 'PWD': '/builds/slave/test', 13:41:38 INFO - 'SHELL': '/bin/bash', 13:41:38 INFO - 'SHLVL': '1', 13:41:38 INFO - 'TERM': 'linux', 13:41:38 INFO - 'TMOUT': '86400', 13:41:38 INFO - 'USER': 'cltbld', 13:41:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:38 INFO - '_': '/tools/buildbot/bin/python'} 13:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:41:38 INFO - Running setup.py (path:/tmp/pip-DvqxkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:41:38 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)) 13:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:41:38 INFO - Running setup.py (path:/tmp/pip-9xc4fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:41:38 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)) 13:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:41:38 INFO - Running setup.py (path:/tmp/pip-ztczMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:41:38 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)) 13:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:41:38 INFO - Running setup.py (path:/tmp/pip-mKkgOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:41:39 INFO - Running setup.py (path:/tmp/pip-S0tBgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:41:39 INFO - Running setup.py (path:/tmp/pip-_RcmwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:41:39 INFO - Running setup.py (path:/tmp/pip-jVgeMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:41:39 INFO - Running setup.py (path:/tmp/pip-ZfxCJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:41:39 INFO - Running setup.py (path:/tmp/pip-PwuyrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:41:39 INFO - Running setup.py (path:/tmp/pip-PgixFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:41:39 INFO - Running setup.py (path:/tmp/pip-5wHIfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:41:39 INFO - Running setup.py (path:/tmp/pip-PmyGOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:41:39 INFO - Running setup.py (path:/tmp/pip-tuOQ2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:41:39 INFO - Running setup.py (path:/tmp/pip-usAlgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:39 INFO - Running setup.py (path:/tmp/pip-2JppY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:41:39 INFO - Running setup.py (path:/tmp/pip-ByvXr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:41:39 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)) 13:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:41:39 INFO - Running setup.py (path:/tmp/pip-Q6MYDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:41:39 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)) 13:41:39 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)) 13:41:39 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)) 13:41:39 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)) 13:41:39 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)) 13:41:39 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)) 13:41:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41:41 INFO - Downloading blessings-1.6.tar.gz 13:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:41:41 INFO - Installing collected packages: blessings 13:41:41 INFO - Running setup.py install for blessings 13:41:41 INFO - Successfully installed blessings 13:41:41 INFO - Cleaning up... 13:41:42 INFO - Return code: 0 13:41:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:41:42 INFO - Reading from file tmpfile_stdout 13:41:42 INFO - Current package versions: 13:41:42 INFO - argparse == 1.2.1 13:41:42 INFO - blessings == 1.6 13:41:42 INFO - blobuploader == 1.2.4 13:41:42 INFO - docopt == 0.6.1 13:41:42 INFO - manifestparser == 1.1 13:41:42 INFO - mozInstall == 1.12 13:41:42 INFO - mozcrash == 0.17 13:41:42 INFO - mozdebug == 0.1 13:41:42 INFO - mozdevice == 0.48 13:41:42 INFO - mozfile == 1.2 13:41:42 INFO - mozhttpd == 0.7 13:41:42 INFO - mozinfo == 0.9 13:41:42 INFO - mozleak == 0.1 13:41:42 INFO - mozlog == 3.1 13:41:42 INFO - moznetwork == 0.27 13:41:42 INFO - mozprocess == 0.22 13:41:42 INFO - mozprofile == 0.28 13:41:42 INFO - mozrunner == 6.11 13:41:42 INFO - mozscreenshot == 0.1 13:41:42 INFO - mozsystemmonitor == 0.0 13:41:42 INFO - moztest == 0.7 13:41:42 INFO - mozversion == 1.4 13:41:42 INFO - psutil == 3.1.1 13:41:42 INFO - requests == 1.2.3 13:41:42 INFO - wsgiref == 0.1.2 13:41:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41: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')]} 13:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41: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')]} 13:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:42 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 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41:42 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 13:41:42 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 13:41:42 INFO - Using env: {'DISPLAY': ':0', 13:41:42 INFO - 'HOME': '/home/cltbld', 13:41:42 INFO - 'LANG': 'en_US.UTF-8', 13:41:42 INFO - 'LANGUAGE': 'en_US:en', 13:41:42 INFO - 'LOGNAME': 'cltbld', 13:41:42 INFO - 'MAIL': '/var/mail/cltbld', 13:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:42 INFO - 'MOZ_NO_REMOTE': '1', 13:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:42 INFO - 'NO_EM_RESTART': '1', 13:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:42 INFO - 'PWD': '/builds/slave/test', 13:41:42 INFO - 'SHELL': '/bin/bash', 13:41:42 INFO - 'SHLVL': '1', 13:41:42 INFO - 'TERM': 'linux', 13:41:42 INFO - 'TMOUT': '86400', 13:41:42 INFO - 'USER': 'cltbld', 13:41:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:42 INFO - '_': '/tools/buildbot/bin/python'} 13:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 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)) 13:41:42 INFO - Cleaning up... 13:41:42 INFO - Return code: 0 13:41:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:41: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')]} 13:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41: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')]} 13:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41: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', 'jsonschema'] in /builds/slave/test/build 13:41: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 jsonschema 13:41:42 INFO - Using env: {'DISPLAY': ':0', 13:41:42 INFO - 'HOME': '/home/cltbld', 13:41:42 INFO - 'LANG': 'en_US.UTF-8', 13:41:42 INFO - 'LANGUAGE': 'en_US:en', 13:41:42 INFO - 'LOGNAME': 'cltbld', 13:41:42 INFO - 'MAIL': '/var/mail/cltbld', 13:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:42 INFO - 'MOZ_NO_REMOTE': '1', 13:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:42 INFO - 'NO_EM_RESTART': '1', 13:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:42 INFO - 'PWD': '/builds/slave/test', 13:41:42 INFO - 'SHELL': '/bin/bash', 13:41:42 INFO - 'SHLVL': '1', 13:41:42 INFO - 'TERM': 'linux', 13:41:42 INFO - 'TMOUT': '86400', 13:41:42 INFO - 'USER': 'cltbld', 13:41:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:42 INFO - '_': '/tools/buildbot/bin/python'} 13:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:42 INFO - Downloading/unpacking jsonschema 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:41:44 INFO - Downloading/unpacking functools32 (from jsonschema) 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41:44 INFO - Downloading functools32-3.2.3-2.tar.gz 13:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:41:44 INFO - warning: no files found matching '*.txt' 13:41:44 INFO - no previously-included directories found matching 'build' 13:41:44 INFO - no previously-included directories found matching 'dist' 13:41:44 INFO - no previously-included directories found matching '.git*' 13:41:44 INFO - Installing collected packages: jsonschema, functools32 13:41:44 INFO - Running setup.py install for functools32 13:41:44 INFO - warning: no files found matching '*.txt' 13:41:44 INFO - no previously-included directories found matching 'build' 13:41:44 INFO - no previously-included directories found matching 'dist' 13:41:44 INFO - no previously-included directories found matching '.git*' 13:41:44 INFO - Successfully installed jsonschema functools32 13:41:44 INFO - Cleaning up... 13:41:45 INFO - Return code: 0 13:41:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:41:45 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')]} 13:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:45 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')]} 13:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:45 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 0x7fd446c5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1312410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', '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 13:41:45 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 13:41:45 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 13:41:45 INFO - Using env: {'DISPLAY': ':0', 13:41:45 INFO - 'HOME': '/home/cltbld', 13:41:45 INFO - 'LANG': 'en_US.UTF-8', 13:41:45 INFO - 'LANGUAGE': 'en_US:en', 13:41:45 INFO - 'LOGNAME': 'cltbld', 13:41:45 INFO - 'MAIL': '/var/mail/cltbld', 13:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:45 INFO - 'MOZ_NO_REMOTE': '1', 13:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:41:45 INFO - 'NO_EM_RESTART': '1', 13:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:45 INFO - 'PWD': '/builds/slave/test', 13:41:45 INFO - 'SHELL': '/bin/bash', 13:41:45 INFO - 'SHLVL': '1', 13:41:45 INFO - 'TERM': 'linux', 13:41:45 INFO - 'TMOUT': '86400', 13:41:45 INFO - 'USER': 'cltbld', 13:41:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:45 INFO - '_': '/tools/buildbot/bin/python'} 13:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:45 INFO - Downloading/unpacking flake8 13:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:41:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:41:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:41:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:41:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:41:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:41:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:41:47 INFO - no previously-included directories found matching 'docs/_build' 13:41:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:41:47 INFO - Running setup.py install for pep8 13:41:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:41:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:41:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:41:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:41:47 INFO - no previously-included directories found matching 'docs/_build' 13:41:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:41:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:41:47 INFO - Cleaning up... 13:41:47 INFO - Return code: 0 13:41:47 INFO - Running post-action listener: _resource_record_post_action 13:41:47 INFO - Running post-action listener: _start_resource_monitoring 13:41:47 INFO - Starting resource monitoring. 13:41:47 INFO - ##### 13:41:47 INFO - ##### Running install step. 13:41:47 INFO - ##### 13:41:47 INFO - Running pre-action listener: _resource_record_pre_action 13:41:47 INFO - Running main action method: install 13:41:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:41:48 INFO - Reading from file tmpfile_stdout 13:41:48 INFO - Detecting whether we're running mozinstall >=1.0... 13:41:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:41:48 INFO - Reading from file tmpfile_stdout 13:41:48 INFO - Output received: 13:41:48 INFO - Usage: mozinstall [options] installer 13:41:48 INFO - Options: 13:41:48 INFO - -h, --help show this help message and exit 13:41:48 INFO - -d DEST, --destination=DEST 13:41:48 INFO - Directory to install application into. [default: 13:41:48 INFO - "/builds/slave/test"] 13:41:48 INFO - --app=APP Application being installed. [default: firefox] 13:41:48 INFO - mkdir: /builds/slave/test/build/application 13:41:48 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'] 13:41:48 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 13:42:03 INFO - Reading from file tmpfile_stdout 13:42:03 INFO - Output received: 13:42:03 INFO - /builds/slave/test/build/application/firefox/firefox 13:42:03 INFO - Running post-action listener: _resource_record_post_action 13:42:03 INFO - ##### 13:42:03 INFO - ##### Running run-tests step. 13:42:03 INFO - ##### 13:42:03 INFO - Running pre-action listener: _resource_record_pre_action 13:42:03 INFO - Running main action method: run_tests 13:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:42:03 INFO - Python 2.7.3 13:42:03 INFO - Return code: 0 13:42:03 INFO - grabbing minidump binary from tooltool 13:42:03 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')]} 13:42:03 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 0x13a1160>, '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 0x13a2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a24f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:42:03 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 13:42:03 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 13:42:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:42:03 INFO - Return code: 0 13:42:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:42:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:42:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:42:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:42:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:42:04 INFO - Return code: 0 13:42:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 13:42:04 INFO - Using env: {'DISPLAY': ':0', 13:42:04 INFO - 'HOME': '/home/cltbld', 13:42:04 INFO - 'LANG': 'en_US.UTF-8', 13:42:04 INFO - 'LANGUAGE': 'en_US:en', 13:42:04 INFO - 'LOGNAME': 'cltbld', 13:42:04 INFO - 'MAIL': '/var/mail/cltbld', 13:42:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:42:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:04 INFO - 'MOZ_NO_REMOTE': '1', 13:42:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:04 INFO - 'NO_EM_RESTART': '1', 13:42:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:04 INFO - 'PWD': '/builds/slave/test', 13:42:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:42:04 INFO - 'SHELL': '/bin/bash', 13:42:04 INFO - 'SHLVL': '1', 13:42:04 INFO - 'TERM': 'linux', 13:42:04 INFO - 'TMOUT': '86400', 13:42:04 INFO - 'USER': 'cltbld', 13:42:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024', 13:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:04 INFO - '_': '/tools/buildbot/bin/python'} 13:42:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:42:05 INFO - mozversion application_buildid: 20160312122531 13:42:05 INFO - mozversion application_changeset: d1d47ba19ce9d46222030d491f9fe28dbf80be12 13:42:05 INFO - mozversion application_display_name: Nightly 13:42:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:42:05 INFO - mozversion application_name: Firefox 13:42:05 INFO - mozversion application_remotingname: firefox 13:42:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:42:05 INFO - mozversion application_vendor: Mozilla 13:42:05 INFO - mozversion application_version: 48.0a1 13:42:05 INFO - mozversion platform_buildid: 20160312122531 13:42:05 INFO - mozversion platform_changeset: d1d47ba19ce9d46222030d491f9fe28dbf80be12 13:42:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:42:05 INFO - mozversion platform_version: 48.0a1 13:42:05 INFO - using testdate: 1457818925 13:42:05 INFO - actual date: 1457818925 13:42:05 INFO - starting webserver on 'localhost:41727' 13:42:05 INFO - SUITE-START | Running 2 tests 13:42:05 INFO - TEST-START | dromaeo_css 13:42:05 INFO - operating with platform_type : linux_ 13:42:05 INFO - Initialising browser for dromaeo_css test... 13:42:05 INFO - TEST-INFO | started process 17259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGF5w5T/profile http://localhost:41727/getInfo.html) 13:42:09 INFO - PROCESS | 17259 | __metrics Screen width/height:1600/1200 13:42:09 INFO - PROCESS | 17259 | colorDepth:24 13:42:09 INFO - PROCESS | 17259 | Browser inner width/height: 1024/697 13:42:09 INFO - PROCESS | 17259 | __metrics 13:42:10 ERROR - PROCESS | 17259 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:42:10 INFO - PROCESS | 17259 | 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. 13:42:11 INFO - TEST-INFO | 17259: exit 0 13:42:11 INFO - Browser initialized. 13:42:11 INFO - Running cycle 1/1 for dromaeo_css test... 13:42:11 INFO - TEST-INFO | started process 17353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGF5w5T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:23 INFO - PROCESS | 17353 | RSS: Main: 154251264 13:42:23 INFO - PROCESS | 17353 | 13:43:14 INFO - PROCESS | 17353 | 1457818994656 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] 13:45:26 INFO - PROCESS | 17353 | Cycle 1(1): loaded http://localhost:41727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41727/tests/dromaeo/cssquery-ext.html) 13:45:27 INFO - PROCESS | 17353 | RSS: Main: 273367040 13:45:27 INFO - PROCESS | 17353 | 13:48:29 INFO - PROCESS | 17353 | Cycle 1(1): loaded http://localhost:41727/tests/dromaeo/cssquery-ext.html (next: http://localhost:41727/tests/dromaeo/cssquery-jquery.html) 13:48:30 INFO - PROCESS | 17353 | RSS: Main: 240336896 13:48:30 INFO - PROCESS | 17353 | 13:51:32 INFO - PROCESS | 17353 | Cycle 1(1): loaded http://localhost:41727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41727/tests/dromaeo/cssquery-mootools.html) 13:51:32 INFO - PROCESS | 17353 | RSS: Main: 239996928 13:51:32 INFO - PROCESS | 17353 | 13:54:34 INFO - PROCESS | 17353 | Cycle 1(1): loaded http://localhost:41727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41727/tests/dromaeo/cssquery-prototype.html) 13:54:35 INFO - PROCESS | 17353 | RSS: Main: 204169216 13:54:35 INFO - PROCESS | 17353 | 13:57:38 INFO - PROCESS | 17353 | Cycle 1(1): loaded http://localhost:41727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41727/tests/dromaeo/cssquery-yui.html) 13:57:38 INFO - PROCESS | 17353 | RSS: Main: 206905344 13:57:38 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | Cycle 1(1): loaded http://localhost:41727/tests/dromaeo/cssquery-yui.html (next: http://localhost:41727/tests/dromaeo/cssquery-dojo.html) 14:00:41 INFO - PROCESS | 17353 | RSS: Main: 235732992 14:00:41 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | __start_tp_report 14:00:41 INFO - PROCESS | 17353 | _x_x_mozilla_page_load 14:00:41 INFO - PROCESS | 17353 | _x_x_mozilla_page_load_details 14:00:41 INFO - PROCESS | 17353 | |i|pagename|runs| 14:00:41 INFO - PROCESS | 17353 | |0;dojo.html;2570.8714564271786;2631.539480590896;2641.96037059444;2642.180923913586;2664.2806442260594;4500.5724456176695;4558.521355257696;4559.110973360196;4571.588557029862;4603.263477843546;4563.201439748047;4585.105904348653;4638.211504044312;4641.675082744209;4642.141203877285;4179.770112643803;4258.488981322245;4316.870493885189;4363.127374525092;4369.1480161368545;4195.139996300751;4274.7862606869685;4323.373110898918;4323.675724320673;4335.046289816235;4231.090315582164;4273.487181538236;4276.208901353244;4297.140571885635;4330.501992270898;4211.389348544444;4212.241796476633;4219.324908014733;4252.319628859368;4259.1268789897995;4150.958490415087;4211.7472951623;4215.009472773896;4215.473065866767;4261.914761704748;4526.52471490492;4557.886052848672;4567.703099298568;4601.286800545888;4612.561806628365;4915.852524424273;4925.3350797642215;4926.137925862996;4934.1611925972675;4977.50224977503;4839.516048395132;4948.1093403187415;4958.281049247875;4983.6013118950395;4987.650864439491;4632.60622847055;4650.67445278834;4668.206404911173;4700.71795692263;4703.764811759467;5063.291139240509;5069.670471419346;5071.46749591295;5078.162103252922;5121.795128194831;4766.666333356701;4806.567408933212;4859.708417494961;4865.9756701216265;4876.853694389174;4941.654084214142;4953.380827396575;4996.4503904570465;5005.174146265898;5011.799528018912;4905.901881962341;4908.410990681141;4910.288008238786;4915.975420122948;4959.231319145538;4801.255805350176;4872.926906096412;4882.7314497702255;4922.1140194765285;4927.901441971212;4193.287141185945;4196.370544418301;4223.915521689549;4245.320748680197;4260.957390426118;3685.4287585424304;3691.151035261851;3696.1498855262903;3719.1817800083936;3736.775793452347;4156;4297;4305.117450922553;4308.655307575386;4342.652587792969;4946.258061290835;4980.7509624518625;4997;5027.2207807789855;5036.823711170092;4243.533211346749;4243.6605071594195;4256.70203085781;4281.721688090264;4286.635635970915;4367.825286988485;4374.978125109417;4416.80124394403;4438.689291749546;4442.933355999663;4669.626429885669;4679.602233810164;4683.274092515666;4711.340412342275;4726.3146843708155;4954.851354459372;4957.900841983213;4959.156943319716;4959.7272150032095;4982.2775697524385;4604.493505714436;4608.308753686973;4666.066786642617;4679.415073115861;4716.316134160596;4884.682495637772;4903.313536104877;4903.31353610502;4915.361003069578;4963.875903102451;4943.4562198157455;4958.0083983202785;4977.9751101244265;4980.302757613865;4981.800727970841;4648.325992731103;4780.760961951958;4832.855014349575;4847.127517046965;4865.7323847188745;4826.903461930812;4830;4845.781939812788;4851.078295124056;4899.828506002273;4779.091972525209;4793.113274044313;4794.232922732346;4795.304680821331;4828.806847726051;4731.645126615449;4770.952290477051;4836.588889944394;4860.441049279237;4874.975625121851;4674.555917187861;4677.7894994726;4692.6480513960905;4692.953070469388;4694.74178920149 14:00:41 INFO - PROCESS | 17353 | |1;ext.html;527.7677821758429;539.1400715858207;553.7591147850683;560.8625886657769;566.8214512428584;27012;27449.45101097977;34287.828560857226;34845.65154348456;34942.650573494255;37976.43035354472;38110;38494;38495.80752096243;38502.22995540088;7747.883781743264;7924.247196516321;7929.167437419074;7935.920640793576;7938.6824527019135;6854.965725171367;8122.390820688443;8123.187681231889;8123.918760812376;8125.634346454423;8074.596270186496;8162.877556836652;8167.754967350989;8173.918260817375;8175.305099066586;8041.276285134337;8093.392995525301;8133.10535841057;8136;8149.551774652392;7926.524408535449;8058.4359094863385;8060.113387527367;8060.5566693831815;8067.314278286352;37508.81245593782;37951.4307285391;37962.810185948896;37997.62002379968;38004.619953800386;2984.7313741763346;2993.6108305920307;3086.2284428892776;3320.9169770755684;3351.6815902489225;28129.086353699666;28673;28674.713252867412;29118;29274.707252927623;3276.508523721437;3277.147941535218;3301.6863397977154;3303.504474328846;3372.4941258811127;262144;264545;264762;265299.9999999981;266670;53113;53206.20190697143;53580;53735;53960.46039539633;63187.6840615794;63888.68055659785;63968.68015659892;64016.35983640197;64047.67976160089;15252.694946101015;15350.07899526032;15417.614559635875;15457;15463.768043479356;12105.757884842254;12188.20776649515;12191.390430478441;12256.938715306367;12258.14193006481;19987.700184497244;20008.69986950197;20227.797722022886;20285.797142028685;20318.492037699176;7838.255365740246;8015.278624923785;8088.474249173785;8101.392395570356;8159.632816523271;866.7833041739565;888.3648191543077;916;930.57658765263;1057.7831544533353;27306.86346568294;27795.861020694767;27830;28176.43647127046;28342.85828570844;857.4126723194631;1006.2302338710892;1018.5212949913529;1037.8391349340864;1052.1267348101057;12545.247285162919;12679.236987519742;12994.545190918461;13000.609981700563;13030.413631386611;310261;313037;314377;314580;316317;41553.37669934954;41971;41971.37042944358;42120.157596848505;42132;1144.8683401408944;1155.942202889869;1234.8147777833397;1253.3983687829893;1273.5224290891101;24216.03135874545;24781.752182478667;25589.488210236064;25658.743412565636;25682;34858.825705872325;35237.64762352344;35331.64668353284;35351.11622209465;35384.28465011137;177819;178718;181494;181505;181774;25923.870380647975;31119.222019449695;31138.844305778326;31236.843815780776;31431;34835.303293934485;38558;38587.421188681634;38752.41871371988;39152.608473914894;32416.08255257038;32605.34789304248;32609;33345;33943;32534.511982320757;32774.50838237476;32828.835855821526;32967.83516082404;33169.668303316656;32957;33243.50134747932;33648.15879602932;33657.326853462306;33700;28028.71971280261;29465.410691786474;29523.55714664325;29526.557101643062;29825.5526167112;23156.76843231546;25526.361840954123;25588.232353029438;25777.355566110997;26113.347166320233 14:00:41 INFO - PROCESS | 17353 | |2;jquery.html;354.2489921366703;354.38160410084396;356.7877113117695;357.36745959651404;370.33894498320484;15508.922455387721;15853.207339633016;16811.495655130337;17237.138143092827;17247.655046899054;16209.108499032549;16615.584610384718;16773.496795096165;16787.83212167878;16804.915975420136;4947.653664243513;4994.808514036964;5077.416097148838;5091.490850914897;5203.219517072432;5048.141815891289;5063.113955057868;5074.974625126869;5096.872578185538;5101.566366858821;5071.2139618359215;5086.949130508685;5091.643584949055;5097;5098;5258.079836028699;5259.947400526023;5284.682919024871;5287.233351164079;5289.894202115975;5062.848114556569;5083.364579427572;5098.643094983353;5101.770420331094;5105.489451054865;11482.942585287105;11666.824997625043;11779.293242405483;11816.70458238551;11827.586034488751;1906.2756152662039;2021.7482058724179;2036.9388918332324;2078.4803799050237;2482.2429159106464;8972.551372431351;9274.44353338802;12846.871531284662;12895.935520322431;13101.868981310161;1697.6774412861516;1734.0982689001776;1789.973150402745;1827.168638269584;1851.7685289338833;58820;59527.702361487914;59636.70181649108;60848.39151608472;62914.37085629131;10202.438865862301;10246.53890574926;10315.484225788681;10346.32748871321;10641.414722190353;13354.198748075147;13432.529861454997;13443.529476468473;13449.32753362328;13469.326533673473;7392.186859445456;7464.029676142067;7623.161452240249;7846.215378462108;7876.330511906437;7674.961625191839;7680.692772289046;7792.376609871197;7794.10367807698;7795.22047795216;4430.269005614102;4527.230370836965;4533;4583.610393116555;4587.266037434061;1766.7349897515476;1791.8208179182238;1796.5329014456336;1799.9370022049166;1814.528222662091;835.8829763833069;845.471580262336;911.3301723233418;972.8589354543551;995.2286977592424;16075.437359692354;16100.436484723214;16111.355545778037;16171.110588917487;16753;861.5950503263456;863.248973393152;868.6091258933506;909.5679552212779;912.6760000199833;6158.722857471335;9275;9420.858687119699;9506.572204250826;9608.95195524018;388998;390429;392612;395020;402092;67332;67472.32527674758;67912;68547;69872.65063674751;938.1650331205233;950.843110886696;961;964.4213471916794;964.8890377606525;14230.573082807532;14473.421063157355;14516.346764395415;14635.195064271567;14815.25923703789;31695;32452.675473244966;32757.34485310328;32976.34047318992;33001.83499082489;43047.56952430436;44487.77756111199;44655;44786.55213447824;45022.77488612536;7365.668544915385;7530.698772049057;7545.547267163768;7611.657475413509;7658.387329013777;8869.423487473294;10007.549660265451;10525.421101839473;11279.718007049561;11528.82706759416;9477.620895164117;9561.282903782105;9808;10024.649137280161;10085;9763.267754918268;9776.26677999167;9781.510924453607;9784.559694813894;9850.605975761177;9599.865334534727;9970.202383809134;10088;10176.389416634729;10295.53670084833;7392.889106663297;7475.2151024141685;7525.570141673064;7649.273319034683;7766.805829854299;9510;9597.32818702712;9746.610135594497;9921.255905807238;10207.642732504326 14:00:41 INFO - PROCESS | 17353 | |3;mootools.html;1257.4844313831331;1397.0430255275137;1402.1236727045593;1540.406943326819;1762.3391228289393;7068.858622827547;7221.855562888739;7225.638718064096;7241.529300595457;7242.818929526765;6914.135733033371;7081;7088.043114179584;7090.85818283634;7091.751788687397;1890.9527261818496;2175.6627722703006;2185.7158569385956;2188.595109904673;2248.6627005949076;2199.230269405703;2208.3595757230382;2211.1929145861804;2211.8783466909313;2212.822974162071;2163.1888041984257;2231.9553608927813;2237.5636750833596;2238.977610223901;2241.0363543676212;2195.176808696747;2220.9333719988426;2223.6998005269243;2240.6863039174527;2250.7861753133425;2169.7287839020123;2173.1416090644266;2182.159868450642;2182.5743979923923;2269.7389800173028;7380.335769780691;7412.369948554379;7439.739609113709;7445.516041457288;7446.85106297871;4457.621102206316;4537.727736335831;4563.406757121586;4565;4566.977165114186;2918.7810914181523;2996.4306781711625;3024.485837407646;3042.2546476113494;3046.939061218763;909.5315912305168;927.1470247372366;933.2114363362947;936.8828896387952;970.0445061614304;10259.230557708128;10262.486875656263;10319.122874555671;10319.329243599217;10328;4121.835126594962;4225.514065882401;4278.465191851019;4286.957130428718;4315.956840431619;8753.649854005896;8797.692080777142;8800.559972001374;8813.91186088131;8820.691275805444;4006;4585.747783871919;4606.792694328763;4617.838375656903;4620.861374158781;4035.515738111387;4137.731047481904;4138.586141385837;4162.500499939966;4163.770992595436;3598.7840729555787;3673.540807399075;3677.2461645362637;3704.5554533456157;3771.358868992278;1179.5340840368178;1195.0917302849896;1201.9098567607464;1203.6449247472017;1220.4995951659778;960.1838437328215;961.0005594181972;970.9708708738749;1025.5180065369264;1240.0761432732672;7066.505344625827;7069.045678833395;7069.116360454943;7097.361237488651;7110.466714996396;452.0506935435559;1073.6027669762238;1115.9163062770324;1140.549482954245;1144.1361771862357;5562.582806289544;5625.959197548466;5671.376148623648;5687.544996400361;5694.402087780806;8489.4481858679;8721.171488708562;9029.548522573845;9141.725748227564;9173.715679804833;8907.55462226899;8908.198262156307;8939.821203575892;8997.820043599091;9032.36773425854;6994.5803251805055;7028.543144695578;7132.928670713226;7138.964305178441;7245.710171593078;6759.797206083826;6805.0472933788315;6821.147356580427;6829.317068293131;6876.140482439695;8263.710770123016;8297.170282971654;8363.247307742333;8391;8541.188587084218;8443.66225350979;8679.305655547667;8683.565821709015;8841.911580884365;8866.202041816268;6171.574775999364;6207.472364848858;6229.750809967551;6249.1563638908165;6279.434850863444;6826.41975432074;6833.4191593715095;6874.65626718652;6876.793696189123;6890.793276201722;6088.360722124113;6236.282827474717;6253.280872699698;6296.0555916612875;6315.684215789284;6357.332480089524;6388.8083357499345;6438.034294855622;6538.117354157318;6560.8359791005605;6556.606603603799;6670.332966703485;6682.465402767864;6685.0306705526455;6695.397414232742;5990.430909063632;6137.877242455215;6223.564350495603;6272.905906411499;6273.654948977667;6334.5430550972615;6372.6495042773095;6376.075469057054;6378.170837791243;6382.585131966407 14:00:41 INFO - PROCESS | 17353 | |4;prototype.html;310.1625610850703;314.0578265204387;315.55034076441063;319.9792013519121;321.07850469153504;5358.624896257259;5460;5576.052071147905;5592.245046918665;5597.608167428281;5390.407055223922;5405.756740946657;5406.783728650849;5417.891642167164;5435.755391007404;4006.2187873364705;4094.0174358153977;4204.957950420502;4208.053188032699;4222.408862759216;4194.874153775391;4197.286461301586;4203.7057405981595;4211.525965911922;4216.515100763406;4170.124273902484;4173.040200753829;4181.121964387482;4182.895427614303;4188.560201178878;3928.292907276689;4021.9798901005456;4074.2666320062376;4081.653059489947;4103.363978583325;3617.656322649344;3647.1793846384353;3649.981750091259;3651.1419816343405;3652.4338727497015;5136.922946155811;5152.484751524855;5152.613553983466;5154.639175257734;5156.226566015091;4786.114568804782;4791.688540244873;4795.904081918377;4796.184648609745;4799.952000479985;5638.126090455986;5650.604457687963;5653.717314134318;5656.886862262772;5660.915086273709;4031.677465802729;4031.8588849390426;4033.193361327717;4033.8705162554534;4039.373897045933;5801.941980580183;6033.306169790487;6036.305824830157;6040.48655864252;6051.4553690168095;3970.344893092665;4028.335324671455;4028.8992775180855;4032.6169013943627;4033.052232725307;4077.5310839253866;4089.7750623715983;4089.795510224477;4091.1817636472824;4097.323941549611;4735.455422626374;4744.691595046311;4744.786484608201;4752.95247047532;4754.738489383117;5718.628289161191;5735.397783232784;5735.77056917727;5738.454846789548;5741.253637027244;1394.623451668044;1428.2073449235565;1430.1847946670507;1433.6989232261342;1436.843341110416;879.4591326334258;920.2178148573659;931.2875650127658;942.1520631431629;950.8858936927613;4918.8770280743265;4936.777844996984;4937.703737775673;4939.802407903716;4941.851744447672;5892.941070589325;5895.911561326584;5899.646021238739;5903.852403689856;5908.468237858613;4977.253411988231;4994.225894986283;4995.075910956485;4997.575206107522;5001.7499125043605;3146.8426578671433;3175.8729650813707;3184.3949649566507;3185.87256509737;3186.5060915558124;5522.91715624266;5524.06090964537;5533.418991005967;5534.944650553443;5540.473655002768;5905.911411328833;6131.172291740647;6181.938180618226;6214.627122372672;6217;5588.91616625751;5602.775888964396;5603.579731520071;5606.046972014768;5606.439356064361;5959.791407300723;5976.940230597812;5982.312034115958;5999.340072592098;6010.819675409744;5841.299044114733;5850.736716847667;5859.5019423349495;5860.824175274749;5862.179294898632;5424.918626220689;5610.270664813548;5617.522510586482;5619.325680918316;5622.662640241599;3988.8404463822285;4012.578679238638;4035.4955630546183;4040.131371754969;4041.6766658667825;5975.014122669884;5976.551758618208;5980.820575382745;5982.282126144891;5984.251968503937;5783.045797443543;5786.710664466844;5794.246747922743;5794.884102318014;5797.217375654402;5778.971105144447;5786.161006654096;5786.247787787561;5790.884182316414;5794.652320860761;5482.890342193054;5670.773169073191;5688.175214593944;5689.146628005832;5692.914606280992;5778.566607504538;5807.070868661163;5813.79651712188;5817.5345972321265;5821.446962538552;5665.801696940587;5669.064604340402;5683.8010669626365;5685.545156387397;5689.800856969986 14:00:41 INFO - PROCESS | 17353 | |5;yui.html;650.749461457339;664.4385494257352;689.4656641103142;698.5668885291117;748.7641392961217;12270.141090123694;12328.4452199651;12384.318862462562;12427.627171184857;12432.627021189368;11523.48144333505;11538.942305288483;11545.884541154586;11551.422428878543;11561.595344162955;635.907793369961;774.8837674348837;783.1541934710499;799.2287442617873;806.8587997100514;803.0724513187249;804.2199066905092;807.8626633472294;811.8051667599792;812.1147948735877;843.5655637346771;847.0386111763131;850.5662112322698;851.2253848997414;851.5061264466625;662.2516556291384;822.3462347433774;837.3092198935841;837.5058715357907;843.1315744782853;621.4779585148452;622.243973572112;622.5424313129846;622.6388694557146;622.7197761007519;12786.424610892533;12848.807267890988;12854.357282135948;12855.228686278853;12861.292628905407;11913.344766037864;12409.627711168589;12904.677383065404;12966.87033129666;13084.542041028519;9369.906300936971;9560.760980975461;9616.615335386576;9770.90229097707;9931.404115753077;3710.4805327254207;3732.9066773330883;3812.1422679897078;3826.540815102178;3880.262750077476;45952;47129.29306060412;47277.76361118173;47397.52602473966;47442;9462.905370946202;9659.517024148765;9764.414135151914;9931;10032.448215348226;16932.661346772995;16943.915280423764;16946;16963;16978;6253.843653908689;6374.74501019954;6445.2587952386075;6457.321981191907;6799.864002719918;3526.9118272043406;3651.087228192952;3674.412094064937;3686.3364594372733;3708.666220040155;2814.943701125966;2824.0680575410065;2836.8297902125937;2839.8154119982137;2851.116153992269;501.19307914258013;501.57366238697546;501.6714052295752;510.79568172731206;515.9871003224949;611.5841227964937;612.650789050246;612.8019721444565;623.2645478335517;628.5819929746758;6942.305769423017;7101.964490177516;7117.608531530712;7140;7321.78034658961;480.7620227987169;519.3145048535896;527.4488159872942;599.1252770954368;602.9005214139705;3292.6378098409155;3320.0869760815485;3369.4103531881824;3420.521127042216;3426.297608990151;53533;53830.19254711182;55312.72343638256;55585.1662225067;55714.72142639261;46158;46379.5362046382;46846.29730554044;47375.28937065947;47987.76006119947;40008.599914000486;41082.383764242964;43517.56482435135;44295;44429.33355999662;6872.793816185523;6906.102206713095;6962.199347075151;6986.16166060076;7066.57600543969;32695.673043270213;32718.83640581782;33475.665243347255;34405.483917740756;34420;38730.4190437138;39561.80219098886;44470.3329450065;44529.777351113036;44742;8568.52873091986;8696.739097827076;8944.5080520572;8977.685780997634;8996.280297576048;8814.33892458081;9513.524323783644;9674.419534827934;9833.655822046194;11869.525218991144;9383.483908385104;9578.13796758295;9694.079062489052;10655;10786.838197427202;10770.676879693621;10908.40003799767;10936.617218397318;10985.890141098487;11061.446927653746;9192.448453092837;9596.23230141573;9658.420494770337;9858.802823943337;10294.279400442198;9479.857802133112;9661.178799802095;9758.707238782848;10086.79826403453;10120.696379108638;9184.862227066733;9488.383255088396;9510.95244523773;9568.712938611852;9772.853407198756 14:00:41 INFO - PROCESS | 17353 | __end_tp_report 14:00:41 INFO - PROCESS | 17353 | __start_cc_report 14:00:41 INFO - PROCESS | 17353 | _x_x_mozilla_cycle_collect,1137 14:00:41 INFO - PROCESS | 17353 | __end_cc_report 14:00:41 INFO - PROCESS | 17353 | __startTimestamp1457820041536__endTimestamp 14:00:41 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | ------- Summary: start ------- 14:00:41 INFO - PROCESS | 17353 | Number of tests: 6 14:00:41 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | [#0] dojo.html Cycles:165 Average:4574.43 Median:4683.27 stddev:470.32 (10.0%) stddev-sans-first:444.72 14:00:41 INFO - PROCESS | 17353 | Values: 2570.9 2631.5 2642.0 2642.2 2664.3 4500.6 4558.5 4559.1 4571.6 4603.3 4563.2 4585.1 4638.2 4641.7 4642.1 4179.8 4258.5 4316.9 4363.1 4369.1 4195.1 4274.8 4323.4 4323.7 4335.0 4231.1 4273.5 4276.2 4297.1 4330.5 4211.4 4212.2 4219.3 4252.3 4259.1 4151.0 4211.7 4215.0 4215.5 4261.9 4526.5 4557.9 4567.7 4601.3 4612.6 4915.9 4925.3 4926.1 4934.2 4977.5 4839.5 4948.1 4958.3 4983.6 4987.7 4632.6 4650.7 4668.2 4700.7 4703.8 5063.3 5069.7 5071.5 5078.2 5121.8 4766.7 4806.6 4859.7 4866.0 4876.9 4941.7 4953.4 4996.5 5005.2 5011.8 4905.9 4908.4 4910.3 4916.0 4959.2 4801.3 4872.9 4882.7 4922.1 4927.9 4193.3 4196.4 4223.9 4245.3 4261.0 3685.4 3691.2 3696.1 3719.2 3736.8 4156.0 4297.0 4305.1 4308.7 4342.7 4946.3 4980.8 4997.0 5027.2 5036.8 4243.5 4243.7 4256.7 4281.7 4286.6 4367.8 4375.0 4416.8 4438.7 4442.9 4669.6 4679.6 4683.3 4711.3 4726.3 4954.9 4957.9 4959.2 4959.7 4982.3 4604.5 4608.3 4666.1 4679.4 4716.3 4884.7 4903.3 4903.3 4915.4 4963.9 4943.5 4958.0 4978.0 4980.3 4981.8 4648.3 4780.8 4832.9 4847.1 4865.7 4826.9 4830.0 4845.8 4851.1 4899.8 4779.1 4793.1 4794.2 4795.3 4828.8 4731.6 4771.0 4836.6 4860.4 4875.0 4674.6 4677.8 4692.6 4693.0 4694.7 14:00:41 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | [#1] ext.html Cycles:180 Average:41214.54 Median:3302.60 stddev:67773.36 (2052.1%) stddev-sans-first:67894.63 14:00:41 INFO - PROCESS | 17353 | Values: 527.8 539.1 553.8 560.9 566.8 27012.0 27449.5 34287.8 34845.7 34942.7 37976.4 38110.0 38494.0 38495.8 38502.2 7747.9 7924.2 7929.2 7935.9 7938.7 6855.0 8122.4 8123.2 8123.9 8125.6 8074.6 8162.9 8167.8 8173.9 8175.3 8041.3 8093.4 8133.1 8136.0 8149.6 7926.5 8058.4 8060.1 8060.6 8067.3 37508.8 37951.4 37962.8 37997.6 38004.6 2984.7 2993.6 3086.2 3320.9 3351.7 28129.1 28673.0 28674.7 29118.0 29274.7 3276.5 3277.1 3301.7 3303.5 3372.5 262144.0 264545.0 264762.0 265300.0 266670.0 53113.0 53206.2 53580.0 53735.0 53960.5 63187.7 63888.7 63968.7 64016.4 64047.7 15252.7 15350.1 15417.6 15457.0 15463.8 12105.8 12188.2 12191.4 12256.9 12258.1 19987.7 20008.7 20227.8 20285.8 20318.5 7838.3 8015.3 8088.5 8101.4 8159.6 866.8 888.4 916.0 930.6 1057.8 27306.9 27795.9 27830.0 28176.4 28342.9 857.4 1006.2 1018.5 1037.8 1052.1 12545.2 12679.2 12994.5 13000.6 13030.4 310261.0 313037.0 314377.0 314580.0 316317.0 41553.4 41971.0 41971.4 42120.2 42132.0 1144.9 1155.9 1234.8 1253.4 1273.5 24216.0 24781.8 25589.5 25658.7 25682.0 34858.8 35237.6 35331.6 35351.1 35384.3 177819.0 178718.0 181494.0 181505.0 181774.0 25923.9 31119.2 31138.8 31236.8 31431.0 34835.3 38558.0 38587.4 38752.4 39152.6 32416.1 32605.3 32609.0 33345.0 33943.0 32534.5 32774.5 32828.8 32967.8 33169.7 32957.0 33243.5 33648.2 33657.3 33700.0 28028.7 29465.4 29523.6 29526.6 29825.6 23156.8 25526.4 25588.2 25777.4 26113.3 14:00:41 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | [#2] jquery.html Cycles:180 Average:23285.91 Median:5055.49 stddev:64620.92 (1278.2%) stddev-sans-first:64779.26 14:00:41 INFO - PROCESS | 17353 | Values: 354.2 354.4 356.8 357.4 370.3 15508.9 15853.2 16811.5 17237.1 17247.7 16209.1 16615.6 16773.5 16787.8 16804.9 4947.7 4994.8 5077.4 5091.5 5203.2 5048.1 5063.1 5075.0 5096.9 5101.6 5071.2 5086.9 5091.6 5097.0 5098.0 5258.1 5259.9 5284.7 5287.2 5289.9 5062.8 5083.4 5098.6 5101.8 5105.5 11482.9 11666.8 11779.3 11816.7 11827.6 1906.3 2021.7 2036.9 2078.5 2482.2 8972.6 9274.4 12846.9 12895.9 13101.9 1697.7 1734.1 1790.0 1827.2 1851.8 58820.0 59527.7 59636.7 60848.4 62914.4 10202.4 10246.5 10315.5 10346.3 10641.4 13354.2 13432.5 13443.5 13449.3 13469.3 7392.2 7464.0 7623.2 7846.2 7876.3 7675.0 7680.7 7792.4 7794.1 7795.2 4430.3 4527.2 4533.0 4583.6 4587.3 1766.7 1791.8 1796.5 1799.9 1814.5 835.9 845.5 911.3 972.9 995.2 16075.4 16100.4 16111.4 16171.1 16753.0 861.6 863.2 868.6 909.6 912.7 6158.7 9275.0 9420.9 9506.6 9609.0 388998.0 390429.0 392612.0 395020.0 402092.0 67332.0 67472.3 67912.0 68547.0 69872.7 938.2 950.8 961.0 964.4 964.9 14230.6 14473.4 14516.3 14635.2 14815.3 31695.0 32452.7 32757.3 32976.3 33001.8 43047.6 44487.8 44655.0 44786.6 45022.8 7365.7 7530.7 7545.5 7611.7 7658.4 8869.4 10007.5 10525.4 11279.7 11528.8 9477.6 9561.3 9808.0 10024.6 10085.0 9763.3 9776.3 9781.5 9784.6 9850.6 9599.9 9970.2 10088.0 10176.4 10295.5 7392.9 7475.2 7525.6 7649.3 7766.8 9510.0 9597.3 9746.6 9921.3 10207.6 14:00:41 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | [#3] mootools.html Cycles:180 Average:5224.08 Median:6251.22 stddev:2701.09 (43.2%) stddev-sans-first:2692.21 14:00:41 INFO - PROCESS | 17353 | Values: 1257.5 1397.0 1402.1 1540.4 1762.3 7068.9 7221.9 7225.6 7241.5 7242.8 6914.1 7081.0 7088.0 7090.9 7091.8 1891.0 2175.7 2185.7 2188.6 2248.7 2199.2 2208.4 2211.2 2211.9 2212.8 2163.2 2232.0 2237.6 2239.0 2241.0 2195.2 2220.9 2223.7 2240.7 2250.8 2169.7 2173.1 2182.2 2182.6 2269.7 7380.3 7412.4 7439.7 7445.5 7446.9 4457.6 4537.7 4563.4 4565.0 4567.0 2918.8 2996.4 3024.5 3042.3 3046.9 909.5 927.1 933.2 936.9 970.0 10259.2 10262.5 10319.1 10319.3 10328.0 4121.8 4225.5 4278.5 4287.0 4316.0 8753.6 8797.7 8800.6 8813.9 8820.7 4006.0 4585.7 4606.8 4617.8 4620.9 4035.5 4137.7 4138.6 4162.5 4163.8 3598.8 3673.5 3677.2 3704.6 3771.4 1179.5 1195.1 1201.9 1203.6 1220.5 960.2 961.0 971.0 1025.5 1240.1 7066.5 7069.0 7069.1 7097.4 7110.5 452.1 1073.6 1115.9 1140.5 1144.1 5562.6 5626.0 5671.4 5687.5 5694.4 8489.4 8721.2 9029.5 9141.7 9173.7 8907.6 8908.2 8939.8 8997.8 9032.4 6994.6 7028.5 7132.9 7139.0 7245.7 6759.8 6805.0 6821.1 6829.3 6876.1 8263.7 8297.2 8363.2 8391.0 8541.2 8443.7 8679.3 8683.6 8841.9 8866.2 6171.6 6207.5 6229.8 6249.2 6279.4 6826.4 6833.4 6874.7 6876.8 6890.8 6088.4 6236.3 6253.3 6296.1 6315.7 6357.3 6388.8 6438.0 6538.1 6560.8 6556.6 6670.3 6682.5 6685.0 6695.4 5990.4 6137.9 6223.6 6272.9 6273.7 6334.5 6372.6 6376.1 6378.2 6382.6 14:00:41 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | [#4] prototype.html Cycles:180 Average:4733.95 Median:5430.34 stddev:1414.81 (26.1%) stddev-sans-first:1379.26 14:00:41 INFO - PROCESS | 17353 | Values: 310.2 314.1 315.6 320.0 321.1 5358.6 5460.0 5576.1 5592.2 5597.6 5390.4 5405.8 5406.8 5417.9 5435.8 4006.2 4094.0 4205.0 4208.1 4222.4 4194.9 4197.3 4203.7 4211.5 4216.5 4170.1 4173.0 4181.1 4182.9 4188.6 3928.3 4022.0 4074.3 4081.7 4103.4 3617.7 3647.2 3650.0 3651.1 3652.4 5136.9 5152.5 5152.6 5154.6 5156.2 4786.1 4791.7 4795.9 4796.2 4800.0 5638.1 5650.6 5653.7 5656.9 5660.9 4031.7 4031.9 4033.2 4033.9 4039.4 5801.9 6033.3 6036.3 6040.5 6051.5 3970.3 4028.3 4028.9 4032.6 4033.1 4077.5 4089.8 4089.8 4091.2 4097.3 4735.5 4744.7 4744.8 4753.0 4754.7 5718.6 5735.4 5735.8 5738.5 5741.3 1394.6 1428.2 1430.2 1433.7 1436.8 879.5 920.2 931.3 942.2 950.9 4918.9 4936.8 4937.7 4939.8 4941.9 5892.9 5895.9 5899.6 5903.9 5908.5 4977.3 4994.2 4995.1 4997.6 5001.7 3146.8 3175.9 3184.4 3185.9 3186.5 5522.9 5524.1 5533.4 5534.9 5540.5 5905.9 6131.2 6181.9 6214.6 6217.0 5588.9 5602.8 5603.6 5606.0 5606.4 5959.8 5976.9 5982.3 5999.3 6010.8 5841.3 5850.7 5859.5 5860.8 5862.2 5424.9 5610.3 5617.5 5619.3 5622.7 3988.8 4012.6 4035.5 4040.1 4041.7 5975.0 5976.6 5980.8 5982.3 5984.3 5783.0 5786.7 5794.2 5794.9 5797.2 5779.0 5786.2 5786.2 5790.9 5794.7 5482.9 5670.8 5688.2 5689.1 5692.9 5778.6 5807.1 5813.8 5817.5 5821.4 5665.8 5669.1 5683.8 5685.5 5689.8 14:00:41 INFO - PROCESS | 17353 | 14:00:41 INFO - PROCESS | 17353 | [#5] yui.html Cycles:180 Average:12843.07 Median:53681.60 stddev:15132.40 (28.2%) stddev-sans-first:15147.15 14:00:41 INFO - PROCESS | 17353 | Values: 650.7 664.4 689.5 698.6 748.8 12270.1 12328.4 12384.3 12427.6 12432.6 11523.5 11538.9 11545.9 11551.4 11561.6 635.9 774.9 783.2 799.2 806.9 803.1 804.2 807.9 811.8 812.1 843.6 847.0 850.6 851.2 851.5 662.3 822.3 837.3 837.5 843.1 621.5 622.2 622.5 622.6 622.7 12786.4 12848.8 12854.4 12855.2 12861.3 11913.3 12409.6 12904.7 12966.9 13084.5 9369.9 9560.8 9616.6 9770.9 9931.4 3710.5 3732.9 3812.1 3826.5 3880.3 45952.0 47129.3 47277.8 47397.5 47442.0 9462.9 9659.5 9764.4 9931.0 10032.4 16932.7 16943.9 16946.0 16963.0 16978.0 6253.8 6374.7 6445.3 6457.3 6799.9 3526.9 3651.1 3674.4 3686.3 3708.7 2814.9 2824.1 2836.8 2839.8 2851.1 501.2 501.6 501.7 510.8 516.0 611.6 612.7 612.8 623.3 628.6 6942.3 7102.0 7117.6 7140.0 7321.8 480.8 519.3 527.4 599.1 602.9 3292.6 3320.1 3369.4 3420.5 3426.3 53533.0 53830.2 55312.7 55585.2 55714.7 46158.0 46379.5 46846.3 47375.3 47987.8 40008.6 41082.4 43517.6 44295.0 44429.3 6872.8 6906.1 6962.2 6986.2 7066.6 32695.7 32718.8 33475.7 34405.5 34420.0 38730.4 39561.8 44470.3 44529.8 44742.0 8568.5 8696.7 8944.5 8977.7 8996.3 8814.3 9513.5 9674.4 9833.7 11869.5 9383.5 9578.1 9694.1 10655.0 10786.8 10770.7 10908.4 10936.6 10985.9 11061.4 9192.4 9596.2 9658.4 9858.8 10294.3 9479.9 9661.2 9758.7 10086.8 10120.7 9184.9 9488.4 9511.0 9568.7 9772.9 14:00:41 INFO - PROCESS | 17353 | -------- Summary: end -------- 14:00:41 INFO - PROCESS | 17353 | 14:00:42 INFO - TEST-INFO | 17353: exit 0 14:00:42 INFO - TEST-OK | dromaeo_css | took 1117167ms 14:00:42 INFO - TEST-START | kraken 14:00:42 INFO - operating with platform_type : linux_ 14:00:42 INFO - Initialising browser for kraken test... 14:00:42 INFO - TEST-INFO | started process 17536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXCfwL/profile http://localhost:41727/getInfo.html) 14:00:46 INFO - PROCESS | 17536 | __metrics Screen width/height:1600/1200 14:00:46 INFO - PROCESS | 17536 | colorDepth:24 14:00:46 INFO - PROCESS | 17536 | Browser inner width/height: 1024/697 14:00:46 INFO - PROCESS | 17536 | __metrics 14:00:47 ERROR - PROCESS | 17536 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:00:48 INFO - TEST-INFO | 17536: exit 0 14:00:48 INFO - Browser initialized. 14:00:48 INFO - Running cycle 1/1 for kraken test... 14:00:48 INFO - TEST-INFO | started process 17619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXCfwL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:00 INFO - PROCESS | 17619 | RSS: Main: 152731648 14:01:00 INFO - PROCESS | 17619 | 14:01:03 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41727/tests/kraken/driver.html?testName=audio-beat-detection) 14:01:03 INFO - PROCESS | 17619 | RSS: Main: 196435968 14:01:03 INFO - PROCESS | 17619 | 14:01:06 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41727/tests/kraken/driver.html?testName=audio-dft) 14:01:06 INFO - PROCESS | 17619 | RSS: Main: 185569280 14:01:06 INFO - PROCESS | 17619 | 14:01:09 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41727/tests/kraken/driver.html?testName=audio-fft) 14:01:10 INFO - PROCESS | 17619 | RSS: Main: 170893312 14:01:10 INFO - PROCESS | 17619 | 14:01:12 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41727/tests/kraken/driver.html?testName=audio-oscillator) 14:01:13 INFO - PROCESS | 17619 | RSS: Main: 173367296 14:01:13 INFO - PROCESS | 17619 | 14:01:15 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:01:16 INFO - PROCESS | 17619 | RSS: Main: 173608960 14:01:16 INFO - PROCESS | 17619 | 14:01:19 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41727/tests/kraken/driver.html?testName=imaging-darkroom) 14:01:19 INFO - PROCESS | 17619 | RSS: Main: 176095232 14:01:19 INFO - PROCESS | 17619 | 14:01:23 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41727/tests/kraken/driver.html?testName=imaging-desaturate) 14:01:23 INFO - PROCESS | 17619 | RSS: Main: 177111040 14:01:23 INFO - PROCESS | 17619 | 14:01:26 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41727/tests/kraken/driver.html?testName=json-parse-financial) 14:01:27 INFO - PROCESS | 17619 | RSS: Main: 176529408 14:01:27 INFO - PROCESS | 17619 | 14:01:28 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:01:29 INFO - PROCESS | 17619 | RSS: Main: 185982976 14:01:29 INFO - PROCESS | 17619 | 14:01:31 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41727/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:01:31 INFO - PROCESS | 17619 | RSS: Main: 183726080 14:01:31 INFO - PROCESS | 17619 | 14:01:34 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:01:34 INFO - PROCESS | 17619 | RSS: Main: 191586304 14:01:34 INFO - PROCESS | 17619 | 14:01:37 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:01:37 INFO - PROCESS | 17619 | RSS: Main: 201220096 14:01:37 INFO - PROCESS | 17619 | 14:01:40 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:01:40 INFO - PROCESS | 17619 | RSS: Main: 201543680 14:01:40 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | Cycle 1(1): loaded http://localhost:41727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41727/tests/kraken/driver.html?testName=ai-astar) 14:01:42 INFO - PROCESS | 17619 | RSS: Main: 260595712 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | __start_tp_report 14:01:42 INFO - PROCESS | 17619 | _x_x_mozilla_page_load 14:01:42 INFO - PROCESS | 17619 | _x_x_mozilla_page_load_details 14:01:42 INFO - PROCESS | 17619 | |i|pagename|runs| 14:01:42 INFO - PROCESS | 17619 | |0;ai-astar;111;112;108;114;115;113;103;112;114;113 14:01:42 INFO - PROCESS | 17619 | |1;audio-beat-detection;160;137;153;174;134;158;155;131;177;130 14:01:42 INFO - PROCESS | 17619 | |2;audio-dft;162;161;163;160;162;161;160;161;163;162 14:01:42 INFO - PROCESS | 17619 | |3;audio-fft;73;76;95;102;76;76;76;110;100;74 14:01:42 INFO - PROCESS | 17619 | |4;audio-oscillator;95;93;141;94;94;94;140;95;93;135 14:01:42 INFO - PROCESS | 17619 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;117;117 14:01:42 INFO - PROCESS | 17619 | |6;imaging-darkroom;146;146;147;146;146;147;145;145;145;146 14:01:42 INFO - PROCESS | 17619 | |7;imaging-desaturate;95;95;95;96;95;94;95;95;95;95 14:01:42 INFO - PROCESS | 17619 | |8;json-parse-financial;67;65;66;66;66;67;66;75;64;64 14:01:42 INFO - PROCESS | 17619 | |9;json-stringify-tinderbox;64;64;65;64;64;65;65;64;64;65 14:01:42 INFO - PROCESS | 17619 | |10;stanford-crypto-aes;89;82;81;88;82;81;81;80;83;81 14:01:42 INFO - PROCESS | 17619 | |11;stanford-crypto-ccm;118;122;114;117;115;121;122;126;122;117 14:01:42 INFO - PROCESS | 17619 | |12;stanford-crypto-pbkdf2;133;131;141;151;139;134;139;138;137;141 14:01:42 INFO - PROCESS | 17619 | |13;stanford-crypto-sha256-iterative;68;67;67;66;66;67;64;66;67;65 14:01:42 INFO - PROCESS | 17619 | __end_tp_report 14:01:42 INFO - PROCESS | 17619 | __start_cc_report 14:01:42 INFO - PROCESS | 17619 | _x_x_mozilla_cycle_collect,1147 14:01:42 INFO - PROCESS | 17619 | __end_cc_report 14:01:42 INFO - PROCESS | 17619 | __startTimestamp1457820102760__endTimestamp 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | ------- Summary: start ------- 14:01:42 INFO - PROCESS | 17619 | Number of tests: 14 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.57 (3.2%) stddev-sans-first:3.78 14:01:42 INFO - PROCESS | 17619 | Values: 111.0 112.0 108.0 114.0 115.0 113.0 103.0 112.0 114.0 113.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:156.50 stddev:17.26 (11.0%) stddev-sans-first:17.99 14:01:42 INFO - PROCESS | 17619 | Values: 160.0 137.0 153.0 174.0 134.0 158.0 155.0 131.0 177.0 130.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 14:01:42 INFO - PROCESS | 17619 | Values: 162.0 161.0 163.0 160.0 162.0 161.0 160.0 161.0 163.0 162.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#3] audio-fft Cycles:10 Average:85.80 Median:76.00 stddev:14.23 (18.7%) stddev-sans-first:14.32 14:01:42 INFO - PROCESS | 17619 | Values: 73.0 76.0 95.0 102.0 76.0 76.0 76.0 110.0 100.0 74.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:21.64 (23.0%) stddev-sans-first:22.48 14:01:42 INFO - PROCESS | 17619 | Values: 95.0 93.0 141.0 94.0 94.0 94.0 140.0 95.0 93.0 135.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:01:42 INFO - PROCESS | 17619 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:01:42 INFO - PROCESS | 17619 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 145.0 145.0 145.0 146.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:01:42 INFO - PROCESS | 17619 | Values: 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.00 stddev:3.13 (4.7%) stddev-sans-first:3.32 14:01:42 INFO - PROCESS | 17619 | Values: 67.0 65.0 66.0 66.0 66.0 67.0 66.0 75.0 64.0 64.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:01:42 INFO - PROCESS | 17619 | Values: 64.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 64.0 65.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:3.12 (3.8%) stddev-sans-first:2.37 14:01:42 INFO - PROCESS | 17619 | Values: 89.0 82.0 81.0 88.0 82.0 81.0 81.0 80.0 83.0 81.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:121.50 stddev:3.78 (3.1%) stddev-sans-first:3.97 14:01:42 INFO - PROCESS | 17619 | Values: 118.0 122.0 114.0 117.0 115.0 121.0 122.0 126.0 122.0 117.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.40 Median:139.00 stddev:5.56 (4.0%) stddev-sans-first:5.55 14:01:42 INFO - PROCESS | 17619 | Values: 133.0 131.0 141.0 151.0 139.0 134.0 139.0 138.0 137.0 141.0 14:01:42 INFO - PROCESS | 17619 | 14:01:42 INFO - PROCESS | 17619 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.05 14:01:42 INFO - PROCESS | 17619 | Values: 68.0 67.0 67.0 66.0 66.0 67.0 64.0 66.0 67.0 65.0 14:01:42 INFO - PROCESS | 17619 | -------- Summary: end -------- 14:01:42 INFO - PROCESS | 17619 | 14:01:43 INFO - TEST-INFO | 17619: exit 0 14:01:43 INFO - TEST-OK | kraken | took 61457ms 14:01:43 INFO - SUITE-END | took 1178s 14:01:43 INFO - Completed test suite (00:19:38) 14:01:43 INFO - javascript benchmark 14:01:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2570.8714564271786, 2631.539480590896, 2641.96037059444, 2642.180923913586, 2664.2806442260594, 4500.5724456176695, 4558.521355257696, 4559.110973360196, 4571.588557029862, 4603.263477843546, 4563.201439748047, 4585.105904348653, 4638.211504044312, 4641.675082744209, 4642.141203877285, 4179.770112643803, 4258.488981322245, 4316.870493885189, 4363.127374525092, 4369.1480161368545, 4195.139996300751, 4274.7862606869685, 4323.373110898918, 4323.675724320673, 4335.046289816235, 4231.090315582164, 4273.487181538236, 4276.208901353244, 4297.140571885635, 4330.501992270898, 4211.389348544444, 4212.241796476633, 4219.324908014733, 4252.319628859368, 4259.1268789897995, 4150.958490415087, 4211.7472951623, 4215.009472773896, 4215.473065866767, 4261.914761704748, 4526.52471490492, 4557.886052848672, 4567.703099298568, 4601.286800545888, 4612.561806628365, 4915.852524424273, 4925.3350797642215, 4926.137925862996, 4934.1611925972675, 4977.50224977503, 4839.516048395132, 4948.1093403187415, 4958.281049247875, 4983.6013118950395, 4987.650864439491, 4632.60622847055, 4650.67445278834, 4668.206404911173, 4700.71795692263, 4703.764811759467, 5063.291139240509, 5069.670471419346, 5071.46749591295, 5078.162103252922, 5121.795128194831, 4766.666333356701, 4806.567408933212, 4859.708417494961, 4865.9756701216265, 4876.853694389174, 4941.654084214142, 4953.380827396575, 4996.4503904570465, 5005.174146265898, 5011.799528018912, 4905.901881962341, 4908.410990681141, 4910.288008238786, 4915.975420122948, 4959.231319145538, 4801.255805350176, 4872.926906096412, 4882.7314497702255, 4922.1140194765285, 4927.901441971212, 4193.287141185945, 4196.370544418301, 4223.915521689549, 4245.320748680197, 4260.957390426118, 3685.4287585424304, 3691.151035261851, 3696.1498855262903, 3719.1817800083936, 3736.775793452347, 4156.0, 4297.0, 4305.117450922553, 4308.655307575386, 4342.652587792969, 4946.258061290835, 4980.7509624518625, 4997.0, 5027.2207807789855, 5036.823711170092, 4243.533211346749, 4243.6605071594195, 4256.70203085781, 4281.721688090264, 4286.635635970915, 4367.825286988485, 4374.978125109417, 4416.80124394403, 4438.689291749546, 4442.933355999663, 4669.626429885669, 4679.602233810164, 4683.274092515666, 4711.340412342275, 4726.3146843708155, 4954.851354459372, 4957.900841983213, 4959.156943319716, 4959.7272150032095, 4982.2775697524385, 4604.493505714436, 4608.308753686973, 4666.066786642617, 4679.415073115861, 4716.316134160596, 4884.682495637772, 4903.313536104877, 4903.31353610502, 4915.361003069578, 4963.875903102451, 4943.4562198157455, 4958.0083983202785, 4977.9751101244265, 4980.302757613865, 4981.800727970841, 4648.325992731103, 4780.760961951958, 4832.855014349575, 4847.127517046965, 4865.7323847188745, 4826.903461930812, 4830.0, 4845.781939812788, 4851.078295124056, 4899.828506002273, 4779.091972525209, 4793.113274044313, 4794.232922732346, 4795.304680821331, 4828.806847726051, 4731.645126615449, 4770.952290477051, 4836.588889944394, 4860.441049279237, 4874.975625121851, 4674.555917187861, 4677.7894994726, 4692.6480513960905, 4692.953070469388, 4694.74178920149], "unit": "score", "name": "dojo.html", "value": 4545.181941343984}, {"lowerIsBetter": false, "replicates": [527.7677821758429, 539.1400715858207, 553.7591147850683, 560.8625886657769, 566.8214512428584, 27012.0, 27449.45101097977, 34287.828560857226, 34845.65154348456, 34942.650573494255, 37976.43035354472, 38110.0, 38494.0, 38495.80752096243, 38502.22995540088, 7747.883781743264, 7924.247196516321, 7929.167437419074, 7935.920640793576, 7938.6824527019135, 6854.965725171367, 8122.390820688443, 8123.187681231889, 8123.918760812376, 8125.634346454423, 8074.596270186496, 8162.877556836652, 8167.754967350989, 8173.918260817375, 8175.305099066586, 8041.276285134337, 8093.392995525301, 8133.10535841057, 8136.0, 8149.551774652392, 7926.524408535449, 8058.4359094863385, 8060.113387527367, 8060.5566693831815, 8067.314278286352, 37508.81245593782, 37951.4307285391, 37962.810185948896, 37997.62002379968, 38004.619953800386, 2984.7313741763346, 2993.6108305920307, 3086.2284428892776, 3320.9169770755684, 3351.6815902489225, 28129.086353699666, 28673.0, 28674.713252867412, 29118.0, 29274.707252927623, 3276.508523721437, 3277.147941535218, 3301.6863397977154, 3303.504474328846, 3372.4941258811127, 262144.0, 264545.0, 264762.0, 265299.9999999981, 266670.0, 53113.0, 53206.20190697143, 53580.0, 53735.0, 53960.46039539633, 63187.6840615794, 63888.68055659785, 63968.68015659892, 64016.35983640197, 64047.67976160089, 15252.694946101015, 15350.07899526032, 15417.614559635875, 15457.0, 15463.768043479356, 12105.757884842254, 12188.20776649515, 12191.390430478441, 12256.938715306367, 12258.14193006481, 19987.700184497244, 20008.69986950197, 20227.797722022886, 20285.797142028685, 20318.492037699176, 7838.255365740246, 8015.278624923785, 8088.474249173785, 8101.392395570356, 8159.632816523271, 866.7833041739565, 888.3648191543077, 916.0, 930.57658765263, 1057.7831544533353, 27306.86346568294, 27795.861020694767, 27830.0, 28176.43647127046, 28342.85828570844, 857.4126723194631, 1006.2302338710892, 1018.5212949913529, 1037.8391349340864, 1052.1267348101057, 12545.247285162919, 12679.236987519742, 12994.545190918461, 13000.609981700563, 13030.413631386611, 310261.0, 313037.0, 314377.0, 314580.0, 316317.0, 41553.37669934954, 41971.0, 41971.37042944358, 42120.157596848505, 42132.0, 1144.8683401408944, 1155.942202889869, 1234.8147777833397, 1253.3983687829893, 1273.5224290891101, 24216.03135874545, 24781.752182478667, 25589.488210236064, 25658.743412565636, 25682.0, 34858.825705872325, 35237.64762352344, 35331.64668353284, 35351.11622209465, 35384.28465011137, 177819.0, 178718.0, 181494.0, 181505.0, 181774.0, 25923.870380647975, 31119.222019449695, 31138.844305778326, 31236.843815780776, 31431.0, 34835.303293934485, 38558.0, 38587.421188681634, 38752.41871371988, 39152.608473914894, 32416.08255257038, 32605.34789304248, 32609.0, 33345.0, 33943.0, 32534.511982320757, 32774.50838237476, 32828.835855821526, 32967.83516082404, 33169.668303316656, 32957.0, 33243.50134747932, 33648.15879602932, 33657.326853462306, 33700.0, 28028.71971280261, 29465.410691786474, 29523.55714664325, 29526.557101643062, 29825.5526167112, 23156.76843231546, 25526.361840954123, 25588.232353029438, 25777.355566110997, 26113.347166320233], "unit": "score", "name": "ext.html", "value": 16954.935278096244}, {"lowerIsBetter": false, "replicates": [354.2489921366703, 354.38160410084396, 356.7877113117695, 357.36745959651404, 370.33894498320484, 15508.922455387721, 15853.207339633016, 16811.495655130337, 17237.138143092827, 17247.655046899054, 16209.108499032549, 16615.584610384718, 16773.496795096165, 16787.83212167878, 16804.915975420136, 4947.653664243513, 4994.808514036964, 5077.416097148838, 5091.490850914897, 5203.219517072432, 5048.141815891289, 5063.113955057868, 5074.974625126869, 5096.872578185538, 5101.566366858821, 5071.2139618359215, 5086.949130508685, 5091.643584949055, 5097.0, 5098.0, 5258.079836028699, 5259.947400526023, 5284.682919024871, 5287.233351164079, 5289.894202115975, 5062.848114556569, 5083.364579427572, 5098.643094983353, 5101.770420331094, 5105.489451054865, 11482.942585287105, 11666.824997625043, 11779.293242405483, 11816.70458238551, 11827.586034488751, 1906.2756152662039, 2021.7482058724179, 2036.9388918332324, 2078.4803799050237, 2482.2429159106464, 8972.551372431351, 9274.44353338802, 12846.871531284662, 12895.935520322431, 13101.868981310161, 1697.6774412861516, 1734.0982689001776, 1789.973150402745, 1827.168638269584, 1851.7685289338833, 58820.0, 59527.702361487914, 59636.70181649108, 60848.39151608472, 62914.37085629131, 10202.438865862301, 10246.53890574926, 10315.484225788681, 10346.32748871321, 10641.414722190353, 13354.198748075147, 13432.529861454997, 13443.529476468473, 13449.32753362328, 13469.326533673473, 7392.186859445456, 7464.029676142067, 7623.161452240249, 7846.215378462108, 7876.330511906437, 7674.961625191839, 7680.692772289046, 7792.376609871197, 7794.10367807698, 7795.22047795216, 4430.269005614102, 4527.230370836965, 4533.0, 4583.610393116555, 4587.266037434061, 1766.7349897515476, 1791.8208179182238, 1796.5329014456336, 1799.9370022049166, 1814.528222662091, 835.8829763833069, 845.471580262336, 911.3301723233418, 972.8589354543551, 995.2286977592424, 16075.437359692354, 16100.436484723214, 16111.355545778037, 16171.110588917487, 16753.0, 861.5950503263456, 863.248973393152, 868.6091258933506, 909.5679552212779, 912.6760000199833, 6158.722857471335, 9275.0, 9420.858687119699, 9506.572204250826, 9608.95195524018, 388998.0, 390429.0, 392612.0, 395020.0, 402092.0, 67332.0, 67472.32527674758, 67912.0, 68547.0, 69872.65063674751, 938.1650331205233, 950.843110886696, 961.0, 964.4213471916794, 964.8890377606525, 14230.573082807532, 14473.421063157355, 14516.346764395415, 14635.195064271567, 14815.25923703789, 31695.0, 32452.675473244966, 32757.34485310328, 32976.34047318992, 33001.83499082489, 43047.56952430436, 44487.77756111199, 44655.0, 44786.55213447824, 45022.77488612536, 7365.668544915385, 7530.698772049057, 7545.547267163768, 7611.657475413509, 7658.387329013777, 8869.423487473294, 10007.549660265451, 10525.421101839473, 11279.718007049561, 11528.82706759416, 9477.620895164117, 9561.282903782105, 9808.0, 10024.649137280161, 10085.0, 9763.267754918268, 9776.26677999167, 9781.510924453607, 9784.559694813894, 9850.605975761177, 9599.865334534727, 9970.202383809134, 10088.0, 10176.389416634729, 10295.53670084833, 7392.889106663297, 7475.2151024141685, 7525.570141673064, 7649.273319034683, 7766.805829854299, 9510.0, 9597.32818702712, 9746.610135594497, 9921.255905807238, 10207.642732504326], "unit": "score", "name": "jquery.html", "value": 7938.540385393895}, {"lowerIsBetter": false, "replicates": [1257.4844313831331, 1397.0430255275137, 1402.1236727045593, 1540.406943326819, 1762.3391228289393, 7068.858622827547, 7221.855562888739, 7225.638718064096, 7241.529300595457, 7242.818929526765, 6914.135733033371, 7081.0, 7088.043114179584, 7090.85818283634, 7091.751788687397, 1890.9527261818496, 2175.6627722703006, 2185.7158569385956, 2188.595109904673, 2248.6627005949076, 2199.230269405703, 2208.3595757230382, 2211.1929145861804, 2211.8783466909313, 2212.822974162071, 2163.1888041984257, 2231.9553608927813, 2237.5636750833596, 2238.977610223901, 2241.0363543676212, 2195.176808696747, 2220.9333719988426, 2223.6998005269243, 2240.6863039174527, 2250.7861753133425, 2169.7287839020123, 2173.1416090644266, 2182.159868450642, 2182.5743979923923, 2269.7389800173028, 7380.335769780691, 7412.369948554379, 7439.739609113709, 7445.516041457288, 7446.85106297871, 4457.621102206316, 4537.727736335831, 4563.406757121586, 4565.0, 4566.977165114186, 2918.7810914181523, 2996.4306781711625, 3024.485837407646, 3042.2546476113494, 3046.939061218763, 909.5315912305168, 927.1470247372366, 933.2114363362947, 936.8828896387952, 970.0445061614304, 10259.230557708128, 10262.486875656263, 10319.122874555671, 10319.329243599217, 10328.0, 4121.835126594962, 4225.514065882401, 4278.465191851019, 4286.957130428718, 4315.956840431619, 8753.649854005896, 8797.692080777142, 8800.559972001374, 8813.91186088131, 8820.691275805444, 4006.0, 4585.747783871919, 4606.792694328763, 4617.838375656903, 4620.861374158781, 4035.515738111387, 4137.731047481904, 4138.586141385837, 4162.500499939966, 4163.770992595436, 3598.7840729555787, 3673.540807399075, 3677.2461645362637, 3704.5554533456157, 3771.358868992278, 1179.5340840368178, 1195.0917302849896, 1201.9098567607464, 1203.6449247472017, 1220.4995951659778, 960.1838437328215, 961.0005594181972, 970.9708708738749, 1025.5180065369264, 1240.0761432732672, 7066.505344625827, 7069.045678833395, 7069.116360454943, 7097.361237488651, 7110.466714996396, 452.0506935435559, 1073.6027669762238, 1115.9163062770324, 1140.549482954245, 1144.1361771862357, 5562.582806289544, 5625.959197548466, 5671.376148623648, 5687.544996400361, 5694.402087780806, 8489.4481858679, 8721.171488708562, 9029.548522573845, 9141.725748227564, 9173.715679804833, 8907.55462226899, 8908.198262156307, 8939.821203575892, 8997.820043599091, 9032.36773425854, 6994.5803251805055, 7028.543144695578, 7132.928670713226, 7138.964305178441, 7245.710171593078, 6759.797206083826, 6805.0472933788315, 6821.147356580427, 6829.317068293131, 6876.140482439695, 8263.710770123016, 8297.170282971654, 8363.247307742333, 8391.0, 8541.188587084218, 8443.66225350979, 8679.305655547667, 8683.565821709015, 8841.911580884365, 8866.202041816268, 6171.574775999364, 6207.472364848858, 6229.750809967551, 6249.1563638908165, 6279.434850863444, 6826.41975432074, 6833.4191593715095, 6874.65626718652, 6876.793696189123, 6890.793276201722, 6088.360722124113, 6236.282827474717, 6253.280872699698, 6296.0555916612875, 6315.684215789284, 6357.332480089524, 6388.8083357499345, 6438.034294855622, 6538.117354157318, 6560.8359791005605, 6556.606603603799, 6670.332966703485, 6682.465402767864, 6685.0306705526455, 6695.397414232742, 5990.430909063632, 6137.877242455215, 6223.564350495603, 6272.905906411499, 6273.654948977667, 6334.5430550972615, 6372.6495042773095, 6376.075469057054, 6378.170837791243, 6382.585131966407], "unit": "score", "name": "mootools.html", "value": 4291.249559486809}, {"lowerIsBetter": false, "replicates": [310.1625610850703, 314.0578265204387, 315.55034076441063, 319.9792013519121, 321.07850469153504, 5358.624896257259, 5460.0, 5576.052071147905, 5592.245046918665, 5597.608167428281, 5390.407055223922, 5405.756740946657, 5406.783728650849, 5417.891642167164, 5435.755391007404, 4006.2187873364705, 4094.0174358153977, 4204.957950420502, 4208.053188032699, 4222.408862759216, 4194.874153775391, 4197.286461301586, 4203.7057405981595, 4211.525965911922, 4216.515100763406, 4170.124273902484, 4173.040200753829, 4181.121964387482, 4182.895427614303, 4188.560201178878, 3928.292907276689, 4021.9798901005456, 4074.2666320062376, 4081.653059489947, 4103.363978583325, 3617.656322649344, 3647.1793846384353, 3649.981750091259, 3651.1419816343405, 3652.4338727497015, 5136.922946155811, 5152.484751524855, 5152.613553983466, 5154.639175257734, 5156.226566015091, 4786.114568804782, 4791.688540244873, 4795.904081918377, 4796.184648609745, 4799.952000479985, 5638.126090455986, 5650.604457687963, 5653.717314134318, 5656.886862262772, 5660.915086273709, 4031.677465802729, 4031.8588849390426, 4033.193361327717, 4033.8705162554534, 4039.373897045933, 5801.941980580183, 6033.306169790487, 6036.305824830157, 6040.48655864252, 6051.4553690168095, 3970.344893092665, 4028.335324671455, 4028.8992775180855, 4032.6169013943627, 4033.052232725307, 4077.5310839253866, 4089.7750623715983, 4089.795510224477, 4091.1817636472824, 4097.323941549611, 4735.455422626374, 4744.691595046311, 4744.786484608201, 4752.95247047532, 4754.738489383117, 5718.628289161191, 5735.397783232784, 5735.77056917727, 5738.454846789548, 5741.253637027244, 1394.623451668044, 1428.2073449235565, 1430.1847946670507, 1433.6989232261342, 1436.843341110416, 879.4591326334258, 920.2178148573659, 931.2875650127658, 942.1520631431629, 950.8858936927613, 4918.8770280743265, 4936.777844996984, 4937.703737775673, 4939.802407903716, 4941.851744447672, 5892.941070589325, 5895.911561326584, 5899.646021238739, 5903.852403689856, 5908.468237858613, 4977.253411988231, 4994.225894986283, 4995.075910956485, 4997.575206107522, 5001.7499125043605, 3146.8426578671433, 3175.8729650813707, 3184.3949649566507, 3185.87256509737, 3186.5060915558124, 5522.91715624266, 5524.06090964537, 5533.418991005967, 5534.944650553443, 5540.473655002768, 5905.911411328833, 6131.172291740647, 6181.938180618226, 6214.627122372672, 6217.0, 5588.91616625751, 5602.775888964396, 5603.579731520071, 5606.046972014768, 5606.439356064361, 5959.791407300723, 5976.940230597812, 5982.312034115958, 5999.340072592098, 6010.819675409744, 5841.299044114733, 5850.736716847667, 5859.5019423349495, 5860.824175274749, 5862.179294898632, 5424.918626220689, 5610.270664813548, 5617.522510586482, 5619.325680918316, 5622.662640241599, 3988.8404463822285, 4012.578679238638, 4035.4955630546183, 4040.131371754969, 4041.6766658667825, 5975.014122669884, 5976.551758618208, 5980.820575382745, 5982.282126144891, 5984.251968503937, 5783.045797443543, 5786.710664466844, 5794.246747922743, 5794.884102318014, 5797.217375654402, 5778.971105144447, 5786.161006654096, 5786.247787787561, 5790.884182316414, 5794.652320860761, 5482.890342193054, 5670.773169073191, 5688.175214593944, 5689.146628005832, 5692.914606280992, 5778.566607504538, 5807.070868661163, 5813.79651712188, 5817.5345972321265, 5821.446962538552, 5665.801696940587, 5669.064604340402, 5683.8010669626365, 5685.545156387397, 5689.800856969986], "unit": "score", "name": "prototype.html", "value": 4275.656799562094}, {"lowerIsBetter": false, "replicates": [650.749461457339, 664.4385494257352, 689.4656641103142, 698.5668885291117, 748.7641392961217, 12270.141090123694, 12328.4452199651, 12384.318862462562, 12427.627171184857, 12432.627021189368, 11523.48144333505, 11538.942305288483, 11545.884541154586, 11551.422428878543, 11561.595344162955, 635.907793369961, 774.8837674348837, 783.1541934710499, 799.2287442617873, 806.8587997100514, 803.0724513187249, 804.2199066905092, 807.8626633472294, 811.8051667599792, 812.1147948735877, 843.5655637346771, 847.0386111763131, 850.5662112322698, 851.2253848997414, 851.5061264466625, 662.2516556291384, 822.3462347433774, 837.3092198935841, 837.5058715357907, 843.1315744782853, 621.4779585148452, 622.243973572112, 622.5424313129846, 622.6388694557146, 622.7197761007519, 12786.424610892533, 12848.807267890988, 12854.357282135948, 12855.228686278853, 12861.292628905407, 11913.344766037864, 12409.627711168589, 12904.677383065404, 12966.87033129666, 13084.542041028519, 9369.906300936971, 9560.760980975461, 9616.615335386576, 9770.90229097707, 9931.404115753077, 3710.4805327254207, 3732.9066773330883, 3812.1422679897078, 3826.540815102178, 3880.262750077476, 45952.0, 47129.29306060412, 47277.76361118173, 47397.52602473966, 47442.0, 9462.905370946202, 9659.517024148765, 9764.414135151914, 9931.0, 10032.448215348226, 16932.661346772995, 16943.915280423764, 16946.0, 16963.0, 16978.0, 6253.843653908689, 6374.74501019954, 6445.2587952386075, 6457.321981191907, 6799.864002719918, 3526.9118272043406, 3651.087228192952, 3674.412094064937, 3686.3364594372733, 3708.666220040155, 2814.943701125966, 2824.0680575410065, 2836.8297902125937, 2839.8154119982137, 2851.116153992269, 501.19307914258013, 501.57366238697546, 501.6714052295752, 510.79568172731206, 515.9871003224949, 611.5841227964937, 612.650789050246, 612.8019721444565, 623.2645478335517, 628.5819929746758, 6942.305769423017, 7101.964490177516, 7117.608531530712, 7140.0, 7321.78034658961, 480.7620227987169, 519.3145048535896, 527.4488159872942, 599.1252770954368, 602.9005214139705, 3292.6378098409155, 3320.0869760815485, 3369.4103531881824, 3420.521127042216, 3426.297608990151, 53533.0, 53830.19254711182, 55312.72343638256, 55585.1662225067, 55714.72142639261, 46158.0, 46379.5362046382, 46846.29730554044, 47375.28937065947, 47987.76006119947, 40008.599914000486, 41082.383764242964, 43517.56482435135, 44295.0, 44429.33355999662, 6872.793816185523, 6906.102206713095, 6962.199347075151, 6986.16166060076, 7066.57600543969, 32695.673043270213, 32718.83640581782, 33475.665243347255, 34405.483917740756, 34420.0, 38730.4190437138, 39561.80219098886, 44470.3329450065, 44529.777351113036, 44742.0, 8568.52873091986, 8696.739097827076, 8944.5080520572, 8977.685780997634, 8996.280297576048, 8814.33892458081, 9513.524323783644, 9674.419534827934, 9833.655822046194, 11869.525218991144, 9383.483908385104, 9578.13796758295, 9694.079062489052, 10655.0, 10786.838197427202, 10770.676879693621, 10908.40003799767, 10936.617218397318, 10985.890141098487, 11061.446927653746, 9192.448453092837, 9596.23230141573, 9658.420494770337, 9858.802823943337, 10294.279400442198, 9479.857802133112, 9661.178799802095, 9758.707238782848, 10086.79826403453, 10120.696379108638, 9184.862227066733, 9488.383255088396, 9510.95244523773, 9568.712938611852, 9772.853407198756], "unit": "score", "name": "yui.html", "value": 5803.559388210861}], "name": "dromaeo_css", "value": 6343.349380289763}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 108.0, 114.0, 115.0, 113.0, 103.0, 112.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [160.0, 137.0, 153.0, 174.0, 134.0, 158.0, 155.0, 131.0, 177.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 163.0, 160.0, 162.0, 161.0, 160.0, 161.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 95.0, 102.0, 76.0, 76.0, 76.0, 110.0, 100.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 141.0, 94.0, 94.0, 94.0, 140.0, 95.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [117.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.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 75.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [89.0, 82.0, 81.0, 88.0, 82.0, 81.0, 81.0, 80.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [118.0, 122.0, 114.0, 117.0, 115.0, 121.0, 122.0, 126.0, 122.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [133.0, 131.0, 141.0, 151.0, 139.0, 134.0, 139.0, 138.0, 137.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 66.0, 66.0, 67.0, 64.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1512.7}]} 14:01:43 INFO - Return code: 0 14:01:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:01:44 ERROR - # TBPL SUCCESS # 14:01:44 INFO - Running post-action listener: _resource_record_post_action 14:01:44 INFO - Running post-run listener: _resource_record_post_run 14:01:45 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518193152; Read time: 16; Write time: 485740 14:01:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232300544; Read time: 0; Write time: 327012 14:01:45 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285892608; Read time: 16; Write time: 158728 14:01:45 INFO - Running post-run listener: _upload_blobber_files 14:01:45 INFO - Blob upload gear active. 14:01:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:01:45 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 14:01:45 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:01:45 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:01:45 INFO - (blobuploader) - INFO - Open directory for files ... 14:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:01:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:46 INFO - (blobuploader) - INFO - Done attempting. 14:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:01:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:46 INFO - (blobuploader) - INFO - Done attempting. 14:01:46 INFO - (blobuploader) - INFO - Iteration through files over. 14:01:46 INFO - Return code: 0 14:01:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:01:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:01:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/952aef21af814307282c47d97d5ddd3b7e394d8484ee31cc0552867e6c853f1d4a953837119d456ec8c650b81242de2dc0a44c450e1a8f1f2c641f832b9abeed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a7240248b06e1fc0bc61774f0a8c42b8ca169ca9bb5b4ef113a968d8427fa477b3cfeff84d3c666c14ca1d6721626e1c8c61e08763126ed62613a4ca3985ec2"} 14:01:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:01:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:01:46 INFO - Contents: 14:01:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/952aef21af814307282c47d97d5ddd3b7e394d8484ee31cc0552867e6c853f1d4a953837119d456ec8c650b81242de2dc0a44c450e1a8f1f2c641f832b9abeed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a7240248b06e1fc0bc61774f0a8c42b8ca169ca9bb5b4ef113a968d8427fa477b3cfeff84d3c666c14ca1d6721626e1c8c61e08763126ed62613a4ca3985ec2"} 14:01:46 INFO - Running post-run listener: copy_logs_to_upload_dir 14:01:46 INFO - Copying logs to upload dir... 14:01:46 INFO - mkdir: /builds/slave/test/build/upload/logs 14:01:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.347189 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-03-12 14:01:46.745252) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 14:01:46.748840) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/952aef21af814307282c47d97d5ddd3b7e394d8484ee31cc0552867e6c853f1d4a953837119d456ec8c650b81242de2dc0a44c450e1a8f1f2c641f832b9abeed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a7240248b06e1fc0bc61774f0a8c42b8ca169ca9bb5b4ef113a968d8427fa477b3cfeff84d3c666c14ca1d6721626e1c8c61e08763126ed62613a4ca3985ec2"} build_url:https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/X4dQ6aeNRqibkd1UQfQhGw/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/Firefox-Non-PGO/sha512/952aef21af814307282c47d97d5ddd3b7e394d8484ee31cc0552867e6c853f1d4a953837119d456ec8c650b81242de2dc0a44c450e1a8f1f2c641f832b9abeed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a7240248b06e1fc0bc61774f0a8c42b8ca169ca9bb5b4ef113a968d8427fa477b3cfeff84d3c666c14ca1d6721626e1c8c61e08763126ed62613a4ca3985ec2"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 14:01:46.893435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:01:46.893812) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1457811890.958560-826730024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:01:46.910383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 14:01:46.910741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 14:01:46.911061) ========= ========= Total master_lag: 0.38 =========