builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1460578156.62 results: success (0) buildid: 20160413123238 builduid: 12bf2d56a8544566868ed0d92021ce79 revision: ff3f8e8e89dce96d03ca9e31015825aa6444cb4b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.619396) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.619849) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.620140) ========= 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-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006283 basedir: '/builds/slave/test' ========= master_lag: 0.20 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.825369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.825683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.838984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.839282) ========= 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-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.888065) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.888376) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.888733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:16.889045) ========= 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-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 13:09:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.0M=0.001s 2016-04-13 13:09:17 (16.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:17.063721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:17.064030) ========= 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-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016350 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:17.113492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 13:09:17.113838) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff3f8e8e89dce96d03ca9e31015825aa6444cb4b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ff3f8e8e89dce96d03ca9e31015825aa6444cb4b --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-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 13:09:17,285 truncating revision to first 12 chars 2016-04-13 13:09:17,285 Setting DEBUG logging. 2016-04-13 13:09:17,285 attempt 1/10 2016-04-13 13:09:17,285 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff3f8e8e89dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 13:09:18,549 unpacking tar archive at: fx-team-ff3f8e8e89dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.574903 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 13:09:18.701557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:18.701912) ========= echo ff3f8e8e89dce96d03ca9e31015825aa6444cb4b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ff3f8e8e89dce96d03ca9e31015825aa6444cb4b'] 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-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ff3f8e8e89dce96d03ca9e31015825aa6444cb4b program finished with exit code 0 elapsedTime=0.003998 script_repo_revision: 'ff3f8e8e89dce96d03ca9e31015825aa6444cb4b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:18.750918) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:18.751232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 13:09:18.761189) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-13 13:09:18.761472) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:09:19 INFO - MultiFileLogger online at 20160413 13:09:19 in /builds/slave/test 13:09:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:09:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:19 INFO - {'append_to_log': False, 13:09:19 INFO - 'base_work_dir': '/builds/slave/test', 13:09:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:09:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:19 INFO - 'branch': 'Fx-Team-Non-PGO', 13:09:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:19 INFO - 'config_files': ('talos/linux_config.py',), 13:09:19 INFO - 'default_actions': ('clobber', 13:09:19 INFO - 'read-buildbot-config', 13:09:19 INFO - 'download-and-extract', 13:09:19 INFO - 'populate-webroot', 13:09:19 INFO - 'create-virtualenv', 13:09:19 INFO - 'install', 13:09:19 INFO - 'run-tests'), 13:09:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:19 INFO - 'download_minidump_stackwalk': True, 13:09:19 INFO - 'download_symbols': 'ondemand', 13:09:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:19 INFO - 'installer_path': 'installer.exe', 13:09:19 INFO - 'log_level': 'info', 13:09:19 INFO - 'log_name': 'talos', 13:09:19 INFO - 'log_to_console': True, 13:09:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:09:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:09:19 INFO - 'opt_config_files': (), 13:09:19 INFO - 'pip_index': False, 13:09:19 INFO - 'sps_profile': False, 13:09:19 INFO - 'sps_profile_interval': 0, 13:09:19 INFO - 'suite': 'dromaeojs-e10s', 13:09:19 INFO - 'system_bits': '32', 13:09:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:19 INFO - 'title': 'talos-linux64-ix-022', 13:09:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:19 INFO - 'use_talos_json': True, 13:09:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:19 INFO - 'work_dir': 'build'} 13:09:19 INFO - ##### 13:09:19 INFO - ##### Running clobber step. 13:09:19 INFO - ##### 13:09:19 INFO - Running pre-action listener: _resource_record_pre_action 13:09:19 INFO - Running main action method: clobber 13:09:19 INFO - rmtree: /builds/slave/test/build 13:09:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:09:20 INFO - Running post-action listener: _resource_record_post_action 13:09:20 INFO - ##### 13:09:20 INFO - ##### Running read-buildbot-config step. 13:09:20 INFO - ##### 13:09:20 INFO - Running pre-action listener: _resource_record_pre_action 13:09:20 INFO - Running main action method: read_buildbot_config 13:09:20 INFO - Using buildbot properties: 13:09:20 INFO - { 13:09:20 INFO - "project": "", 13:09:20 INFO - "product": "firefox", 13:09:20 INFO - "script_repo_revision": "production", 13:09:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:09:20 INFO - "repository": "", 13:09:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:09:20 INFO - "buildid": "20160413123238", 13:09:20 INFO - "pgo_build": "False", 13:09:20 INFO - "basedir": "/builds/slave/test", 13:09:20 INFO - "buildnumber": 1137, 13:09:20 INFO - "slavename": "talos-linux64-ix-022", 13:09:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:09:20 INFO - "platform": "ubuntu64_hw", 13:09:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:09:20 INFO - "branch": "fx-team", 13:09:20 INFO - "repo_path": "integration/fx-team", 13:09:20 INFO - "revision": "ff3f8e8e89dce96d03ca9e31015825aa6444cb4b", 13:09:20 INFO - "stage_platform": "linux64", 13:09:20 INFO - "builduid": "12bf2d56a8544566868ed0d92021ce79", 13:09:20 INFO - "slavebuilddir": "test" 13:09:20 INFO - } 13:09:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:09:20 INFO - Running post-action listener: _resource_record_post_action 13:09:20 INFO - ##### 13:09:20 INFO - ##### Running download-and-extract step. 13:09:20 INFO - ##### 13:09:20 INFO - Running pre-action listener: _resource_record_pre_action 13:09:20 INFO - Running main action method: download_and_extract 13:09:20 INFO - mkdir: /builds/slave/test/build/tests 13:09:20 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:09:20 INFO - https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:20 INFO - Downloaded 1361 bytes. 13:09:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:09:20 INFO - Using the following test package requirements: 13:09:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:09:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:09:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:20 INFO - u'jsshell-linux-x86_64.zip'], 13:09:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:09:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:09:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:09:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:09:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:09:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:09:20 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:09:20 INFO - https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:21 INFO - Downloaded 22199056 bytes. 13:09:21 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:09:21 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:09:23 INFO - Return code: 0 13:09:23 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:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:23 INFO - https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:24 INFO - Downloaded 22199056 bytes. 13:09:24 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:09:24 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:09:25 INFO - Return code: 0 13:09:25 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:09:25 INFO - https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:26 INFO - Downloaded 10841076 bytes. 13:09:26 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:09:26 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:09:26 INFO - Return code: 0 13:09: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:09:26 INFO - https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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:09:28 INFO - Downloaded 54166608 bytes. 13:09:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:09:28 INFO - mkdir: /builds/slave/test/properties 13:09:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:28 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:28 INFO - Contents: 13:09:28 INFO - build_url:https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:09:29 INFO - Running post-action listener: _resource_record_post_action 13:09:29 INFO - Running post-action listener: set_extra_try_arguments 13:09:29 INFO - ##### 13:09:29 INFO - ##### Running populate-webroot step. 13:09:29 INFO - ##### 13:09:29 INFO - Running pre-action listener: _resource_record_pre_action 13:09:29 INFO - Running main action method: populate_webroot 13:09:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:29 INFO - '--tppagecycles', 13:09:29 INFO - '7'], 13:09:29 INFO - 'tests': ['tsvgm']}}, 13:09:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:09:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:09:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:29 INFO - 'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:29 INFO - 'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['damp', 'tps']}, 13:09:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:29 INFO - 'tests': ['damp', 'tps']}, 13:09:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['dromaeo_dom']}, 13:09:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['a11yr', 13:09:29 INFO - 'ts_paint', 13:09:29 INFO - 'tpaint', 13:09:29 INFO - 'sessionrestore', 13:09:29 INFO - 'sessionrestore_no_auto_restore', 13:09:29 INFO - 'tabpaint']}, 13:09:29 INFO - 'other-e10s': {'tests': ['a11yr', 13:09:29 INFO - 'ts_paint', 13:09:29 INFO - 'tpaint', 13:09:29 INFO - 'sessionrestore', 13:09:29 INFO - 'sessionrestore_no_auto_restore', 13:09:29 INFO - 'tabpaint']}, 13:09:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:09:29 INFO - 'ts_paint', 13:09:29 INFO - 'tpaint', 13:09:29 INFO - 'sessionrestore', 13:09:29 INFO - 'sessionrestore_no_auto_restore', 13:09:29 INFO - 'tabpaint']}, 13:09:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:09:29 INFO - 'ts_paint', 13:09:29 INFO - 'tpaint', 13:09:29 INFO - 'sessionrestore', 13:09:29 INFO - 'sessionrestore_no_auto_restore', 13:09:29 INFO - 'tabpaint']}, 13:09:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['a11yr', 13:09:29 INFO - 'ts_paint', 13:09:29 INFO - 'tpaint', 13:09:29 INFO - 'sessionrestore', 13:09:29 INFO - 'sessionrestore_no_auto_restore', 13:09:29 INFO - 'tabpaint']}, 13:09:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['a11yr', 13:09:29 INFO - 'ts_paint', 13:09:29 INFO - 'tpaint', 13:09:29 INFO - 'sessionrestore', 13:09:29 INFO - 'sessionrestore_no_auto_restore', 13:09:29 INFO - 'tabpaint']}, 13:09:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['tsvgx', 13:09:29 INFO - 'tsvgr_opacity', 13:09:29 INFO - 'tart', 13:09:29 INFO - 'tscrollx', 13:09:29 INFO - 'cart']}, 13:09:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:09:29 INFO - 'tsvgr_opacity', 13:09:29 INFO - 'tart', 13:09:29 INFO - 'tscrollx', 13:09:29 INFO - 'cart']}, 13:09:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:29 INFO - 'talos_options': ['--disable-e10s'], 13:09:29 INFO - 'tests': ['tp5o']}, 13:09:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:29 INFO - 'tests': ['tp5o']}, 13:09:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:29 INFO - 'talos_options': ['--disable-e10s', 13:09:29 INFO - '--xperf_path', 13:09:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:29 INFO - 'tests': ['tp5n']}, 13:09:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:29 INFO - 'talos_options': ['--xperf_path', 13:09:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:29 INFO - 'tests': ['tp5n']}}, 13:09:29 INFO - 'talos.zip': {'path': '', 13:09:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:29 INFO - Running post-action listener: _resource_record_post_action 13:09:29 INFO - ##### 13:09:29 INFO - ##### Running create-virtualenv step. 13:09:29 INFO - ##### 13:09:29 INFO - Running pre-action listener: _resource_record_pre_action 13:09:29 INFO - Running main action method: create_virtualenv 13:09:29 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:29 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:09:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:29 INFO - Using real prefix '/usr' 13:09:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:30 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:32 INFO - Installing pip.................done. 13:09:32 INFO - Return code: 0 13:09:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 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 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:32 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:09:32 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:09:32 INFO - Using env: {'DISPLAY': ':0', 13:09:32 INFO - 'HOME': '/home/cltbld', 13:09:32 INFO - 'LANG': 'en_US.UTF-8', 13:09:32 INFO - 'LANGUAGE': 'en_US:en', 13:09:32 INFO - 'LOGNAME': 'cltbld', 13:09:32 INFO - 'MAIL': '/var/mail/cltbld', 13:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:32 INFO - 'MOZ_NO_REMOTE': '1', 13:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:32 INFO - 'NO_EM_RESTART': '1', 13:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:32 INFO - 'PWD': '/builds/slave/test', 13:09:32 INFO - 'SHELL': '/bin/bash', 13:09:32 INFO - 'SHLVL': '1', 13:09:32 INFO - 'TERM': 'linux', 13:09:32 INFO - 'TMOUT': '86400', 13:09:32 INFO - 'USER': 'cltbld', 13:09:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:32 INFO - '_': '/tools/buildbot/bin/python'} 13:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:32 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:09:32 INFO - Cleaning up... 13:09:32 INFO - Return code: 0 13:09:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 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 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:32 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:09:32 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:09:32 INFO - Using env: {'DISPLAY': ':0', 13:09:32 INFO - 'HOME': '/home/cltbld', 13:09:32 INFO - 'LANG': 'en_US.UTF-8', 13:09:32 INFO - 'LANGUAGE': 'en_US:en', 13:09:32 INFO - 'LOGNAME': 'cltbld', 13:09:32 INFO - 'MAIL': '/var/mail/cltbld', 13:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:32 INFO - 'MOZ_NO_REMOTE': '1', 13:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:32 INFO - 'NO_EM_RESTART': '1', 13:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:32 INFO - 'PWD': '/builds/slave/test', 13:09:32 INFO - 'SHELL': '/bin/bash', 13:09:32 INFO - 'SHLVL': '1', 13:09:32 INFO - 'TERM': 'linux', 13:09:32 INFO - 'TMOUT': '86400', 13:09:32 INFO - 'USER': 'cltbld', 13:09:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:32 INFO - '_': '/tools/buildbot/bin/python'} 13:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:32 INFO - Downloading/unpacking psutil>=0.7.1 13:09: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:09: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:09: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:09: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:09: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:09: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:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:34 INFO - Installing collected packages: psutil 13:09:34 INFO - Running setup.py install for psutil 13:09:34 INFO - building 'psutil._psutil_linux' extension 13:09:34 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:09:34 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:09:34 INFO - building 'psutil._psutil_posix' extension 13:09:34 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:09:34 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:09:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:34 INFO - Successfully installed psutil 13:09:34 INFO - Cleaning up... 13:09:35 INFO - Return code: 0 13:09:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:09: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:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:35 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 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:35 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:09:35 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:09:35 INFO - Using env: {'DISPLAY': ':0', 13:09:35 INFO - 'HOME': '/home/cltbld', 13:09:35 INFO - 'LANG': 'en_US.UTF-8', 13:09:35 INFO - 'LANGUAGE': 'en_US:en', 13:09:35 INFO - 'LOGNAME': 'cltbld', 13:09:35 INFO - 'MAIL': '/var/mail/cltbld', 13:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:35 INFO - 'MOZ_NO_REMOTE': '1', 13:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:35 INFO - 'NO_EM_RESTART': '1', 13:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:35 INFO - 'PWD': '/builds/slave/test', 13:09:35 INFO - 'SHELL': '/bin/bash', 13:09:35 INFO - 'SHLVL': '1', 13:09:35 INFO - 'TERM': 'linux', 13:09:35 INFO - 'TMOUT': '86400', 13:09:35 INFO - 'USER': 'cltbld', 13:09:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:35 INFO - '_': '/tools/buildbot/bin/python'} 13:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:09:35 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:09:35 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:09:35 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:09:35 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:09:35 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:09:35 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:09:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:37 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:09:37 INFO - Installing collected packages: mozsystemmonitor 13:09:37 INFO - Running setup.py install for mozsystemmonitor 13:09:37 INFO - Successfully installed mozsystemmonitor 13:09:37 INFO - Cleaning up... 13:09:37 INFO - Return code: 0 13:09:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:37 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 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:37 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:09:37 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:09:37 INFO - Using env: {'DISPLAY': ':0', 13:09:37 INFO - 'HOME': '/home/cltbld', 13:09:37 INFO - 'LANG': 'en_US.UTF-8', 13:09:37 INFO - 'LANGUAGE': 'en_US:en', 13:09:37 INFO - 'LOGNAME': 'cltbld', 13:09:37 INFO - 'MAIL': '/var/mail/cltbld', 13:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:37 INFO - 'MOZ_NO_REMOTE': '1', 13:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:37 INFO - 'NO_EM_RESTART': '1', 13:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:37 INFO - 'PWD': '/builds/slave/test', 13:09:37 INFO - 'SHELL': '/bin/bash', 13:09:37 INFO - 'SHLVL': '1', 13:09:37 INFO - 'TERM': 'linux', 13:09:37 INFO - 'TMOUT': '86400', 13:09:37 INFO - 'USER': 'cltbld', 13:09:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:37 INFO - '_': '/tools/buildbot/bin/python'} 13:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:37 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:37 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:09:37 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:09:37 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:09:37 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:09:37 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:09:37 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:09:39 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:39 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:09:39 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:09:39 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:09:39 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:09:39 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:09:39 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:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:39 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:09:39 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:09:39 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:09:39 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:09:39 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:09:39 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:09:40 INFO - Downloading docopt-0.6.1.tar.gz 13:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:40 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:40 INFO - Running setup.py install for blobuploader 13:09:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:40 INFO - Running setup.py install for requests 13:09:40 INFO - Running setup.py install for docopt 13:09:40 INFO - Successfully installed blobuploader requests docopt 13:09:40 INFO - Cleaning up... 13:09:40 INFO - Return code: 0 13:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:40 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:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:40 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:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:40 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 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:40 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:09:40 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:09:40 INFO - Using env: {'DISPLAY': ':0', 13:09:40 INFO - 'HOME': '/home/cltbld', 13:09:40 INFO - 'LANG': 'en_US.UTF-8', 13:09:40 INFO - 'LANGUAGE': 'en_US:en', 13:09:40 INFO - 'LOGNAME': 'cltbld', 13:09:40 INFO - 'MAIL': '/var/mail/cltbld', 13:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:40 INFO - 'MOZ_NO_REMOTE': '1', 13:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:40 INFO - 'NO_EM_RESTART': '1', 13:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:40 INFO - 'PWD': '/builds/slave/test', 13:09:40 INFO - 'SHELL': '/bin/bash', 13:09:40 INFO - 'SHLVL': '1', 13:09:40 INFO - 'TERM': 'linux', 13:09:40 INFO - 'TMOUT': '86400', 13:09:40 INFO - 'USER': 'cltbld', 13:09:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:40 INFO - '_': '/tools/buildbot/bin/python'} 13:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:40 INFO - Running setup.py (path:/tmp/pip-X8JMmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:41 INFO - Running setup.py (path:/tmp/pip-KAMMh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:41 INFO - Running setup.py (path:/tmp/pip-5VpPoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:41 INFO - Running setup.py (path:/tmp/pip-i7TcPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:41 INFO - Running setup.py (path:/tmp/pip-1A3sFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:41 INFO - Running setup.py (path:/tmp/pip-BMtjpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:41 INFO - Running setup.py (path:/tmp/pip-nvWlvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:41 INFO - Running setup.py (path:/tmp/pip-Y6gEr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:41 INFO - Running setup.py (path:/tmp/pip-F0WR18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:41 INFO - Running setup.py (path:/tmp/pip-BfqzXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:41 INFO - Running setup.py (path:/tmp/pip-eiRG4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:41 INFO - Running setup.py (path:/tmp/pip-zWpW1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:41 INFO - Running setup.py (path:/tmp/pip-xAEcoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:41 INFO - Running setup.py (path:/tmp/pip-xrVIGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:41 INFO - Running setup.py (path:/tmp/pip-Fcrn1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:42 INFO - Running setup.py (path:/tmp/pip-axIyVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:42 INFO - Running setup.py (path:/tmp/pip-y7y4sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:42 INFO - Running setup.py install for manifestparser 13:09:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:42 INFO - Running setup.py install for mozcrash 13:09:42 INFO - Running setup.py install for mozdebug 13:09:42 INFO - Running setup.py install for mozdevice 13:09:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:42 INFO - Running setup.py install for mozfile 13:09:42 INFO - Running setup.py install for mozhttpd 13:09:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:42 INFO - Running setup.py install for mozinfo 13:09:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:42 INFO - Running setup.py install for mozInstall 13:09:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:43 INFO - Running setup.py install for mozleak 13:09:43 INFO - Running setup.py install for mozlog 13:09:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:43 INFO - Running setup.py install for moznetwork 13:09:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:43 INFO - Running setup.py install for mozprocess 13:09:43 INFO - Running setup.py install for mozprofile 13:09:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:43 INFO - Running setup.py install for mozrunner 13:09:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:43 INFO - Running setup.py install for mozscreenshot 13:09:43 INFO - Running setup.py install for moztest 13:09:43 INFO - Running setup.py install for mozversion 13:09:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:43 INFO - Cleaning up... 13:09:43 INFO - Return code: 0 13:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 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 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:43 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:09:43 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:09:43 INFO - Using env: {'DISPLAY': ':0', 13:09:43 INFO - 'HOME': '/home/cltbld', 13:09:43 INFO - 'LANG': 'en_US.UTF-8', 13:09:43 INFO - 'LANGUAGE': 'en_US:en', 13:09:43 INFO - 'LOGNAME': 'cltbld', 13:09:43 INFO - 'MAIL': '/var/mail/cltbld', 13:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:43 INFO - 'MOZ_NO_REMOTE': '1', 13:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:43 INFO - 'NO_EM_RESTART': '1', 13:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:43 INFO - 'PWD': '/builds/slave/test', 13:09:43 INFO - 'SHELL': '/bin/bash', 13:09:43 INFO - 'SHLVL': '1', 13:09:43 INFO - 'TERM': 'linux', 13:09:43 INFO - 'TMOUT': '86400', 13:09:43 INFO - 'USER': 'cltbld', 13:09:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:43 INFO - '_': '/tools/buildbot/bin/python'} 13:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:44 INFO - Running setup.py (path:/tmp/pip-QY_nKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:44 INFO - Running setup.py (path:/tmp/pip-XmCTpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:44 INFO - Running setup.py (path:/tmp/pip-Aj8cvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:44 INFO - Running setup.py (path:/tmp/pip-IwVCZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:44 INFO - Running setup.py (path:/tmp/pip-DeEUL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:44 INFO - Running setup.py (path:/tmp/pip-eeVayY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:44 INFO - Running setup.py (path:/tmp/pip-vZr3TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:44 INFO - Running setup.py (path:/tmp/pip-GsLYl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:44 INFO - Running setup.py (path:/tmp/pip-ff_0r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:44 INFO - Running setup.py (path:/tmp/pip-o40MgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:44 INFO - Running setup.py (path:/tmp/pip-fTasXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:44 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:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:45 INFO - Running setup.py (path:/tmp/pip-DEwUm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:45 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:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:45 INFO - Running setup.py (path:/tmp/pip-XGyvcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:45 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:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:45 INFO - Running setup.py (path:/tmp/pip-7GJB0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:45 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:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:45 INFO - Running setup.py (path:/tmp/pip-MwAY_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:45 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:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:45 INFO - Running setup.py (path:/tmp/pip-Sxpihp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:45 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:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:45 INFO - Running setup.py (path:/tmp/pip-uFndmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:45 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:09:45 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:09:45 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:09:45 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:09:45 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:09:45 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:09:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:47 INFO - Downloading blessings-1.6.tar.gz 13:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:47 INFO - Installing collected packages: blessings 13:09:47 INFO - Running setup.py install for blessings 13:09:47 INFO - Successfully installed blessings 13:09:47 INFO - Cleaning up... 13:09:47 INFO - Return code: 0 13:09:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:47 INFO - Reading from file tmpfile_stdout 13:09:47 INFO - Current package versions: 13:09:47 INFO - argparse == 1.2.1 13:09:47 INFO - blessings == 1.6 13:09:47 INFO - blobuploader == 1.2.4 13:09:47 INFO - docopt == 0.6.1 13:09:47 INFO - manifestparser == 1.1 13:09:47 INFO - mozInstall == 1.12 13:09:47 INFO - mozcrash == 0.17 13:09:47 INFO - mozdebug == 0.1 13:09:47 INFO - mozdevice == 0.48 13:09:47 INFO - mozfile == 1.2 13:09:47 INFO - mozhttpd == 0.7 13:09:47 INFO - mozinfo == 0.9 13:09:47 INFO - mozleak == 0.1 13:09:47 INFO - mozlog == 3.1 13:09:47 INFO - moznetwork == 0.27 13:09:47 INFO - mozprocess == 0.22 13:09:47 INFO - mozprofile == 0.28 13:09:47 INFO - mozrunner == 6.11 13:09:47 INFO - mozscreenshot == 0.1 13:09:47 INFO - mozsystemmonitor == 0.0 13:09:47 INFO - moztest == 0.7 13:09:47 INFO - mozversion == 1.4 13:09:47 INFO - psutil == 3.1.1 13:09:47 INFO - requests == 1.2.3 13:09:47 INFO - wsgiref == 0.1.2 13:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:47 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:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:47 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:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:47 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 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:47 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:09:47 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:09:47 INFO - Using env: {'DISPLAY': ':0', 13:09:47 INFO - 'HOME': '/home/cltbld', 13:09:47 INFO - 'LANG': 'en_US.UTF-8', 13:09:47 INFO - 'LANGUAGE': 'en_US:en', 13:09:47 INFO - 'LOGNAME': 'cltbld', 13:09:47 INFO - 'MAIL': '/var/mail/cltbld', 13:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:47 INFO - 'MOZ_NO_REMOTE': '1', 13:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:47 INFO - 'NO_EM_RESTART': '1', 13:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:47 INFO - 'PWD': '/builds/slave/test', 13:09:47 INFO - 'SHELL': '/bin/bash', 13:09:47 INFO - 'SHLVL': '1', 13:09:47 INFO - 'TERM': 'linux', 13:09:47 INFO - 'TMOUT': '86400', 13:09:47 INFO - 'USER': 'cltbld', 13:09:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:47 INFO - '_': '/tools/buildbot/bin/python'} 13:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:48 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:09:48 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:09:48 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:09:48 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:09:48 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:09:48 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:09:48 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:09:48 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:09:48 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:09:48 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:09:48 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:09:48 INFO - Cleaning up... 13:09:48 INFO - Return code: 0 13:09:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:09:48 INFO - Using env: {'DISPLAY': ':0', 13:09:48 INFO - 'HOME': '/home/cltbld', 13:09:48 INFO - 'LANG': 'en_US.UTF-8', 13:09:48 INFO - 'LANGUAGE': 'en_US:en', 13:09:48 INFO - 'LOGNAME': 'cltbld', 13:09:48 INFO - 'MAIL': '/var/mail/cltbld', 13:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:48 INFO - 'MOZ_NO_REMOTE': '1', 13:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:48 INFO - 'NO_EM_RESTART': '1', 13:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:48 INFO - 'PWD': '/builds/slave/test', 13:09:48 INFO - 'SHELL': '/bin/bash', 13:09:48 INFO - 'SHLVL': '1', 13:09:48 INFO - 'TERM': 'linux', 13:09:48 INFO - 'TMOUT': '86400', 13:09:48 INFO - 'USER': 'cltbld', 13:09:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:48 INFO - '_': '/tools/buildbot/bin/python'} 13:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:48 INFO - Downloading/unpacking jsonschema 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:50 INFO - Downloading/unpacking functools32 (from jsonschema) 13:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:50 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:50 INFO - warning: no files found matching '*.txt' 13:09:50 INFO - no previously-included directories found matching 'build' 13:09:50 INFO - no previously-included directories found matching 'dist' 13:09:50 INFO - no previously-included directories found matching '.git*' 13:09:50 INFO - Installing collected packages: jsonschema, functools32 13:09:50 INFO - Running setup.py install for functools32 13:09:50 INFO - warning: no files found matching '*.txt' 13:09:50 INFO - no previously-included directories found matching 'build' 13:09:50 INFO - no previously-included directories found matching 'dist' 13:09:50 INFO - no previously-included directories found matching '.git*' 13:09:50 INFO - Successfully installed jsonschema functools32 13:09:50 INFO - Cleaning up... 13:09:50 INFO - Return code: 0 13:09:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:09:50 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:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:50 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:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:50 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 0x7f58af596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, '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-1460578154.979160-1534013276', '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:09:50 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:09:50 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:09:50 INFO - Using env: {'DISPLAY': ':0', 13:09:50 INFO - 'HOME': '/home/cltbld', 13:09:50 INFO - 'LANG': 'en_US.UTF-8', 13:09:50 INFO - 'LANGUAGE': 'en_US:en', 13:09:50 INFO - 'LOGNAME': 'cltbld', 13:09:50 INFO - 'MAIL': '/var/mail/cltbld', 13:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:50 INFO - 'MOZ_NO_REMOTE': '1', 13:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:50 INFO - 'NO_EM_RESTART': '1', 13:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:50 INFO - 'PWD': '/builds/slave/test', 13:09:50 INFO - 'SHELL': '/bin/bash', 13:09:50 INFO - 'SHLVL': '1', 13:09:50 INFO - 'TERM': 'linux', 13:09:50 INFO - 'TMOUT': '86400', 13:09:50 INFO - 'USER': 'cltbld', 13:09:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:50 INFO - '_': '/tools/buildbot/bin/python'} 13:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:50 INFO - Downloading/unpacking flake8 13:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:09:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:09:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:09:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:09:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:09:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:09:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:09:53 INFO - no previously-included directories found matching 'docs/_build' 13:09:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:09:53 INFO - Running setup.py install for pep8 13:09:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:09:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:09:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:09:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:09:53 INFO - no previously-included directories found matching 'docs/_build' 13:09:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:09:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:09:53 INFO - Cleaning up... 13:09:53 INFO - Return code: 0 13:09:53 INFO - Running post-action listener: _resource_record_post_action 13:09:53 INFO - Running post-action listener: _start_resource_monitoring 13:09:53 INFO - Starting resource monitoring. 13:09:53 INFO - ##### 13:09:53 INFO - ##### Running install step. 13:09:53 INFO - ##### 13:09:53 INFO - Running pre-action listener: _resource_record_pre_action 13:09:53 INFO - Running main action method: install 13:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:53 INFO - Reading from file tmpfile_stdout 13:09:53 INFO - Detecting whether we're running mozinstall >=1.0... 13:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:09:53 INFO - Reading from file tmpfile_stdout 13:09:53 INFO - Output received: 13:09:53 INFO - Usage: mozinstall [options] installer 13:09:53 INFO - Options: 13:09:53 INFO - -h, --help show this help message and exit 13:09:53 INFO - -d DEST, --destination=DEST 13:09:53 INFO - Directory to install application into. [default: 13:09:53 INFO - "/builds/slave/test"] 13:09:53 INFO - --app=APP Application being installed. [default: firefox] 13:09:53 INFO - mkdir: /builds/slave/test/build/application 13:09:53 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:09:53 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:10:09 INFO - Reading from file tmpfile_stdout 13:10:09 INFO - Output received: 13:10:09 INFO - /builds/slave/test/build/application/firefox/firefox 13:10:09 INFO - Running post-action listener: _resource_record_post_action 13:10:09 INFO - ##### 13:10:09 INFO - ##### Running run-tests step. 13:10:09 INFO - ##### 13:10:09 INFO - Running pre-action listener: _resource_record_pre_action 13:10:09 INFO - Running main action method: run_tests 13:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:09 INFO - Python 2.7.3 13:10:09 INFO - Return code: 0 13:10:09 INFO - grabbing minidump binary from tooltool 13:10:09 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:10:09 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 0x1861410>, '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 0x1862310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18627a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:09 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:10:09 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:10:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:09 INFO - Return code: 0 13:10:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:10:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:10:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:10:10 INFO - Return code: 0 13:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:10:10 INFO - Using env: {'DISPLAY': ':0', 13:10:10 INFO - 'HOME': '/home/cltbld', 13:10:10 INFO - 'LANG': 'en_US.UTF-8', 13:10:10 INFO - 'LANGUAGE': 'en_US:en', 13:10:10 INFO - 'LOGNAME': 'cltbld', 13:10:10 INFO - 'MAIL': '/var/mail/cltbld', 13:10:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:10 INFO - 'MOZ_NO_REMOTE': '1', 13:10:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:10 INFO - 'NO_EM_RESTART': '1', 13:10:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:10 INFO - 'PWD': '/builds/slave/test', 13:10:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:10 INFO - 'SHELL': '/bin/bash', 13:10:10 INFO - 'SHLVL': '1', 13:10:10 INFO - 'TERM': 'linux', 13:10:10 INFO - 'TMOUT': '86400', 13:10:10 INFO - 'USER': 'cltbld', 13:10:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460578154.979160-1534013276', 13:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:10 INFO - '_': '/tools/buildbot/bin/python'} 13:10:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:10:10 INFO - mozversion application_buildid: 20160413123238 13:10:10 INFO - mozversion application_changeset: ff3f8e8e89dce96d03ca9e31015825aa6444cb4b 13:10:10 INFO - mozversion application_display_name: Nightly 13:10:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:10 INFO - mozversion application_name: Firefox 13:10:10 INFO - mozversion application_remotingname: firefox 13:10:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:10:10 INFO - mozversion application_vendor: Mozilla 13:10:10 INFO - mozversion application_version: 48.0a1 13:10:10 INFO - mozversion platform_buildid: 20160413123238 13:10:10 INFO - mozversion platform_changeset: ff3f8e8e89dce96d03ca9e31015825aa6444cb4b 13:10:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:10:10 INFO - mozversion platform_version: 48.0a1 13:10:10 INFO - using testdate: 1460578210 13:10:10 INFO - actual date: 1460578210 13:10:10 INFO - starting webserver on 'localhost:53603' 13:10:10 INFO - SUITE-START | Running 2 tests 13:10:10 INFO - TEST-START | dromaeo_css 13:10:10 INFO - operating with platform_type : linux_ 13:10:10 INFO - Initialising browser for dromaeo_css test... 13:10:10 INFO - TEST-INFO | started process 6679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp57Y1Io/profile http://localhost:53603/getInfo.html) 13:10:14 INFO - PROCESS | 6679 | 13:10:14 INFO - PROCESS | 6679 | (process:6746): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:10:15 INFO - PROCESS | 6679 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 13:10:15 INFO - PROCESS | 6679 | __metrics Screen width/height:1600/1200 13:10:15 INFO - PROCESS | 6679 | colorDepth:24 13:10:15 INFO - PROCESS | 6679 | Browser inner width/height: 1024/697 13:10:15 INFO - PROCESS | 6679 | __metrics 13:10:16 ERROR - PROCESS | 6679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:10:17 INFO - TEST-INFO | 6679: exit 0 13:10:17 INFO - Browser initialized. 13:10:17 INFO - Running cycle 1/1 for dromaeo_css test... 13:10:17 INFO - TEST-INFO | started process 6797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp57Y1Io/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:19 INFO - PROCESS | 6797 | 13:10:19 INFO - PROCESS | 6797 | (process:6857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:10:29 INFO - PROCESS | 6797 | RSS: Main: 164155392 13:10:29 INFO - PROCESS | 6797 | 13:11:18 INFO - PROCESS | 6797 | 1460578278920 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:13:30 INFO - PROCESS | 6797 | Cycle 1(1): loaded http://localhost:53603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53603/tests/dromaeo/cssquery-ext.html) 13:13:31 INFO - PROCESS | 6797 | RSS: Main: 169922560 13:13:31 INFO - PROCESS | 6797 | 13:16:33 INFO - PROCESS | 6797 | Cycle 1(1): loaded http://localhost:53603/tests/dromaeo/cssquery-ext.html (next: http://localhost:53603/tests/dromaeo/cssquery-jquery.html) 13:16:34 INFO - PROCESS | 6797 | RSS: Main: 165863424 13:16:34 INFO - PROCESS | 6797 | 13:19:36 INFO - PROCESS | 6797 | Cycle 1(1): loaded http://localhost:53603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53603/tests/dromaeo/cssquery-mootools.html) 13:19:36 INFO - PROCESS | 6797 | RSS: Main: 166707200 13:19:36 INFO - PROCESS | 6797 | 13:22:38 INFO - PROCESS | 6797 | Cycle 1(1): loaded http://localhost:53603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53603/tests/dromaeo/cssquery-prototype.html) 13:22:39 INFO - PROCESS | 6797 | RSS: Main: 164188160 13:22:39 INFO - PROCESS | 6797 | 13:25:41 INFO - PROCESS | 6797 | Cycle 1(1): loaded http://localhost:53603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53603/tests/dromaeo/cssquery-yui.html) 13:25:42 INFO - PROCESS | 6797 | RSS: Main: 165609472 13:25:42 INFO - PROCESS | 6797 | 13:28:44 INFO - PROCESS | 6797 | Cycle 1(1): loaded http://localhost:53603/tests/dromaeo/cssquery-yui.html (next: http://localhost:53603/tests/dromaeo/cssquery-dojo.html) 13:28:45 INFO - PROCESS | 6797 | RSS: Main: 167387136 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - PROCESS | 6797 | __start_tp_report 13:28:45 INFO - PROCESS | 6797 | _x_x_mozilla_page_load 13:28:45 INFO - PROCESS | 6797 | _x_x_mozilla_page_load_details 13:28:45 INFO - PROCESS | 6797 | |i|pagename|runs| 13:28:45 INFO - PROCESS | 6797 | |0;dojo.html;2641.049222279979;2689.058829409707;2732.8087033907636;2734.5214587447203;2736.028709808018;4673.5092815254375;4673.883152921178;4691.413573303337;4696.50686677899;4697.718136911779;4659.603933665642;4740.099381117594;4747.192977193877;4757.381540399743;4760.143174228638;4331.805068771905;4359.912801743963;4412.757298348605;4414.22751018572;4429.424174857264;4374;4435.201663700533;4437.977810110945;4473.1501014807245;4497.707649002804;4015.2973229684835;4321.2653848845775;4378.190034843564;4378.562143785628;4384.167008268419;4369.1480161368545;4372.978135109336;4376.321670141133;4408.25059739845;4417.18282117806;4314.762688052156;4328.480582330109;4351.129774045204;4379.1241751649795;4379.408779814716;4645.070985802853;4657.534246575349;4669.439667239919;4690.273007683781;4743.146233677937;5086.92369614456;5141.845744627667;5146.56300821069;5147.6911385317;5162.277281180638;5005.049040682259;5146.639735218536;5203.271541984125;5230.633855630107;5252.2384254282915;4771.379720636364;4784.019276048437;4793.760311984422;4798.088363210979;4834.226523756182;5267.078261304257;5268.683878967274;5271.024860400838;5275.20871869215;5276.683398996072;4870.683405578626;4962.206047032458;4965.280034395065;4971.726555039435;4997.650164488451;5072.239164125337;5102.2346648003095;5107.54032137102;5113.258577506241;5146.511081447256;5040.59675225981;5048.16705243638;5051.62112841531;5058.165402708585;5063.0380227756605;4896.828610998598;4987.351644286219;5056.418511871182;5115;5122.846314610493;4245.596668316505;4259.701820872509;4292.763897985641;4334.566543345641;4336.609705126491;3736.9813150934615;3766.7928263945746;3784.2053168834304;3836.846526138979;3857.7492462989817;4317.892052698708;4385.802638881258;4408.338749187647;4409.536998615164;4457.531959144308;5147.510986456281;5157.123289040872;5160.741962901915;5176.3270774799785;5194.220866869924;4435.3125265583885;4458.71018383804;4459.470898417082;4465.866024019285;4506.729596224237;4515.954840451619;4544.2501987171745;4582.656300777455;4594.885127871763;4620.607248383925;4742.264948932921;4751.073540659608;4757.6193904488255;4758.64310176745;4800.399950006249;5053.570446512088;5061.468545802638;5061.7382457960375;5062.873428164326;5086.491350865032;4740.1230772307235;4798.136335459651;4813.687110337817;4872.780724867319;4888.413390393175;5032.3961124665275;5033.370828646419;5037.0681423936685;5045.369328833895;5119.078565858182;5110.284560161506;5119.769610367468;5122.257272695513;5141.948580514147;5147.253648221062;4800.0639875224;4907.460179380337;4934.802607895644;4967.577755890789;5009.373828271466;4922.4339200992345;4931;4936.259561065869;4958.603311734981;5042.445331013512;4805.783739731791;4904.215325547895;4905.313256144072;4924.852254432372;4928.581070608895;4828.4688684244;4951.084049450863;4976.2038073908;5049.419316778617;5055.393352797688;4790.760461976817;4799.592034676952;4810.542998415145;4845.030993801324;4863.270509423614 13:28:45 INFO - PROCESS | 6797 | |1;ext.html;586.879689663619;601.6540489218698;605.6305653551331;618.0605479670899;634.4226753654176;32157.99999999997;33044.66955330446;33250.50124248138;33285.16787080324;33336.49995250073;33684.663153368456;33907.491387629205;34127;34386.48420273698;34441.31117377657;7461.813454663623;7577.545347279153;7628.847423051563;7646.426518011143;7659.502132361406;7585.431092668072;7684.615769211545;7705.075390953066;7708.884366734504;7726.536407815521;7728.884066739003;7751.689932402697;7789.221077892222;7805.063392392893;7806.180351063113;7673.155952845183;7751.689932402697;7753.922460775405;7773.3004029637605;7776.300132988058;7664.195259497728;7726.806829829243;7752.457327987043;7756.108047574545;7787.766367008999;28220.15339539817;34063;34206.14484637879;34587.30825383478;34628.48057279143;3031.1967328657925;3157.5421563873338;3399.7280217582534;3566.4115420955513;3625.963740362615;26307.342316442242;26862.5970610441;27030.1890943272;27584.448311033666;27673.169804905683;3545.964540354615;3574.749767516275;3576.8032758198287;3584.802835844054;3632.8728494502566;176247;180796;182372.08813955978;182658;183783;56065.439345606836;56695.433045669015;56716.71641641848;56718;56750.43249567534;60190.69904650536;61443.07835382473;61564;61623.07565386523;61783;13963.232022238672;14088.506902258372;14186.787198192036;14232.715345693236;14283;10701.518431670593;10719.142468602493;10762.623308184333;10851.620193293196;10899.673009809718;19037.333693320943;19199.52001199953;19339.90330048341;19345.90327048384;19385.51536211606;7284.70861165558;7387.6675549600395;7406.444516661272;7577.242275772379;7598.240175982358;818.6725309875978;834.2658460554673;876.7106854737921;991.2169386184834;1045.696747943088;28097;28359.29101772431;28513.42973140567;28866;29074.27314317159;929.4330458420358;931.5807886451124;1002.4536627538009;1004.5278719002057;1084.0406240477234;14822.332995015035;15223.391064357524;15258;15404.46084387041;15556.533304000897;345256;347617;350487;351060;352079;48294;49955.25067123996;50009;50189.74905125524;50471.74764126156;1163.778882012415;1219.1283232488636;1243.3534562027694;1243.440451796677;1245.9439325230387;26703.732962670125;27521;27524.311892202855;27805.165845024683;28144.71855281503;42514.78742606267;43193.3520997179;43401;43482.78258608687;43566.346504803085;307476;308203;309374;309393;310556;25577.360565986;26516.469670606864;26570.86714566415;26588.069417570292;26735.331616709736;41477.58522414858;41582.37626435545;42327;42961;43022.13955720805;36693.08267293339;36723.63276367202;37017.6298237025;37222.62777372191;37525.6247437533;36338.8183059083;36459.81770091239;36590.26819463543;36838.26323473462;36842.263154737295;35857.46213806743;36018;36395.63604363923;36465.27069458649;36812;32136.03591892247;32819.52536451221;33075.67697292082;33120.1719957003;33238;25616.359591010372;25795.226143215732;25917.870410647825;25972.740272597788;26220.344491387867 13:28:45 INFO - PROCESS | 6797 | |2;jquery.html;359.43748034326285;361.1693105856531;363.37680877295435;369.6248307967412;381.1025036040124;15457.30442130104;15789.921050394747;16905.661886762256;16997;16999.830001699997;15613.219339033032;16217;16852.74720879188;16873.91563042183;16880.83119168808;5089.338386009823;5238.711870847102;5327.840164795043;5328.360596728378;5337.332833395825;3645.781253124808;5172.379314482268;5754.338251101135;6115.6330620162935;6120.602160859552;5975.163477113208;6004.219451471303;6017.217761690974;6042.305134909476;6060.575759696823;4999.3000979862845;5286.709230992294;5305.602079843989;5305.6551324164;5308.283381743473;5033.335994889784;5128.743562821881;5291.444398338196;5355.464453554652;5432.83701488952;18436.170372333145;18775.342862999867;18965.715514267296;19947.601047979104;19969.400917972485;1860.979179735345;1912.6461604603194;1914.2151717795637;2162.7188465499544;2365.940851478727;9029.367944243906;9399.295052870993;9552.474613896233;9680.854787178198;13099.672508187276;1807.3854889337688;1876.9249230030782;1885.4155211884222;1885.679434496139;1899.7625296837896;66526.3347366525;67724.6613766928;67738;68378;69818.3018169817;9094.226990705863;9415.576299066559;10025.749356266151;10354.948225258826;10383.480825958672;14379.209143497208;14414.42342306296;14425.278736063156;14533.200673962821;14586.4894728684;7102.715891364391;7112.537685050455;7259.491835571459;7329.523580967327;7342;6583.210014798255;6636.369544893228;6645.202575690948;6736.629485378253;6763.816332141855;4414.359917811899;4435.977820110878;4454.910901781946;4460.330950357472;4460.375547423363;1719.4497760716702;1782.7058535341782;1796.3982066008034;1828.8902665840092;1910.4746194796542;755.2749360613763;851.5188918261287;907.5190149220923;928.7167413938679;944.6552008516842;15465.458708945132;15589.454369097028;15728.606784830243;16495.83504164967;16745.665086698198;832.4297855968681;857.7298151082389;871.1158174452935;877.5699907045629;880.7093659092484;8300.584970751439;8477.74566762998;8495.36284778644;8551.417987672301;8562.015368232609;403721;408819;419499;421594;422025;76023.61988190023;78134.60932695415;78657.21342786614;79119.20880791234;79369.60315198387;961.0869673809908;970.6990832841842;985.2512090811035;991.7223177510309;998.026923749353;13501.797473038108;13658.385372658055;13774.724505510034;13845.16928984264;13955.58133256004;31323.530147047357;31405;32370.514442283857;32382.35235295328;32843;48037.75981120072;50651.24023139582;51055.74472127764;51407.74296128495;51437.7428112857;7447.5531468112085;7690.2694244046725;7746.883796743166;7748.302652761278;7907.723229686933;9748.805023899624;10783.838242426213;10961.945190273998;11011.449427528752;11154;5866.560007999332;8768.342374321825;9811.116999470081;10429.322094063862;10433.373997560171;10269.845952310572;10327.431991240554;10371.792564148524;10414.542983350068;10557.366558006544;10119.848202276824;10519.894801052198;10533.157347412036;10565.841512377167;10578.365298082139;7250.927490725237;7395.963020184865;7618.542887426772;7657.119431265476;7714.768556943301;9614.95192524033;10194.949025254826;10267.794644107225;10400.427976461064;10407.84388234162 13:28:45 INFO - PROCESS | 6797 | |3;mootools.html;1459.5621313605916;1469.9191544465054;1607.4936395035563;1748.2045669220506;1774.964500709985;6771.762988295411;7588.127365352986;7619.619019049053;7902.84194316114;7909.446338756289;7597.810054748634;7711.074671039483;7715;7719.691212351513;7727.806804829882;2217.7116974793253;2246.2138251611887;2249.2352600116037;2256.334381357495;2259;2229.398062523118;2260.1976298414074;2264.094362255095;2265.320403878838;2267.353804165813;2199.230269405703;2251.0883092347626;2264;2269.466675331296;2285.931422057333;2200.5378870437225;2201.1635578480236;2213.6236839737285;2221.3780141560387;2225.8219342452567;2199.065397206181;2208.061573831131;2208.856424332413;2214;2215.601191785478;7853.8821917671285;7910.050793904711;7929.246721561442;7931.9603401983195;7950.6422211000645;4684.391029166187;4863.27050942358;4867.245576935581;4882.584980276645;4883.731394773286;2835.787315951312;2941.4411261860178;2944.926376840575;2983.6270466191727;2983.9403211935855;964.4550828781786;992.4144754594823;994.1351024608565;1001.9949900250525;1039.1271332081012;10767.300125491818;10796.838047429295;10809.054370213358;10812;10857.077148442313;4279.465066866642;4295.367760251147;4485.41689580359;4498.145352383102;4507.706999045052;9093.40892841963;9148.313876459291;9162.541872906328;9167.358284919992;9189.356745027917;4806.086843499724;4807.903841923142;4809.2305231162845;4810.6151507879285;4831.637627177975;3853.4797802296894;4304.6556275498515;4419.889502762457;4426.490953540384;4437.334399839985;3714.665680088805;3797.468354430382;3802.619738026175;3805.904852378713;3850.364689826203;1260.861305256421;1270.8093785932185;1272.7709012377861;1285.1132718424258;1295.902807289457;732.3665029749228;803.4536515169741;812.8414959083041;845.6110189312861;848.7793173774863;5466.480684334982;5589.021921163861;5657.349404818498;5660.29246344207;5852.590318677651;415.11787451665214;417.1011470281548;417.6804744370559;418.16575931017815;447.62399584349305;3439;3632.364336241147;3681.5950245472977;3692.0585250760882;3723.1995121049104;9372.62509499626;9747.658831940847;9780.315377923476;9836.508174591241;9855.26085543587;9126.406783559047;9534.904650953402;9737.123658870736;9739.074787895139;9740.269479789044;7183.712651493986;7278.526895751759;7298.56208627484;7341.853162936818;7347.742829001067;5309.36287645485;5558.583106266965;5619.931918880818;5722.2561067061015;5765.711714414347;8614.526201058752;8778.473291602524;8857.158569935846;8871.822563548822;8938.50838203905;8875.911240887508;8893;9004.774880628036;9278.675246366345;9345.439273643331;6499.38255865692;6908.1019467468905;7043.401310888632;7408.185099638928;7557.470977031555;7399;7457.105147382132;7471.40228781707;7496.25037496246;7508.887366689613;6365;6684.799456016327;6749.527533072638;6755.763548275787;6769.559978601375;6649.63427011519;6667.966660166668;6708.496862735412;6762.594244345355;6785.287544807724;6176.876462470816;6212;6243.43809057187;6266.592671476339;6278.121063051085;4613.769311534477;4705.529447055267;4735.868859013526;4908.263760435963;4936.605071594336;4775.856724298276;4787.3776409068;4807.687500312469;4858.58702010333;4925.827596034122 13:28:45 INFO - PROCESS | 6797 | |4;prototype.html;305.5035567203293;316.4793914011451;318.8182735840571;319.19085119222774;324.9561309223255;5185;5287.339082614673;5366.758495867685;5444.428335024825;5482.861683943265;5313.468653134694;5315.734213289339;5337.866553336168;5356.276902618145;5368.597355198356;4055.655269302113;4107.486564179478;4119.732217405874;4119.794010299481;4126.112885729567;4062.3906414037833;4143.274926887798;4147.066909945268;4158.313878210091;4168.5623009584015;4097.078157414573;4098.672106231509;4107.001888621293;4108.404281379198;4122.340425531916;4137.510496221358;4158.209940111399;4163.125743593834;4164.208800327928;4179.623833854937;3421.1105112670634;3532.8233588320736;3545.663161999606;3548.556430446194;3548.580567772886;5156.948430515722;5178.637495375326;5179.8446046618665;5180.481951804827;5186.662866913639;4697.953020469786;4707.340972263852;4717.339572459859;4727.716337019755;4733.692309999839;5510.779568817243;5545.6207478745555;5585.525230355424;5596.664200147963;5611.3546942101775;3891.3579259422163;3918.902027449308;3928.0965377962943;3934.1934903344745;3937.842486300573;5915.1718759373725;5915.349311575723;5946;5960.403959604048;5983.252093488314;3886.591907849692;4022.778747168934;4028.67770578353;4032;4033.4554835097474;4049.088954985105;4062.2484840304637;4082.9387559186634;4091.997460622107;4120.91758164835;4703.565412549137;4705.529447055335;4708.646851486153;4711.199096153662;4728.172569800271;5303.231031500411;5380.542653874386;5695.8860822784145;5699.088145896637;5717.199592057115;1382.8340599128169;1416.965615100982;1423.8576142385677;1423.9359228834728;1425.49394964786;913.7806926337764;917.4907926100944;935.2938531408879;940.6848705683673;956.2875657634968;4901.975490122598;4933.161362568372;4939.456659767423;4954.133026720381;4968.27959945813;5723.513501352431;5733.168690539848;5739.16782066598;5739.655620662774;5749.568782341341;4714.787834547454;4847.854564363075;4850.442199147073;4881.365422495124;4909.803607855717;3057.7859549831296;3060.1125673554866;3081.845907704606;3085.629724433082;3087.7838551301643;5348.304720386403;5363.704996225167;5369.543588794996;5384.111621582395;5406.378266499403;5691.573132015115;5897.764089436375;5905.202797622352;5931.525477961753;5968.134620480006;5292.259083728281;5379.811706590251;5409.782798870223;5414.485623865727;5426.728663566806;5528.55771538284;5647.576431767552;5679.926826708304;5770.798022069207;5813.738381772915;5584.692841893735;5589.161625756169;5602.747876345493;5609.971950140223;5666.943330566642;5329.786808527616;5335.813246536352;5337.386200586982;5348.277982472317;5372.247885295984;3927;4008.899777505586;4010.218007488512;4013.297672907171;4013.317735984831;5520.972395137998;5608.691521966168;5708.143778433268;5709.857253568694;5736.971315143564;5576.247206627054;5583.776648934159;5639.125935480007;5647.1529270609735;5659.179418984307;5592;5608.915866262091;5642.153676948491;5649.85875353103;5654.547636189012;5330.600204984719;5518.255035570147;5550.833474995757;5575.163725441216;5626;5653.547716182778;5681.630694004876;5711.8000869969355;5736.282964629421;5742.770289188553;5426.945730542644;5499.815676467295;5540.279763630702;5564.443555644403;5589.90996755645 13:28:45 INFO - PROCESS | 6797 | |5;yui.html;647.8315637934137;764.2395816162918;765.9272369124931;765.9770206893795;779.3453499060789;11367;12214.389280535983;12224.037618554234;12377.195482293655;12458.190217635847;12010;12836.48654053839;12891.742165156691;12925.741485170314;12981.831635152834;645.7578408096964;812.2446125103666;821.7288294862711;826.6528058215564;826.7685048186518;801.418971245848;822.251750906675;823.7199352220244;827.8468483330573;828.3911325175991;842.8525008123554;847.1359213602123;847.563504795031;850.6384786465758;851.433796525313;850.3197442046338;851.5274022917279;851.5529347092764;852.86780549015;852.8891244138254;617.2469587103726;621.4065567383138;621.8445388652837;622.6886556721639;625.9499240060784;12595.93702031484;12658.430370633252;12675.49298028087;12688.746225075447;12746.426410811442;12849.357532123357;12899.93550032244;12956.80564791529;12984.026198035184;13015;10286;10292.897071029269;10325;10393.48032598367;10649.414282214475;3360.9831950840335;3380.8985730428126;3444.51776751255;3444.810535420551;3448.2241495663525;44912.326315105296;45179.77410112961;45258.321125183145;45285;46916.29625555653;10248;10279.537420816081;10296.794064118676;10334.276600638033;10423.843642345371;17948.102594870466;18008.36970706019;18111.275548978156;18150.183241754152;18162.364317248834;6810.897836532456;6875.1749790025515;6899.413549848319;6920.930790692129;7025.068106270714;3660.5058317127377;3711.888643340704;3764.642358975893;3780.584135745066;3811.8094095295123;2892.132360291946;2986.537086751557;2987.9551806722916;3010.277533392014;3017.09487153853;514.5240652396593;519.4597618476741;520.6927912531548;526.0504788856075;526.1108726252697;612.9877402451926;618.3322012226785;624.6720471752367;626.0577830365271;628.2691334253082;7623;7922.603869806487;7942.563159026194;8048.83902321962;8342.582870856433;471.1354664191247;505.36828963795256;516.7752027867814;540.2032002795845;561.3039830610014;3745.962540374616;3838.9040273993373;3852.325842977468;3908.4332771747936;3943.1719338939142;51056;53477;53551.19673204905;53659;53733;44920;45926.5407345929;46144.3078353825;46479.30281045787;46760.7661961688;41389.75830725083;41681.37477937833;41725.582744172774;41920.161596767895;42312.576874231476;7300.671469783766;7345.265473452612;7421.740239091606;7582.696692132474;7608.657610407434;28000.859995700706;28208.717912820608;28469.857650711612;28850.567241491815;28875.71124288814;34612;36849.07877303089;37132.814335928146;37186.62813371832;37310.6268937318;9869.950650246703;9931.453770042717;9935.254855885692;9945.154661853534;9955.303128780915;10512.369257844553;10599.735006624896;10618.415987120783;10708.411037393018;11187.664370068911;9861.309708320636;9888.703338899844;9977.551010204414;9980.451075190644;10154.339967902062;9279.907200928174;9454.33819632619;9578.856317155387;9796.363236389612;9847.556859941464;9133.543322833964;9136.95431522838;9416.52917354116;9482.525873706149;9496.335256531976;8148.103708592169;8154.877676834971;8253.917460825314;8283.751487455385;8307.83384332322;8461.576921154041;8519.27586155159;8574.914250857411;8647.783805404915;8751.69369072105 13:28:45 INFO - PROCESS | 6797 | __end_tp_report 13:28:45 INFO - PROCESS | 6797 | __start_cc_report 13:28:45 INFO - PROCESS | 6797 | _x_x_mozilla_cycle_collect,363 13:28:45 INFO - PROCESS | 6797 | __end_cc_report 13:28:45 INFO - PROCESS | 6797 | __startTimestamp1460579325058__endTimestamp 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - PROCESS | 6797 | ------- Summary: start ------- 13:28:45 INFO - PROCESS | 6797 | Number of tests: 6 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - PROCESS | 6797 | [#0] dojo.html Cycles:165 Average:4705.74 Median:4800.06 stddev:490.01 (10.2%) stddev-sans-first:463.97 13:28:45 INFO - PROCESS | 6797 | Values: 2641.0 2689.1 2732.8 2734.5 2736.0 4673.5 4673.9 4691.4 4696.5 4697.7 4659.6 4740.1 4747.2 4757.4 4760.1 4331.8 4359.9 4412.8 4414.2 4429.4 4374.0 4435.2 4438.0 4473.2 4497.7 4015.3 4321.3 4378.2 4378.6 4384.2 4369.1 4373.0 4376.3 4408.3 4417.2 4314.8 4328.5 4351.1 4379.1 4379.4 4645.1 4657.5 4669.4 4690.3 4743.1 5086.9 5141.8 5146.6 5147.7 5162.3 5005.0 5146.6 5203.3 5230.6 5252.2 4771.4 4784.0 4793.8 4798.1 4834.2 5267.1 5268.7 5271.0 5275.2 5276.7 4870.7 4962.2 4965.3 4971.7 4997.7 5072.2 5102.2 5107.5 5113.3 5146.5 5040.6 5048.2 5051.6 5058.2 5063.0 4896.8 4987.4 5056.4 5115.0 5122.8 4245.6 4259.7 4292.8 4334.6 4336.6 3737.0 3766.8 3784.2 3836.8 3857.7 4317.9 4385.8 4408.3 4409.5 4457.5 5147.5 5157.1 5160.7 5176.3 5194.2 4435.3 4458.7 4459.5 4465.9 4506.7 4516.0 4544.3 4582.7 4594.9 4620.6 4742.3 4751.1 4757.6 4758.6 4800.4 5053.6 5061.5 5061.7 5062.9 5086.5 4740.1 4798.1 4813.7 4872.8 4888.4 5032.4 5033.4 5037.1 5045.4 5119.1 5110.3 5119.8 5122.3 5141.9 5147.3 4800.1 4907.5 4934.8 4967.6 5009.4 4922.4 4931.0 4936.3 4958.6 5042.4 4805.8 4904.2 4905.3 4924.9 4928.6 4828.5 4951.1 4976.2 5049.4 5055.4 4790.8 4799.6 4810.5 4845.0 4863.3 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - PROCESS | 6797 | [#1] ext.html Cycles:180 Average:44094.57 Median:351569.50 stddev:76018.35 (21.6%) stddev-sans-first:76161.42 13:28:45 INFO - PROCESS | 6797 | Values: 586.9 601.7 605.6 618.1 634.4 32158.0 33044.7 33250.5 33285.2 33336.5 33684.7 33907.5 34127.0 34386.5 34441.3 7461.8 7577.5 7628.8 7646.4 7659.5 7585.4 7684.6 7705.1 7708.9 7726.5 7728.9 7751.7 7789.2 7805.1 7806.2 7673.2 7751.7 7753.9 7773.3 7776.3 7664.2 7726.8 7752.5 7756.1 7787.8 28220.2 34063.0 34206.1 34587.3 34628.5 3031.2 3157.5 3399.7 3566.4 3626.0 26307.3 26862.6 27030.2 27584.4 27673.2 3546.0 3574.7 3576.8 3584.8 3632.9 176247.0 180796.0 182372.1 182658.0 183783.0 56065.4 56695.4 56716.7 56718.0 56750.4 60190.7 61443.1 61564.0 61623.1 61783.0 13963.2 14088.5 14186.8 14232.7 14283.0 10701.5 10719.1 10762.6 10851.6 10899.7 19037.3 19199.5 19339.9 19345.9 19385.5 7284.7 7387.7 7406.4 7577.2 7598.2 818.7 834.3 876.7 991.2 1045.7 28097.0 28359.3 28513.4 28866.0 29074.3 929.4 931.6 1002.5 1004.5 1084.0 14822.3 15223.4 15258.0 15404.5 15556.5 345256.0 347617.0 350487.0 351060.0 352079.0 48294.0 49955.3 50009.0 50189.7 50471.7 1163.8 1219.1 1243.4 1243.4 1245.9 26703.7 27521.0 27524.3 27805.2 28144.7 42514.8 43193.4 43401.0 43482.8 43566.3 307476.0 308203.0 309374.0 309393.0 310556.0 25577.4 26516.5 26570.9 26588.1 26735.3 41477.6 41582.4 42327.0 42961.0 43022.1 36693.1 36723.6 37017.6 37222.6 37525.6 36338.8 36459.8 36590.3 36838.3 36842.3 35857.5 36018.0 36395.6 36465.3 36812.0 32136.0 32819.5 33075.7 33120.2 33238.0 25616.4 25795.2 25917.9 25972.7 26220.3 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - PROCESS | 6797 | [#2] jquery.html Cycles:180 Average:24700.17 Median:26518.53 stddev:68406.24 (258.0%) stddev-sans-first:68573.72 13:28:45 INFO - PROCESS | 6797 | Values: 359.4 361.2 363.4 369.6 381.1 15457.3 15789.9 16905.7 16997.0 16999.8 15613.2 16217.0 16852.7 16873.9 16880.8 5089.3 5238.7 5327.8 5328.4 5337.3 3645.8 5172.4 5754.3 6115.6 6120.6 5975.2 6004.2 6017.2 6042.3 6060.6 4999.3 5286.7 5305.6 5305.7 5308.3 5033.3 5128.7 5291.4 5355.5 5432.8 18436.2 18775.3 18965.7 19947.6 19969.4 1861.0 1912.6 1914.2 2162.7 2365.9 9029.4 9399.3 9552.5 9680.9 13099.7 1807.4 1876.9 1885.4 1885.7 1899.8 66526.3 67724.7 67738.0 68378.0 69818.3 9094.2 9415.6 10025.7 10354.9 10383.5 14379.2 14414.4 14425.3 14533.2 14586.5 7102.7 7112.5 7259.5 7329.5 7342.0 6583.2 6636.4 6645.2 6736.6 6763.8 4414.4 4436.0 4454.9 4460.3 4460.4 1719.4 1782.7 1796.4 1828.9 1910.5 755.3 851.5 907.5 928.7 944.7 15465.5 15589.5 15728.6 16495.8 16745.7 832.4 857.7 871.1 877.6 880.7 8300.6 8477.7 8495.4 8551.4 8562.0 403721.0 408819.0 419499.0 421594.0 422025.0 76023.6 78134.6 78657.2 79119.2 79369.6 961.1 970.7 985.3 991.7 998.0 13501.8 13658.4 13774.7 13845.2 13955.6 31323.5 31405.0 32370.5 32382.4 32843.0 48037.8 50651.2 51055.7 51407.7 51437.7 7447.6 7690.3 7746.9 7748.3 7907.7 9748.8 10783.8 10961.9 11011.4 11154.0 5866.6 8768.3 9811.1 10429.3 10433.4 10269.8 10327.4 10371.8 10414.5 10557.4 10119.8 10519.9 10533.2 10565.8 10578.4 7250.9 7396.0 7618.5 7657.1 7714.8 9615.0 10194.9 10267.8 10400.4 10407.8 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - PROCESS | 6797 | [#3] mootools.html Cycles:180 Average:5212.09 Median:4931.22 stddev:2880.32 (58.4%) stddev-sans-first:2874.59 13:28:45 INFO - PROCESS | 6797 | Values: 1459.6 1469.9 1607.5 1748.2 1775.0 6771.8 7588.1 7619.6 7902.8 7909.4 7597.8 7711.1 7715.0 7719.7 7727.8 2217.7 2246.2 2249.2 2256.3 2259.0 2229.4 2260.2 2264.1 2265.3 2267.4 2199.2 2251.1 2264.0 2269.5 2285.9 2200.5 2201.2 2213.6 2221.4 2225.8 2199.1 2208.1 2208.9 2214.0 2215.6 7853.9 7910.1 7929.2 7932.0 7950.6 4684.4 4863.3 4867.2 4882.6 4883.7 2835.8 2941.4 2944.9 2983.6 2983.9 964.5 992.4 994.1 1002.0 1039.1 10767.3 10796.8 10809.1 10812.0 10857.1 4279.5 4295.4 4485.4 4498.1 4507.7 9093.4 9148.3 9162.5 9167.4 9189.4 4806.1 4807.9 4809.2 4810.6 4831.6 3853.5 4304.7 4419.9 4426.5 4437.3 3714.7 3797.5 3802.6 3805.9 3850.4 1260.9 1270.8 1272.8 1285.1 1295.9 732.4 803.5 812.8 845.6 848.8 5466.5 5589.0 5657.3 5660.3 5852.6 415.1 417.1 417.7 418.2 447.6 3439.0 3632.4 3681.6 3692.1 3723.2 9372.6 9747.7 9780.3 9836.5 9855.3 9126.4 9534.9 9737.1 9739.1 9740.3 7183.7 7278.5 7298.6 7341.9 7347.7 5309.4 5558.6 5619.9 5722.3 5765.7 8614.5 8778.5 8857.2 8871.8 8938.5 8875.9 8893.0 9004.8 9278.7 9345.4 6499.4 6908.1 7043.4 7408.2 7557.5 7399.0 7457.1 7471.4 7496.3 7508.9 6365.0 6684.8 6749.5 6755.8 6769.6 6649.6 6668.0 6708.5 6762.6 6785.3 6176.9 6212.0 6243.4 6266.6 6278.1 4613.8 4705.5 4735.9 4908.3 4936.6 4775.9 4787.4 4807.7 4858.6 4925.8 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - PROCESS | 6797 | [#4] prototype.html Cycles:180 Average:4627.54 Median:5322.76 stddev:1360.08 (25.6%) stddev-sans-first:1324.64 13:28:45 INFO - PROCESS | 6797 | Values: 305.5 316.5 318.8 319.2 325.0 5185.0 5287.3 5366.8 5444.4 5482.9 5313.5 5315.7 5337.9 5356.3 5368.6 4055.7 4107.5 4119.7 4119.8 4126.1 4062.4 4143.3 4147.1 4158.3 4168.6 4097.1 4098.7 4107.0 4108.4 4122.3 4137.5 4158.2 4163.1 4164.2 4179.6 3421.1 3532.8 3545.7 3548.6 3548.6 5156.9 5178.6 5179.8 5180.5 5186.7 4698.0 4707.3 4717.3 4727.7 4733.7 5510.8 5545.6 5585.5 5596.7 5611.4 3891.4 3918.9 3928.1 3934.2 3937.8 5915.2 5915.3 5946.0 5960.4 5983.3 3886.6 4022.8 4028.7 4032.0 4033.5 4049.1 4062.2 4082.9 4092.0 4120.9 4703.6 4705.5 4708.6 4711.2 4728.2 5303.2 5380.5 5695.9 5699.1 5717.2 1382.8 1417.0 1423.9 1423.9 1425.5 913.8 917.5 935.3 940.7 956.3 4902.0 4933.2 4939.5 4954.1 4968.3 5723.5 5733.2 5739.2 5739.7 5749.6 4714.8 4847.9 4850.4 4881.4 4909.8 3057.8 3060.1 3081.8 3085.6 3087.8 5348.3 5363.7 5369.5 5384.1 5406.4 5691.6 5897.8 5905.2 5931.5 5968.1 5292.3 5379.8 5409.8 5414.5 5426.7 5528.6 5647.6 5679.9 5770.8 5813.7 5584.7 5589.2 5602.7 5610.0 5666.9 5329.8 5335.8 5337.4 5348.3 5372.2 3927.0 4008.9 4010.2 4013.3 4013.3 5521.0 5608.7 5708.1 5709.9 5737.0 5576.2 5583.8 5639.1 5647.2 5659.2 5592.0 5608.9 5642.2 5649.9 5654.5 5330.6 5518.3 5550.8 5575.2 5626.0 5653.5 5681.6 5711.8 5736.3 5742.8 5426.9 5499.8 5540.3 5564.4 5589.9 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - PROCESS | 6797 | [#5] yui.html Cycles:180 Average:12495.81 Median:518.12 stddev:14304.91 (2760.9%) stddev-sans-first:14317.37 13:28:45 INFO - PROCESS | 6797 | Values: 647.8 764.2 765.9 766.0 779.3 11367.0 12214.4 12224.0 12377.2 12458.2 12010.0 12836.5 12891.7 12925.7 12981.8 645.8 812.2 821.7 826.7 826.8 801.4 822.3 823.7 827.8 828.4 842.9 847.1 847.6 850.6 851.4 850.3 851.5 851.6 852.9 852.9 617.2 621.4 621.8 622.7 625.9 12595.9 12658.4 12675.5 12688.7 12746.4 12849.4 12899.9 12956.8 12984.0 13015.0 10286.0 10292.9 10325.0 10393.5 10649.4 3361.0 3380.9 3444.5 3444.8 3448.2 44912.3 45179.8 45258.3 45285.0 46916.3 10248.0 10279.5 10296.8 10334.3 10423.8 17948.1 18008.4 18111.3 18150.2 18162.4 6810.9 6875.2 6899.4 6920.9 7025.1 3660.5 3711.9 3764.6 3780.6 3811.8 2892.1 2986.5 2988.0 3010.3 3017.1 514.5 519.5 520.7 526.1 526.1 613.0 618.3 624.7 626.1 628.3 7623.0 7922.6 7942.6 8048.8 8342.6 471.1 505.4 516.8 540.2 561.3 3746.0 3838.9 3852.3 3908.4 3943.2 51056.0 53477.0 53551.2 53659.0 53733.0 44920.0 45926.5 46144.3 46479.3 46760.8 41389.8 41681.4 41725.6 41920.2 42312.6 7300.7 7345.3 7421.7 7582.7 7608.7 28000.9 28208.7 28469.9 28850.6 28875.7 34612.0 36849.1 37132.8 37186.6 37310.6 9870.0 9931.5 9935.3 9945.2 9955.3 10512.4 10599.7 10618.4 10708.4 11187.7 9861.3 9888.7 9977.6 9980.5 10154.3 9279.9 9454.3 9578.9 9796.4 9847.6 9133.5 9137.0 9416.5 9482.5 9496.3 8148.1 8154.9 8253.9 8283.8 8307.8 8461.6 8519.3 8574.9 8647.8 8751.7 13:28:45 INFO - PROCESS | 6797 | -------- Summary: end -------- 13:28:45 INFO - PROCESS | 6797 | 13:28:45 INFO - TEST-INFO | 6797: exit 0 13:28:45 INFO - TEST-OK | dromaeo_css | took 1114940ms 13:28:45 INFO - TEST-START | kraken 13:28:45 INFO - operating with platform_type : linux_ 13:28:45 INFO - Initialising browser for kraken test... 13:28:45 INFO - TEST-INFO | started process 7031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbtaWV/profile http://localhost:53603/getInfo.html) 13:28:49 INFO - PROCESS | 7031 | 13:28:49 INFO - PROCESS | 7031 | (process:7099): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:28:49 INFO - PROCESS | 7031 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 13:28:50 INFO - PROCESS | 7031 | __metrics Screen width/height:1600/1200 13:28:50 INFO - PROCESS | 7031 | colorDepth:24 13:28:50 INFO - PROCESS | 7031 | Browser inner width/height: 1024/697 13:28:50 INFO - PROCESS | 7031 | __metrics 13:28:51 ERROR - PROCESS | 7031 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:28:52 INFO - TEST-INFO | 7031: exit 0 13:28:52 INFO - Browser initialized. 13:28:52 INFO - Running cycle 1/1 for kraken test... 13:28:52 INFO - TEST-INFO | started process 7150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbtaWV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:54 INFO - PROCESS | 7150 | 13:28:54 INFO - PROCESS | 7150 | (process:7210): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:29:04 INFO - PROCESS | 7150 | RSS: Main: 164343808 13:29:04 INFO - PROCESS | 7150 | 13:29:06 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53603/tests/kraken/driver.html?testName=audio-beat-detection) 13:29:07 INFO - PROCESS | 7150 | RSS: Main: 168779776 13:29:07 INFO - PROCESS | 7150 | 13:29:10 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53603/tests/kraken/driver.html?testName=audio-dft) 13:29:11 INFO - PROCESS | 7150 | RSS: Main: 171810816 13:29:11 INFO - PROCESS | 7150 | 13:29:14 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53603/tests/kraken/driver.html?testName=audio-fft) 13:29:14 INFO - PROCESS | 7150 | RSS: Main: 164229120 13:29:14 INFO - PROCESS | 7150 | 13:29:16 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53603/tests/kraken/driver.html?testName=audio-oscillator) 13:29:17 INFO - PROCESS | 7150 | RSS: Main: 164724736 13:29:17 INFO - PROCESS | 7150 | 13:29:19 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:20 INFO - PROCESS | 7150 | RSS: Main: 165056512 13:29:20 INFO - PROCESS | 7150 | 13:29:23 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53603/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:24 INFO - PROCESS | 7150 | RSS: Main: 165539840 13:29:24 INFO - PROCESS | 7150 | 13:29:27 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53603/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:28 INFO - PROCESS | 7150 | RSS: Main: 163037184 13:29:28 INFO - PROCESS | 7150 | 13:29:31 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53603/tests/kraken/driver.html?testName=json-parse-financial) 13:29:31 INFO - PROCESS | 7150 | RSS: Main: 163360768 13:29:31 INFO - PROCESS | 7150 | 13:29:33 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:34 INFO - PROCESS | 7150 | RSS: Main: 163368960 13:29:34 INFO - PROCESS | 7150 | 13:29:36 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53603/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:29:36 INFO - PROCESS | 7150 | RSS: Main: 163745792 13:29:36 INFO - PROCESS | 7150 | 13:29:38 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:29:39 INFO - PROCESS | 7150 | RSS: Main: 164003840 13:29:39 INFO - PROCESS | 7150 | 13:29:42 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:43 INFO - PROCESS | 7150 | RSS: Main: 164978688 13:29:43 INFO - PROCESS | 7150 | 13:29:46 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:46 INFO - PROCESS | 7150 | RSS: Main: 164184064 13:29:46 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | Cycle 1(1): loaded http://localhost:53603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53603/tests/kraken/driver.html?testName=ai-astar) 13:29:48 INFO - PROCESS | 7150 | RSS: Main: 165859328 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | __start_tp_report 13:29:48 INFO - PROCESS | 7150 | _x_x_mozilla_page_load 13:29:48 INFO - PROCESS | 7150 | _x_x_mozilla_page_load_details 13:29:48 INFO - PROCESS | 7150 | |i|pagename|runs| 13:29:48 INFO - PROCESS | 7150 | |0;ai-astar;113;106;113;113;114;125;113;113;113;114 13:29:48 INFO - PROCESS | 7150 | |1;audio-beat-detection;159;131;159;196;135;160;158;133;189;138 13:29:48 INFO - PROCESS | 7150 | |2;audio-dft;168;161;163;166;168;165;162;163;167;164 13:29:48 INFO - PROCESS | 7150 | |3;audio-fft;73;75;73;152;77;75;73;78;150;77 13:29:48 INFO - PROCESS | 7150 | |4;audio-oscillator;94;94;150;95;95;95;140;94;94;141 13:29:48 INFO - PROCESS | 7150 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;119;118;118 13:29:48 INFO - PROCESS | 7150 | |6;imaging-darkroom;148;148;149;149;148;148;148;147;148;147 13:29:48 INFO - PROCESS | 7150 | |7;imaging-desaturate;96;96;96;96;95;96;95;96;96;96 13:29:48 INFO - PROCESS | 7150 | |8;json-parse-financial;66;65;68;73;65;64;71;93;65;64 13:29:48 INFO - PROCESS | 7150 | |9;json-stringify-tinderbox;65;64;66;66;66;65;65;65;65;65 13:29:48 INFO - PROCESS | 7150 | |10;stanford-crypto-aes;84;86;85;83;85;86;94;88;89;88 13:29:48 INFO - PROCESS | 7150 | |11;stanford-crypto-ccm;142;162;141;146;144;140;146;140;174;143 13:29:48 INFO - PROCESS | 7150 | |12;stanford-crypto-pbkdf2;186;181;183;182;175;180;176;178;175;178 13:29:48 INFO - PROCESS | 7150 | |13;stanford-crypto-sha256-iterative;74;75;73;81;71;72;75;80;71;71 13:29:48 INFO - PROCESS | 7150 | __end_tp_report 13:29:48 INFO - PROCESS | 7150 | __start_cc_report 13:29:48 INFO - PROCESS | 7150 | _x_x_mozilla_cycle_collect,917 13:29:48 INFO - PROCESS | 7150 | __end_cc_report 13:29:48 INFO - PROCESS | 7150 | __startTimestamp1460579388832__endTimestamp 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | ------- Summary: start ------- 13:29:48 INFO - PROCESS | 7150 | Number of tests: 14 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#0] ai-astar Cycles:10 Average:113.70 Median:113.00 stddev:4.60 (4.1%) stddev-sans-first:4.87 13:29:48 INFO - PROCESS | 7150 | Values: 113.0 106.0 113.0 113.0 114.0 125.0 113.0 113.0 113.0 114.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:159.00 stddev:22.72 (14.3%) stddev-sans-first:24.07 13:29:48 INFO - PROCESS | 7150 | Values: 159.0 131.0 159.0 196.0 135.0 160.0 158.0 133.0 189.0 138.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.50 stddev:2.50 (1.5%) stddev-sans-first:2.35 13:29:48 INFO - PROCESS | 7150 | Values: 168.0 161.0 163.0 166.0 168.0 165.0 162.0 163.0 167.0 164.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#3] audio-fft Cycles:10 Average:90.30 Median:75.00 stddev:32.05 (42.7%) stddev-sans-first:33.37 13:29:48 INFO - PROCESS | 7150 | Values: 73.0 75.0 73.0 152.0 77.0 75.0 73.0 78.0 150.0 77.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.00 stddev:23.93 (25.5%) stddev-sans-first:24.74 13:29:48 INFO - PROCESS | 7150 | Values: 94.0 94.0 150.0 95.0 95.0 95.0 140.0 94.0 94.0 141.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:29:48 INFO - PROCESS | 7150 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:29:48 INFO - PROCESS | 7150 | Values: 148.0 148.0 149.0 149.0 148.0 148.0 148.0 147.0 148.0 147.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:29:48 INFO - PROCESS | 7150 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#8] json-parse-financial Cycles:10 Average:69.40 Median:67.00 stddev:8.83 (13.2%) stddev-sans-first:9.28 13:29:48 INFO - PROCESS | 7150 | Values: 66.0 65.0 68.0 73.0 65.0 64.0 71.0 93.0 65.0 64.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 13:29:48 INFO - PROCESS | 7150 | Values: 65.0 64.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 65.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:3.16 (3.6%) stddev-sans-first:3.18 13:29:48 INFO - PROCESS | 7150 | Values: 84.0 86.0 85.0 83.0 85.0 86.0 94.0 88.0 89.0 88.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:145.00 stddev:11.22 (7.7%) stddev-sans-first:11.71 13:29:48 INFO - PROCESS | 7150 | Values: 142.0 162.0 141.0 146.0 144.0 140.0 146.0 140.0 174.0 143.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.50 stddev:3.66 (2.0%) stddev-sans-first:3.00 13:29:48 INFO - PROCESS | 7150 | Values: 186.0 181.0 183.0 182.0 175.0 180.0 176.0 178.0 175.0 178.0 13:29:48 INFO - PROCESS | 7150 | 13:29:48 INFO - PROCESS | 7150 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.50 stddev:3.62 (4.9%) stddev-sans-first:3.84 13:29:48 INFO - PROCESS | 7150 | Values: 74.0 75.0 73.0 81.0 71.0 72.0 75.0 80.0 71.0 71.0 13:29:48 INFO - PROCESS | 7150 | -------- Summary: end -------- 13:29:48 INFO - PROCESS | 7150 | 13:29:49 INFO - TEST-INFO | 7150: exit 0 13:29:49 INFO - TEST-OK | kraken | took 64021ms 13:29:49 INFO - SUITE-END | took 1178s 13:29:49 INFO - Completed test suite (00:19:39) 13:29:49 INFO - javascript benchmark 13:29:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.049222279979, 2689.058829409707, 2732.8087033907636, 2734.5214587447203, 2736.028709808018, 4673.5092815254375, 4673.883152921178, 4691.413573303337, 4696.50686677899, 4697.718136911779, 4659.603933665642, 4740.099381117594, 4747.192977193877, 4757.381540399743, 4760.143174228638, 4331.805068771905, 4359.912801743963, 4412.757298348605, 4414.22751018572, 4429.424174857264, 4374.0, 4435.201663700533, 4437.977810110945, 4473.1501014807245, 4497.707649002804, 4015.2973229684835, 4321.2653848845775, 4378.190034843564, 4378.562143785628, 4384.167008268419, 4369.1480161368545, 4372.978135109336, 4376.321670141133, 4408.25059739845, 4417.18282117806, 4314.762688052156, 4328.480582330109, 4351.129774045204, 4379.1241751649795, 4379.408779814716, 4645.070985802853, 4657.534246575349, 4669.439667239919, 4690.273007683781, 4743.146233677937, 5086.92369614456, 5141.845744627667, 5146.56300821069, 5147.6911385317, 5162.277281180638, 5005.049040682259, 5146.639735218536, 5203.271541984125, 5230.633855630107, 5252.2384254282915, 4771.379720636364, 4784.019276048437, 4793.760311984422, 4798.088363210979, 4834.226523756182, 5267.078261304257, 5268.683878967274, 5271.024860400838, 5275.20871869215, 5276.683398996072, 4870.683405578626, 4962.206047032458, 4965.280034395065, 4971.726555039435, 4997.650164488451, 5072.239164125337, 5102.2346648003095, 5107.54032137102, 5113.258577506241, 5146.511081447256, 5040.59675225981, 5048.16705243638, 5051.62112841531, 5058.165402708585, 5063.0380227756605, 4896.828610998598, 4987.351644286219, 5056.418511871182, 5115.0, 5122.846314610493, 4245.596668316505, 4259.701820872509, 4292.763897985641, 4334.566543345641, 4336.609705126491, 3736.9813150934615, 3766.7928263945746, 3784.2053168834304, 3836.846526138979, 3857.7492462989817, 4317.892052698708, 4385.802638881258, 4408.338749187647, 4409.536998615164, 4457.531959144308, 5147.510986456281, 5157.123289040872, 5160.741962901915, 5176.3270774799785, 5194.220866869924, 4435.3125265583885, 4458.71018383804, 4459.470898417082, 4465.866024019285, 4506.729596224237, 4515.954840451619, 4544.2501987171745, 4582.656300777455, 4594.885127871763, 4620.607248383925, 4742.264948932921, 4751.073540659608, 4757.6193904488255, 4758.64310176745, 4800.399950006249, 5053.570446512088, 5061.468545802638, 5061.7382457960375, 5062.873428164326, 5086.491350865032, 4740.1230772307235, 4798.136335459651, 4813.687110337817, 4872.780724867319, 4888.413390393175, 5032.3961124665275, 5033.370828646419, 5037.0681423936685, 5045.369328833895, 5119.078565858182, 5110.284560161506, 5119.769610367468, 5122.257272695513, 5141.948580514147, 5147.253648221062, 4800.0639875224, 4907.460179380337, 4934.802607895644, 4967.577755890789, 5009.373828271466, 4922.4339200992345, 4931.0, 4936.259561065869, 4958.603311734981, 5042.445331013512, 4805.783739731791, 4904.215325547895, 4905.313256144072, 4924.852254432372, 4928.581070608895, 4828.4688684244, 4951.084049450863, 4976.2038073908, 5049.419316778617, 5055.393352797688, 4790.760461976817, 4799.592034676952, 4810.542998415145, 4845.030993801324, 4863.270509423614], "value": 4675.1213216435735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.879689663619, 601.6540489218698, 605.6305653551331, 618.0605479670899, 634.4226753654176, 32157.99999999997, 33044.66955330446, 33250.50124248138, 33285.16787080324, 33336.49995250073, 33684.663153368456, 33907.491387629205, 34127.0, 34386.48420273698, 34441.31117377657, 7461.813454663623, 7577.545347279153, 7628.847423051563, 7646.426518011143, 7659.502132361406, 7585.431092668072, 7684.615769211545, 7705.075390953066, 7708.884366734504, 7726.536407815521, 7728.884066739003, 7751.689932402697, 7789.221077892222, 7805.063392392893, 7806.180351063113, 7673.155952845183, 7751.689932402697, 7753.922460775405, 7773.3004029637605, 7776.300132988058, 7664.195259497728, 7726.806829829243, 7752.457327987043, 7756.108047574545, 7787.766367008999, 28220.15339539817, 34063.0, 34206.14484637879, 34587.30825383478, 34628.48057279143, 3031.1967328657925, 3157.5421563873338, 3399.7280217582534, 3566.4115420955513, 3625.963740362615, 26307.342316442242, 26862.5970610441, 27030.1890943272, 27584.448311033666, 27673.169804905683, 3545.964540354615, 3574.749767516275, 3576.8032758198287, 3584.802835844054, 3632.8728494502566, 176247.0, 180796.0, 182372.08813955978, 182658.0, 183783.0, 56065.439345606836, 56695.433045669015, 56716.71641641848, 56718.0, 56750.43249567534, 60190.69904650536, 61443.07835382473, 61564.0, 61623.07565386523, 61783.0, 13963.232022238672, 14088.506902258372, 14186.787198192036, 14232.715345693236, 14283.0, 10701.518431670593, 10719.142468602493, 10762.623308184333, 10851.620193293196, 10899.673009809718, 19037.333693320943, 19199.52001199953, 19339.90330048341, 19345.90327048384, 19385.51536211606, 7284.70861165558, 7387.6675549600395, 7406.444516661272, 7577.242275772379, 7598.240175982358, 818.6725309875978, 834.2658460554673, 876.7106854737921, 991.2169386184834, 1045.696747943088, 28097.0, 28359.29101772431, 28513.42973140567, 28866.0, 29074.27314317159, 929.4330458420358, 931.5807886451124, 1002.4536627538009, 1004.5278719002057, 1084.0406240477234, 14822.332995015035, 15223.391064357524, 15258.0, 15404.46084387041, 15556.533304000897, 345256.0, 347617.0, 350487.0, 351060.0, 352079.0, 48294.0, 49955.25067123996, 50009.0, 50189.74905125524, 50471.74764126156, 1163.778882012415, 1219.1283232488636, 1243.3534562027694, 1243.440451796677, 1245.9439325230387, 26703.732962670125, 27521.0, 27524.311892202855, 27805.165845024683, 28144.71855281503, 42514.78742606267, 43193.3520997179, 43401.0, 43482.78258608687, 43566.346504803085, 307476.0, 308203.0, 309374.0, 309393.0, 310556.0, 25577.360565986, 26516.469670606864, 26570.86714566415, 26588.069417570292, 26735.331616709736, 41477.58522414858, 41582.37626435545, 42327.0, 42961.0, 43022.13955720805, 36693.08267293339, 36723.63276367202, 37017.6298237025, 37222.62777372191, 37525.6247437533, 36338.8183059083, 36459.81770091239, 36590.26819463543, 36838.26323473462, 36842.263154737295, 35857.46213806743, 36018.0, 36395.63604363923, 36465.27069458649, 36812.0, 32136.03591892247, 32819.52536451221, 33075.67697292082, 33120.1719957003, 33238.0, 25616.359591010372, 25795.226143215732, 25917.870410647825, 25972.740272597788, 26220.344491387867], "value": 17338.872715178935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.43748034326285, 361.1693105856531, 363.37680877295435, 369.6248307967412, 381.1025036040124, 15457.30442130104, 15789.921050394747, 16905.661886762256, 16997.0, 16999.830001699997, 15613.219339033032, 16217.0, 16852.74720879188, 16873.91563042183, 16880.83119168808, 5089.338386009823, 5238.711870847102, 5327.840164795043, 5328.360596728378, 5337.332833395825, 3645.781253124808, 5172.379314482268, 5754.338251101135, 6115.6330620162935, 6120.602160859552, 5975.163477113208, 6004.219451471303, 6017.217761690974, 6042.305134909476, 6060.575759696823, 4999.3000979862845, 5286.709230992294, 5305.602079843989, 5305.6551324164, 5308.283381743473, 5033.335994889784, 5128.743562821881, 5291.444398338196, 5355.464453554652, 5432.83701488952, 18436.170372333145, 18775.342862999867, 18965.715514267296, 19947.601047979104, 19969.400917972485, 1860.979179735345, 1912.6461604603194, 1914.2151717795637, 2162.7188465499544, 2365.940851478727, 9029.367944243906, 9399.295052870993, 9552.474613896233, 9680.854787178198, 13099.672508187276, 1807.3854889337688, 1876.9249230030782, 1885.4155211884222, 1885.679434496139, 1899.7625296837896, 66526.3347366525, 67724.6613766928, 67738.0, 68378.0, 69818.3018169817, 9094.226990705863, 9415.576299066559, 10025.749356266151, 10354.948225258826, 10383.480825958672, 14379.209143497208, 14414.42342306296, 14425.278736063156, 14533.200673962821, 14586.4894728684, 7102.715891364391, 7112.537685050455, 7259.491835571459, 7329.523580967327, 7342.0, 6583.210014798255, 6636.369544893228, 6645.202575690948, 6736.629485378253, 6763.816332141855, 4414.359917811899, 4435.977820110878, 4454.910901781946, 4460.330950357472, 4460.375547423363, 1719.4497760716702, 1782.7058535341782, 1796.3982066008034, 1828.8902665840092, 1910.4746194796542, 755.2749360613763, 851.5188918261287, 907.5190149220923, 928.7167413938679, 944.6552008516842, 15465.458708945132, 15589.454369097028, 15728.606784830243, 16495.83504164967, 16745.665086698198, 832.4297855968681, 857.7298151082389, 871.1158174452935, 877.5699907045629, 880.7093659092484, 8300.584970751439, 8477.74566762998, 8495.36284778644, 8551.417987672301, 8562.015368232609, 403721.0, 408819.0, 419499.0, 421594.0, 422025.0, 76023.61988190023, 78134.60932695415, 78657.21342786614, 79119.20880791234, 79369.60315198387, 961.0869673809908, 970.6990832841842, 985.2512090811035, 991.7223177510309, 998.026923749353, 13501.797473038108, 13658.385372658055, 13774.724505510034, 13845.16928984264, 13955.58133256004, 31323.530147047357, 31405.0, 32370.514442283857, 32382.35235295328, 32843.0, 48037.75981120072, 50651.24023139582, 51055.74472127764, 51407.74296128495, 51437.7428112857, 7447.5531468112085, 7690.2694244046725, 7746.883796743166, 7748.302652761278, 7907.723229686933, 9748.805023899624, 10783.838242426213, 10961.945190273998, 11011.449427528752, 11154.0, 5866.560007999332, 8768.342374321825, 9811.116999470081, 10429.322094063862, 10433.373997560171, 10269.845952310572, 10327.431991240554, 10371.792564148524, 10414.542983350068, 10557.366558006544, 10119.848202276824, 10519.894801052198, 10533.157347412036, 10565.841512377167, 10578.365298082139, 7250.927490725237, 7395.963020184865, 7618.542887426772, 7657.119431265476, 7714.768556943301, 9614.95192524033, 10194.949025254826, 10267.794644107225, 10400.427976461064, 10407.84388234162], "value": 8136.881937358411, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.5621313605916, 1469.9191544465054, 1607.4936395035563, 1748.2045669220506, 1774.964500709985, 6771.762988295411, 7588.127365352986, 7619.619019049053, 7902.84194316114, 7909.446338756289, 7597.810054748634, 7711.074671039483, 7715.0, 7719.691212351513, 7727.806804829882, 2217.7116974793253, 2246.2138251611887, 2249.2352600116037, 2256.334381357495, 2259.0, 2229.398062523118, 2260.1976298414074, 2264.094362255095, 2265.320403878838, 2267.353804165813, 2199.230269405703, 2251.0883092347626, 2264.0, 2269.466675331296, 2285.931422057333, 2200.5378870437225, 2201.1635578480236, 2213.6236839737285, 2221.3780141560387, 2225.8219342452567, 2199.065397206181, 2208.061573831131, 2208.856424332413, 2214.0, 2215.601191785478, 7853.8821917671285, 7910.050793904711, 7929.246721561442, 7931.9603401983195, 7950.6422211000645, 4684.391029166187, 4863.27050942358, 4867.245576935581, 4882.584980276645, 4883.731394773286, 2835.787315951312, 2941.4411261860178, 2944.926376840575, 2983.6270466191727, 2983.9403211935855, 964.4550828781786, 992.4144754594823, 994.1351024608565, 1001.9949900250525, 1039.1271332081012, 10767.300125491818, 10796.838047429295, 10809.054370213358, 10812.0, 10857.077148442313, 4279.465066866642, 4295.367760251147, 4485.41689580359, 4498.145352383102, 4507.706999045052, 9093.40892841963, 9148.313876459291, 9162.541872906328, 9167.358284919992, 9189.356745027917, 4806.086843499724, 4807.903841923142, 4809.2305231162845, 4810.6151507879285, 4831.637627177975, 3853.4797802296894, 4304.6556275498515, 4419.889502762457, 4426.490953540384, 4437.334399839985, 3714.665680088805, 3797.468354430382, 3802.619738026175, 3805.904852378713, 3850.364689826203, 1260.861305256421, 1270.8093785932185, 1272.7709012377861, 1285.1132718424258, 1295.902807289457, 732.3665029749228, 803.4536515169741, 812.8414959083041, 845.6110189312861, 848.7793173774863, 5466.480684334982, 5589.021921163861, 5657.349404818498, 5660.29246344207, 5852.590318677651, 415.11787451665214, 417.1011470281548, 417.6804744370559, 418.16575931017815, 447.62399584349305, 3439.0, 3632.364336241147, 3681.5950245472977, 3692.0585250760882, 3723.1995121049104, 9372.62509499626, 9747.658831940847, 9780.315377923476, 9836.508174591241, 9855.26085543587, 9126.406783559047, 9534.904650953402, 9737.123658870736, 9739.074787895139, 9740.269479789044, 7183.712651493986, 7278.526895751759, 7298.56208627484, 7341.853162936818, 7347.742829001067, 5309.36287645485, 5558.583106266965, 5619.931918880818, 5722.2561067061015, 5765.711714414347, 8614.526201058752, 8778.473291602524, 8857.158569935846, 8871.822563548822, 8938.50838203905, 8875.911240887508, 8893.0, 9004.774880628036, 9278.675246366345, 9345.439273643331, 6499.38255865692, 6908.1019467468905, 7043.401310888632, 7408.185099638928, 7557.470977031555, 7399.0, 7457.105147382132, 7471.40228781707, 7496.25037496246, 7508.887366689613, 6365.0, 6684.799456016327, 6749.527533072638, 6755.763548275787, 6769.559978601375, 6649.63427011519, 6667.966660166668, 6708.496862735412, 6762.594244345355, 6785.287544807724, 6176.876462470816, 6212.0, 6243.43809057187, 6266.592671476339, 6278.121063051085, 4613.769311534477, 4705.529447055267, 4735.868859013526, 4908.263760435963, 4936.605071594336, 4775.856724298276, 4787.3776409068, 4807.687500312469, 4858.58702010333, 4925.827596034122], "value": 4156.001498778584, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.5035567203293, 316.4793914011451, 318.8182735840571, 319.19085119222774, 324.9561309223255, 5185.0, 5287.339082614673, 5366.758495867685, 5444.428335024825, 5482.861683943265, 5313.468653134694, 5315.734213289339, 5337.866553336168, 5356.276902618145, 5368.597355198356, 4055.655269302113, 4107.486564179478, 4119.732217405874, 4119.794010299481, 4126.112885729567, 4062.3906414037833, 4143.274926887798, 4147.066909945268, 4158.313878210091, 4168.5623009584015, 4097.078157414573, 4098.672106231509, 4107.001888621293, 4108.404281379198, 4122.340425531916, 4137.510496221358, 4158.209940111399, 4163.125743593834, 4164.208800327928, 4179.623833854937, 3421.1105112670634, 3532.8233588320736, 3545.663161999606, 3548.556430446194, 3548.580567772886, 5156.948430515722, 5178.637495375326, 5179.8446046618665, 5180.481951804827, 5186.662866913639, 4697.953020469786, 4707.340972263852, 4717.339572459859, 4727.716337019755, 4733.692309999839, 5510.779568817243, 5545.6207478745555, 5585.525230355424, 5596.664200147963, 5611.3546942101775, 3891.3579259422163, 3918.902027449308, 3928.0965377962943, 3934.1934903344745, 3937.842486300573, 5915.1718759373725, 5915.349311575723, 5946.0, 5960.403959604048, 5983.252093488314, 3886.591907849692, 4022.778747168934, 4028.67770578353, 4032.0, 4033.4554835097474, 4049.088954985105, 4062.2484840304637, 4082.9387559186634, 4091.997460622107, 4120.91758164835, 4703.565412549137, 4705.529447055335, 4708.646851486153, 4711.199096153662, 4728.172569800271, 5303.231031500411, 5380.542653874386, 5695.8860822784145, 5699.088145896637, 5717.199592057115, 1382.8340599128169, 1416.965615100982, 1423.8576142385677, 1423.9359228834728, 1425.49394964786, 913.7806926337764, 917.4907926100944, 935.2938531408879, 940.6848705683673, 956.2875657634968, 4901.975490122598, 4933.161362568372, 4939.456659767423, 4954.133026720381, 4968.27959945813, 5723.513501352431, 5733.168690539848, 5739.16782066598, 5739.655620662774, 5749.568782341341, 4714.787834547454, 4847.854564363075, 4850.442199147073, 4881.365422495124, 4909.803607855717, 3057.7859549831296, 3060.1125673554866, 3081.845907704606, 3085.629724433082, 3087.7838551301643, 5348.304720386403, 5363.704996225167, 5369.543588794996, 5384.111621582395, 5406.378266499403, 5691.573132015115, 5897.764089436375, 5905.202797622352, 5931.525477961753, 5968.134620480006, 5292.259083728281, 5379.811706590251, 5409.782798870223, 5414.485623865727, 5426.728663566806, 5528.55771538284, 5647.576431767552, 5679.926826708304, 5770.798022069207, 5813.738381772915, 5584.692841893735, 5589.161625756169, 5602.747876345493, 5609.971950140223, 5666.943330566642, 5329.786808527616, 5335.813246536352, 5337.386200586982, 5348.277982472317, 5372.247885295984, 3927.0, 4008.899777505586, 4010.218007488512, 4013.297672907171, 4013.317735984831, 5520.972395137998, 5608.691521966168, 5708.143778433268, 5709.857253568694, 5736.971315143564, 5576.247206627054, 5583.776648934159, 5639.125935480007, 5647.1529270609735, 5659.179418984307, 5592.0, 5608.915866262091, 5642.153676948491, 5649.85875353103, 5654.547636189012, 5330.600204984719, 5518.255035570147, 5550.833474995757, 5575.163725441216, 5626.0, 5653.547716182778, 5681.630694004876, 5711.8000869969355, 5736.282964629421, 5742.770289188553, 5426.945730542644, 5499.815676467295, 5540.279763630702, 5564.443555644403, 5589.90996755645], "value": 4190.81804492033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.8315637934137, 764.2395816162918, 765.9272369124931, 765.9770206893795, 779.3453499060789, 11367.0, 12214.389280535983, 12224.037618554234, 12377.195482293655, 12458.190217635847, 12010.0, 12836.48654053839, 12891.742165156691, 12925.741485170314, 12981.831635152834, 645.7578408096964, 812.2446125103666, 821.7288294862711, 826.6528058215564, 826.7685048186518, 801.418971245848, 822.251750906675, 823.7199352220244, 827.8468483330573, 828.3911325175991, 842.8525008123554, 847.1359213602123, 847.563504795031, 850.6384786465758, 851.433796525313, 850.3197442046338, 851.5274022917279, 851.5529347092764, 852.86780549015, 852.8891244138254, 617.2469587103726, 621.4065567383138, 621.8445388652837, 622.6886556721639, 625.9499240060784, 12595.93702031484, 12658.430370633252, 12675.49298028087, 12688.746225075447, 12746.426410811442, 12849.357532123357, 12899.93550032244, 12956.80564791529, 12984.026198035184, 13015.0, 10286.0, 10292.897071029269, 10325.0, 10393.48032598367, 10649.414282214475, 3360.9831950840335, 3380.8985730428126, 3444.51776751255, 3444.810535420551, 3448.2241495663525, 44912.326315105296, 45179.77410112961, 45258.321125183145, 45285.0, 46916.29625555653, 10248.0, 10279.537420816081, 10296.794064118676, 10334.276600638033, 10423.843642345371, 17948.102594870466, 18008.36970706019, 18111.275548978156, 18150.183241754152, 18162.364317248834, 6810.897836532456, 6875.1749790025515, 6899.413549848319, 6920.930790692129, 7025.068106270714, 3660.5058317127377, 3711.888643340704, 3764.642358975893, 3780.584135745066, 3811.8094095295123, 2892.132360291946, 2986.537086751557, 2987.9551806722916, 3010.277533392014, 3017.09487153853, 514.5240652396593, 519.4597618476741, 520.6927912531548, 526.0504788856075, 526.1108726252697, 612.9877402451926, 618.3322012226785, 624.6720471752367, 626.0577830365271, 628.2691334253082, 7623.0, 7922.603869806487, 7942.563159026194, 8048.83902321962, 8342.582870856433, 471.1354664191247, 505.36828963795256, 516.7752027867814, 540.2032002795845, 561.3039830610014, 3745.962540374616, 3838.9040273993373, 3852.325842977468, 3908.4332771747936, 3943.1719338939142, 51056.0, 53477.0, 53551.19673204905, 53659.0, 53733.0, 44920.0, 45926.5407345929, 46144.3078353825, 46479.30281045787, 46760.7661961688, 41389.75830725083, 41681.37477937833, 41725.582744172774, 41920.161596767895, 42312.576874231476, 7300.671469783766, 7345.265473452612, 7421.740239091606, 7582.696692132474, 7608.657610407434, 28000.859995700706, 28208.717912820608, 28469.857650711612, 28850.567241491815, 28875.71124288814, 34612.0, 36849.07877303089, 37132.814335928146, 37186.62813371832, 37310.6268937318, 9869.950650246703, 9931.453770042717, 9935.254855885692, 9945.154661853534, 9955.303128780915, 10512.369257844553, 10599.735006624896, 10618.415987120783, 10708.411037393018, 11187.664370068911, 9861.309708320636, 9888.703338899844, 9977.551010204414, 9980.451075190644, 10154.339967902062, 9279.907200928174, 9454.33819632619, 9578.856317155387, 9796.363236389612, 9847.556859941464, 9133.543322833964, 9136.95431522838, 9416.52917354116, 9482.525873706149, 9496.335256531976, 8148.103708592169, 8154.877676834971, 8253.917460825314, 8283.751487455385, 8307.83384332322, 8461.576921154041, 8519.27586155159, 8574.914250857411, 8647.783805404915, 8751.69369072105], "value": 5824.54332073886, "unit": "score"}], "name": "dromaeo_css", "value": 6371.75198275083, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 113.0, 113.0, 114.0, 125.0, 113.0, 113.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 159.0, 196.0, 135.0, 160.0, 158.0, 133.0, 189.0, 138.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 163.0, 166.0, 168.0, 165.0, 162.0, 163.0, 167.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 152.0, 77.0, 75.0, 73.0, 78.0, 150.0, 77.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 150.0, 95.0, 95.0, 95.0, 140.0, 94.0, 94.0, 141.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 68.0, 73.0, 65.0, 64.0, 71.0, 93.0, 65.0, 64.0], "value": 69.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 83.0, 85.0, 86.0, 94.0, 88.0, 89.0, 88.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 162.0, 141.0, 146.0, 144.0, 140.0, 146.0, 140.0, 174.0, 143.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 183.0, 182.0, 175.0, 180.0, 176.0, 178.0, 175.0, 178.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 81.0, 71.0, 72.0, 75.0, 80.0, 71.0, 71.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1618.3, "alertThreshold": 2.0}]} 13:29:50 INFO - Return code: 0 13:29:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:29:50 ERROR - # TBPL SUCCESS # 13:29:50 INFO - Running post-action listener: _resource_record_post_action 13:29:50 INFO - Running post-run listener: _resource_record_post_run 13:29:51 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518909952; Read time: 12; Write time: 413780 13:29:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233361408; Read time: 0; Write time: 234944 13:29:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285548544; Read time: 12; Write time: 178836 13:29:51 INFO - Running post-run listener: _upload_blobber_files 13:29:51 INFO - Blob upload gear active. 13:29:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:51 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 13:29:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:29:51 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:52 INFO - (blobuploader) - INFO - Done attempting. 13:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:53 INFO - (blobuploader) - INFO - Done attempting. 13:29:53 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:53 INFO - Return code: 0 13:29:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9bc030b66f89b7b0594c92ab2eed5637865545c9c583693e10e63490cd72478624fc5683629338900ba71bd929f150b4c726305a4f940908fdd5fa7966e5af1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/43964f4a1ca0389f828391d30992e63d6fcb99fcf8d09fcfce196b8ad73ab48de8a1f80f0cf659340f01f114d788191a6c1a9b48bc0dadf1ee69efb87b0fc94d"} 13:29:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:53 INFO - Contents: 13:29:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9bc030b66f89b7b0594c92ab2eed5637865545c9c583693e10e63490cd72478624fc5683629338900ba71bd929f150b4c726305a4f940908fdd5fa7966e5af1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/43964f4a1ca0389f828391d30992e63d6fcb99fcf8d09fcfce196b8ad73ab48de8a1f80f0cf659340f01f114d788191a6c1a9b48bc0dadf1ee69efb87b0fc94d"} 13:29:53 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:53 INFO - Copying logs to upload dir... 13:29:53 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.772855 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-13 13:29:53.557694) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 13:29:53.563416) ========= 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-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9bc030b66f89b7b0594c92ab2eed5637865545c9c583693e10e63490cd72478624fc5683629338900ba71bd929f150b4c726305a4f940908fdd5fa7966e5af1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/43964f4a1ca0389f828391d30992e63d6fcb99fcf8d09fcfce196b8ad73ab48de8a1f80f0cf659340f01f114d788191a6c1a9b48bc0dadf1ee69efb87b0fc94d"} build_url:https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/K-pY6c4lQMuPBjmr7BNc7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9bc030b66f89b7b0594c92ab2eed5637865545c9c583693e10e63490cd72478624fc5683629338900ba71bd929f150b4c726305a4f940908fdd5fa7966e5af1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/43964f4a1ca0389f828391d30992e63d6fcb99fcf8d09fcfce196b8ad73ab48de8a1f80f0cf659340f01f114d788191a6c1a9b48bc0dadf1ee69efb87b0fc94d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 13:29:53.590241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 13:29:53.590575) ========= 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-1460578154.979160-1534013276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 13:29:53.675128) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 13:29:53.675874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 13:29:53.676559) ========= ========= Total master_lag: 0.47 =========