builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1460401215.1 results: success (0) buildid: 20160411024708 builduid: f1bc25edda414291a8d39c9aed0be10d revision: e847cfcb315f511f4928b03fd47dcf57aad05e1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.104334) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.105069) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.105504) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006397 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.154591) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.154854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.209427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.209707) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.263310) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.263582) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.263917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.264218) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 12:00:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-04-11 12:00:16 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.466267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.466567) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014044 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.520104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:15.520460) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e847cfcb315f511f4928b03fd47dcf57aad05e1e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e847cfcb315f511f4928b03fd47dcf57aad05e1e --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=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 12:00:16,281 truncating revision to first 12 chars 2016-04-11 12:00:16,281 Setting DEBUG logging. 2016-04-11 12:00:16,281 attempt 1/10 2016-04-11 12:00:16,281 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e847cfcb315f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 12:00:16,686 unpacking tar archive at: mozilla-central-e847cfcb315f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679928 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.216319) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.216625) ========= echo e847cfcb315f511f4928b03fd47dcf57aad05e1e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e847cfcb315f511f4928b03fd47dcf57aad05e1e'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e847cfcb315f511f4928b03fd47dcf57aad05e1e program finished with exit code 0 elapsedTime=0.003705 script_repo_revision: 'e847cfcb315f511f4928b03fd47dcf57aad05e1e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.269158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.269535) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 12:00:16.281953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-11 12:00:16.282227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:00:17 INFO - MultiFileLogger online at 20160411 12:00:17 in /builds/slave/test 12:00:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:00:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:00:17 INFO - {'append_to_log': False, 12:00:17 INFO - 'base_work_dir': '/builds/slave/test', 12:00:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:00:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:00:17 INFO - 'branch': 'Firefox-Non-PGO', 12:00:17 INFO - 'buildbot_json_path': 'buildprops.json', 12:00:17 INFO - 'config_files': ('talos/linux_config.py',), 12:00:17 INFO - 'default_actions': ('clobber', 12:00:17 INFO - 'read-buildbot-config', 12:00:17 INFO - 'download-and-extract', 12:00:17 INFO - 'populate-webroot', 12:00:17 INFO - 'create-virtualenv', 12:00:17 INFO - 'install', 12:00:17 INFO - 'run-tests'), 12:00:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:00:17 INFO - 'download_minidump_stackwalk': True, 12:00:17 INFO - 'download_symbols': 'ondemand', 12:00:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:00:17 INFO - 'tooltool.py': '/tools/tooltool.py', 12:00:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:00:17 INFO - '/tools/misc-python/virtualenv.py')}, 12:00:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:00:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:00:17 INFO - 'installer_path': 'installer.exe', 12:00:17 INFO - 'log_level': 'info', 12:00:17 INFO - 'log_name': 'talos', 12:00:17 INFO - 'log_to_console': True, 12:00:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:00:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:00:17 INFO - 'opt_config_files': (), 12:00:17 INFO - 'pip_index': False, 12:00:17 INFO - 'sps_profile': False, 12:00:17 INFO - 'sps_profile_interval': 0, 12:00:17 INFO - 'suite': 'dromaeojs-e10s', 12:00:17 INFO - 'system_bits': '32', 12:00:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:00:17 INFO - 'title': 'talos-linux64-ix-006', 12:00:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:00:17 INFO - 'use_talos_json': True, 12:00:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:00:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:00:17 INFO - 'work_dir': 'build'} 12:00:17 INFO - ##### 12:00:17 INFO - ##### Running clobber step. 12:00:17 INFO - ##### 12:00:17 INFO - Running pre-action listener: _resource_record_pre_action 12:00:17 INFO - Running main action method: clobber 12:00:17 INFO - rmtree: /builds/slave/test/build 12:00:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:00:17 INFO - Running post-action listener: _resource_record_post_action 12:00:17 INFO - ##### 12:00:17 INFO - ##### Running read-buildbot-config step. 12:00:17 INFO - ##### 12:00:17 INFO - Running pre-action listener: _resource_record_pre_action 12:00:17 INFO - Running main action method: read_buildbot_config 12:00:17 INFO - Using buildbot properties: 12:00:17 INFO - { 12:00:17 INFO - "project": "", 12:00:17 INFO - "product": "firefox", 12:00:17 INFO - "script_repo_revision": "production", 12:00:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:00:17 INFO - "repository": "", 12:00:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:00:17 INFO - "buildid": "20160411024708", 12:00:17 INFO - "pgo_build": "False", 12:00:17 INFO - "basedir": "/builds/slave/test", 12:00:17 INFO - "buildnumber": 284, 12:00:17 INFO - "slavename": "talos-linux64-ix-006", 12:00:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:00:17 INFO - "platform": "ubuntu64_hw", 12:00:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:00:17 INFO - "branch": "mozilla-central", 12:00:17 INFO - "repo_path": "mozilla-central", 12:00:17 INFO - "revision": "e847cfcb315f511f4928b03fd47dcf57aad05e1e", 12:00:17 INFO - "stage_platform": "linux64", 12:00:17 INFO - "builduid": "f1bc25edda414291a8d39c9aed0be10d", 12:00:17 INFO - "slavebuilddir": "test" 12:00:17 INFO - } 12:00:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:00:17 INFO - Running post-action listener: _resource_record_post_action 12:00:17 INFO - ##### 12:00:17 INFO - ##### Running download-and-extract step. 12:00:17 INFO - ##### 12:00:17 INFO - Running pre-action listener: _resource_record_pre_action 12:00:17 INFO - Running main action method: download_and_extract 12:00:17 INFO - mkdir: /builds/slave/test/build/tests 12:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:17 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:20 INFO - Downloaded 1361 bytes. 12:00:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:00:20 INFO - Using the following test package requirements: 12:00:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:00:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:00:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:20 INFO - u'jsshell-linux-x86_64.zip'], 12:00:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:00:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:00:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:00:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:00:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:00:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:00: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')]} 12:00:20 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:23 INFO - Downloaded 22190241 bytes. 12:00:23 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'] 12:00:23 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 12:00:24 INFO - Return code: 0 12:00:24 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 12:00:24 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')]} 12:00:24 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:26 INFO - Downloaded 22190241 bytes. 12:00:26 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'] 12:00:26 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 12:00:28 INFO - Return code: 0 12:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:28 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:30 INFO - Downloaded 10841046 bytes. 12:00:30 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'] 12:00:30 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 12:00:30 INFO - Return code: 0 12:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:30 INFO - https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTjJnrFsQPivc77p-uE3Xg/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 12:00:33 INFO - Downloaded 54095643 bytes. 12:00:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:00:33 INFO - mkdir: /builds/slave/test/properties 12:00:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:00:33 INFO - Writing to file /builds/slave/test/properties/build_url 12:00:33 INFO - Contents: 12:00:33 INFO - build_url:https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:00:35 INFO - Running post-action listener: _resource_record_post_action 12:00:35 INFO - Running post-action listener: set_extra_try_arguments 12:00:35 INFO - ##### 12:00:35 INFO - ##### Running populate-webroot step. 12:00:35 INFO - ##### 12:00:35 INFO - Running pre-action listener: _resource_record_pre_action 12:00:35 INFO - Running main action method: populate_webroot 12:00:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:00:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:00:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:00:35 INFO - '--tppagecycles', 12:00:35 INFO - '7'], 12:00:35 INFO - 'tests': ['tsvgm']}}, 12:00:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:00:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:00:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:00:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:00:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:35 INFO - 'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:35 INFO - 'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['damp', 'tps']}, 12:00:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:35 INFO - 'tests': ['damp', 'tps']}, 12:00:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['dromaeo_dom']}, 12:00:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:00:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['a11yr', 12:00:35 INFO - 'ts_paint', 12:00:35 INFO - 'tpaint', 12:00:35 INFO - 'sessionrestore', 12:00:35 INFO - 'sessionrestore_no_auto_restore', 12:00:35 INFO - 'tabpaint']}, 12:00:35 INFO - 'other-e10s': {'tests': ['a11yr', 12:00:35 INFO - 'ts_paint', 12:00:35 INFO - 'tpaint', 12:00:35 INFO - 'sessionrestore', 12:00:35 INFO - 'sessionrestore_no_auto_restore', 12:00:35 INFO - 'tabpaint']}, 12:00:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:00:35 INFO - 'ts_paint', 12:00:35 INFO - 'tpaint', 12:00:35 INFO - 'sessionrestore', 12:00:35 INFO - 'sessionrestore_no_auto_restore', 12:00:35 INFO - 'tabpaint']}, 12:00:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:00:35 INFO - 'ts_paint', 12:00:35 INFO - 'tpaint', 12:00:35 INFO - 'sessionrestore', 12:00:35 INFO - 'sessionrestore_no_auto_restore', 12:00:35 INFO - 'tabpaint']}, 12:00:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['a11yr', 12:00:35 INFO - 'ts_paint', 12:00:35 INFO - 'tpaint', 12:00:35 INFO - 'sessionrestore', 12:00:35 INFO - 'sessionrestore_no_auto_restore', 12:00:35 INFO - 'tabpaint']}, 12:00:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['a11yr', 12:00:35 INFO - 'ts_paint', 12:00:35 INFO - 'tpaint', 12:00:35 INFO - 'sessionrestore', 12:00:35 INFO - 'sessionrestore_no_auto_restore', 12:00:35 INFO - 'tabpaint']}, 12:00:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['tsvgx', 12:00:35 INFO - 'tsvgr_opacity', 12:00:35 INFO - 'tart', 12:00:35 INFO - 'tscrollx', 12:00:35 INFO - 'cart']}, 12:00:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:00:35 INFO - 'tsvgr_opacity', 12:00:35 INFO - 'tart', 12:00:35 INFO - 'tscrollx', 12:00:35 INFO - 'cart']}, 12:00:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:35 INFO - 'talos_options': ['--disable-e10s'], 12:00:35 INFO - 'tests': ['tp5o']}, 12:00:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:35 INFO - 'tests': ['tp5o']}, 12:00:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:35 INFO - 'talos_options': ['--disable-e10s', 12:00:35 INFO - '--xperf_path', 12:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:35 INFO - 'tests': ['tp5n']}, 12:00:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:35 INFO - 'talos_options': ['--xperf_path', 12:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:35 INFO - 'tests': ['tp5n']}}, 12:00:35 INFO - 'talos.zip': {'path': '', 12:00:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:00:35 INFO - Running post-action listener: _resource_record_post_action 12:00:35 INFO - ##### 12:00:35 INFO - ##### Running create-virtualenv step. 12:00:35 INFO - ##### 12:00:35 INFO - Running pre-action listener: _resource_record_pre_action 12:00:35 INFO - Running main action method: create_virtualenv 12:00:35 INFO - Creating virtualenv /builds/slave/test/build/venv 12:00:35 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 12:00:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:00:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:00:35 INFO - Using real prefix '/usr' 12:00:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:00:35 INFO - Installing distribute.............................................................................................................................................................................................done. 12:00:37 INFO - Installing pip.................done. 12:00:37 INFO - Return code: 0 12:00:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:00: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')]} 12:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00: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')]} 12:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00: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', 'pip>=1.5'] in /builds/slave/test/build 12:00: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 pip>=1.5 12:00:37 INFO - Using env: {'DISPLAY': ':0', 12:00:37 INFO - 'HOME': '/home/cltbld', 12:00:37 INFO - 'LANG': 'en_US.UTF-8', 12:00:37 INFO - 'LANGUAGE': 'en_US:en', 12:00:37 INFO - 'LOGNAME': 'cltbld', 12:00:37 INFO - 'MAIL': '/var/mail/cltbld', 12:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:37 INFO - 'MOZ_NO_REMOTE': '1', 12:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:37 INFO - 'NO_EM_RESTART': '1', 12:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:37 INFO - 'PWD': '/builds/slave/test', 12:00:37 INFO - 'SHELL': '/bin/bash', 12:00:37 INFO - 'SHLVL': '1', 12:00:37 INFO - 'TERM': 'linux', 12:00:37 INFO - 'TMOUT': '86400', 12:00:37 INFO - 'USER': 'cltbld', 12:00:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:37 INFO - '_': '/tools/buildbot/bin/python'} 12:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:38 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 12:00:38 INFO - Cleaning up... 12:00:38 INFO - Return code: 0 12:00:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:38 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 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00:38 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 12:00:38 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 12:00:38 INFO - Using env: {'DISPLAY': ':0', 12:00:38 INFO - 'HOME': '/home/cltbld', 12:00:38 INFO - 'LANG': 'en_US.UTF-8', 12:00:38 INFO - 'LANGUAGE': 'en_US:en', 12:00:38 INFO - 'LOGNAME': 'cltbld', 12:00:38 INFO - 'MAIL': '/var/mail/cltbld', 12:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:38 INFO - 'MOZ_NO_REMOTE': '1', 12:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:38 INFO - 'NO_EM_RESTART': '1', 12:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:38 INFO - 'PWD': '/builds/slave/test', 12:00:38 INFO - 'SHELL': '/bin/bash', 12:00:38 INFO - 'SHLVL': '1', 12:00:38 INFO - 'TERM': 'linux', 12:00:38 INFO - 'TMOUT': '86400', 12:00:38 INFO - 'USER': 'cltbld', 12:00:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:38 INFO - '_': '/tools/buildbot/bin/python'} 12:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:38 INFO - Downloading/unpacking psutil>=0.7.1 12:00:38 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 12:00:38 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 12:00:38 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 12:00:38 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 12:00:38 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 12:00:38 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 12:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:00:40 INFO - Installing collected packages: psutil 12:00:40 INFO - Running setup.py install for psutil 12:00:40 INFO - building 'psutil._psutil_linux' extension 12:00:40 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 12:00:41 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 12:00:41 INFO - building 'psutil._psutil_posix' extension 12:00:41 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 12:00:41 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 12:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:00:41 INFO - Successfully installed psutil 12:00:41 INFO - Cleaning up... 12:00:41 INFO - Return code: 0 12:00:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:00:41 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')]} 12:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:41 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')]} 12:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:41 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 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00:41 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 12:00:41 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 12:00:41 INFO - Using env: {'DISPLAY': ':0', 12:00:41 INFO - 'HOME': '/home/cltbld', 12:00:41 INFO - 'LANG': 'en_US.UTF-8', 12:00:41 INFO - 'LANGUAGE': 'en_US:en', 12:00:41 INFO - 'LOGNAME': 'cltbld', 12:00:41 INFO - 'MAIL': '/var/mail/cltbld', 12:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:41 INFO - 'MOZ_NO_REMOTE': '1', 12:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:41 INFO - 'NO_EM_RESTART': '1', 12:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:41 INFO - 'PWD': '/builds/slave/test', 12:00:41 INFO - 'SHELL': '/bin/bash', 12:00:41 INFO - 'SHLVL': '1', 12:00:41 INFO - 'TERM': 'linux', 12:00:41 INFO - 'TMOUT': '86400', 12:00:41 INFO - 'USER': 'cltbld', 12:00:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:41 INFO - '_': '/tools/buildbot/bin/python'} 12:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:00:41 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 12:00:41 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 12:00:41 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 12:00:41 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 12:00:41 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 12:00:41 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 12:00:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:00:43 INFO - Installing collected packages: mozsystemmonitor 12:00:43 INFO - Running setup.py install for mozsystemmonitor 12:00:43 INFO - Successfully installed mozsystemmonitor 12:00:43 INFO - Cleaning up... 12:00:43 INFO - Return code: 0 12:00:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:00: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')]} 12:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00: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')]} 12:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:43 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 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00:43 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 12:00:43 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 12:00:43 INFO - Using env: {'DISPLAY': ':0', 12:00:43 INFO - 'HOME': '/home/cltbld', 12:00:43 INFO - 'LANG': 'en_US.UTF-8', 12:00:43 INFO - 'LANGUAGE': 'en_US:en', 12:00:43 INFO - 'LOGNAME': 'cltbld', 12:00:43 INFO - 'MAIL': '/var/mail/cltbld', 12:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:43 INFO - 'MOZ_NO_REMOTE': '1', 12:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:43 INFO - 'NO_EM_RESTART': '1', 12:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:43 INFO - 'PWD': '/builds/slave/test', 12:00:43 INFO - 'SHELL': '/bin/bash', 12:00:43 INFO - 'SHLVL': '1', 12:00:43 INFO - 'TERM': 'linux', 12:00:43 INFO - 'TMOUT': '86400', 12:00:43 INFO - 'USER': 'cltbld', 12:00:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:43 INFO - '_': '/tools/buildbot/bin/python'} 12:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:44 INFO - Downloading/unpacking blobuploader==1.2.4 12:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:46 INFO - Downloading blobuploader-1.2.4.tar.gz 12:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:00:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:00:46 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 12:00:46 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 12:00:46 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 12:00:46 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 12:00:46 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 12:00:46 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 12:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:00:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:00:46 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 12:00:46 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 12:00:46 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 12:00:46 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 12:00:46 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 12:00:46 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 12:00:47 INFO - Downloading docopt-0.6.1.tar.gz 12:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:00:47 INFO - Installing collected packages: blobuploader, requests, docopt 12:00:47 INFO - Running setup.py install for blobuploader 12:00:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:00:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:00:47 INFO - Running setup.py install for requests 12:00:47 INFO - Running setup.py install for docopt 12:00:47 INFO - Successfully installed blobuploader requests docopt 12:00:47 INFO - Cleaning up... 12:00:47 INFO - Return code: 0 12:00:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00: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')]} 12:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00: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')]} 12:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:47 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 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00:47 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 12:00:47 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 12:00:47 INFO - Using env: {'DISPLAY': ':0', 12:00:47 INFO - 'HOME': '/home/cltbld', 12:00:47 INFO - 'LANG': 'en_US.UTF-8', 12:00:47 INFO - 'LANGUAGE': 'en_US:en', 12:00:47 INFO - 'LOGNAME': 'cltbld', 12:00:47 INFO - 'MAIL': '/var/mail/cltbld', 12:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:47 INFO - 'MOZ_NO_REMOTE': '1', 12:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:47 INFO - 'NO_EM_RESTART': '1', 12:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:47 INFO - 'PWD': '/builds/slave/test', 12:00:47 INFO - 'SHELL': '/bin/bash', 12:00:47 INFO - 'SHLVL': '1', 12:00:47 INFO - 'TERM': 'linux', 12:00:47 INFO - 'TMOUT': '86400', 12:00:47 INFO - 'USER': 'cltbld', 12:00:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:47 INFO - '_': '/tools/buildbot/bin/python'} 12:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:00:48 INFO - Running setup.py (path:/tmp/pip-tEEXIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:00:48 INFO - Running setup.py (path:/tmp/pip-pXt6D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:00:48 INFO - Running setup.py (path:/tmp/pip-JNs1KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:00:48 INFO - Running setup.py (path:/tmp/pip-S1dLcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:00:48 INFO - Running setup.py (path:/tmp/pip-Q95CMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:00:48 INFO - Running setup.py (path:/tmp/pip-ukaNP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:00:48 INFO - Running setup.py (path:/tmp/pip-j6IjWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:00:48 INFO - Running setup.py (path:/tmp/pip-9qZaL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:00:48 INFO - Running setup.py (path:/tmp/pip-6qLNbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:00:48 INFO - Running setup.py (path:/tmp/pip-57BK5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:00:48 INFO - Running setup.py (path:/tmp/pip-wIPmQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:00:48 INFO - Running setup.py (path:/tmp/pip-z6oiCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:00:48 INFO - Running setup.py (path:/tmp/pip-WqFwfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:00:48 INFO - Running setup.py (path:/tmp/pip-s4Ke0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:49 INFO - Running setup.py (path:/tmp/pip-pUg8gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:00:49 INFO - Running setup.py (path:/tmp/pip-j0ltIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:00:49 INFO - Running setup.py (path:/tmp/pip-tu7gm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:00:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:00:49 INFO - Running setup.py install for manifestparser 12:00:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:00:49 INFO - Running setup.py install for mozcrash 12:00:49 INFO - Running setup.py install for mozdebug 12:00:49 INFO - Running setup.py install for mozdevice 12:00:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:00:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:00:49 INFO - Running setup.py install for mozfile 12:00:49 INFO - Running setup.py install for mozhttpd 12:00:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:00:49 INFO - Running setup.py install for mozinfo 12:00:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:00:49 INFO - Running setup.py install for mozInstall 12:00:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Running setup.py install for mozleak 12:00:50 INFO - Running setup.py install for mozlog 12:00:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Running setup.py install for moznetwork 12:00:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Running setup.py install for mozprocess 12:00:50 INFO - Running setup.py install for mozprofile 12:00:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Running setup.py install for mozrunner 12:00:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:00:50 INFO - Running setup.py install for mozscreenshot 12:00:50 INFO - Running setup.py install for moztest 12:00:50 INFO - Running setup.py install for mozversion 12:00:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:00:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:00:51 INFO - Cleaning up... 12:00:51 INFO - Return code: 0 12:00:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:51 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 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00:51 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 12:00:51 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 12:00:51 INFO - Using env: {'DISPLAY': ':0', 12:00:51 INFO - 'HOME': '/home/cltbld', 12:00:51 INFO - 'LANG': 'en_US.UTF-8', 12:00:51 INFO - 'LANGUAGE': 'en_US:en', 12:00:51 INFO - 'LOGNAME': 'cltbld', 12:00:51 INFO - 'MAIL': '/var/mail/cltbld', 12:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:51 INFO - 'MOZ_NO_REMOTE': '1', 12:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:51 INFO - 'NO_EM_RESTART': '1', 12:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:51 INFO - 'PWD': '/builds/slave/test', 12:00:51 INFO - 'SHELL': '/bin/bash', 12:00:51 INFO - 'SHLVL': '1', 12:00:51 INFO - 'TERM': 'linux', 12:00:51 INFO - 'TMOUT': '86400', 12:00:51 INFO - 'USER': 'cltbld', 12:00:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:51 INFO - '_': '/tools/buildbot/bin/python'} 12:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:00:51 INFO - Running setup.py (path:/tmp/pip-0Wr6nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:00:51 INFO - Running setup.py (path:/tmp/pip-JD8uSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:00:51 INFO - Running setup.py (path:/tmp/pip-rLQzzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:00:51 INFO - Running setup.py (path:/tmp/pip-Ea_iHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:00:51 INFO - Running setup.py (path:/tmp/pip-2lEb9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:00:51 INFO - Running setup.py (path:/tmp/pip-IPqVZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:00:51 INFO - Running setup.py (path:/tmp/pip-WuYG5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:00:51 INFO - Running setup.py (path:/tmp/pip-ey39Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:00:51 INFO - Running setup.py (path:/tmp/pip-31eHyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:00:51 INFO - Running setup.py (path:/tmp/pip-HUVxyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:00:51 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)) 12:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:00:51 INFO - Running setup.py (path:/tmp/pip-Euksnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:00:52 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)) 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:00:52 INFO - Running setup.py (path:/tmp/pip-W8hDGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:00:52 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)) 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:00:52 INFO - Running setup.py (path:/tmp/pip-qKLpQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:00:52 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)) 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:00:52 INFO - Running setup.py (path:/tmp/pip-c0cdl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:00:52 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)) 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:52 INFO - Running setup.py (path:/tmp/pip-KocW0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:52 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)) 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:00:52 INFO - Running setup.py (path:/tmp/pip-I3mmP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:00:52 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)) 12:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:00:52 INFO - Running setup.py (path:/tmp/pip-yCX4ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:00:52 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)) 12:00:52 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)) 12:00:52 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)) 12:00:52 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)) 12:00:52 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)) 12:00:52 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)) 12:00:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:00: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 12:00: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 12:00: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 12:00: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 12:00: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 12:00: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 12:00:54 INFO - Downloading blessings-1.6.tar.gz 12:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:00:54 INFO - Installing collected packages: blessings 12:00:54 INFO - Running setup.py install for blessings 12:00:55 INFO - Successfully installed blessings 12:00:55 INFO - Cleaning up... 12:00:55 INFO - Return code: 0 12:00:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:00:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:00:55 INFO - Reading from file tmpfile_stdout 12:00:55 INFO - Current package versions: 12:00:55 INFO - argparse == 1.2.1 12:00:55 INFO - blessings == 1.6 12:00:55 INFO - blobuploader == 1.2.4 12:00:55 INFO - docopt == 0.6.1 12:00:55 INFO - manifestparser == 1.1 12:00:55 INFO - mozInstall == 1.12 12:00:55 INFO - mozcrash == 0.17 12:00:55 INFO - mozdebug == 0.1 12:00:55 INFO - mozdevice == 0.48 12:00:55 INFO - mozfile == 1.2 12:00:55 INFO - mozhttpd == 0.7 12:00:55 INFO - mozinfo == 0.9 12:00:55 INFO - mozleak == 0.1 12:00:55 INFO - mozlog == 3.1 12:00:55 INFO - moznetwork == 0.27 12:00:55 INFO - mozprocess == 0.22 12:00:55 INFO - mozprofile == 0.28 12:00:55 INFO - mozrunner == 6.11 12:00:55 INFO - mozscreenshot == 0.1 12:00:55 INFO - mozsystemmonitor == 0.0 12:00:55 INFO - moztest == 0.7 12:00:55 INFO - mozversion == 1.4 12:00:55 INFO - psutil == 3.1.1 12:00:55 INFO - requests == 1.2.3 12:00:55 INFO - wsgiref == 0.1.2 12:00:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00:55 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')]} 12:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:55 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')]} 12:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:55 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 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00:55 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 12:00:55 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 12:00:55 INFO - Using env: {'DISPLAY': ':0', 12:00:55 INFO - 'HOME': '/home/cltbld', 12:00:55 INFO - 'LANG': 'en_US.UTF-8', 12:00:55 INFO - 'LANGUAGE': 'en_US:en', 12:00:55 INFO - 'LOGNAME': 'cltbld', 12:00:55 INFO - 'MAIL': '/var/mail/cltbld', 12:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:55 INFO - 'MOZ_NO_REMOTE': '1', 12:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:55 INFO - 'NO_EM_RESTART': '1', 12:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:55 INFO - 'PWD': '/builds/slave/test', 12:00:55 INFO - 'SHELL': '/bin/bash', 12:00:55 INFO - 'SHLVL': '1', 12:00:55 INFO - 'TERM': 'linux', 12:00:55 INFO - 'TMOUT': '86400', 12:00:55 INFO - 'USER': 'cltbld', 12:00:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:55 INFO - '_': '/tools/buildbot/bin/python'} 12:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 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)) 12:00:55 INFO - Cleaning up... 12:00:55 INFO - Return code: 0 12:00:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:00:55 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')]} 12:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:55 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')]} 12:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:55 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 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00:55 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 12:00:55 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 12:00:55 INFO - Using env: {'DISPLAY': ':0', 12:00:55 INFO - 'HOME': '/home/cltbld', 12:00:55 INFO - 'LANG': 'en_US.UTF-8', 12:00:55 INFO - 'LANGUAGE': 'en_US:en', 12:00:55 INFO - 'LOGNAME': 'cltbld', 12:00:55 INFO - 'MAIL': '/var/mail/cltbld', 12:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:55 INFO - 'MOZ_NO_REMOTE': '1', 12:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:55 INFO - 'NO_EM_RESTART': '1', 12:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:55 INFO - 'PWD': '/builds/slave/test', 12:00:55 INFO - 'SHELL': '/bin/bash', 12:00:55 INFO - 'SHLVL': '1', 12:00:55 INFO - 'TERM': 'linux', 12:00:55 INFO - 'TMOUT': '86400', 12:00:55 INFO - 'USER': 'cltbld', 12:00:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:55 INFO - '_': '/tools/buildbot/bin/python'} 12:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:55 INFO - Downloading/unpacking jsonschema 12:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:00:57 INFO - Downloading/unpacking functools32 (from jsonschema) 12:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:58 INFO - Downloading functools32-3.2.3-2.tar.gz 12:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:00:58 INFO - warning: no files found matching '*.txt' 12:00:58 INFO - no previously-included directories found matching 'build' 12:00:58 INFO - no previously-included directories found matching 'dist' 12:00:58 INFO - no previously-included directories found matching '.git*' 12:00:58 INFO - Installing collected packages: jsonschema, functools32 12:00:58 INFO - Running setup.py install for functools32 12:00:58 INFO - warning: no files found matching '*.txt' 12:00:58 INFO - no previously-included directories found matching 'build' 12:00:58 INFO - no previously-included directories found matching 'dist' 12:00:58 INFO - no previously-included directories found matching '.git*' 12:00:58 INFO - Successfully installed jsonschema functools32 12:00:58 INFO - Cleaning up... 12:00:58 INFO - Return code: 0 12:00:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13bda60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', '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 12:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:00:58 INFO - Using env: {'DISPLAY': ':0', 12:00:58 INFO - 'HOME': '/home/cltbld', 12:00:58 INFO - 'LANG': 'en_US.UTF-8', 12:00:58 INFO - 'LANGUAGE': 'en_US:en', 12:00:58 INFO - 'LOGNAME': 'cltbld', 12:00:58 INFO - 'MAIL': '/var/mail/cltbld', 12:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:58 INFO - 'MOZ_NO_REMOTE': '1', 12:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:58 INFO - 'NO_EM_RESTART': '1', 12:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:58 INFO - 'PWD': '/builds/slave/test', 12:00:58 INFO - 'SHELL': '/bin/bash', 12:00:58 INFO - 'SHLVL': '1', 12:00:58 INFO - 'TERM': 'linux', 12:00:58 INFO - 'TMOUT': '86400', 12:00:58 INFO - 'USER': 'cltbld', 12:00:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:58 INFO - '_': '/tools/buildbot/bin/python'} 12:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:58 INFO - Downloading/unpacking flake8 12:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:01:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:01:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:01:01 INFO - no previously-included directories found matching 'docs/_build' 12:01:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:01:01 INFO - Running setup.py install for pep8 12:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:01:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:01:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:01:01 INFO - no previously-included directories found matching 'docs/_build' 12:01:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:01:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:01:01 INFO - Cleaning up... 12:01:01 INFO - Return code: 0 12:01:01 INFO - Running post-action listener: _resource_record_post_action 12:01:01 INFO - Running post-action listener: _start_resource_monitoring 12:01:01 INFO - Starting resource monitoring. 12:01:01 INFO - ##### 12:01:01 INFO - ##### Running install step. 12:01:01 INFO - ##### 12:01:01 INFO - Running pre-action listener: _resource_record_pre_action 12:01:01 INFO - Running main action method: install 12:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:02 INFO - Reading from file tmpfile_stdout 12:01:02 INFO - Detecting whether we're running mozinstall >=1.0... 12:01:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:01:02 INFO - Reading from file tmpfile_stdout 12:01:02 INFO - Output received: 12:01:02 INFO - Usage: mozinstall [options] installer 12:01:02 INFO - Options: 12:01:02 INFO - -h, --help show this help message and exit 12:01:02 INFO - -d DEST, --destination=DEST 12:01:02 INFO - Directory to install application into. [default: 12:01:02 INFO - "/builds/slave/test"] 12:01:02 INFO - --app=APP Application being installed. [default: firefox] 12:01:02 INFO - mkdir: /builds/slave/test/build/application 12:01:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:01:17 INFO - Reading from file tmpfile_stdout 12:01:17 INFO - Output received: 12:01:17 INFO - /builds/slave/test/build/application/firefox/firefox 12:01:17 INFO - Running post-action listener: _resource_record_post_action 12:01:17 INFO - ##### 12:01:17 INFO - ##### Running run-tests step. 12:01:17 INFO - ##### 12:01:17 INFO - Running pre-action listener: _resource_record_pre_action 12:01:17 INFO - Running main action method: run_tests 12:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:01:17 INFO - Python 2.7.3 12:01:17 INFO - Return code: 0 12:01:17 INFO - grabbing minidump binary from tooltool 12:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1246410>, '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 0x1247310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12477a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:01:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:01:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:01:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:01:17 INFO - Return code: 0 12:01:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:01:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:01:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:01:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:01:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:01:18 INFO - Return code: 0 12:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 12:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 12:01:18 INFO - Using env: {'DISPLAY': ':0', 12:01:18 INFO - 'HOME': '/home/cltbld', 12:01:18 INFO - 'LANG': 'en_US.UTF-8', 12:01:18 INFO - 'LANGUAGE': 'en_US:en', 12:01:18 INFO - 'LOGNAME': 'cltbld', 12:01:18 INFO - 'MAIL': '/var/mail/cltbld', 12:01:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:01:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:18 INFO - 'MOZ_NO_REMOTE': '1', 12:01:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:18 INFO - 'NO_EM_RESTART': '1', 12:01:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:18 INFO - 'PWD': '/builds/slave/test', 12:01:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:01:18 INFO - 'SHELL': '/bin/bash', 12:01:18 INFO - 'SHLVL': '1', 12:01:18 INFO - 'TERM': 'linux', 12:01:18 INFO - 'TMOUT': '86400', 12:01:18 INFO - 'USER': 'cltbld', 12:01:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725', 12:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:18 INFO - '_': '/tools/buildbot/bin/python'} 12:01:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 12:01:18 INFO - mozversion application_buildid: 20160411024708 12:01:18 INFO - mozversion application_changeset: e847cfcb315f511f4928b03fd47dcf57aad05e1e 12:01:18 INFO - mozversion application_display_name: Nightly 12:01:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:01:18 INFO - mozversion application_name: Firefox 12:01:18 INFO - mozversion application_remotingname: firefox 12:01:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:01:18 INFO - mozversion application_vendor: Mozilla 12:01:18 INFO - mozversion application_version: 48.0a1 12:01:18 INFO - mozversion platform_buildid: 20160411024708 12:01:18 INFO - mozversion platform_changeset: e847cfcb315f511f4928b03fd47dcf57aad05e1e 12:01:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:01:18 INFO - mozversion platform_version: 48.0a1 12:01:18 INFO - using testdate: 1460401278 12:01:18 INFO - actual date: 1460401278 12:01:18 INFO - starting webserver on 'localhost:52444' 12:01:18 INFO - SUITE-START | Running 2 tests 12:01:18 INFO - TEST-START | dromaeo_css 12:01:18 INFO - operating with platform_type : linux_ 12:01:18 INFO - Initialising browser for dromaeo_css test... 12:01:18 INFO - TEST-INFO | started process 15961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL7OSCk/profile http://localhost:52444/getInfo.html) 12:01:22 INFO - PROCESS | 15961 | 12:01:22 INFO - PROCESS | 15961 | (process:16029): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:01:23 INFO - PROCESS | 15961 | 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] 12:01:23 INFO - PROCESS | 15961 | __metrics Screen width/height:1600/1200 12:01:23 INFO - PROCESS | 15961 | colorDepth:24 12:01:23 INFO - PROCESS | 15961 | Browser inner width/height: 1024/697 12:01:23 INFO - PROCESS | 15961 | __metrics 12:01:24 ERROR - PROCESS | 15961 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 12:01:25 INFO - TEST-INFO | 15961: exit 0 12:01:25 INFO - Browser initialized. 12:01:25 INFO - Running cycle 1/1 for dromaeo_css test... 12:01:25 INFO - TEST-INFO | started process 16080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL7OSCk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:01:27 INFO - PROCESS | 16080 | 12:01:27 INFO - PROCESS | 16080 | (process:16139): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:01:37 INFO - PROCESS | 16080 | RSS: Main: 163872768 12:01:37 INFO - PROCESS | 16080 | 12:02:26 INFO - PROCESS | 16080 | 1460401346883 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] 12:04:38 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:52444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52444/tests/dromaeo/cssquery-ext.html) 12:04:39 INFO - PROCESS | 16080 | RSS: Main: 168583168 12:04:39 INFO - PROCESS | 16080 | 12:07:41 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:52444/tests/dromaeo/cssquery-ext.html (next: http://localhost:52444/tests/dromaeo/cssquery-jquery.html) 12:07:42 INFO - PROCESS | 16080 | RSS: Main: 165228544 12:07:42 INFO - PROCESS | 16080 | 12:10:44 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:52444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52444/tests/dromaeo/cssquery-mootools.html) 12:10:44 INFO - PROCESS | 16080 | RSS: Main: 165777408 12:10:44 INFO - PROCESS | 16080 | 12:13:46 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:52444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52444/tests/dromaeo/cssquery-prototype.html) 12:13:47 INFO - PROCESS | 16080 | RSS: Main: 164265984 12:13:47 INFO - PROCESS | 16080 | 12:16:49 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:52444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52444/tests/dromaeo/cssquery-yui.html) 12:16:50 INFO - PROCESS | 16080 | RSS: Main: 164843520 12:16:50 INFO - PROCESS | 16080 | 12:19:52 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:52444/tests/dromaeo/cssquery-yui.html (next: http://localhost:52444/tests/dromaeo/cssquery-dojo.html) 12:19:53 INFO - PROCESS | 16080 | RSS: Main: 166658048 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - PROCESS | 16080 | __start_tp_report 12:19:53 INFO - PROCESS | 16080 | _x_x_mozilla_page_load 12:19:53 INFO - PROCESS | 16080 | _x_x_mozilla_page_load_details 12:19:53 INFO - PROCESS | 16080 | |i|pagename|runs| 12:19:53 INFO - PROCESS | 16080 | |0;dojo.html;2628.369191394065;2665.920022399329;2730.249181475095;2730.6177135201074;2737.3567211705235;4741.525847415257;4780.8645671177155;4781.139394908915;4794.304825800257;4866.562009419152;4691.85924422267;4754.453237877637;4801.759912004394;4820.783064762085;4850.708957462554;4389.31965545341;4403.107256069952;4408.360787685784;4452.955470445303;4495.370648109251;597.0212772425158;4091.593643914052;4300.78496075195;4387.802548885308;4395.714278571899;4353.760543170124;4358.433403657536;4362.760048197348;4394.406755088086;4409.206342858316;4383.60547550722;4388.1223755249075;4388.648908087377;4392.780360981938;4453.087117140978;4269.231538323101;4330.935035974463;4378.43080399546;4406.5593440656;4425.889352766175;4606.355110284563;4631.143238500888;4634.165850146972;4645.535446455361;4676.345311656337;5032.119379108642;5033.345665063555;5039.521245481674;5042.0168067226905;5122.257272695439;4989.151844186497;5035.622328325354;5066.240063990431;5131.897362052738;5134.358205224347;4779.665423420397;4795.95204047962;4801.303810947393;4860.7326597037145;4863.513648635179;5252.6585771925465;5254.5533629641905;5259.184826351921;5263.394709608444;5271.314729085271;4941.777620007037;4984.850454486371;5052.368453943257;5053.646244762831;5060.291559181717;5126.846194614168;5130.410002849645;5143.228515722672;5143.27994080829;5156.871078223075;5067.341245638044;5077.543021128043;5084.872878178001;5089.440161582223;5099.490050994945;4923.655344125877;5075.467075957045;5090.516400941905;5145.974270128625;5153.484651534892;4249.277622804131;4259.5101563319995;4271.572842715704;4276.059266961326;4318.395424640553;3653.8173091345325;3762.529683789526;3781.1303400218103;3782.6217378261954;3793.203427280302;4424.3142312941545;4447.844325448658;4501.099780044005;4506.526814684476;4564.726116432958;5068.214426763784;5101.566366858859;5107.157319042391;5109.4379618241965;5151.639385243072;4366.737995720267;4463.174312752087;4466.508684044752;4472.418585583853;4513.255312873404;4535.727856328631;4579.702319349231;4593.609543188866;4603.49361570227;4613.538646135359;4846.733429661403;4854.466008739107;4859.198232291703;4867.707937523689;4916.778744956557;5195.9740201298755;5207.1668533034535;5208.270842082187;5221.477852214748;5244.475552444725;4882.316475693335;4891.19295316283;4893.363862697826;4897.118518666674;4933.358663373739;4893.241547560134;5014.473480284518;5088.465711100281;5093.617978651542;5103.464136265638;5063.392392912727;5078.949210507995;5093.949060509496;5110;5132.769025393792;4880.487548807324;4884.023195361013;4922.212446008622;4937.679050861682;4993.101241776515;4907;4974.204127339608;4992.825251116194;5019.799208031638;5035.748212589283;4903.092927808367;4904.847360870264;4908.214685650279;4908.312836202863;4961.677490963076;5022.497750225094;5044.621653375938;5051.898962020812;5052.1663925451885;5097;4789.353437285922;4827.468978412302;4874.268859671078;4875.0493653737185;4910.680805747615 12:19:53 INFO - PROCESS | 16080 | |1;ext.html;559.9468050535198;600.3156401702058;607.2288193993628;625.8153844615838;651.0429668387475;32333;33068;33330.83334583326;33404.83297583512;33493.83253083731;33646.83176584114;34078;34320;34400.483992740126;34418.48372274418;7481.775546733593;7563.243675632448;7670.079590449154;7678.961605191967;7688.038995125609;7531.585762783072;7802.531848089133;7820.530768153901;7824.217578242187;7833.295003449688;7763.534187948741;7826.217378262185;7848.803779905491;7859.764207073797;7871.685132594718;7768.805779855492;7777.727779527718;7815.804604884866;7826.02174728159;7839.725609603636;7681.423893208032;7789.649465774054;7790.922090779133;7794.532328060278;7807.063152421689;30674.38651226963;30728.385432291452;30828.38343233145;30845;30897.536536951964;3109.300407408338;3179.8728050877935;3588.5334906462253;3918.1771827916173;3991.3015222335976;25359.492810143878;25653.358666033313;25957.95437602516;26004.609930850864;26240;3485.5468789057513;3499.825008749552;3552.6447355264527;3581.068922080278;3616.9276614467562;261568;265329;265702;265817;266042;50784.74607626938;51431.7428412863;51459.48540514622;51534;51598.74200628973;53848;54019.45980540223;54031.18953215705;55574.72212638911;59343;14087.436502539784;14215.218163001135;14237.216953067473;14292.071015383966;14297.142171469744;10763.83854242187;10808.51361688726;10830.458477076272;10840.620578279722;10847.02376786093;18574.53563660892;18783.34258300953;18809.435716928514;18868.905655471634;18900.527486812665;6539.574927629689;6755.560888542229;6995.160580730345;7035;7067.116610423697;832.3507664022072;918.8254231695956;1002.3885429887763;1007.7279134633754;1008.7578981044496;28939.276518087216;31182.064538063896;31197.220069498446;31424.214394640316;31928;922.8338898998111;953.2421724728857;968.970930872075;993.6323560282597;1104.2380757277454;13095.803562946563;13705.657358565917;13897.984792205276;13948;13979.580612581638;315869;321360;323921;325966;326289;46495;46821.76589117101;47024.7648761754;47139.76430117896;47608.52391476041;1262.3057318474803;1265.1523479268913;1268.124993754325;1270.1109223543556;1275.9234445933273;24746;25971;26125.60811587866;26334.604980925684;26430.339241519116;38963.80518097391;39592.60407395889;39727.00682482845;39768.40347394849;39827;243661;245736;246064;246734;247594;24534;24534.50930981406;24687.38281542976;24926.37684057913;24988.500229994934;41014.58985410227;41097.794511027256;41255.381169281885;41507.584924150375;42200.36699449572;34701.82649086738;35320.29359412746;35792.10519737027;35908.820455897556;36409;35075.12312192113;35175.82412087923;35371.29257414889;35391.46912796362;36095.91712248637;30291.242718932204;34753.65246347504;35476.290474190886;35762.8211858939;36154.45768313425;26938.730612693624;28809.56785648259;29203.269918251364;30578.235544111576;30923.2269193263;23713.28860134199;23852.880735596213;23991.76008239965;24260.393490162885;24575.87712061428 12:19:53 INFO - PROCESS | 16080 | |2;jquery.html;357.9373609618316;358.85645741703325;361.2828535357317;371.70263788968816;372.3260897775029;15633.843661563395;15884.68230635388;17483;17501.649967000652;17505.82494175058;15959.441419550318;16120.435784747537;16930.32278708853;16940.915295423507;16992;5027.748612569366;5135.845924622248;5158.226266060084;5189.117849965515;5220.269162317279;3737.7570457920147;5155.329807125087;5587.580931430139;5926;5934.020886553713;5840.240768700063;5843.620164689303;5853.5902486825935;5857.47282744555;5904.822855314347;5636.549076073904;5853.560982926255;5877.6473411595225;5884.794032208873;5891.322497912752;4544.772761361919;5070.163423035195;5105.157648987913;5113.386393632751;5121.103806833789;11939.761204775856;12099.576514822027;12136.15046946714;12173.391330433531;12182.81725774114;1886.830185283331;1889.5559543507266;1939.2243102758869;1940.4760714607119;2365.3377054424786;8685.131486851327;8911.86632200511;9264.44413335202;9445.480498572575;9509.096635819586;1708.2056843567677;1756.9385071522436;1768.4606195110487;1773.725072613747;1798.199801088516;63300;64365;64775.67612161956;66161.00758488674;66401;9871.703848884545;10039.096481316716;10043.748906277255;10570.630027948984;10739.355638661706;14046.297685115704;14135.78796318056;14240.715185696228;14245.358958846877;14270.500532481314;6919.8962015569805;7044.577325360495;7060.894086588705;7140.6072666003865;7192.748253811092;6154.969225153845;6221.222347206599;6251.249850018027;6295.811125666238;6296.464800491918;4316.805743741539;4337.1976184405985;4393.253146965024;4394.265161948718;4425.889352766207;1680.7478878168129;1754.7806524184477;1827.8342842967006;1885.7359969604267;1887.3205645967441;866.27233124176;884.7611144990946;890.3322508118911;925.7639301977953;997.436448406648;15559.533214003599;15652.060876347456;15767.684646307009;15873.52379428619;16098.597535061483;874.4054043250524;882.5763633455977;901.7024381953939;932.7061975477703;951.5622813505864;9197.08029197075;9419;9468.526573671288;9492.525373731285;9683.080107389787;361867;362311;365635;366370;369227;71901;73216.26783732095;73709;74738.6263068692;78001;930.3719989007393;972.4262685015875;990.9256805739599;991.5141580625442;999.9150072243941;15079.396824126912;15164.848351516344;15198.468053618513;15328.540143795704;15716.60708482297;32259.51610725794;33154.17114572155;33431.16422089467;33757.83121084379;34591.827040864635;43566;47889.52110478851;48466.757666211444;48696;49165;7713.344365728976;7736.92263077362;7741.225877412214;7785.493942893921;7971.402144839044;8207.548584827891;10874.998755265115;11052.392118433563;11402.82895756581;11976.940115299367;9881.901180988098;10060.496975151067;10462.163026957673;10499.370037797757;10646.095081918123;9899.356541825047;10241.180705543688;10249.436281004319;10280.485975701036;10518.842217366593;10497.422641754776;10550.314229575053;10683.412412317397;10794.514246858753;11008.944955275172;6872.209695884837;7088.645567721696;7302.634868256459;7599.810004749705;8101.716439924574;10141.746456338651;10162.441065741456;10231.693049208536;10372.740681483023;10526.842097368393 12:19:53 INFO - PROCESS | 16080 | |3;mootools.html;1398.3357904995128;1446.5515690136056;1573.779670846081;1760.3046796515384;1762.8797029258205;6862.107925969617;7224.783256502314;7427.034485516882;7718.80702982425;7720.38236941044;7232.746853860116;7252.2747725227455;7258.383037441824;7291.963540182292;7302.5618462892135;2169.1323470611724;2206.735191776989;2215.678726584644;2228.075348730275;2233.508628101823;2198.6372248578964;2198.9010494527706;2232.620454522735;2236.3626366485555;2242.035924552442;2185.9234926777567;2221.8777967211877;2229;2234.1175235781857;2252.3017864462067;2146.8604540704882;2154.7306586676664;2158.7733288004847;2163.2969284982364;2180.0407820558903;2161.9027143778567;2181.182056728727;2185.61751693453;2186.814120799734;2190.8466407351493;7402.11174659039;7403.629818509053;7464.32821046103;7527.397808175333;7554.357879580242;4566;4703.247480403119;4709.62323014158;4709.95290047102;4713.858584242478;2856.8143070700544;2871.4400691865094;2893.7974341796084;2910.8544572771275;2963.081444752134;934.3366209990915;965.5027660754716;975.67314949492;979.8138353712772;992.1219720547296;10409.427481488516;10505.107065899409;10556.049955503964;10557.73605659857;10580.841287380696;4164.187983343219;4176.102138040336;4282.5075116361395;4385.3641222022625;4411.735295882258;9013.18881300686;9035.909640903637;9095.681651142178;9123.406978546373;9130.132637399436;4623.676342655982;4648.65135114861;4666.673332866734;4673.3690951721765;4676.462206846189;3755.455458958436;4184.225918205142;4216.641585465209;4227.239096962577;4314.9784251078545;3699.7595156314756;3719.9814000930364;3722.571904230994;3746.2882052409955;3836.2519308734527;1163.5345861655405;1173.8356630071796;1181.7695549367963;1190.2263528706237;1217.391304347826;1205.102198861836;1209.9213551119326;1212.3635091576994;1222.205566381859;1228.336698182989;7178.784636460915;7222.674979625929;7227.1327440707455;7237.167725711505;7311.451641126937;447.22406624506453;450.4459514796818;455.71062375391864;460.4290679557392;461.3932678527725;5616.438356164351;5643.322801263875;5644.153376993484;5686.175504551899;5695.743691533891;8514.787130321667;8794.34042446819;8991.370604057784;9057.230135438562;9072.727818165466;8834.55827208637;8903.51030693305;8956.955215223883;9023.007469178385;9025;6934.826629334206;7031.156261248683;7182.138143422718;7205.603691797001;7215.49491535598;7234.16807067194;7261.092363454568;7287;7291.125064992023;7526.473146879666;8685.696000639948;8749.431286966326;8792.780180495538;8889.422187557788;8942.195202431552;8675.696350627697;8872.378933474853;8884.955575222082;8898.955505222433;9032.729018129467;6533.18335208099;6533.542652014504;6775.254721980677;6782.1861376635115;6788.76239331621;7317.012203352479;7323.377512911462;7340.926590734024;7341.59621220838;7419.443541734499;6575.769848055295;6702.396784289437;6767.695453704497;6792.694328755119;6854.383105520527;6676.566023208476;6696.59820410777;6705.731770729116;6784.7964561063245;6856.554323968926;6818.18181818185;6823.317668233137;6936.647353765968;6944.756933507303;6987;6166.660833654192;6215.34738852414;6226.875462490634;6232.844178895564;6243.719032643633;6348.841278968062;6360.968195158995;6403.29563747978;6414.166158399378;6434.903476447764 12:19:53 INFO - PROCESS | 16080 | |4;prototype.html;303.6705174885249;307.57093854073554;307.59090409755026;311.6307175996444;320.8748588050661;5304.283921670573;5388.245645609612;5424.593155513333;5427.565794736422;5475.5072043516075;5314.9468505314935;5327.786888524454;5336.38631557371;5342.732863356836;5361.115415956372;3925.9018524536973;4045.271851066807;4165.916681666365;4177.268977928866;4196.202721482909;4186.079062606222;4190.706650534464;4203.075323428856;4207.389928460371;4210.263203939314;4182.079942412664;4187.036981494243;4192.161567686475;4198.391233271173;4210.705250632457;4039.111395493016;4180.47744031996;4189.245935731567;4192.5597812229735;4197.265478541273;3651.47053677218;3674.7243956703355;3677.5586929568353;3680.8527658893613;3690;5050.469700681412;5054.974725126388;5062.367204099488;5065.442801291855;5090.9236361454605;4679.321498382716;4776.450708168536;4783.28250762385;4783.976080119612;4812.278158276252;5612.747426365823;5614.326280846324;5615.9157612635845;5620;5625;4024.63162524743;4036.858709945138;4037.2732908076537;4052.169305292408;4061.817218225187;5701.429857014306;5804.796832110856;5897.4102589741115;5911.733971971272;5949.5240380769865;4088.4071809587444;4111.97944010284;4115.933629446082;4125.071858831739;4125.773082480432;4141.482314710661;4187.476565429321;4188.434561334242;4197.370394440797;4206.432131662247;4654.301854721751;4758.191107511731;4767.69010014348;4774.618030557616;4779.761011949388;5654.293213348332;5671.688057156896;5680.318361796611;5680.857978550569;5706;1446.8263808343065;1471.4108762536434;1474.7243634256506;1475.6089636246404;1475.7491226491522;916.1296768070359;934.5420743835607;981.3817295104038;983.3018556824592;995.6913356859396;4874.780634871439;4914.631402644744;4944.975275123601;4946.258061290763;4955.331030310934;5776.942230577724;5777.62445441045;5779.537636989031;5785.392533783976;5806.970965145232;4854.247591623304;4903.092927808367;4947.120094364191;4977.328060711758;4980.626453016038;3093.8607762650736;3097.4579448596855;3109.113902537766;3118.656947735747;3129.530570414456;5428.5928555358505;5449.128139497661;5454.127339625641;5459.262999495097;5466.890662186814;5748.626339287933;5935.881282374415;5944.4352786485215;5961.791337303173;5975.223220981245;5454.372747134131;5461.208124821878;5467.507924286754;5474.890502189934;5498.752556134984;5593.356763972195;5751.683657398883;5777.826665200051;5796.391378905323;5835.766569337179;5665.971670141623;5666.660000399989;5670.659760414388;5678;5704.429557044263;5446.727663616883;5451.836444906659;5453.509184173285;5456.8267822418375;5462.781488740406;3769.6041915599562;4012.8996775080855;4040.7171497996032;4152.37714342851;4157.168566286694;5727.198192253005;5779.913301300568;5784.913226301693;5816.680082595498;5821;5676.290463692038;5677.914831277617;5691.857703557279;5695.971520142372;5701.9736447439855;5490.96414135602;5643.209950607001;5654.943450565442;5661.405552417102;5686.744096515584;5311.176767601028;5513.614047016831;5526.806561770319;5544;5555.444455554412;5494.560435165257;5639.629287302373;5678.77284908599;5723.971380143073;5732.16883551891;5496.450354964471;5511.255980442589;5533.363663178786;5539.9169012464035;5558.833235002957 12:19:53 INFO - PROCESS | 16080 | |5;yui.html;675.4798804920212;689.5828024045452;786.5870418030537;793.8967934168558;822.8066404394966;12363.62909112727;12663.493460261601;12701.301428421433;12746.29895355755;12777.488900443983;11965.940170299158;11990.880091199107;12133.635990920264;12134.45394957227;12220.266783992967;642.75575281393;788.9132195458495;795.4272923495089;811.4036183405193;814.9062857771344;806.1092492795465;807.1887752808419;807.5437377881508;811.5171472973572;814.914433984432;850.3579797253096;850.6384786465758;851.3104385447807;853.5220276645099;854.8760429737684;850.2262940723912;850.3409857360533;850.9191626795475;851.1148405658108;851.1233429567556;623.8378021714342;627.8587317853492;628.3998781163978;629.6694235526339;629.8960671489199;12330.383480825923;12397.814032789516;12457.06572007103;12467.563635272722;12498.437570309357;12334.32161231132;12497.500099995988;12503.437345319482;12626.24242545441;12897.87102128976;9743.951280243624;9952.353097048668;10013.699589012342;10134.54394552247;10135.54390052442;3380.3577320309064;3412.351653185887;3417.094469965461;3428.8114153721535;3515.701165400944;43706.12587748259;43814.78092609548;44039.55960440387;44932.3260151098;45432;9844.458554779412;9994.650187243411;10031.398116113056;10083.697489075339;10207.336523125972;17675.469735907944;17694.646107078042;17701.20344584471;17823.376181833573;17859.196336164903;6442.226932768004;6819.863602728017;6852.417544508772;6893;7002.3697867192195;3755.8497660093835;3762.529683789526;3771.340015497277;3820.4269359596283;3894.7857867817543;2686.2344231893817;2747.7114902934904;2760.4341110072387;2768.9030883918967;2771.2102050915796;444.6753869675155;476.96661233714;479.8608403562997;488.46757034832206;489.9216125419916;554.4206304411899;566.6062086849682;581.134110175835;620.3003769671069;630.5334052800986;7510.151891273632;8139.75580732579;8144.959275203586;8223.342132629376;8597.140285971478;614.073253698284;624.3226099681805;641.7978336823885;658.2134349452455;679.0222080204489;3792.3363411402893;3841.615838416136;3860.2665493556133;3984.541777695602;4022.2759903217116;48126;49034.509654903704;49138.50861491339;49306;49735.502644973814;41738.79130604388;41869;42780.78609606932;42897;43364.78317608392;39193.41209881854;39513;39986.200275994895;40139.79930100389;40270.39594406086;7436.59098749574;7498.925010749823;7651.885221721567;7744.6902123914415;7807.687692492464;28365.149045528666;28481.28796780097;28778.28054298659;28793.424131516833;28919.855400722863;35334.64665353416;36339.27321453609;36573.81713091524;36593.26813463769;36626.08434789152;9487.810243795224;9772.071653192936;9913.256505761952;9955.601775928882;10277.691669249934;10211.489425528842;10288.691339259834;10548.419836908737;10587.258891877495;10660.25378223517;9458.290628202774;9957.302988790716;10070.295079344669;10276.640317588848;10283.280170388001;9686.564104615169;9891.802163956825;9910.801783964425;9959.800803984024;10286.177105831366;9778.608855645694;10114.949425252827;10190.235732319958;10321;10499;8382.706605268786;8420.578971051546;8449.788755281168;8730.781730456536;8760.386772925835;8608.139186081342;8624.827503450022;8651.567421629019;8718.520481373585;8754.124587541195 12:19:53 INFO - PROCESS | 16080 | __end_tp_report 12:19:53 INFO - PROCESS | 16080 | __start_cc_report 12:19:53 INFO - PROCESS | 16080 | _x_x_mozilla_cycle_collect,374 12:19:53 INFO - PROCESS | 16080 | __end_cc_report 12:19:53 INFO - PROCESS | 16080 | __startTimestamp1460402393152__endTimestamp 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - PROCESS | 16080 | ------- Summary: start ------- 12:19:53 INFO - PROCESS | 16080 | Number of tests: 6 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - PROCESS | 16080 | [#0] dojo.html Cycles:165 Average:4699.56 Median:4880.49 stddev:590.51 (12.1%) stddev-sans-first:569.53 12:19:53 INFO - PROCESS | 16080 | Values: 2628.4 2665.9 2730.2 2730.6 2737.4 4741.5 4780.9 4781.1 4794.3 4866.6 4691.9 4754.5 4801.8 4820.8 4850.7 4389.3 4403.1 4408.4 4453.0 4495.4 597.0 4091.6 4300.8 4387.8 4395.7 4353.8 4358.4 4362.8 4394.4 4409.2 4383.6 4388.1 4388.6 4392.8 4453.1 4269.2 4330.9 4378.4 4406.6 4425.9 4606.4 4631.1 4634.2 4645.5 4676.3 5032.1 5033.3 5039.5 5042.0 5122.3 4989.2 5035.6 5066.2 5131.9 5134.4 4779.7 4796.0 4801.3 4860.7 4863.5 5252.7 5254.6 5259.2 5263.4 5271.3 4941.8 4984.9 5052.4 5053.6 5060.3 5126.8 5130.4 5143.2 5143.3 5156.9 5067.3 5077.5 5084.9 5089.4 5099.5 4923.7 5075.5 5090.5 5146.0 5153.5 4249.3 4259.5 4271.6 4276.1 4318.4 3653.8 3762.5 3781.1 3782.6 3793.2 4424.3 4447.8 4501.1 4506.5 4564.7 5068.2 5101.6 5107.2 5109.4 5151.6 4366.7 4463.2 4466.5 4472.4 4513.3 4535.7 4579.7 4593.6 4603.5 4613.5 4846.7 4854.5 4859.2 4867.7 4916.8 5196.0 5207.2 5208.3 5221.5 5244.5 4882.3 4891.2 4893.4 4897.1 4933.4 4893.2 5014.5 5088.5 5093.6 5103.5 5063.4 5078.9 5093.9 5110.0 5132.8 4880.5 4884.0 4922.2 4937.7 4993.1 4907.0 4974.2 4992.8 5019.8 5035.7 4903.1 4904.8 4908.2 4908.3 4961.7 5022.5 5044.6 5051.9 5052.2 5097.0 4789.4 4827.5 4874.3 4875.0 4910.7 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - PROCESS | 16080 | [#1] ext.html Cycles:180 Average:42967.97 Median:34409.48 stddev:73244.98 (212.9%) stddev-sans-first:73381.24 12:19:53 INFO - PROCESS | 16080 | Values: 559.9 600.3 607.2 625.8 651.0 32333.0 33068.0 33330.8 33404.8 33493.8 33646.8 34078.0 34320.0 34400.5 34418.5 7481.8 7563.2 7670.1 7679.0 7688.0 7531.6 7802.5 7820.5 7824.2 7833.3 7763.5 7826.2 7848.8 7859.8 7871.7 7768.8 7777.7 7815.8 7826.0 7839.7 7681.4 7789.6 7790.9 7794.5 7807.1 30674.4 30728.4 30828.4 30845.0 30897.5 3109.3 3179.9 3588.5 3918.2 3991.3 25359.5 25653.4 25958.0 26004.6 26240.0 3485.5 3499.8 3552.6 3581.1 3616.9 261568.0 265329.0 265702.0 265817.0 266042.0 50784.7 51431.7 51459.5 51534.0 51598.7 53848.0 54019.5 54031.2 55574.7 59343.0 14087.4 14215.2 14237.2 14292.1 14297.1 10763.8 10808.5 10830.5 10840.6 10847.0 18574.5 18783.3 18809.4 18868.9 18900.5 6539.6 6755.6 6995.2 7035.0 7067.1 832.4 918.8 1002.4 1007.7 1008.8 28939.3 31182.1 31197.2 31424.2 31928.0 922.8 953.2 969.0 993.6 1104.2 13095.8 13705.7 13898.0 13948.0 13979.6 315869.0 321360.0 323921.0 325966.0 326289.0 46495.0 46821.8 47024.8 47139.8 47608.5 1262.3 1265.2 1268.1 1270.1 1275.9 24746.0 25971.0 26125.6 26334.6 26430.3 38963.8 39592.6 39727.0 39768.4 39827.0 243661.0 245736.0 246064.0 246734.0 247594.0 24534.0 24534.5 24687.4 24926.4 24988.5 41014.6 41097.8 41255.4 41507.6 42200.4 34701.8 35320.3 35792.1 35908.8 36409.0 35075.1 35175.8 35371.3 35391.5 36095.9 30291.2 34753.7 35476.3 35762.8 36154.5 26938.7 28809.6 29203.3 30578.2 30923.2 23713.3 23852.9 23991.8 24260.4 24575.9 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - PROCESS | 16080 | [#2] jquery.html Cycles:180 Average:22943.84 Median:4393.76 stddev:60278.73 (1371.9%) stddev-sans-first:60423.98 12:19:53 INFO - PROCESS | 16080 | Values: 357.9 358.9 361.3 371.7 372.3 15633.8 15884.7 17483.0 17501.6 17505.8 15959.4 16120.4 16930.3 16940.9 16992.0 5027.7 5135.8 5158.2 5189.1 5220.3 3737.8 5155.3 5587.6 5926.0 5934.0 5840.2 5843.6 5853.6 5857.5 5904.8 5636.5 5853.6 5877.6 5884.8 5891.3 4544.8 5070.2 5105.2 5113.4 5121.1 11939.8 12099.6 12136.2 12173.4 12182.8 1886.8 1889.6 1939.2 1940.5 2365.3 8685.1 8911.9 9264.4 9445.5 9509.1 1708.2 1756.9 1768.5 1773.7 1798.2 63300.0 64365.0 64775.7 66161.0 66401.0 9871.7 10039.1 10043.7 10570.6 10739.4 14046.3 14135.8 14240.7 14245.4 14270.5 6919.9 7044.6 7060.9 7140.6 7192.7 6155.0 6221.2 6251.2 6295.8 6296.5 4316.8 4337.2 4393.3 4394.3 4425.9 1680.7 1754.8 1827.8 1885.7 1887.3 866.3 884.8 890.3 925.8 997.4 15559.5 15652.1 15767.7 15873.5 16098.6 874.4 882.6 901.7 932.7 951.6 9197.1 9419.0 9468.5 9492.5 9683.1 361867.0 362311.0 365635.0 366370.0 369227.0 71901.0 73216.3 73709.0 74738.6 78001.0 930.4 972.4 990.9 991.5 999.9 15079.4 15164.8 15198.5 15328.5 15716.6 32259.5 33154.2 33431.2 33757.8 34591.8 43566.0 47889.5 48466.8 48696.0 49165.0 7713.3 7736.9 7741.2 7785.5 7971.4 8207.5 10875.0 11052.4 11402.8 11976.9 9881.9 10060.5 10462.2 10499.4 10646.1 9899.4 10241.2 10249.4 10280.5 10518.8 10497.4 10550.3 10683.4 10794.5 11008.9 6872.2 7088.6 7302.6 7599.8 8101.7 10141.7 10162.4 10231.7 10372.7 10526.8 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - PROCESS | 16080 | [#3] mootools.html Cycles:180 Average:5345.01 Median:6354.90 stddev:2802.51 (44.1%) stddev-sans-first:2794.67 12:19:53 INFO - PROCESS | 16080 | Values: 1398.3 1446.6 1573.8 1760.3 1762.9 6862.1 7224.8 7427.0 7718.8 7720.4 7232.7 7252.3 7258.4 7292.0 7302.6 2169.1 2206.7 2215.7 2228.1 2233.5 2198.6 2198.9 2232.6 2236.4 2242.0 2185.9 2221.9 2229.0 2234.1 2252.3 2146.9 2154.7 2158.8 2163.3 2180.0 2161.9 2181.2 2185.6 2186.8 2190.8 7402.1 7403.6 7464.3 7527.4 7554.4 4566.0 4703.2 4709.6 4710.0 4713.9 2856.8 2871.4 2893.8 2910.9 2963.1 934.3 965.5 975.7 979.8 992.1 10409.4 10505.1 10556.0 10557.7 10580.8 4164.2 4176.1 4282.5 4385.4 4411.7 9013.2 9035.9 9095.7 9123.4 9130.1 4623.7 4648.7 4666.7 4673.4 4676.5 3755.5 4184.2 4216.6 4227.2 4315.0 3699.8 3720.0 3722.6 3746.3 3836.3 1163.5 1173.8 1181.8 1190.2 1217.4 1205.1 1209.9 1212.4 1222.2 1228.3 7178.8 7222.7 7227.1 7237.2 7311.5 447.2 450.4 455.7 460.4 461.4 5616.4 5643.3 5644.2 5686.2 5695.7 8514.8 8794.3 8991.4 9057.2 9072.7 8834.6 8903.5 8957.0 9023.0 9025.0 6934.8 7031.2 7182.1 7205.6 7215.5 7234.2 7261.1 7287.0 7291.1 7526.5 8685.7 8749.4 8792.8 8889.4 8942.2 8675.7 8872.4 8885.0 8899.0 9032.7 6533.2 6533.5 6775.3 6782.2 6788.8 7317.0 7323.4 7340.9 7341.6 7419.4 6575.8 6702.4 6767.7 6792.7 6854.4 6676.6 6696.6 6705.7 6784.8 6856.6 6818.2 6823.3 6936.6 6944.8 6987.0 6166.7 6215.3 6226.9 6232.8 6243.7 6348.8 6361.0 6403.3 6414.2 6434.9 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - PROCESS | 16080 | [#4] prototype.html Cycles:180 Average:4670.96 Median:5351.92 stddev:1357.02 (25.4%) stddev-sans-first:1320.64 12:19:53 INFO - PROCESS | 16080 | Values: 303.7 307.6 307.6 311.6 320.9 5304.3 5388.2 5424.6 5427.6 5475.5 5314.9 5327.8 5336.4 5342.7 5361.1 3925.9 4045.3 4165.9 4177.3 4196.2 4186.1 4190.7 4203.1 4207.4 4210.3 4182.1 4187.0 4192.2 4198.4 4210.7 4039.1 4180.5 4189.2 4192.6 4197.3 3651.5 3674.7 3677.6 3680.9 3690.0 5050.5 5055.0 5062.4 5065.4 5090.9 4679.3 4776.5 4783.3 4784.0 4812.3 5612.7 5614.3 5615.9 5620.0 5625.0 4024.6 4036.9 4037.3 4052.2 4061.8 5701.4 5804.8 5897.4 5911.7 5949.5 4088.4 4112.0 4115.9 4125.1 4125.8 4141.5 4187.5 4188.4 4197.4 4206.4 4654.3 4758.2 4767.7 4774.6 4779.8 5654.3 5671.7 5680.3 5680.9 5706.0 1446.8 1471.4 1474.7 1475.6 1475.7 916.1 934.5 981.4 983.3 995.7 4874.8 4914.6 4945.0 4946.3 4955.3 5776.9 5777.6 5779.5 5785.4 5807.0 4854.2 4903.1 4947.1 4977.3 4980.6 3093.9 3097.5 3109.1 3118.7 3129.5 5428.6 5449.1 5454.1 5459.3 5466.9 5748.6 5935.9 5944.4 5961.8 5975.2 5454.4 5461.2 5467.5 5474.9 5498.8 5593.4 5751.7 5777.8 5796.4 5835.8 5666.0 5666.7 5670.7 5678.0 5704.4 5446.7 5451.8 5453.5 5456.8 5462.8 3769.6 4012.9 4040.7 4152.4 4157.2 5727.2 5779.9 5784.9 5816.7 5821.0 5676.3 5677.9 5691.9 5696.0 5702.0 5491.0 5643.2 5654.9 5661.4 5686.7 5311.2 5513.6 5526.8 5544.0 5555.4 5494.6 5639.6 5678.8 5724.0 5732.2 5496.5 5511.3 5533.4 5539.9 5558.8 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - PROCESS | 16080 | [#5] yui.html Cycles:180 Average:12188.61 Median:22954.48 stddev:13559.04 (59.1%) stddev-sans-first:13569.51 12:19:53 INFO - PROCESS | 16080 | Values: 675.5 689.6 786.6 793.9 822.8 12363.6 12663.5 12701.3 12746.3 12777.5 11965.9 11990.9 12133.6 12134.5 12220.3 642.8 788.9 795.4 811.4 814.9 806.1 807.2 807.5 811.5 814.9 850.4 850.6 851.3 853.5 854.9 850.2 850.3 850.9 851.1 851.1 623.8 627.9 628.4 629.7 629.9 12330.4 12397.8 12457.1 12467.6 12498.4 12334.3 12497.5 12503.4 12626.2 12897.9 9744.0 9952.4 10013.7 10134.5 10135.5 3380.4 3412.4 3417.1 3428.8 3515.7 43706.1 43814.8 44039.6 44932.3 45432.0 9844.5 9994.7 10031.4 10083.7 10207.3 17675.5 17694.6 17701.2 17823.4 17859.2 6442.2 6819.9 6852.4 6893.0 7002.4 3755.8 3762.5 3771.3 3820.4 3894.8 2686.2 2747.7 2760.4 2768.9 2771.2 444.7 477.0 479.9 488.5 489.9 554.4 566.6 581.1 620.3 630.5 7510.2 8139.8 8145.0 8223.3 8597.1 614.1 624.3 641.8 658.2 679.0 3792.3 3841.6 3860.3 3984.5 4022.3 48126.0 49034.5 49138.5 49306.0 49735.5 41738.8 41869.0 42780.8 42897.0 43364.8 39193.4 39513.0 39986.2 40139.8 40270.4 7436.6 7498.9 7651.9 7744.7 7807.7 28365.1 28481.3 28778.3 28793.4 28919.9 35334.6 36339.3 36573.8 36593.3 36626.1 9487.8 9772.1 9913.3 9955.6 10277.7 10211.5 10288.7 10548.4 10587.3 10660.3 9458.3 9957.3 10070.3 10276.6 10283.3 9686.6 9891.8 9910.8 9959.8 10286.2 9778.6 10114.9 10190.2 10321.0 10499.0 8382.7 8420.6 8449.8 8730.8 8760.4 8608.1 8624.8 8651.6 8718.5 8754.1 12:19:53 INFO - PROCESS | 16080 | -------- Summary: end -------- 12:19:53 INFO - PROCESS | 16080 | 12:19:53 INFO - TEST-INFO | 16080: exit 0 12:19:53 INFO - TEST-OK | dromaeo_css | took 1114947ms 12:19:53 INFO - TEST-START | kraken 12:19:53 INFO - operating with platform_type : linux_ 12:19:53 INFO - Initialising browser for kraken test... 12:19:53 INFO - TEST-INFO | started process 16317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iSd8C/profile http://localhost:52444/getInfo.html) 12:19:57 INFO - PROCESS | 16317 | 12:19:57 INFO - PROCESS | 16317 | (process:16383): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:19:57 INFO - PROCESS | 16317 | 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] 12:19:58 INFO - PROCESS | 16317 | __metrics Screen width/height:1600/1200 12:19:58 INFO - PROCESS | 16317 | colorDepth:24 12:19:58 INFO - PROCESS | 16317 | Browser inner width/height: 1024/697 12:19:58 INFO - PROCESS | 16317 | __metrics 12:19:58 ERROR - PROCESS | 16317 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 12:19:59 INFO - TEST-INFO | 16317: exit 0 12:19:59 INFO - Browser initialized. 12:19:59 INFO - Running cycle 1/1 for kraken test... 12:19:59 INFO - TEST-INFO | started process 16434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iSd8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:01 INFO - PROCESS | 16434 | 12:20:01 INFO - PROCESS | 16434 | (process:16494): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:20:11 INFO - PROCESS | 16434 | RSS: Main: 165150720 12:20:11 INFO - PROCESS | 16434 | 12:20:14 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52444/tests/kraken/driver.html?testName=audio-beat-detection) 12:20:15 INFO - PROCESS | 16434 | RSS: Main: 168980480 12:20:15 INFO - PROCESS | 16434 | 12:20:18 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52444/tests/kraken/driver.html?testName=audio-dft) 12:20:18 INFO - PROCESS | 16434 | RSS: Main: 172527616 12:20:18 INFO - PROCESS | 16434 | 12:20:21 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52444/tests/kraken/driver.html?testName=audio-fft) 12:20:22 INFO - PROCESS | 16434 | RSS: Main: 164294656 12:20:22 INFO - PROCESS | 16434 | 12:20:24 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52444/tests/kraken/driver.html?testName=audio-oscillator) 12:20:25 INFO - PROCESS | 16434 | RSS: Main: 163987456 12:20:25 INFO - PROCESS | 16434 | 12:20:27 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:20:27 INFO - PROCESS | 16434 | RSS: Main: 165076992 12:20:27 INFO - PROCESS | 16434 | 12:20:31 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52444/tests/kraken/driver.html?testName=imaging-darkroom) 12:20:31 INFO - PROCESS | 16434 | RSS: Main: 165257216 12:20:31 INFO - PROCESS | 16434 | 12:20:35 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52444/tests/kraken/driver.html?testName=imaging-desaturate) 12:20:35 INFO - PROCESS | 16434 | RSS: Main: 164556800 12:20:35 INFO - PROCESS | 16434 | 12:20:38 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52444/tests/kraken/driver.html?testName=json-parse-financial) 12:20:39 INFO - PROCESS | 16434 | RSS: Main: 165208064 12:20:39 INFO - PROCESS | 16434 | 12:20:41 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:20:41 INFO - PROCESS | 16434 | RSS: Main: 165801984 12:20:41 INFO - PROCESS | 16434 | 12:20:43 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52444/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:20:44 INFO - PROCESS | 16434 | RSS: Main: 165625856 12:20:44 INFO - PROCESS | 16434 | 12:20:46 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:20:47 INFO - PROCESS | 16434 | RSS: Main: 166047744 12:20:47 INFO - PROCESS | 16434 | 12:20:50 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:20:50 INFO - PROCESS | 16434 | RSS: Main: 166531072 12:20:50 INFO - PROCESS | 16434 | 12:20:53 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:20:54 INFO - PROCESS | 16434 | RSS: Main: 166092800 12:20:54 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | Cycle 1(1): loaded http://localhost:52444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52444/tests/kraken/driver.html?testName=ai-astar) 12:20:56 INFO - PROCESS | 16434 | RSS: Main: 167755776 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | __start_tp_report 12:20:56 INFO - PROCESS | 16434 | _x_x_mozilla_page_load 12:20:56 INFO - PROCESS | 16434 | _x_x_mozilla_page_load_details 12:20:56 INFO - PROCESS | 16434 | |i|pagename|runs| 12:20:56 INFO - PROCESS | 16434 | |0;ai-astar;116;108;115;116;114;126;114;114;114;115 12:20:56 INFO - PROCESS | 16434 | |1;audio-beat-detection;162;131;152;181;134;156;156;134;196;143 12:20:56 INFO - PROCESS | 16434 | |2;audio-dft;164;162;164;166;168;161;162;162;165;163 12:20:56 INFO - PROCESS | 16434 | |3;audio-fft;74;75;77;156;74;78;73;73;155;75 12:20:56 INFO - PROCESS | 16434 | |4;audio-oscillator;94;94;147;94;96;94;134;94;95;144 12:20:56 INFO - PROCESS | 16434 | |5;imaging-gaussian-blur;118;117;117;117;118;117;118;116;118;117 12:20:56 INFO - PROCESS | 16434 | |6;imaging-darkroom;146;148;151;147;147;147;147;147;147;147 12:20:56 INFO - PROCESS | 16434 | |7;imaging-desaturate;96;96;96;100;96;96;96;95;96;96 12:20:56 INFO - PROCESS | 16434 | |8;json-parse-financial;67;64;66;67;65;66;67;80;65;65 12:20:56 INFO - PROCESS | 16434 | |9;json-stringify-tinderbox;63;64;64;65;64;65;64;65;64;65 12:20:56 INFO - PROCESS | 16434 | |10;stanford-crypto-aes;87;90;84;86;92;86;87;87;86;84 12:20:56 INFO - PROCESS | 16434 | |11;stanford-crypto-ccm;148;138;139;138;152;138;139;141;181;143 12:20:56 INFO - PROCESS | 16434 | |12;stanford-crypto-pbkdf2;175;176;183;173;177;170;175;178;176;171 12:20:56 INFO - PROCESS | 16434 | |13;stanford-crypto-sha256-iterative;73;79;72;75;76;72;71;73;71;68 12:20:56 INFO - PROCESS | 16434 | __end_tp_report 12:20:56 INFO - PROCESS | 16434 | __start_cc_report 12:20:56 INFO - PROCESS | 16434 | _x_x_mozilla_cycle_collect,926 12:20:56 INFO - PROCESS | 16434 | __end_cc_report 12:20:56 INFO - PROCESS | 16434 | __startTimestamp1460402456420__endTimestamp 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | ------- Summary: start ------- 12:20:56 INFO - PROCESS | 16434 | Number of tests: 14 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:4.42 (3.8%) stddev-sans-first:4.68 12:20:56 INFO - PROCESS | 16434 | Values: 116.0 108.0 115.0 116.0 114.0 126.0 114.0 114.0 114.0 115.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:156.00 stddev:21.13 (13.5%) stddev-sans-first:22.23 12:20:56 INFO - PROCESS | 16434 | Values: 162.0 131.0 152.0 181.0 134.0 156.0 156.0 134.0 196.0 143.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.16 (1.3%) stddev-sans-first:2.29 12:20:56 INFO - PROCESS | 16434 | Values: 164.0 162.0 164.0 166.0 168.0 161.0 162.0 162.0 165.0 163.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#3] audio-fft Cycles:10 Average:91.00 Median:74.50 stddev:34.03 (45.7%) stddev-sans-first:35.54 12:20:56 INFO - PROCESS | 16434 | Values: 74.0 75.0 77.0 156.0 74.0 78.0 73.0 73.0 155.0 75.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:94.00 stddev:23.05 (24.5%) stddev-sans-first:23.84 12:20:56 INFO - PROCESS | 16434 | Values: 94.0 94.0 147.0 94.0 96.0 94.0 134.0 94.0 95.0 144.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 12:20:56 INFO - PROCESS | 16434 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 118.0 116.0 118.0 117.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.33 12:20:56 INFO - PROCESS | 16434 | Values: 146.0 148.0 151.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.34 (1.4%) stddev-sans-first:1.41 12:20:56 INFO - PROCESS | 16434 | Values: 96.0 96.0 96.0 100.0 96.0 96.0 96.0 95.0 96.0 96.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:66.50 stddev:4.61 (6.9%) stddev-sans-first:4.89 12:20:56 INFO - PROCESS | 16434 | Values: 67.0 64.0 66.0 67.0 65.0 66.0 67.0 80.0 65.0 65.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 12:20:56 INFO - PROCESS | 16434 | Values: 63.0 64.0 64.0 65.0 64.0 65.0 64.0 65.0 64.0 65.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:2.47 (2.8%) stddev-sans-first:2.62 12:20:56 INFO - PROCESS | 16434 | Values: 87.0 90.0 84.0 86.0 92.0 86.0 87.0 87.0 86.0 84.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:142.00 stddev:13.28 (9.4%) stddev-sans-first:14.06 12:20:56 INFO - PROCESS | 16434 | Values: 148.0 138.0 139.0 138.0 152.0 138.0 139.0 141.0 181.0 143.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:176.00 stddev:3.69 (2.1%) stddev-sans-first:3.91 12:20:56 INFO - PROCESS | 16434 | Values: 175.0 176.0 183.0 173.0 177.0 170.0 175.0 178.0 176.0 171.0 12:20:56 INFO - PROCESS | 16434 | 12:20:56 INFO - PROCESS | 16434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:3.06 (4.2%) stddev-sans-first:3.24 12:20:56 INFO - PROCESS | 16434 | Values: 73.0 79.0 72.0 75.0 76.0 72.0 71.0 73.0 71.0 68.0 12:20:56 INFO - PROCESS | 16434 | -------- Summary: end -------- 12:20:56 INFO - PROCESS | 16434 | 12:20:57 INFO - TEST-INFO | 16434: exit 0 12:20:57 INFO - TEST-OK | kraken | took 63464ms 12:20:57 INFO - SUITE-END | took 1178s 12:20:57 INFO - Completed test suite (00:19:38) 12:20:57 INFO - javascript benchmark 12:20:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.369191394065, 2665.920022399329, 2730.249181475095, 2730.6177135201074, 2737.3567211705235, 4741.525847415257, 4780.8645671177155, 4781.139394908915, 4794.304825800257, 4866.562009419152, 4691.85924422267, 4754.453237877637, 4801.759912004394, 4820.783064762085, 4850.708957462554, 4389.31965545341, 4403.107256069952, 4408.360787685784, 4452.955470445303, 4495.370648109251, 597.0212772425158, 4091.593643914052, 4300.78496075195, 4387.802548885308, 4395.714278571899, 4353.760543170124, 4358.433403657536, 4362.760048197348, 4394.406755088086, 4409.206342858316, 4383.60547550722, 4388.1223755249075, 4388.648908087377, 4392.780360981938, 4453.087117140978, 4269.231538323101, 4330.935035974463, 4378.43080399546, 4406.5593440656, 4425.889352766175, 4606.355110284563, 4631.143238500888, 4634.165850146972, 4645.535446455361, 4676.345311656337, 5032.119379108642, 5033.345665063555, 5039.521245481674, 5042.0168067226905, 5122.257272695439, 4989.151844186497, 5035.622328325354, 5066.240063990431, 5131.897362052738, 5134.358205224347, 4779.665423420397, 4795.95204047962, 4801.303810947393, 4860.7326597037145, 4863.513648635179, 5252.6585771925465, 5254.5533629641905, 5259.184826351921, 5263.394709608444, 5271.314729085271, 4941.777620007037, 4984.850454486371, 5052.368453943257, 5053.646244762831, 5060.291559181717, 5126.846194614168, 5130.410002849645, 5143.228515722672, 5143.27994080829, 5156.871078223075, 5067.341245638044, 5077.543021128043, 5084.872878178001, 5089.440161582223, 5099.490050994945, 4923.655344125877, 5075.467075957045, 5090.516400941905, 5145.974270128625, 5153.484651534892, 4249.277622804131, 4259.5101563319995, 4271.572842715704, 4276.059266961326, 4318.395424640553, 3653.8173091345325, 3762.529683789526, 3781.1303400218103, 3782.6217378261954, 3793.203427280302, 4424.3142312941545, 4447.844325448658, 4501.099780044005, 4506.526814684476, 4564.726116432958, 5068.214426763784, 5101.566366858859, 5107.157319042391, 5109.4379618241965, 5151.639385243072, 4366.737995720267, 4463.174312752087, 4466.508684044752, 4472.418585583853, 4513.255312873404, 4535.727856328631, 4579.702319349231, 4593.609543188866, 4603.49361570227, 4613.538646135359, 4846.733429661403, 4854.466008739107, 4859.198232291703, 4867.707937523689, 4916.778744956557, 5195.9740201298755, 5207.1668533034535, 5208.270842082187, 5221.477852214748, 5244.475552444725, 4882.316475693335, 4891.19295316283, 4893.363862697826, 4897.118518666674, 4933.358663373739, 4893.241547560134, 5014.473480284518, 5088.465711100281, 5093.617978651542, 5103.464136265638, 5063.392392912727, 5078.949210507995, 5093.949060509496, 5110.0, 5132.769025393792, 4880.487548807324, 4884.023195361013, 4922.212446008622, 4937.679050861682, 4993.101241776515, 4907.0, 4974.204127339608, 4992.825251116194, 5019.799208031638, 5035.748212589283, 4903.092927808367, 4904.847360870264, 4908.214685650279, 4908.312836202863, 4961.677490963076, 5022.497750225094, 5044.621653375938, 5051.898962020812, 5052.1663925451885, 5097.0, 4789.353437285922, 4827.468978412302, 4874.268859671078, 4875.0493653737185, 4910.680805747615], "value": 4663.61796308744, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9468050535198, 600.3156401702058, 607.2288193993628, 625.8153844615838, 651.0429668387475, 32333.0, 33068.0, 33330.83334583326, 33404.83297583512, 33493.83253083731, 33646.83176584114, 34078.0, 34320.0, 34400.483992740126, 34418.48372274418, 7481.775546733593, 7563.243675632448, 7670.079590449154, 7678.961605191967, 7688.038995125609, 7531.585762783072, 7802.531848089133, 7820.530768153901, 7824.217578242187, 7833.295003449688, 7763.534187948741, 7826.217378262185, 7848.803779905491, 7859.764207073797, 7871.685132594718, 7768.805779855492, 7777.727779527718, 7815.804604884866, 7826.02174728159, 7839.725609603636, 7681.423893208032, 7789.649465774054, 7790.922090779133, 7794.532328060278, 7807.063152421689, 30674.38651226963, 30728.385432291452, 30828.38343233145, 30845.0, 30897.536536951964, 3109.300407408338, 3179.8728050877935, 3588.5334906462253, 3918.1771827916173, 3991.3015222335976, 25359.492810143878, 25653.358666033313, 25957.95437602516, 26004.609930850864, 26240.0, 3485.5468789057513, 3499.825008749552, 3552.6447355264527, 3581.068922080278, 3616.9276614467562, 261568.0, 265329.0, 265702.0, 265817.0, 266042.0, 50784.74607626938, 51431.7428412863, 51459.48540514622, 51534.0, 51598.74200628973, 53848.0, 54019.45980540223, 54031.18953215705, 55574.72212638911, 59343.0, 14087.436502539784, 14215.218163001135, 14237.216953067473, 14292.071015383966, 14297.142171469744, 10763.83854242187, 10808.51361688726, 10830.458477076272, 10840.620578279722, 10847.02376786093, 18574.53563660892, 18783.34258300953, 18809.435716928514, 18868.905655471634, 18900.527486812665, 6539.574927629689, 6755.560888542229, 6995.160580730345, 7035.0, 7067.116610423697, 832.3507664022072, 918.8254231695956, 1002.3885429887763, 1007.7279134633754, 1008.7578981044496, 28939.276518087216, 31182.064538063896, 31197.220069498446, 31424.214394640316, 31928.0, 922.8338898998111, 953.2421724728857, 968.970930872075, 993.6323560282597, 1104.2380757277454, 13095.803562946563, 13705.657358565917, 13897.984792205276, 13948.0, 13979.580612581638, 315869.0, 321360.0, 323921.0, 325966.0, 326289.0, 46495.0, 46821.76589117101, 47024.7648761754, 47139.76430117896, 47608.52391476041, 1262.3057318474803, 1265.1523479268913, 1268.124993754325, 1270.1109223543556, 1275.9234445933273, 24746.0, 25971.0, 26125.60811587866, 26334.604980925684, 26430.339241519116, 38963.80518097391, 39592.60407395889, 39727.00682482845, 39768.40347394849, 39827.0, 243661.0, 245736.0, 246064.0, 246734.0, 247594.0, 24534.0, 24534.50930981406, 24687.38281542976, 24926.37684057913, 24988.500229994934, 41014.58985410227, 41097.794511027256, 41255.381169281885, 41507.584924150375, 42200.36699449572, 34701.82649086738, 35320.29359412746, 35792.10519737027, 35908.820455897556, 36409.0, 35075.12312192113, 35175.82412087923, 35371.29257414889, 35391.46912796362, 36095.91712248637, 30291.242718932204, 34753.65246347504, 35476.290474190886, 35762.8211858939, 36154.45768313425, 26938.730612693624, 28809.56785648259, 29203.269918251364, 30578.235544111576, 30923.2269193263, 23713.28860134199, 23852.880735596213, 23991.76008239965, 24260.393490162885, 24575.87712061428], "value": 16952.79739552258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.9373609618316, 358.85645741703325, 361.2828535357317, 371.70263788968816, 372.3260897775029, 15633.843661563395, 15884.68230635388, 17483.0, 17501.649967000652, 17505.82494175058, 15959.441419550318, 16120.435784747537, 16930.32278708853, 16940.915295423507, 16992.0, 5027.748612569366, 5135.845924622248, 5158.226266060084, 5189.117849965515, 5220.269162317279, 3737.7570457920147, 5155.329807125087, 5587.580931430139, 5926.0, 5934.020886553713, 5840.240768700063, 5843.620164689303, 5853.5902486825935, 5857.47282744555, 5904.822855314347, 5636.549076073904, 5853.560982926255, 5877.6473411595225, 5884.794032208873, 5891.322497912752, 4544.772761361919, 5070.163423035195, 5105.157648987913, 5113.386393632751, 5121.103806833789, 11939.761204775856, 12099.576514822027, 12136.15046946714, 12173.391330433531, 12182.81725774114, 1886.830185283331, 1889.5559543507266, 1939.2243102758869, 1940.4760714607119, 2365.3377054424786, 8685.131486851327, 8911.86632200511, 9264.44413335202, 9445.480498572575, 9509.096635819586, 1708.2056843567677, 1756.9385071522436, 1768.4606195110487, 1773.725072613747, 1798.199801088516, 63300.0, 64365.0, 64775.67612161956, 66161.00758488674, 66401.0, 9871.703848884545, 10039.096481316716, 10043.748906277255, 10570.630027948984, 10739.355638661706, 14046.297685115704, 14135.78796318056, 14240.715185696228, 14245.358958846877, 14270.500532481314, 6919.8962015569805, 7044.577325360495, 7060.894086588705, 7140.6072666003865, 7192.748253811092, 6154.969225153845, 6221.222347206599, 6251.249850018027, 6295.811125666238, 6296.464800491918, 4316.805743741539, 4337.1976184405985, 4393.253146965024, 4394.265161948718, 4425.889352766207, 1680.7478878168129, 1754.7806524184477, 1827.8342842967006, 1885.7359969604267, 1887.3205645967441, 866.27233124176, 884.7611144990946, 890.3322508118911, 925.7639301977953, 997.436448406648, 15559.533214003599, 15652.060876347456, 15767.684646307009, 15873.52379428619, 16098.597535061483, 874.4054043250524, 882.5763633455977, 901.7024381953939, 932.7061975477703, 951.5622813505864, 9197.08029197075, 9419.0, 9468.526573671288, 9492.525373731285, 9683.080107389787, 361867.0, 362311.0, 365635.0, 366370.0, 369227.0, 71901.0, 73216.26783732095, 73709.0, 74738.6263068692, 78001.0, 930.3719989007393, 972.4262685015875, 990.9256805739599, 991.5141580625442, 999.9150072243941, 15079.396824126912, 15164.848351516344, 15198.468053618513, 15328.540143795704, 15716.60708482297, 32259.51610725794, 33154.17114572155, 33431.16422089467, 33757.83121084379, 34591.827040864635, 43566.0, 47889.52110478851, 48466.757666211444, 48696.0, 49165.0, 7713.344365728976, 7736.92263077362, 7741.225877412214, 7785.493942893921, 7971.402144839044, 8207.548584827891, 10874.998755265115, 11052.392118433563, 11402.82895756581, 11976.940115299367, 9881.901180988098, 10060.496975151067, 10462.163026957673, 10499.370037797757, 10646.095081918123, 9899.356541825047, 10241.180705543688, 10249.436281004319, 10280.485975701036, 10518.842217366593, 10497.422641754776, 10550.314229575053, 10683.412412317397, 10794.514246858753, 11008.944955275172, 6872.209695884837, 7088.645567721696, 7302.634868256459, 7599.810004749705, 8101.716439924574, 10141.746456338651, 10162.441065741456, 10231.693049208536, 10372.740681483023, 10526.842097368393], "value": 8016.2493395007805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.3357904995128, 1446.5515690136056, 1573.779670846081, 1760.3046796515384, 1762.8797029258205, 6862.107925969617, 7224.783256502314, 7427.034485516882, 7718.80702982425, 7720.38236941044, 7232.746853860116, 7252.2747725227455, 7258.383037441824, 7291.963540182292, 7302.5618462892135, 2169.1323470611724, 2206.735191776989, 2215.678726584644, 2228.075348730275, 2233.508628101823, 2198.6372248578964, 2198.9010494527706, 2232.620454522735, 2236.3626366485555, 2242.035924552442, 2185.9234926777567, 2221.8777967211877, 2229.0, 2234.1175235781857, 2252.3017864462067, 2146.8604540704882, 2154.7306586676664, 2158.7733288004847, 2163.2969284982364, 2180.0407820558903, 2161.9027143778567, 2181.182056728727, 2185.61751693453, 2186.814120799734, 2190.8466407351493, 7402.11174659039, 7403.629818509053, 7464.32821046103, 7527.397808175333, 7554.357879580242, 4566.0, 4703.247480403119, 4709.62323014158, 4709.95290047102, 4713.858584242478, 2856.8143070700544, 2871.4400691865094, 2893.7974341796084, 2910.8544572771275, 2963.081444752134, 934.3366209990915, 965.5027660754716, 975.67314949492, 979.8138353712772, 992.1219720547296, 10409.427481488516, 10505.107065899409, 10556.049955503964, 10557.73605659857, 10580.841287380696, 4164.187983343219, 4176.102138040336, 4282.5075116361395, 4385.3641222022625, 4411.735295882258, 9013.18881300686, 9035.909640903637, 9095.681651142178, 9123.406978546373, 9130.132637399436, 4623.676342655982, 4648.65135114861, 4666.673332866734, 4673.3690951721765, 4676.462206846189, 3755.455458958436, 4184.225918205142, 4216.641585465209, 4227.239096962577, 4314.9784251078545, 3699.7595156314756, 3719.9814000930364, 3722.571904230994, 3746.2882052409955, 3836.2519308734527, 1163.5345861655405, 1173.8356630071796, 1181.7695549367963, 1190.2263528706237, 1217.391304347826, 1205.102198861836, 1209.9213551119326, 1212.3635091576994, 1222.205566381859, 1228.336698182989, 7178.784636460915, 7222.674979625929, 7227.1327440707455, 7237.167725711505, 7311.451641126937, 447.22406624506453, 450.4459514796818, 455.71062375391864, 460.4290679557392, 461.3932678527725, 5616.438356164351, 5643.322801263875, 5644.153376993484, 5686.175504551899, 5695.743691533891, 8514.787130321667, 8794.34042446819, 8991.370604057784, 9057.230135438562, 9072.727818165466, 8834.55827208637, 8903.51030693305, 8956.955215223883, 9023.007469178385, 9025.0, 6934.826629334206, 7031.156261248683, 7182.138143422718, 7205.603691797001, 7215.49491535598, 7234.16807067194, 7261.092363454568, 7287.0, 7291.125064992023, 7526.473146879666, 8685.696000639948, 8749.431286966326, 8792.780180495538, 8889.422187557788, 8942.195202431552, 8675.696350627697, 8872.378933474853, 8884.955575222082, 8898.955505222433, 9032.729018129467, 6533.18335208099, 6533.542652014504, 6775.254721980677, 6782.1861376635115, 6788.76239331621, 7317.012203352479, 7323.377512911462, 7340.926590734024, 7341.59621220838, 7419.443541734499, 6575.769848055295, 6702.396784289437, 6767.695453704497, 6792.694328755119, 6854.383105520527, 6676.566023208476, 6696.59820410777, 6705.731770729116, 6784.7964561063245, 6856.554323968926, 6818.18181818185, 6823.317668233137, 6936.647353765968, 6944.756933507303, 6987.0, 6166.660833654192, 6215.34738852414, 6226.875462490634, 6232.844178895564, 6243.719032643633, 6348.841278968062, 6360.968195158995, 6403.29563747978, 6414.166158399378, 6434.903476447764], "value": 4307.819687530839, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.6705174885249, 307.57093854073554, 307.59090409755026, 311.6307175996444, 320.8748588050661, 5304.283921670573, 5388.245645609612, 5424.593155513333, 5427.565794736422, 5475.5072043516075, 5314.9468505314935, 5327.786888524454, 5336.38631557371, 5342.732863356836, 5361.115415956372, 3925.9018524536973, 4045.271851066807, 4165.916681666365, 4177.268977928866, 4196.202721482909, 4186.079062606222, 4190.706650534464, 4203.075323428856, 4207.389928460371, 4210.263203939314, 4182.079942412664, 4187.036981494243, 4192.161567686475, 4198.391233271173, 4210.705250632457, 4039.111395493016, 4180.47744031996, 4189.245935731567, 4192.5597812229735, 4197.265478541273, 3651.47053677218, 3674.7243956703355, 3677.5586929568353, 3680.8527658893613, 3690.0, 5050.469700681412, 5054.974725126388, 5062.367204099488, 5065.442801291855, 5090.9236361454605, 4679.321498382716, 4776.450708168536, 4783.28250762385, 4783.976080119612, 4812.278158276252, 5612.747426365823, 5614.326280846324, 5615.9157612635845, 5620.0, 5625.0, 4024.63162524743, 4036.858709945138, 4037.2732908076537, 4052.169305292408, 4061.817218225187, 5701.429857014306, 5804.796832110856, 5897.4102589741115, 5911.733971971272, 5949.5240380769865, 4088.4071809587444, 4111.97944010284, 4115.933629446082, 4125.071858831739, 4125.773082480432, 4141.482314710661, 4187.476565429321, 4188.434561334242, 4197.370394440797, 4206.432131662247, 4654.301854721751, 4758.191107511731, 4767.69010014348, 4774.618030557616, 4779.761011949388, 5654.293213348332, 5671.688057156896, 5680.318361796611, 5680.857978550569, 5706.0, 1446.8263808343065, 1471.4108762536434, 1474.7243634256506, 1475.6089636246404, 1475.7491226491522, 916.1296768070359, 934.5420743835607, 981.3817295104038, 983.3018556824592, 995.6913356859396, 4874.780634871439, 4914.631402644744, 4944.975275123601, 4946.258061290763, 4955.331030310934, 5776.942230577724, 5777.62445441045, 5779.537636989031, 5785.392533783976, 5806.970965145232, 4854.247591623304, 4903.092927808367, 4947.120094364191, 4977.328060711758, 4980.626453016038, 3093.8607762650736, 3097.4579448596855, 3109.113902537766, 3118.656947735747, 3129.530570414456, 5428.5928555358505, 5449.128139497661, 5454.127339625641, 5459.262999495097, 5466.890662186814, 5748.626339287933, 5935.881282374415, 5944.4352786485215, 5961.791337303173, 5975.223220981245, 5454.372747134131, 5461.208124821878, 5467.507924286754, 5474.890502189934, 5498.752556134984, 5593.356763972195, 5751.683657398883, 5777.826665200051, 5796.391378905323, 5835.766569337179, 5665.971670141623, 5666.660000399989, 5670.659760414388, 5678.0, 5704.429557044263, 5446.727663616883, 5451.836444906659, 5453.509184173285, 5456.8267822418375, 5462.781488740406, 3769.6041915599562, 4012.8996775080855, 4040.7171497996032, 4152.37714342851, 4157.168566286694, 5727.198192253005, 5779.913301300568, 5784.913226301693, 5816.680082595498, 5821.0, 5676.290463692038, 5677.914831277617, 5691.857703557279, 5695.971520142372, 5701.9736447439855, 5490.96414135602, 5643.209950607001, 5654.943450565442, 5661.405552417102, 5686.744096515584, 5311.176767601028, 5513.614047016831, 5526.806561770319, 5544.0, 5555.444455554412, 5494.560435165257, 5639.629287302373, 5678.77284908599, 5723.971380143073, 5732.16883551891, 5496.450354964471, 5511.255980442589, 5533.363663178786, 5539.9169012464035, 5558.833235002957], "value": 4234.341844988143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.4798804920212, 689.5828024045452, 786.5870418030537, 793.8967934168558, 822.8066404394966, 12363.62909112727, 12663.493460261601, 12701.301428421433, 12746.29895355755, 12777.488900443983, 11965.940170299158, 11990.880091199107, 12133.635990920264, 12134.45394957227, 12220.266783992967, 642.75575281393, 788.9132195458495, 795.4272923495089, 811.4036183405193, 814.9062857771344, 806.1092492795465, 807.1887752808419, 807.5437377881508, 811.5171472973572, 814.914433984432, 850.3579797253096, 850.6384786465758, 851.3104385447807, 853.5220276645099, 854.8760429737684, 850.2262940723912, 850.3409857360533, 850.9191626795475, 851.1148405658108, 851.1233429567556, 623.8378021714342, 627.8587317853492, 628.3998781163978, 629.6694235526339, 629.8960671489199, 12330.383480825923, 12397.814032789516, 12457.06572007103, 12467.563635272722, 12498.437570309357, 12334.32161231132, 12497.500099995988, 12503.437345319482, 12626.24242545441, 12897.87102128976, 9743.951280243624, 9952.353097048668, 10013.699589012342, 10134.54394552247, 10135.54390052442, 3380.3577320309064, 3412.351653185887, 3417.094469965461, 3428.8114153721535, 3515.701165400944, 43706.12587748259, 43814.78092609548, 44039.55960440387, 44932.3260151098, 45432.0, 9844.458554779412, 9994.650187243411, 10031.398116113056, 10083.697489075339, 10207.336523125972, 17675.469735907944, 17694.646107078042, 17701.20344584471, 17823.376181833573, 17859.196336164903, 6442.226932768004, 6819.863602728017, 6852.417544508772, 6893.0, 7002.3697867192195, 3755.8497660093835, 3762.529683789526, 3771.340015497277, 3820.4269359596283, 3894.7857867817543, 2686.2344231893817, 2747.7114902934904, 2760.4341110072387, 2768.9030883918967, 2771.2102050915796, 444.6753869675155, 476.96661233714, 479.8608403562997, 488.46757034832206, 489.9216125419916, 554.4206304411899, 566.6062086849682, 581.134110175835, 620.3003769671069, 630.5334052800986, 7510.151891273632, 8139.75580732579, 8144.959275203586, 8223.342132629376, 8597.140285971478, 614.073253698284, 624.3226099681805, 641.7978336823885, 658.2134349452455, 679.0222080204489, 3792.3363411402893, 3841.615838416136, 3860.2665493556133, 3984.541777695602, 4022.2759903217116, 48126.0, 49034.509654903704, 49138.50861491339, 49306.0, 49735.502644973814, 41738.79130604388, 41869.0, 42780.78609606932, 42897.0, 43364.78317608392, 39193.41209881854, 39513.0, 39986.200275994895, 40139.79930100389, 40270.39594406086, 7436.59098749574, 7498.925010749823, 7651.885221721567, 7744.6902123914415, 7807.687692492464, 28365.149045528666, 28481.28796780097, 28778.28054298659, 28793.424131516833, 28919.855400722863, 35334.64665353416, 36339.27321453609, 36573.81713091524, 36593.26813463769, 36626.08434789152, 9487.810243795224, 9772.071653192936, 9913.256505761952, 9955.601775928882, 10277.691669249934, 10211.489425528842, 10288.691339259834, 10548.419836908737, 10587.258891877495, 10660.25378223517, 9458.290628202774, 9957.302988790716, 10070.295079344669, 10276.640317588848, 10283.280170388001, 9686.564104615169, 9891.802163956825, 9910.801783964425, 9959.800803984024, 10286.177105831366, 9778.608855645694, 10114.949425252827, 10190.235732319958, 10321.0, 10499.0, 8382.706605268786, 8420.578971051546, 8449.788755281168, 8730.781730456536, 8760.386772925835, 8608.139186081342, 8624.827503450022, 8651.567421629019, 8718.520481373585, 8754.124587541195], "value": 5793.27695429894, "unit": "score"}], "name": "dromaeo_css", "value": 6372.711717853799, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 115.0, 116.0, 114.0, 126.0, 114.0, 114.0, 114.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 152.0, 181.0, 134.0, 156.0, 156.0, 134.0, 196.0, 143.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 166.0, 168.0, 161.0, 162.0, 162.0, 165.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 156.0, 74.0, 78.0, 73.0, 73.0, 155.0, 75.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 147.0, 94.0, 96.0, 94.0, 134.0, 94.0, 95.0, 144.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 116.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 151.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 100.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 67.0, 65.0, 66.0, 67.0, 80.0, 65.0, 65.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 84.0, 86.0, 92.0, 86.0, 87.0, 87.0, 86.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 138.0, 139.0, 138.0, 152.0, 138.0, 139.0, 141.0, 181.0, 143.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 183.0, 173.0, 177.0, 170.0, 175.0, 178.0, 176.0, 171.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 72.0, 75.0, 76.0, 72.0, 71.0, 73.0, 71.0, 68.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1606.5, "alertThreshold": 2.0}]} 12:20:57 INFO - Return code: 0 12:20:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:20:57 ERROR - # TBPL SUCCESS # 12:20:57 INFO - Running post-action listener: _resource_record_post_action 12:20:57 INFO - Running post-run listener: _resource_record_post_run 12:20:58 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 357875712; Read time: 28; Write time: 239004 12:20:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 72859648; Read time: 0; Write time: 59972 12:20:58 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285016064; Read time: 28; Write time: 179032 12:20:58 INFO - Running post-run listener: _upload_blobber_files 12:20:58 INFO - Blob upload gear active. 12:20:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:20:58 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 12:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:20:59 INFO - (blobuploader) - INFO - Open directory for files ... 12:20:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:20:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:20:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:00 INFO - (blobuploader) - INFO - Done attempting. 12:21:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:21:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:21:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:01 INFO - (blobuploader) - INFO - Done attempting. 12:21:01 INFO - (blobuploader) - INFO - Iteration through files over. 12:21:01 INFO - Return code: 0 12:21:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:21:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:21:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8854d55463b0af79146d97acae6487d34d0932e2245cc016b54788870dce8dee564ad9dbcca3a394d377bbc557dbceddbdff19e3d6495ad85d47abb6fe7c585e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7a254e369c63e80b51424ef50db9ea3620b0d33da05391130e0b1518915ce8fb400b6bdd678974489c2e65b91900315248c9bbf6433fecd2ab04aca80bfd35"} 12:21:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:21:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:21:01 INFO - Contents: 12:21:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8854d55463b0af79146d97acae6487d34d0932e2245cc016b54788870dce8dee564ad9dbcca3a394d377bbc557dbceddbdff19e3d6495ad85d47abb6fe7c585e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7a254e369c63e80b51424ef50db9ea3620b0d33da05391130e0b1518915ce8fb400b6bdd678974489c2e65b91900315248c9bbf6433fecd2ab04aca80bfd35"} 12:21:01 INFO - Running post-run listener: copy_logs_to_upload_dir 12:21:01 INFO - Copying logs to upload dir... 12:21:01 INFO - mkdir: /builds/slave/test/build/upload/logs 12:21:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.545194 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-11 12:21:00.842748) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 12:21:00.846749) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 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/Firefox-Non-PGO/sha512/8854d55463b0af79146d97acae6487d34d0932e2245cc016b54788870dce8dee564ad9dbcca3a394d377bbc557dbceddbdff19e3d6495ad85d47abb6fe7c585e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7a254e369c63e80b51424ef50db9ea3620b0d33da05391130e0b1518915ce8fb400b6bdd678974489c2e65b91900315248c9bbf6433fecd2ab04aca80bfd35"} build_url:https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/KTjJnrFsQPivc77p-uE3Xg/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/Firefox-Non-PGO/sha512/8854d55463b0af79146d97acae6487d34d0932e2245cc016b54788870dce8dee564ad9dbcca3a394d377bbc557dbceddbdff19e3d6495ad85d47abb6fe7c585e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7a254e369c63e80b51424ef50db9ea3620b0d33da05391130e0b1518915ce8fb400b6bdd678974489c2e65b91900315248c9bbf6433fecd2ab04aca80bfd35"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 12:21:00.872519) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:21:00.872884) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1460400550.782205-610974725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:21:00.957707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 12:21:00.958090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 12:21:00.958450) ========= ========= Total master_lag: 0.32 =========