builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1460114176.11 results: success (0) buildid: 20160408030000 builduid: 5d4b3832a52842e3a0a31d9ca975fdaa revision: e7466050cdd23e629ffbe97bfa9b8226d3cb7980 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.114887) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.115294) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.115588) ========= 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-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006555 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.145109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.145408) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.161446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.161711) ========= 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-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004693 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.220438) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.220931) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.221285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.221672) ========= 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-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 04:16:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-04-08 04:16:17 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.372127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.608637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.608923) ========= 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-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015401 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.662095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.662462) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e7466050cdd23e629ffbe97bfa9b8226d3cb7980 --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 e7466050cdd23e629ffbe97bfa9b8226d3cb7980 --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-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 04:16:17,140 truncating revision to first 12 chars 2016-04-08 04:16:17,140 Setting DEBUG logging. 2016-04-08 04:16:17,140 attempt 1/10 2016-04-08 04:16:17,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e7466050cdd2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 04:16:17,404 unpacking tar archive at: mozilla-central-e7466050cdd2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:17.247650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:17.247956) ========= echo e7466050cdd23e629ffbe97bfa9b8226d3cb7980 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e7466050cdd23e629ffbe97bfa9b8226d3cb7980'] 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-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e7466050cdd23e629ffbe97bfa9b8226d3cb7980 program finished with exit code 0 elapsedTime=0.004498 script_repo_revision: 'e7466050cdd23e629ffbe97bfa9b8226d3cb7980' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:17.301637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:17.301921) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:17.326710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-08 04:16:17.327031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:17 INFO - MultiFileLogger online at 20160408 04:16:17 in /builds/slave/test 04:16:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:16:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:17 INFO - {'append_to_log': False, 04:16:17 INFO - 'base_work_dir': '/builds/slave/test', 04:16:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:16:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:17 INFO - 'branch': 'Firefox-Non-PGO', 04:16:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:17 INFO - 'config_files': ('talos/linux_config.py',), 04:16:17 INFO - 'default_actions': ('clobber', 04:16:17 INFO - 'read-buildbot-config', 04:16:17 INFO - 'download-and-extract', 04:16:17 INFO - 'populate-webroot', 04:16:17 INFO - 'create-virtualenv', 04:16:17 INFO - 'install', 04:16:17 INFO - 'run-tests'), 04:16:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:17 INFO - 'download_minidump_stackwalk': True, 04:16:17 INFO - 'download_symbols': 'ondemand', 04:16:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:17 INFO - 'installer_path': 'installer.exe', 04:16:17 INFO - 'log_level': 'info', 04:16:17 INFO - 'log_name': 'talos', 04:16:17 INFO - 'log_to_console': True, 04:16:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:17 INFO - 'opt_config_files': (), 04:16:17 INFO - 'pip_index': False, 04:16:17 INFO - 'sps_profile': False, 04:16:17 INFO - 'sps_profile_interval': 0, 04:16:17 INFO - 'suite': 'dromaeojs', 04:16:17 INFO - 'system_bits': '32', 04:16:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:17 INFO - 'title': 'talos-linux64-ix-006', 04:16:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:17 INFO - 'use_talos_json': True, 04:16:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:17 INFO - 'work_dir': 'build'} 04:16:17 INFO - ##### 04:16:17 INFO - ##### Running clobber step. 04:16:17 INFO - ##### 04:16:17 INFO - Running pre-action listener: _resource_record_pre_action 04:16:17 INFO - Running main action method: clobber 04:16:17 INFO - rmtree: /builds/slave/test/build 04:16:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:18 INFO - Running post-action listener: _resource_record_post_action 04:16:18 INFO - ##### 04:16:18 INFO - ##### Running read-buildbot-config step. 04:16:18 INFO - ##### 04:16:18 INFO - Running pre-action listener: _resource_record_pre_action 04:16:18 INFO - Running main action method: read_buildbot_config 04:16:18 INFO - Using buildbot properties: 04:16:18 INFO - { 04:16:18 INFO - "project": "", 04:16:18 INFO - "product": "firefox", 04:16:18 INFO - "script_repo_revision": "production", 04:16:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:16:18 INFO - "repository": "", 04:16:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:16:18 INFO - "buildid": "20160408030000", 04:16:18 INFO - "pgo_build": "False", 04:16:18 INFO - "basedir": "/builds/slave/test", 04:16:18 INFO - "buildnumber": 54, 04:16:18 INFO - "slavename": "talos-linux64-ix-006", 04:16:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:16:18 INFO - "platform": "ubuntu64_hw", 04:16:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:16:18 INFO - "branch": "mozilla-central", 04:16:18 INFO - "repo_path": "mozilla-central", 04:16:18 INFO - "revision": "e7466050cdd23e629ffbe97bfa9b8226d3cb7980", 04:16:18 INFO - "stage_platform": "linux64", 04:16:18 INFO - "builduid": "5d4b3832a52842e3a0a31d9ca975fdaa", 04:16:18 INFO - "slavebuilddir": "test" 04:16:18 INFO - } 04:16:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:16:18 INFO - Running post-action listener: _resource_record_post_action 04:16:18 INFO - ##### 04:16:18 INFO - ##### Running download-and-extract step. 04:16:18 INFO - ##### 04:16:18 INFO - Running pre-action listener: _resource_record_pre_action 04:16:18 INFO - Running main action method: download_and_extract 04:16:18 INFO - mkdir: /builds/slave/test/build/tests 04:16:18 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')]} 04:16:18 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:26 INFO - Downloaded 1361 bytes. 04:16:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:16:26 INFO - Using the following test package requirements: 04:16:26 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:16:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:26 INFO - u'jsshell-linux-x86_64.zip'], 04:16:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:26 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:26 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:16:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:16:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:30 INFO - Downloaded 22186012 bytes. 04:16:30 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'] 04:16:30 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 04:16:31 INFO - Return code: 0 04:16:31 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 04:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:31 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:33 INFO - Downloaded 22186012 bytes. 04:16:33 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'] 04:16:33 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 04:16:34 INFO - Return code: 0 04:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:34 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:35 INFO - Downloaded 10847693 bytes. 04:16:35 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'] 04:16:35 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 04:16:35 INFO - Return code: 0 04:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:35 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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 04:16:37 INFO - Downloaded 54053591 bytes. 04:16:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:37 INFO - mkdir: /builds/slave/test/properties 04:16:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:37 INFO - Contents: 04:16:37 INFO - build_url:https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:38 INFO - Running post-action listener: _resource_record_post_action 04:16:38 INFO - Running post-action listener: set_extra_try_arguments 04:16:38 INFO - ##### 04:16:38 INFO - ##### Running populate-webroot step. 04:16:38 INFO - ##### 04:16:38 INFO - Running pre-action listener: _resource_record_pre_action 04:16:38 INFO - Running main action method: populate_webroot 04:16:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:38 INFO - '--tppagecycles', 04:16:38 INFO - '7'], 04:16:38 INFO - 'tests': ['tsvgm']}}, 04:16:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:16:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:16:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:38 INFO - 'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:38 INFO - 'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['damp', 'tps']}, 04:16:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:38 INFO - 'tests': ['damp', 'tps']}, 04:16:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['dromaeo_dom']}, 04:16:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['a11yr', 04:16:38 INFO - 'ts_paint', 04:16:38 INFO - 'tpaint', 04:16:38 INFO - 'sessionrestore', 04:16:38 INFO - 'sessionrestore_no_auto_restore', 04:16:38 INFO - 'tabpaint']}, 04:16:38 INFO - 'other-e10s': {'tests': ['a11yr', 04:16:38 INFO - 'ts_paint', 04:16:38 INFO - 'tpaint', 04:16:38 INFO - 'sessionrestore', 04:16:38 INFO - 'sessionrestore_no_auto_restore', 04:16:38 INFO - 'tabpaint']}, 04:16:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:16:38 INFO - 'ts_paint', 04:16:38 INFO - 'tpaint', 04:16:38 INFO - 'sessionrestore', 04:16:38 INFO - 'sessionrestore_no_auto_restore', 04:16:38 INFO - 'tabpaint']}, 04:16:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:16:38 INFO - 'ts_paint', 04:16:38 INFO - 'tpaint', 04:16:38 INFO - 'sessionrestore', 04:16:38 INFO - 'sessionrestore_no_auto_restore', 04:16:38 INFO - 'tabpaint']}, 04:16:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['a11yr', 04:16:38 INFO - 'ts_paint', 04:16:38 INFO - 'tpaint', 04:16:38 INFO - 'sessionrestore', 04:16:38 INFO - 'sessionrestore_no_auto_restore', 04:16:38 INFO - 'tabpaint']}, 04:16:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['a11yr', 04:16:38 INFO - 'ts_paint', 04:16:38 INFO - 'tpaint', 04:16:38 INFO - 'sessionrestore', 04:16:38 INFO - 'sessionrestore_no_auto_restore', 04:16:38 INFO - 'tabpaint']}, 04:16:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['tsvgx', 04:16:38 INFO - 'tsvgr_opacity', 04:16:38 INFO - 'tart', 04:16:38 INFO - 'tscrollx', 04:16:38 INFO - 'cart']}, 04:16:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:16:38 INFO - 'tsvgr_opacity', 04:16:38 INFO - 'tart', 04:16:38 INFO - 'tscrollx', 04:16:38 INFO - 'cart']}, 04:16:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:38 INFO - 'talos_options': ['--disable-e10s'], 04:16:38 INFO - 'tests': ['tp5o']}, 04:16:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:38 INFO - 'tests': ['tp5o']}, 04:16:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:38 INFO - 'talos_options': ['--disable-e10s', 04:16:38 INFO - '--xperf_path', 04:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:38 INFO - 'tests': ['tp5n']}, 04:16:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:38 INFO - 'talos_options': ['--xperf_path', 04:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:38 INFO - 'tests': ['tp5n']}}, 04:16:38 INFO - 'talos.zip': {'path': '', 04:16:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:38 INFO - Running post-action listener: _resource_record_post_action 04:16:38 INFO - ##### 04:16:38 INFO - ##### Running create-virtualenv step. 04:16:38 INFO - ##### 04:16:38 INFO - Running pre-action listener: _resource_record_pre_action 04:16:38 INFO - Running main action method: create_virtualenv 04:16:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:38 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 04:16:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:38 INFO - Using real prefix '/usr' 04:16:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:40 INFO - Installing pip.................done. 04:16:40 INFO - Return code: 0 04:16:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:40 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 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:16:40 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 04:16:40 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 04:16:40 INFO - Using env: {'DISPLAY': ':0', 04:16:40 INFO - 'HOME': '/home/cltbld', 04:16:40 INFO - 'LANG': 'en_US.UTF-8', 04:16:40 INFO - 'LANGUAGE': 'en_US:en', 04:16:40 INFO - 'LOGNAME': 'cltbld', 04:16:40 INFO - 'MAIL': '/var/mail/cltbld', 04:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:40 INFO - 'MOZ_NO_REMOTE': '1', 04:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:40 INFO - 'NO_EM_RESTART': '1', 04:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:40 INFO - 'PWD': '/builds/slave/test', 04:16:40 INFO - 'SHELL': '/bin/bash', 04:16:40 INFO - 'SHLVL': '1', 04:16:40 INFO - 'TERM': 'linux', 04:16:40 INFO - 'TMOUT': '86400', 04:16:40 INFO - 'USER': 'cltbld', 04:16:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:40 INFO - '_': '/tools/buildbot/bin/python'} 04:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:40 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 04:16:40 INFO - Cleaning up... 04:16:40 INFO - Return code: 0 04:16:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:40 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 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:16:40 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 04:16:40 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 04:16:40 INFO - Using env: {'DISPLAY': ':0', 04:16:40 INFO - 'HOME': '/home/cltbld', 04:16:40 INFO - 'LANG': 'en_US.UTF-8', 04:16:40 INFO - 'LANGUAGE': 'en_US:en', 04:16:40 INFO - 'LOGNAME': 'cltbld', 04:16:40 INFO - 'MAIL': '/var/mail/cltbld', 04:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:40 INFO - 'MOZ_NO_REMOTE': '1', 04:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:40 INFO - 'NO_EM_RESTART': '1', 04:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:40 INFO - 'PWD': '/builds/slave/test', 04:16:40 INFO - 'SHELL': '/bin/bash', 04:16:40 INFO - 'SHLVL': '1', 04:16:40 INFO - 'TERM': 'linux', 04:16:40 INFO - 'TMOUT': '86400', 04:16:40 INFO - 'USER': 'cltbld', 04:16:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:40 INFO - '_': '/tools/buildbot/bin/python'} 04:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:41 INFO - Downloading/unpacking psutil>=0.7.1 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:43 INFO - Installing collected packages: psutil 04:16:43 INFO - Running setup.py install for psutil 04:16:43 INFO - building 'psutil._psutil_linux' extension 04:16:43 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 04:16:43 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 04:16:43 INFO - building 'psutil._psutil_posix' extension 04:16:43 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 04:16:43 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 04:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:43 INFO - Successfully installed psutil 04:16:43 INFO - Cleaning up... 04:16:43 INFO - Return code: 0 04:16:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:16: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')]} 04:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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', '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 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:16: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:16: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 mozsystemmonitor==0.0.0 04:16:43 INFO - Using env: {'DISPLAY': ':0', 04:16:43 INFO - 'HOME': '/home/cltbld', 04:16:43 INFO - 'LANG': 'en_US.UTF-8', 04:16:43 INFO - 'LANGUAGE': 'en_US:en', 04:16:43 INFO - 'LOGNAME': 'cltbld', 04:16:43 INFO - 'MAIL': '/var/mail/cltbld', 04:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:43 INFO - 'MOZ_NO_REMOTE': '1', 04:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:43 INFO - 'NO_EM_RESTART': '1', 04:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:43 INFO - 'PWD': '/builds/slave/test', 04:16:43 INFO - 'SHELL': '/bin/bash', 04:16:43 INFO - 'SHLVL': '1', 04:16:43 INFO - 'TERM': 'linux', 04:16:43 INFO - 'TMOUT': '86400', 04:16:43 INFO - 'USER': 'cltbld', 04:16:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:43 INFO - '_': '/tools/buildbot/bin/python'} 04:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:16:45 INFO - Installing collected packages: mozsystemmonitor 04:16:45 INFO - Running setup.py install for mozsystemmonitor 04:16:45 INFO - Successfully installed mozsystemmonitor 04:16:46 INFO - Cleaning up... 04:16:46 INFO - Return code: 0 04:16:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:46 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')]} 04:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:46 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')]} 04:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:46 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 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:16:46 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 04:16:46 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 04:16:46 INFO - Using env: {'DISPLAY': ':0', 04:16:46 INFO - 'HOME': '/home/cltbld', 04:16:46 INFO - 'LANG': 'en_US.UTF-8', 04:16:46 INFO - 'LANGUAGE': 'en_US:en', 04:16:46 INFO - 'LOGNAME': 'cltbld', 04:16:46 INFO - 'MAIL': '/var/mail/cltbld', 04:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:46 INFO - 'MOZ_NO_REMOTE': '1', 04:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:46 INFO - 'NO_EM_RESTART': '1', 04:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:46 INFO - 'PWD': '/builds/slave/test', 04:16:46 INFO - 'SHELL': '/bin/bash', 04:16:46 INFO - 'SHLVL': '1', 04:16:46 INFO - 'TERM': 'linux', 04:16:46 INFO - 'TMOUT': '86400', 04:16:46 INFO - 'USER': 'cltbld', 04:16:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:46 INFO - '_': '/tools/buildbot/bin/python'} 04:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:49 INFO - Downloading docopt-0.6.1.tar.gz 04:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:49 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:49 INFO - Running setup.py install for blobuploader 04:16:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:49 INFO - Running setup.py install for requests 04:16:49 INFO - Running setup.py install for docopt 04:16:49 INFO - Successfully installed blobuploader requests docopt 04:16:49 INFO - Cleaning up... 04:16:49 INFO - Return code: 0 04:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:49 INFO - Using env: {'DISPLAY': ':0', 04:16:49 INFO - 'HOME': '/home/cltbld', 04:16:49 INFO - 'LANG': 'en_US.UTF-8', 04:16:49 INFO - 'LANGUAGE': 'en_US:en', 04:16:49 INFO - 'LOGNAME': 'cltbld', 04:16:49 INFO - 'MAIL': '/var/mail/cltbld', 04:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:49 INFO - 'MOZ_NO_REMOTE': '1', 04:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:49 INFO - 'NO_EM_RESTART': '1', 04:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:49 INFO - 'PWD': '/builds/slave/test', 04:16:49 INFO - 'SHELL': '/bin/bash', 04:16:49 INFO - 'SHLVL': '1', 04:16:49 INFO - 'TERM': 'linux', 04:16:49 INFO - 'TMOUT': '86400', 04:16:49 INFO - 'USER': 'cltbld', 04:16:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:49 INFO - '_': '/tools/buildbot/bin/python'} 04:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:49 INFO - Running setup.py (path:/tmp/pip-RNk1Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:50 INFO - Running setup.py (path:/tmp/pip-NM3Umd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:50 INFO - Running setup.py (path:/tmp/pip-YJeTJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:50 INFO - Running setup.py (path:/tmp/pip-lR_tzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:50 INFO - Running setup.py (path:/tmp/pip-PhG153-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:50 INFO - Running setup.py (path:/tmp/pip-jZZPU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:50 INFO - Running setup.py (path:/tmp/pip-vcltH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:50 INFO - Running setup.py (path:/tmp/pip-FWQljY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:50 INFO - Running setup.py (path:/tmp/pip-Y9kCcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:50 INFO - Running setup.py (path:/tmp/pip-fAtNSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:50 INFO - Running setup.py (path:/tmp/pip-lcpGB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:50 INFO - Running setup.py (path:/tmp/pip-d5a6pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:50 INFO - Running setup.py (path:/tmp/pip-3TDkvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:50 INFO - Running setup.py (path:/tmp/pip-VKXc2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:50 INFO - Running setup.py (path:/tmp/pip-owD9i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:51 INFO - Running setup.py (path:/tmp/pip-p8Hsew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:51 INFO - Running setup.py (path:/tmp/pip-dcbE7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:51 INFO - Running setup.py install for manifestparser 04:16:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Running setup.py install for mozcrash 04:16:51 INFO - Running setup.py install for mozdebug 04:16:51 INFO - Running setup.py install for mozdevice 04:16:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Running setup.py install for mozfile 04:16:51 INFO - Running setup.py install for mozhttpd 04:16:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Running setup.py install for mozinfo 04:16:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Running setup.py install for mozInstall 04:16:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:51 INFO - Running setup.py install for mozleak 04:16:52 INFO - Running setup.py install for mozlog 04:16:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:52 INFO - Running setup.py install for moznetwork 04:16:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:52 INFO - Running setup.py install for mozprocess 04:16:52 INFO - Running setup.py install for mozprofile 04:16:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:52 INFO - Running setup.py install for mozrunner 04:16:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:52 INFO - Running setup.py install for mozscreenshot 04:16:52 INFO - Running setup.py install for moztest 04:16:52 INFO - Running setup.py install for mozversion 04:16:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:52 INFO - Cleaning up... 04:16:52 INFO - Return code: 0 04:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:52 INFO - Using env: {'DISPLAY': ':0', 04:16:52 INFO - 'HOME': '/home/cltbld', 04:16:52 INFO - 'LANG': 'en_US.UTF-8', 04:16:52 INFO - 'LANGUAGE': 'en_US:en', 04:16:52 INFO - 'LOGNAME': 'cltbld', 04:16:52 INFO - 'MAIL': '/var/mail/cltbld', 04:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:52 INFO - 'MOZ_NO_REMOTE': '1', 04:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:52 INFO - 'NO_EM_RESTART': '1', 04:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:52 INFO - 'PWD': '/builds/slave/test', 04:16:52 INFO - 'SHELL': '/bin/bash', 04:16:52 INFO - 'SHLVL': '1', 04:16:52 INFO - 'TERM': 'linux', 04:16:52 INFO - 'TMOUT': '86400', 04:16:52 INFO - 'USER': 'cltbld', 04:16:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:52 INFO - '_': '/tools/buildbot/bin/python'} 04:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:53 INFO - Running setup.py (path:/tmp/pip-HmmiPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:53 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)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:53 INFO - Running setup.py (path:/tmp/pip-IjFrmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:53 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)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:53 INFO - Running setup.py (path:/tmp/pip-BwG_3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:53 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)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:53 INFO - Running setup.py (path:/tmp/pip-i52pfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:53 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)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:53 INFO - Running setup.py (path:/tmp/pip-XR8BVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:53 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)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:53 INFO - Running setup.py (path:/tmp/pip-VWA3vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:53 INFO - Running setup.py (path:/tmp/pip-uWUGdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:53 INFO - Running setup.py (path:/tmp/pip-AdLDbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:53 INFO - Running setup.py (path:/tmp/pip-_mQ4Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:53 INFO - Running setup.py (path:/tmp/pip-rRAZ9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:53 INFO - Running setup.py (path:/tmp/pip-HrkLmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:53 INFO - Running setup.py (path:/tmp/pip-YUxOwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:54 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)) 04:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:54 INFO - Running setup.py (path:/tmp/pip-PqInX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:54 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)) 04:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:54 INFO - Running setup.py (path:/tmp/pip-Ws0iHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:54 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)) 04:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:54 INFO - Running setup.py (path:/tmp/pip-_jn5lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:54 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)) 04:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:54 INFO - Running setup.py (path:/tmp/pip-fOoEA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:54 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)) 04:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:54 INFO - Running setup.py (path:/tmp/pip-aRDRd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:54 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)) 04:16:54 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)) 04:16:54 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)) 04:16:54 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)) 04:16:54 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)) 04:16:54 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)) 04:16:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:54 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 04:16:54 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 04:16:54 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 04:16:54 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 04:16:54 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 04:16:54 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 04:16:56 INFO - Downloading blessings-1.6.tar.gz 04:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:56 INFO - Installing collected packages: blessings 04:16:56 INFO - Running setup.py install for blessings 04:16:56 INFO - Successfully installed blessings 04:16:56 INFO - Cleaning up... 04:16:56 INFO - Return code: 0 04:16:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:57 INFO - Reading from file tmpfile_stdout 04:16:57 INFO - Current package versions: 04:16:57 INFO - argparse == 1.2.1 04:16:57 INFO - blessings == 1.6 04:16:57 INFO - blobuploader == 1.2.4 04:16:57 INFO - docopt == 0.6.1 04:16:57 INFO - manifestparser == 1.1 04:16:57 INFO - mozInstall == 1.12 04:16:57 INFO - mozcrash == 0.17 04:16:57 INFO - mozdebug == 0.1 04:16:57 INFO - mozdevice == 0.48 04:16:57 INFO - mozfile == 1.2 04:16:57 INFO - mozhttpd == 0.7 04:16:57 INFO - mozinfo == 0.9 04:16:57 INFO - mozleak == 0.1 04:16:57 INFO - mozlog == 3.1 04:16:57 INFO - moznetwork == 0.27 04:16:57 INFO - mozprocess == 0.22 04:16:57 INFO - mozprofile == 0.28 04:16:57 INFO - mozrunner == 6.11 04:16:57 INFO - mozscreenshot == 0.1 04:16:57 INFO - mozsystemmonitor == 0.0 04:16:57 INFO - moztest == 0.7 04:16:57 INFO - mozversion == 1.4 04:16:57 INFO - psutil == 3.1.1 04:16:57 INFO - requests == 1.2.3 04:16:57 INFO - wsgiref == 0.1.2 04:16:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:57 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')]} 04:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 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')]} 04:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 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 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:16:57 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 04:16:57 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 04:16:57 INFO - Using env: {'DISPLAY': ':0', 04:16:57 INFO - 'HOME': '/home/cltbld', 04:16:57 INFO - 'LANG': 'en_US.UTF-8', 04:16:57 INFO - 'LANGUAGE': 'en_US:en', 04:16:57 INFO - 'LOGNAME': 'cltbld', 04:16:57 INFO - 'MAIL': '/var/mail/cltbld', 04:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:57 INFO - 'MOZ_NO_REMOTE': '1', 04:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:57 INFO - 'NO_EM_RESTART': '1', 04:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:57 INFO - 'PWD': '/builds/slave/test', 04:16:57 INFO - 'SHELL': '/bin/bash', 04:16:57 INFO - 'SHLVL': '1', 04:16:57 INFO - 'TERM': 'linux', 04:16:57 INFO - 'TMOUT': '86400', 04:16:57 INFO - 'USER': 'cltbld', 04:16:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:57 INFO - '_': '/tools/buildbot/bin/python'} 04:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 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)) 04:16:57 INFO - Cleaning up... 04:16:57 INFO - Return code: 0 04:16:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16:57 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')]} 04:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 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')]} 04:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 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 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:16:57 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 04:16:57 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 04:16:57 INFO - Using env: {'DISPLAY': ':0', 04:16:57 INFO - 'HOME': '/home/cltbld', 04:16:57 INFO - 'LANG': 'en_US.UTF-8', 04:16:57 INFO - 'LANGUAGE': 'en_US:en', 04:16:57 INFO - 'LOGNAME': 'cltbld', 04:16:57 INFO - 'MAIL': '/var/mail/cltbld', 04:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:57 INFO - 'MOZ_NO_REMOTE': '1', 04:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:57 INFO - 'NO_EM_RESTART': '1', 04:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:57 INFO - 'PWD': '/builds/slave/test', 04:16:57 INFO - 'SHELL': '/bin/bash', 04:16:57 INFO - 'SHLVL': '1', 04:16:57 INFO - 'TERM': 'linux', 04:16:57 INFO - 'TMOUT': '86400', 04:16:57 INFO - 'USER': 'cltbld', 04:16:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:57 INFO - '_': '/tools/buildbot/bin/python'} 04:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:57 INFO - Downloading/unpacking jsonschema 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:17:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:00 INFO - Downloading/unpacking functools32 (from jsonschema) 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:01 INFO - warning: no files found matching '*.txt' 04:17:01 INFO - no previously-included directories found matching 'build' 04:17:01 INFO - no previously-included directories found matching 'dist' 04:17:01 INFO - no previously-included directories found matching '.git*' 04:17:01 INFO - Installing collected packages: jsonschema, functools32 04:17:01 INFO - Running setup.py install for functools32 04:17:01 INFO - warning: no files found matching '*.txt' 04:17:01 INFO - no previously-included directories found matching 'build' 04:17:01 INFO - no previously-included directories found matching 'dist' 04:17:01 INFO - no previously-included directories found matching '.git*' 04:17:01 INFO - Successfully installed jsonschema functools32 04:17:01 INFO - Cleaning up... 04:17:01 INFO - Return code: 0 04:17:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:01 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 0x7f2a43231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, '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-1460113255.145727-200028318', '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 04:17:01 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 04:17:01 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 04:17:01 INFO - Using env: {'DISPLAY': ':0', 04:17:01 INFO - 'HOME': '/home/cltbld', 04:17:01 INFO - 'LANG': 'en_US.UTF-8', 04:17:01 INFO - 'LANGUAGE': 'en_US:en', 04:17:01 INFO - 'LOGNAME': 'cltbld', 04:17:01 INFO - 'MAIL': '/var/mail/cltbld', 04:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:01 INFO - 'MOZ_NO_REMOTE': '1', 04:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:01 INFO - 'NO_EM_RESTART': '1', 04:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:01 INFO - 'PWD': '/builds/slave/test', 04:17:01 INFO - 'SHELL': '/bin/bash', 04:17:01 INFO - 'SHLVL': '1', 04:17:01 INFO - 'TERM': 'linux', 04:17:01 INFO - 'TMOUT': '86400', 04:17:01 INFO - 'USER': 'cltbld', 04:17:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:01 INFO - '_': '/tools/buildbot/bin/python'} 04:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:01 INFO - Downloading/unpacking flake8 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:04 INFO - no previously-included directories found matching 'docs/_build' 04:17:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:04 INFO - Running setup.py install for pep8 04:17:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:04 INFO - no previously-included directories found matching 'docs/_build' 04:17:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:04 INFO - Cleaning up... 04:17:04 INFO - Return code: 0 04:17:04 INFO - Running post-action listener: _resource_record_post_action 04:17:04 INFO - Running post-action listener: _start_resource_monitoring 04:17:04 INFO - Starting resource monitoring. 04:17:04 INFO - ##### 04:17:04 INFO - ##### Running install step. 04:17:04 INFO - ##### 04:17:04 INFO - Running pre-action listener: _resource_record_pre_action 04:17:04 INFO - Running main action method: install 04:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:04 INFO - Reading from file tmpfile_stdout 04:17:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:04 INFO - Reading from file tmpfile_stdout 04:17:04 INFO - Output received: 04:17:04 INFO - Usage: mozinstall [options] installer 04:17:04 INFO - Options: 04:17:04 INFO - -h, --help show this help message and exit 04:17:04 INFO - -d DEST, --destination=DEST 04:17:04 INFO - Directory to install application into. [default: 04:17:04 INFO - "/builds/slave/test"] 04:17:04 INFO - --app=APP Application being installed. [default: firefox] 04:17:04 INFO - mkdir: /builds/slave/test/build/application 04:17:04 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'] 04:17:04 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 04:17:20 INFO - Reading from file tmpfile_stdout 04:17:20 INFO - Output received: 04:17:20 INFO - /builds/slave/test/build/application/firefox/firefox 04:17:20 INFO - Running post-action listener: _resource_record_post_action 04:17:20 INFO - ##### 04:17:20 INFO - ##### Running run-tests step. 04:17:20 INFO - ##### 04:17:20 INFO - Running pre-action listener: _resource_record_pre_action 04:17:20 INFO - Running main action method: run_tests 04:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:20 INFO - Python 2.7.3 04:17:20 INFO - Return code: 0 04:17:20 INFO - grabbing minidump binary from tooltool 04:17: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')]} 04:17:20 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 0x2612410>, '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 0x2613310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26137a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:20 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 04:17:20 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 04:17:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:20 INFO - Return code: 0 04:17:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:17:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:17:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:17:21 INFO - Return code: 0 04:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:17:21 INFO - Using env: {'DISPLAY': ':0', 04:17:21 INFO - 'HOME': '/home/cltbld', 04:17:21 INFO - 'LANG': 'en_US.UTF-8', 04:17:21 INFO - 'LANGUAGE': 'en_US:en', 04:17:21 INFO - 'LOGNAME': 'cltbld', 04:17:21 INFO - 'MAIL': '/var/mail/cltbld', 04:17:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:21 INFO - 'MOZ_NO_REMOTE': '1', 04:17:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:21 INFO - 'NO_EM_RESTART': '1', 04:17:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:21 INFO - 'PWD': '/builds/slave/test', 04:17:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:21 INFO - 'SHELL': '/bin/bash', 04:17:21 INFO - 'SHLVL': '1', 04:17:21 INFO - 'TERM': 'linux', 04:17:21 INFO - 'TMOUT': '86400', 04:17:21 INFO - 'USER': 'cltbld', 04:17:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1460113255.145727-200028318', 04:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:21 INFO - '_': '/tools/buildbot/bin/python'} 04:17:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:17:21 INFO - mozversion application_buildid: 20160408030000 04:17:21 INFO - mozversion application_changeset: e7466050cdd23e629ffbe97bfa9b8226d3cb7980 04:17:21 INFO - mozversion application_display_name: Nightly 04:17:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:21 INFO - mozversion application_name: Firefox 04:17:21 INFO - mozversion application_remotingname: firefox 04:17:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:17:21 INFO - mozversion application_vendor: Mozilla 04:17:21 INFO - mozversion application_version: 48.0a1 04:17:21 INFO - mozversion platform_buildid: 20160408030000 04:17:21 INFO - mozversion platform_changeset: e7466050cdd23e629ffbe97bfa9b8226d3cb7980 04:17:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:17:21 INFO - mozversion platform_version: 48.0a1 04:17:21 INFO - using testdate: 1460114241 04:17:21 INFO - actual date: 1460114241 04:17:21 INFO - starting webserver on 'localhost:39971' 04:17:21 INFO - SUITE-START | Running 2 tests 04:17:21 INFO - TEST-START | dromaeo_css 04:17:21 INFO - operating with platform_type : linux_ 04:17:21 INFO - Initialising browser for dromaeo_css test... 04:17:21 INFO - TEST-INFO | started process 6948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV5SeQj/profile http://localhost:39971/getInfo.html) 04:17:26 INFO - PROCESS | 6948 | __metrics Screen width/height:1600/1200 04:17:26 INFO - PROCESS | 6948 | colorDepth:24 04:17:26 INFO - PROCESS | 6948 | Browser inner width/height: 1024/697 04:17:26 INFO - PROCESS | 6948 | __metrics 04:17:27 ERROR - PROCESS | 6948 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:17:28 INFO - TEST-INFO | 6948: exit 0 04:17:28 INFO - Browser initialized. 04:17:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:28 INFO - TEST-INFO | started process 7029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV5SeQj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:39 INFO - PROCESS | 7029 | RSS: Main: 154771456 04:17:39 INFO - PROCESS | 7029 | 04:18:31 INFO - PROCESS | 7029 | 1460114311097 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] 04:20:42 INFO - PROCESS | 7029 | Cycle 1(1): loaded http://localhost:39971/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39971/tests/dromaeo/cssquery-ext.html) 04:20:43 INFO - PROCESS | 7029 | RSS: Main: 239497216 04:20:43 INFO - PROCESS | 7029 | 04:23:45 INFO - PROCESS | 7029 | Cycle 1(1): loaded http://localhost:39971/tests/dromaeo/cssquery-ext.html (next: http://localhost:39971/tests/dromaeo/cssquery-jquery.html) 04:23:46 INFO - PROCESS | 7029 | RSS: Main: 239579136 04:23:46 INFO - PROCESS | 7029 | 04:26:48 INFO - PROCESS | 7029 | Cycle 1(1): loaded http://localhost:39971/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39971/tests/dromaeo/cssquery-mootools.html) 04:26:48 INFO - PROCESS | 7029 | RSS: Main: 233795584 04:26:48 INFO - PROCESS | 7029 | 04:29:50 INFO - PROCESS | 7029 | Cycle 1(1): loaded http://localhost:39971/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39971/tests/dromaeo/cssquery-prototype.html) 04:29:51 INFO - PROCESS | 7029 | RSS: Main: 220422144 04:29:51 INFO - PROCESS | 7029 | 04:32:54 INFO - PROCESS | 7029 | Cycle 1(1): loaded http://localhost:39971/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39971/tests/dromaeo/cssquery-yui.html) 04:32:54 INFO - PROCESS | 7029 | RSS: Main: 219418624 04:32:54 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | Cycle 1(1): loaded http://localhost:39971/tests/dromaeo/cssquery-yui.html (next: http://localhost:39971/tests/dromaeo/cssquery-dojo.html) 04:35:57 INFO - PROCESS | 7029 | RSS: Main: 309239808 04:35:57 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | __start_tp_report 04:35:57 INFO - PROCESS | 7029 | _x_x_mozilla_page_load 04:35:57 INFO - PROCESS | 7029 | _x_x_mozilla_page_load_details 04:35:57 INFO - PROCESS | 7029 | |i|pagename|runs| 04:35:57 INFO - PROCESS | 7029 | |0;dojo.html;2610.243029521439;2676.1703871799746;2681.74523420275;2690.6233127362175;2714.5520989036804;4457.375967364572;4508.729476231429;4552.567506086921;4556.248219043858;4571.085782843432;4505.256632655608;4542.432195975503;4562.201614717428;4645.721256724599;4731.810727570902;4171.707980441371;4243.554426785189;4274.252005898971;4301.827926882921;4387.451568553931;4253.851115210969;4336.631386332166;4351;4351.847685331014;4384.320430333303;4081.795910204493;4147.585241475828;4151.3150330195485;4243.405923170759;4317.676174286941;4261.595148460891;4280.6361459275995;4284.485861696585;4290.270653988799;4329.112531930947;4277.286869943995;4280.250956082704;4282.42187304713;4318.978405107954;4330.155619654169;4398.626116780046;4459.888502787424;4485.596296333346;4556.7721613919175;4557.202489564346;4876.975615121937;4886.218205087204;4895.437024742165;4941.728204948727;4941.827036053721;4838.419389673227;4918.2376731606655;4920.6309526785635;4922.483139270396;4964.900701985976;4601.861944141681;4636.211843986531;4673.439187297546;4678.8128474861305;4679.532046795362;5025.899482010339;5062.7215503146945;5068;5068.594512438996;5111.948880511221;4732.905341893143;4810;4862.82980095695;4869.466118172764;4870.975645121752;4961.08219979305;4967.652264341461;4971.204607262893;4995.300657907896;5025.994801039807;4925.581325587294;4939.48135445773;4945.629077819178;4947.678400903929;4993.425756038102;4720.645951553579;4904.313396124546;4925.064237794808;4983.526564976321;4989.900201996013;4224.5353011168745;4225.133847561243;4233.238017156941;4254.085371645111;4259.61663450291;3693.169036966715;3698.167912219783;3705.27747089315;3738.8504459821847;3751.0622344413896;4202.495700515958;4265.87202383929;4285.18581469526;4294.849680261238;4371.431713877239;4890.462049174588;4896.2655601660035;4896.608271338356;4914.213725803854;4925;4235.53409124996;4240.427542281753;4241.978790106092;4247.5964783345535;4285.250081235834;4415.359772832985;4435.445569303837;4510.864674059783;4568.406107206042;4584.9541504585195;4669.603083737852;4682.063587282625;4700.388949436551;4705.294205869147;4746.7863946121815;4936.3089167515855;4955.578775803953;4956.553910148104;4957.677750946177;5007.499250074963;4583.839565615188;4707.270373092176;4728.1252968201;4738.668293219579;4778.402699662543;4792.95207047925;4801.68789028712;4813.975930120327;4814.446338671098;4861.562459378673;4710.081534100817;4859.4654587996;4894.583960363409;4896.167651499325;4942.1104201244125;4761.547652972962;4777.116233496814;4791.089692958327;4813.975930120467;4831.710097394168;4738.312944622941;4772.308015337687;4779.593734532604;4781.7609119543185;4831.033793241296;4567.748773817472;4700.670953033392;4715.292706094114;4734.100520901018;4787.521247875185;4838.153323168502;4839.443464001685;4851.878703032452;4868.196747536758;4897.755112244302;4749.216379297515;4750.073735621659;4754.21555443348;4766.356541866804;4809.95190048109 04:35:57 INFO - PROCESS | 7029 | |1;ext.html;575.9193712880195;585.4730742331901;606.0757345048803;611.7400104955394;633.6071635585935;26610.33474163147;27285.863570682144;27297.181084567444;27307.180784576445;33560.66439335606;39925;40595;40663.79668101655;40691;40708.79645601768;7781.572013539253;7965.920340796576;7975.880361794578;7976.361891048702;7978.880316795253;7650.8469830603635;7768.805779855492;7774.378049756035;7786.571738554378;7791.3766898648255;7788.532688038736;7814.804629884242;7825.37397008238;7843.333316668061;7843.960780196091;7734;7772.572508512029;7780.727674531393;7781.96109019457;7789;7823.960880195563;7913.129555748863;7915;7929.762107136795;7933.325667318285;37975.810120949216;38513.88173650448;38538.0365490865;38602.61397386046;38683;3046.8933587324336;3208.0696597986557;3267.526208699749;3314.734821214297;3730.1047748540427;28303;28995.71004289951;29355.55966660502;29423;30051.248718781986;3097.0863595239457;3145.9528107078413;3180.3480286541435;3245.4969479730444;3283.40898638245;231956;234065;234098.4196659343;234635.8268208665;234870;32994.67005329916;34062.829685851415;51684;51944.22083668748;51983.48016519862;31265.374692506477;31329.686703132676;31440.842795785873;31450.842745786125;31468.37063258722;13308.667283317995;13423.798643020362;13533.902245152018;13539.45842166322;13573.796393054112;11281.774364512663;11441.771164576661;11450.770984580262;11455.541778328774;11464.770704586028;8077.434579579373;8140.837183256302;8177.632006559719;8194.057683366489;8225.136360682041;3213.50190720434;3241.9027429177163;3248.6264079631146;3269.9509507357407;3286.7206287465356;921.7972046149837;944.6363150187227;956.7512446763892;973.4743238651049;994.0556471352244;26180.345491362867;26619;27834.304142396602;28020.43959120806;28036.579451308247;969.7042402067437;999.4453078541479;1006.3358183598936;1027.9206832825503;1042.6924057403085;14395.712085758436;15056.548303550911;15214.239288035555;15277.38890444392;15278.38886444552;332256;336049;337124;337418;338015;45520;46170.76914615473;46252.306215406796;46269.30596040995;46362.53637463582;1069.5240617924949;1213.7815193265296;1229.8339724137306;1246.6197809667956;1254.868238834909;26700;27777;27866;27896.163115106578;28233.294167645974;37332.440013400366;47566;49154;49194.75402622964;49211.261831071846;325506;326362;330253;330556;331169;33229;33447;34165;37375.813120934225;38130.61869381271;41749;43430.56569434392;43849.56150438455;44213.11573768571;44833.55166448424;30909.227269318446;32257.032289031366;34940.82529587336;36777.81611091927;37193.81403092967;31085.222869428446;32413;33428.832855835564;33582.66417335893;34198.48702269418;33532.161695957795;33928.321433571684;34118.31763364669;34416.82791586026;34500.137496562784;29263.414731705674;30602.387952241275;30657.233569160948;30711.539326909668;31034;23540.176093836635;23975.280741577084;24414.26757197287;24430.26709198727;24654.383640409134 04:35:57 INFO - PROCESS | 7029 | |2;jquery.html;362.06948143271796;362.4671732553146;363.25532658051003;384.52895203375886;386.277660774352;16559.751603725937;17149.056801875893;17414.825851741494;17445.3021879125;17462.388816391427;16086.678266434665;16435.2604132814;16435.424760133366;16962.151892405393;16965.660686786257;5003.324551185579;5158.845234642967;5200.063988482072;5207.375114986207;5208.921866172011;3716.5725941516666;3885.494885664874;3906.0430194602363;3925.7448265862627;5145.974270128663;3922.0391004203866;5962.463378295953;5968.462838344548;5968.79109231177;5972.88054238915;5860.824175274706;5917.733701983421;5926.674032928187;5944.940550594482;5953.285605727318;3326.900192994214;5114.156164232897;5233.921491177635;5278.577713782888;5281.894362112775;18507.259709611735;19318.517037074187;19476.70784938227;19678.70481942772;20892.895535522224;1984.9503762405911;2041.2345370486069;2287.4395773035544;2337.812974961999;2540.771330580238;12797.872021279762;13112.213267203999;13139.145955512957;13142.802857957138;13471.797923031163;1763.2241813601975;1808.1456064448676;1821.9908900455546;1825.534488705385;1838.7793464784177;65188.348116518704;65865;66505.00242496414;66846;67066.66466667636;8961.327900407496;9176.26589872822;9596;9656.613735450645;9883.901160988442;13501;13646.454141834414;13663.248521331223;13675.726485470235;13716.108452950526;7417.443691723142;7471;7509.249075092447;7665.961670191613;7668.808279792938;7215.567065976058;7248.746293879689;7249.637518124073;7392.889106663404;7421.332080112816;5781.4218578141845;5876.265466816648;5975.282966044103;5979.1629171915965;6022.909656355158;1695.4828777223065;1697.7198762204098;1703.608170120879;1712.5889786451162;1749.2303386509896;897.721398178705;923.2383283790899;939.699296225215;951.2342564235856;1005.6681295172575;16733.58166045834;16865.747013794804;17112.315507379815;17122.828771712124;17519.47441576755;884.0364003236375;897.5512243878061;899.2086963472234;916.8808054952814;961.4471678784727;9513.714588562354;9555.952220238854;9575.138237558653;9818.250889750881;9885;387676;394146;399423;402524;407485;35238;61130;66154.66922665355;67251;68454.35311963638;897.3135551303258;905.343625871238;927.6335847340263;930.5347326336831;959.832029394867;15651.37394504207;15693.293801778718;15770.763438548202;15886.443974460839;16214.756778648565;31550;34930.47604285989;35236;36651.45022824607;36881;41444.1711165781;44182.77908610436;46560;47009.76495117503;48222;7421.888671669822;7512.812179695551;7620.5808680523105;7635.00744903159;7684.269994350528;10782.622608208674;10914.126869850552;11038.724031899266;11055.447227638746;11171.52940006978;9900.20798336117;9910.950445247727;9940.1053905146;9940.652077177265;10226.670532830982;9467.715968520955;9698.175655069399;9722.513874306398;9732.513374331114;9754.707358779247;9789.9021009789;9984.35101718386;10113.544890480092;10175.949120254352;10355.689329320132;6445.452136568444;7377.631118443949;7649.120351159688;7658.7319443821425;7668.80827979305;7858.410619203697;9563.234941204548;9644.9035509644;10033.304539303652;10163.491825408848 04:35:57 INFO - PROCESS | 7029 | |3;mootools.html;1279.0151583280879;1371.3211960079761;1421.1757180835116;1511.6069821846318;1762.6562820250056;6612.86774264515;6838.281980392062;7660.770176894688;7871.527708337504;7886.487378320405;7775.339096176832;7781.144074151839;7840.7255746048895;7844.294013538781;7859.607019649024;1858.1545396844404;2142.442964829148;2195.9451013724624;2226.1763147635397;2227.0535022615322;2227.13141874669;2238.809701175402;2242.8766417847014;2242.9102835886547;2243.663450482424;2171.9782802172012;2181.1711549611127;2226.4545186429345;2226.6993955816;2232.408411770882;2134.3170185540635;2147.5597502511946;2148.4091874734418;2148.4521447030984;2168.0894024509744;2159.406163305088;2188.1794327127327;2190.539986602815;2190.5618876224817;2190.835687323457;7838.059432868035;7867.291943725035;7967.880481792778;7969.681212751483;7986.880196797053;4504.25679762842;4526.343680166357;4602.033572949685;4618.422697162855;4705.011947491031;2853.985730071357;2867.899623513188;2915.9708402915912;2933.9853300733575;2959.6300462442196;950.7860731335394;960.6109525642127;985.9112679858775;991.4101109839634;1010.7624708193568;10855.402952837512;10877.728056798644;10889.727756806064;10910.181736369805;10947.178961577914;4056.9797151014054;4146.150039241948;4216.831326746896;4285.228658841438;4293.034067334825;9168.724938251864;9253.259739220846;9271.76820579491;9290.907090929139;9301.162895339452;4695.929561056587;4709.340692303081;4711.175544279738;4717.3159891816185;4723.220668589644;3707.4994875691436;4100.446439730657;4235.576442355801;4242.257604919127;4259.1268789897995;3661;3719;3758.4362345648374;3766.2844059628583;3829.2915810574577;1217.1723228204905;1234.9567765128177;1281.1992504684572;1281.641140480667;1299.4672184404537;1196.2702751321688;1212.3271584270815;1227.110344999868;1228.680543058811;1234.672811704899;7310.780676579711;7313.963430182815;7315.085614298213;7361.963190184015;7512.6243687815395;1060.3478860500736;1070.812607793633;1083.2254937719567;1097.4786976186247;1099.279971618575;5368.91946620801;5617.971910140505;5766.279215098113;5812.82561523155;5817.825465236049;9316.95341523288;9778.559964801601;9804.65683701067;9811.607535698493;9834.704958851245;9460.432374057578;9514.619415223451;9678.56446459911;9691.418514889128;9951.353162044445;7392.112946446461;7545.584992825447;7558.508696934681;7573.242675732493;7638.274363935418;7201.819954501179;7281.017062696468;7332.670029848777;7352.816179595553;7379.557226566423;8712.825743484967;9045.547722613974;9080.727578172666;9105.908940910505;9260.49067301305;9140.817183656423;9153.816923661356;9303.906960930304;9321.30090243221;9377.718668439958;5650.152477128464;5816.651000939957;5828.912566311594;6452.967525195946;6563.573367731082;6629.867402652017;6680.298568650416;7346.5592064476305;7575.166731659623;7630.8092297693;6796.694148763417;6912.55068420551;6920.134983127109;7008.5094043416475;7032.542884712478;6698.430633396021;6755.493337999571;6789.355011273921;6871.106756121672;6931.965340173267;7061.858762824818;7104.14750229955;7104.964475177591;7165.677544510614;7183.173934997542;6602.141721576164;6634.004899265149;6692.464602831665;6699.497537684791;6714.227863795726;6731;6824.317568243136;6831;6839.897401538881;6856.485763567653 04:35:57 INFO - PROCESS | 7029 | |4;prototype.html;301.1897994395077;307.6246978686003;310.59932686833986;315.7489795612488;318.3839271010593;5020.096382651117;5023.271625614284;5025.924611130831;5038.622103342254;5084.262781896623;4993.25101234815;5007.2489126630935;5016.623753218505;5022.146235140026;5034.949650503494;3975.642192202701;3993.0616305168264;3995.680345572347;3999.620036096581;4005.759654420744;3695.722820788438;3941.940870886939;3956.7823769692654;4003.499562554681;4014.558398576154;3886.436466712325;3890.3580909150096;3905.628965248297;3911.2568611963634;3914.064451661254;3663.6153203913473;3886.067343837459;3889.9416508752392;3910.706696997708;3911.3546264866263;3279.426100432415;3312.850921708529;3415.8121303328307;3420.4698271767916;3424.6404127566498;4760.857174284777;4772.5227477252;4776.11641846256;4782.593479554242;4798.2802579613335;4186.665066794649;4228.133232687292;4462.486814016397;4467.463904331501;4489.6408287336935;5243.449437809013;5291.28567643367;5296.232046353296;5297.708626025567;5298.682079075229;3696.1868388954654;3704.74066815323;3709.4806727058235;3709.962900370989;3720.655986728371;5367.704776237305;5514.503694667499;5515.972420137914;5580.330360356743;5580.358258800249;3778.886633401002;3794.734368594227;3822.48396466479;3827.1771569112775;3827.196288779332;3839.6928245740273;3855.614438556178;3861;3865.381538953754;3889.630485103911;4431.224535706238;4431.645468362588;4436.6672499562665;4443.600075993111;4449.377087207794;5033.521815427529;5290.523852853262;5291.603129765283;5300.575953923677;5308.708021058879;1341.932903354848;1348.9190648561118;1353.2759973414372;1353.8713822186876;1359.6600849787553;888.9066648001867;907.8592818113203;923.8845144356956;924.7919218175857;925.319889880937;4663.48701642819;4673.228917228619;4679.181143299909;4685;4690.15577196108;5423.972880135653;5424.7016414096815;5433.701146436984;5441.183822426668;5448.673079615236;4500.437445319335;4665.206914824488;4671.43942726875;4681.180793361148;4682.484926658065;2775.2923004634094;2826.321682796155;2895.5222388306115;2923.780716446275;2929.472694914936;5195.974020129951;5206.349206349207;5213.661112027706;5213.661112027706;5218.217267409919;5398.190271459234;5588.636738611977;5595.07681232592;5608.46719561641;5613.214150019001;5170.095233334227;5198.662086964411;5202.583793296527;5212.166053431432;5213.478652134756;5428.647137936022;5430.321209848769;5446.891062178814;5462.579729270339;5464.3442786865835;5063.392392912874;5313.388960269618;5334.7458050589885;5342.198670199501;5361.678299302054;5176.689398635944;5181.430042695225;5195.74021298926;5206.271122042993;5233.659812112201;3794.241151769602;3832.1760821423527;3836.9808150959066;3851.9614803851605;3865.710071744574;5157.948420515747;5426.70153141581;5453.427390124139;5454.536364409069;5477.397486276586;5295.417504074471;5307.071262529119;5314.22943673173;5315.149576067811;5324.494173053554;5225.190095535198;5228.790848366023;5234.659747116578;5242.790288388422;5292.603054770831;4973.204287314013;5219.660722053054;5230.633855630222;5231.378272735465;5250.028744682246;5327.121025030827;5335.706536140394;5336.17289320156;5336.67979921206;5345.625806193529;5204.5687435955415;5206.947930520646;5215.895682086413;5216.452272511332;5235.4502777207845 04:35:57 INFO - PROCESS | 7029 | |5;yui.html;664.797236842763;665.8634979829136;736.8415790605019;740.6592967235072;756.2286467802842;11421.828672569907;12062.638120856378;12305.753884922318;12345.25928444294;12368.628941131768;11983.101267404936;12183.269003859774;12373.381330933462;12404.069694772905;12430.813537796941;648.3872740260456;782.898223230982;794.1462927353105;803.1526739290047;809.380823669893;797.4457751862429;798.9560574168419;802.6227672993713;802.9277365037145;805.1706742055692;836.1178956201205;850.6257246811414;851.2041241439243;852.3905407633541;852.9232369086781;670.4502308107354;820.9343252539783;838.8406202821444;844.3582877013453;848.2832006954114;621.8134559632138;622.1041699952054;622.2750495672582;622.5704264057831;622.6575383539035;12008.819867701992;12103.878961210452;12105.636830895088;12108;12117.27296362221;12512.311822849739;12853.87146128536;12930.09489335747;13004.414801333962;13081.28052957087;9281.907180928172;9432.811343773155;9547.2839537035;9566.426014439156;9686.51567421633;3341.96658033419;3391.3895498810202;3418.504316874064;3419.111031131899;3435.862565497402;45423;45774.85562860922;45908;45920.3111953321;46007.30989035167;9102.90897091034;9129.497877616663;9328.099515688968;9486.762830929281;9602;17455.563610909576;17663;17763.11184440773;17860.642787144185;17894.731579026324;6644.900326495106;6652.70062847173;6665.533412661067;6690.59856408617;6983.2318444971015;3823.751456155341;3894.552126505488;3895.824687889052;3926.509186351706;4024.215278020816;2675.665541807274;2753.7383948524857;2756.503829310703;2760.8205466645004;2761.8204816686853;412.3299638088107;500.1123006663202;518.284767021508;518.4038355890681;541.0261529247339;536.3188750287113;541.7535021565178;544.964577302482;569.9344575373802;586.5073338395769;7861.135275119732;7876.56678882667;7972.960135199403;8059;8223.342132629496;445.1364353154869;518.8728761453468;537.2800447400502;583.6760597868224;595.6158277910723;3795.5065841440437;3813.60803306791;3863.2466668999277;3879.359905615598;3911.5501717302873;52468.73765631224;53431.19853202205;53725.1941220882;54002;54174;45219.64341069773;46782.76608616935;47263.5273647266;47311;47416.7629161852;42916.35625465683;43284;43421.782891085975;43827.56172438235;44060.559394406286;7543.7736867894055;7556.508826926232;7758.88361674564;7787.143414224318;7843.882341764992;29989.35165049421;30907.69092309138;30942.845285773426;30962;31231.687683123786;38266;39156.80421597988;39315;39487.80256098701;39869.60130398775;9873.654422095193;9948.552315145691;10042.447665378475;10161.898381016095;10191.082802547806;10673.35959842412;10886.510107045044;10967.177461690246;11028.889711103107;11444.885551144382;9880.752981175241;9885.258605604464;10024.649137280161;10169.491525423848;10487.10859576914;10106.292559520763;10213.795724085625;10464.686059418229;10541.262111652111;10773.084287835309;9932.354396964174;10362.792744144925;10520.947395262974;10526.31578947366;10668.786624267626;8191.508509489449;8372.455790373606;8406.369522285975;8743.91256087431;8855.3801233913;8038.638261278374;8681.131886811268;8753.956230218808;8756.912430875864;8774 04:35:57 INFO - PROCESS | 7029 | __end_tp_report 04:35:57 INFO - PROCESS | 7029 | __start_cc_report 04:35:57 INFO - PROCESS | 7029 | _x_x_mozilla_cycle_collect,866 04:35:57 INFO - PROCESS | 7029 | __end_cc_report 04:35:57 INFO - PROCESS | 7029 | __startTimestamp1460115357920__endTimestamp 04:35:57 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | ------- Summary: start ------- 04:35:57 INFO - PROCESS | 7029 | Number of tests: 6 04:35:57 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | [#0] dojo.html Cycles:165 Average:4567.86 Median:4710.08 stddev:455.47 (9.7%) stddev-sans-first:430.20 04:35:57 INFO - PROCESS | 7029 | Values: 2610.2 2676.2 2681.7 2690.6 2714.6 4457.4 4508.7 4552.6 4556.2 4571.1 4505.3 4542.4 4562.2 4645.7 4731.8 4171.7 4243.6 4274.3 4301.8 4387.5 4253.9 4336.6 4351.0 4351.8 4384.3 4081.8 4147.6 4151.3 4243.4 4317.7 4261.6 4280.6 4284.5 4290.3 4329.1 4277.3 4280.3 4282.4 4319.0 4330.2 4398.6 4459.9 4485.6 4556.8 4557.2 4877.0 4886.2 4895.4 4941.7 4941.8 4838.4 4918.2 4920.6 4922.5 4964.9 4601.9 4636.2 4673.4 4678.8 4679.5 5025.9 5062.7 5068.0 5068.6 5111.9 4732.9 4810.0 4862.8 4869.5 4871.0 4961.1 4967.7 4971.2 4995.3 5026.0 4925.6 4939.5 4945.6 4947.7 4993.4 4720.6 4904.3 4925.1 4983.5 4989.9 4224.5 4225.1 4233.2 4254.1 4259.6 3693.2 3698.2 3705.3 3738.9 3751.1 4202.5 4265.9 4285.2 4294.8 4371.4 4890.5 4896.3 4896.6 4914.2 4925.0 4235.5 4240.4 4242.0 4247.6 4285.3 4415.4 4435.4 4510.9 4568.4 4585.0 4669.6 4682.1 4700.4 4705.3 4746.8 4936.3 4955.6 4956.6 4957.7 5007.5 4583.8 4707.3 4728.1 4738.7 4778.4 4793.0 4801.7 4814.0 4814.4 4861.6 4710.1 4859.5 4894.6 4896.2 4942.1 4761.5 4777.1 4791.1 4814.0 4831.7 4738.3 4772.3 4779.6 4781.8 4831.0 4567.7 4700.7 4715.3 4734.1 4787.5 4838.2 4839.4 4851.9 4868.2 4897.8 4749.2 4750.1 4754.2 4766.4 4810.0 04:35:57 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | [#1] ext.html Cycles:180 Average:44301.81 Median:33546.41 stddev:79785.70 (237.8%) stddev-sans-first:79941.98 04:35:57 INFO - PROCESS | 7029 | Values: 575.9 585.5 606.1 611.7 633.6 26610.3 27285.9 27297.2 27307.2 33560.7 39925.0 40595.0 40663.8 40691.0 40708.8 7781.6 7965.9 7975.9 7976.4 7978.9 7650.8 7768.8 7774.4 7786.6 7791.4 7788.5 7814.8 7825.4 7843.3 7844.0 7734.0 7772.6 7780.7 7782.0 7789.0 7824.0 7913.1 7915.0 7929.8 7933.3 37975.8 38513.9 38538.0 38602.6 38683.0 3046.9 3208.1 3267.5 3314.7 3730.1 28303.0 28995.7 29355.6 29423.0 30051.2 3097.1 3146.0 3180.3 3245.5 3283.4 231956.0 234065.0 234098.4 234635.8 234870.0 32994.7 34062.8 51684.0 51944.2 51983.5 31265.4 31329.7 31440.8 31450.8 31468.4 13308.7 13423.8 13533.9 13539.5 13573.8 11281.8 11441.8 11450.8 11455.5 11464.8 8077.4 8140.8 8177.6 8194.1 8225.1 3213.5 3241.9 3248.6 3270.0 3286.7 921.8 944.6 956.8 973.5 994.1 26180.3 26619.0 27834.3 28020.4 28036.6 969.7 999.4 1006.3 1027.9 1042.7 14395.7 15056.5 15214.2 15277.4 15278.4 332256.0 336049.0 337124.0 337418.0 338015.0 45520.0 46170.8 46252.3 46269.3 46362.5 1069.5 1213.8 1229.8 1246.6 1254.9 26700.0 27777.0 27866.0 27896.2 28233.3 37332.4 47566.0 49154.0 49194.8 49211.3 325506.0 326362.0 330253.0 330556.0 331169.0 33229.0 33447.0 34165.0 37375.8 38130.6 41749.0 43430.6 43849.6 44213.1 44833.6 30909.2 32257.0 34940.8 36777.8 37193.8 31085.2 32413.0 33428.8 33582.7 34198.5 33532.2 33928.3 34118.3 34416.8 34500.1 29263.4 30602.4 30657.2 30711.5 31034.0 23540.2 23975.3 24414.3 24430.3 24654.4 04:35:57 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | [#2] jquery.html Cycles:180 Average:23814.09 Median:5130.07 stddev:65288.34 (1272.7%) stddev-sans-first:65447.75 04:35:57 INFO - PROCESS | 7029 | Values: 362.1 362.5 363.3 384.5 386.3 16559.8 17149.1 17414.8 17445.3 17462.4 16086.7 16435.3 16435.4 16962.2 16965.7 5003.3 5158.8 5200.1 5207.4 5208.9 3716.6 3885.5 3906.0 3925.7 5146.0 3922.0 5962.5 5968.5 5968.8 5972.9 5860.8 5917.7 5926.7 5944.9 5953.3 3326.9 5114.2 5233.9 5278.6 5281.9 18507.3 19318.5 19476.7 19678.7 20892.9 1985.0 2041.2 2287.4 2337.8 2540.8 12797.9 13112.2 13139.1 13142.8 13471.8 1763.2 1808.1 1822.0 1825.5 1838.8 65188.3 65865.0 66505.0 66846.0 67066.7 8961.3 9176.3 9596.0 9656.6 9883.9 13501.0 13646.5 13663.2 13675.7 13716.1 7417.4 7471.0 7509.2 7666.0 7668.8 7215.6 7248.7 7249.6 7392.9 7421.3 5781.4 5876.3 5975.3 5979.2 6022.9 1695.5 1697.7 1703.6 1712.6 1749.2 897.7 923.2 939.7 951.2 1005.7 16733.6 16865.7 17112.3 17122.8 17519.5 884.0 897.6 899.2 916.9 961.4 9513.7 9556.0 9575.1 9818.3 9885.0 387676.0 394146.0 399423.0 402524.0 407485.0 35238.0 61130.0 66154.7 67251.0 68454.4 897.3 905.3 927.6 930.5 959.8 15651.4 15693.3 15770.8 15886.4 16214.8 31550.0 34930.5 35236.0 36651.5 36881.0 41444.2 44182.8 46560.0 47009.8 48222.0 7421.9 7512.8 7620.6 7635.0 7684.3 10782.6 10914.1 11038.7 11055.4 11171.5 9900.2 9911.0 9940.1 9940.7 10226.7 9467.7 9698.2 9722.5 9732.5 9754.7 9789.9 9984.4 10113.5 10175.9 10355.7 6445.5 7377.6 7649.1 7658.7 7668.8 7858.4 9563.2 9644.9 10033.3 10163.5 04:35:57 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | [#3] mootools.html Cycles:180 Average:5489.14 Median:6582.86 stddev:2926.34 (44.5%) stddev-sans-first:2917.44 04:35:57 INFO - PROCESS | 7029 | Values: 1279.0 1371.3 1421.2 1511.6 1762.7 6612.9 6838.3 7660.8 7871.5 7886.5 7775.3 7781.1 7840.7 7844.3 7859.6 1858.2 2142.4 2195.9 2226.2 2227.1 2227.1 2238.8 2242.9 2242.9 2243.7 2172.0 2181.2 2226.5 2226.7 2232.4 2134.3 2147.6 2148.4 2148.5 2168.1 2159.4 2188.2 2190.5 2190.6 2190.8 7838.1 7867.3 7967.9 7969.7 7986.9 4504.3 4526.3 4602.0 4618.4 4705.0 2854.0 2867.9 2916.0 2934.0 2959.6 950.8 960.6 985.9 991.4 1010.8 10855.4 10877.7 10889.7 10910.2 10947.2 4057.0 4146.2 4216.8 4285.2 4293.0 9168.7 9253.3 9271.8 9290.9 9301.2 4695.9 4709.3 4711.2 4717.3 4723.2 3707.5 4100.4 4235.6 4242.3 4259.1 3661.0 3719.0 3758.4 3766.3 3829.3 1217.2 1235.0 1281.2 1281.6 1299.5 1196.3 1212.3 1227.1 1228.7 1234.7 7310.8 7314.0 7315.1 7362.0 7512.6 1060.3 1070.8 1083.2 1097.5 1099.3 5368.9 5618.0 5766.3 5812.8 5817.8 9317.0 9778.6 9804.7 9811.6 9834.7 9460.4 9514.6 9678.6 9691.4 9951.4 7392.1 7545.6 7558.5 7573.2 7638.3 7201.8 7281.0 7332.7 7352.8 7379.6 8712.8 9045.5 9080.7 9105.9 9260.5 9140.8 9153.8 9303.9 9321.3 9377.7 5650.2 5816.7 5828.9 6453.0 6563.6 6629.9 6680.3 7346.6 7575.2 7630.8 6796.7 6912.6 6920.1 7008.5 7032.5 6698.4 6755.5 6789.4 6871.1 6932.0 7061.9 7104.1 7105.0 7165.7 7183.2 6602.1 6634.0 6692.5 6699.5 6714.2 6731.0 6824.3 6831.0 6839.9 6856.5 04:35:57 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | [#4] prototype.html Cycles:180 Average:4381.04 Median:5022.71 stddev:1281.12 (25.5%) stddev-sans-first:1247.57 04:35:57 INFO - PROCESS | 7029 | Values: 301.2 307.6 310.6 315.7 318.4 5020.1 5023.3 5025.9 5038.6 5084.3 4993.3 5007.2 5016.6 5022.1 5034.9 3975.6 3993.1 3995.7 3999.6 4005.8 3695.7 3941.9 3956.8 4003.5 4014.6 3886.4 3890.4 3905.6 3911.3 3914.1 3663.6 3886.1 3889.9 3910.7 3911.4 3279.4 3312.9 3415.8 3420.5 3424.6 4760.9 4772.5 4776.1 4782.6 4798.3 4186.7 4228.1 4462.5 4467.5 4489.6 5243.4 5291.3 5296.2 5297.7 5298.7 3696.2 3704.7 3709.5 3710.0 3720.7 5367.7 5514.5 5516.0 5580.3 5580.4 3778.9 3794.7 3822.5 3827.2 3827.2 3839.7 3855.6 3861.0 3865.4 3889.6 4431.2 4431.6 4436.7 4443.6 4449.4 5033.5 5290.5 5291.6 5300.6 5308.7 1341.9 1348.9 1353.3 1353.9 1359.7 888.9 907.9 923.9 924.8 925.3 4663.5 4673.2 4679.2 4685.0 4690.2 5424.0 5424.7 5433.7 5441.2 5448.7 4500.4 4665.2 4671.4 4681.2 4682.5 2775.3 2826.3 2895.5 2923.8 2929.5 5196.0 5206.3 5213.7 5213.7 5218.2 5398.2 5588.6 5595.1 5608.5 5613.2 5170.1 5198.7 5202.6 5212.2 5213.5 5428.6 5430.3 5446.9 5462.6 5464.3 5063.4 5313.4 5334.7 5342.2 5361.7 5176.7 5181.4 5195.7 5206.3 5233.7 3794.2 3832.2 3837.0 3852.0 3865.7 5157.9 5426.7 5453.4 5454.5 5477.4 5295.4 5307.1 5314.2 5315.1 5324.5 5225.2 5228.8 5234.7 5242.8 5292.6 4973.2 5219.7 5230.6 5231.4 5250.0 5327.1 5335.7 5336.2 5336.7 5345.6 5204.6 5206.9 5215.9 5216.5 5235.5 04:35:57 INFO - PROCESS | 7029 | 04:35:57 INFO - PROCESS | 7029 | [#5] yui.html Cycles:180 Average:12698.47 Median:47363.88 stddev:14707.33 (31.1%) stddev-sans-first:14720.83 04:35:57 INFO - PROCESS | 7029 | Values: 664.8 665.9 736.8 740.7 756.2 11421.8 12062.6 12305.8 12345.3 12368.6 11983.1 12183.3 12373.4 12404.1 12430.8 648.4 782.9 794.1 803.2 809.4 797.4 799.0 802.6 802.9 805.2 836.1 850.6 851.2 852.4 852.9 670.5 820.9 838.8 844.4 848.3 621.8 622.1 622.3 622.6 622.7 12008.8 12103.9 12105.6 12108.0 12117.3 12512.3 12853.9 12930.1 13004.4 13081.3 9281.9 9432.8 9547.3 9566.4 9686.5 3342.0 3391.4 3418.5 3419.1 3435.9 45423.0 45774.9 45908.0 45920.3 46007.3 9102.9 9129.5 9328.1 9486.8 9602.0 17455.6 17663.0 17763.1 17860.6 17894.7 6644.9 6652.7 6665.5 6690.6 6983.2 3823.8 3894.6 3895.8 3926.5 4024.2 2675.7 2753.7 2756.5 2760.8 2761.8 412.3 500.1 518.3 518.4 541.0 536.3 541.8 545.0 569.9 586.5 7861.1 7876.6 7973.0 8059.0 8223.3 445.1 518.9 537.3 583.7 595.6 3795.5 3813.6 3863.2 3879.4 3911.6 52468.7 53431.2 53725.2 54002.0 54174.0 45219.6 46782.8 47263.5 47311.0 47416.8 42916.4 43284.0 43421.8 43827.6 44060.6 7543.8 7556.5 7758.9 7787.1 7843.9 29989.4 30907.7 30942.8 30962.0 31231.7 38266.0 39156.8 39315.0 39487.8 39869.6 9873.7 9948.6 10042.4 10161.9 10191.1 10673.4 10886.5 10967.2 11028.9 11444.9 9880.8 9885.3 10024.6 10169.5 10487.1 10106.3 10213.8 10464.7 10541.3 10773.1 9932.4 10362.8 10520.9 10526.3 10668.8 8191.5 8372.5 8406.4 8743.9 8855.4 8038.6 8681.1 8754.0 8756.9 8774.0 04:35:57 INFO - PROCESS | 7029 | -------- Summary: end -------- 04:35:57 INFO - PROCESS | 7029 | 04:35:58 INFO - TEST-INFO | 7029: exit 0 04:35:58 INFO - TEST-OK | dromaeo_css | took 1116940ms 04:35:58 INFO - TEST-START | kraken 04:35:58 INFO - operating with platform_type : linux_ 04:35:58 INFO - Initialising browser for kraken test... 04:35:58 INFO - TEST-INFO | started process 7205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6e944/profile http://localhost:39971/getInfo.html) 04:36:02 INFO - PROCESS | 7205 | __metrics Screen width/height:1600/1200 04:36:02 INFO - PROCESS | 7205 | colorDepth:24 04:36:02 INFO - PROCESS | 7205 | Browser inner width/height: 1024/697 04:36:02 INFO - PROCESS | 7205 | __metrics 04:36:03 ERROR - PROCESS | 7205 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:36:04 INFO - TEST-INFO | 7205: exit 0 04:36:04 INFO - Browser initialized. 04:36:04 INFO - Running cycle 1/1 for kraken test... 04:36:04 INFO - TEST-INFO | started process 7284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6e944/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:16 INFO - PROCESS | 7284 | RSS: Main: 154267648 04:36:16 INFO - PROCESS | 7284 | 04:36:19 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39971/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:19 INFO - PROCESS | 7284 | RSS: Main: 194535424 04:36:19 INFO - PROCESS | 7284 | 04:36:22 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39971/tests/kraken/driver.html?testName=audio-dft) 04:36:23 INFO - PROCESS | 7284 | RSS: Main: 185495552 04:36:23 INFO - PROCESS | 7284 | 04:36:26 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39971/tests/kraken/driver.html?testName=audio-fft) 04:36:26 INFO - PROCESS | 7284 | RSS: Main: 170962944 04:36:26 INFO - PROCESS | 7284 | 04:36:28 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39971/tests/kraken/driver.html?testName=audio-oscillator) 04:36:29 INFO - PROCESS | 7284 | RSS: Main: 172298240 04:36:29 INFO - PROCESS | 7284 | 04:36:31 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39971/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:32 INFO - PROCESS | 7284 | RSS: Main: 174268416 04:36:32 INFO - PROCESS | 7284 | 04:36:35 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39971/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:36 INFO - PROCESS | 7284 | RSS: Main: 174387200 04:36:36 INFO - PROCESS | 7284 | 04:36:39 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39971/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:40 INFO - PROCESS | 7284 | RSS: Main: 175222784 04:36:40 INFO - PROCESS | 7284 | 04:36:42 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39971/tests/kraken/driver.html?testName=json-parse-financial) 04:36:43 INFO - PROCESS | 7284 | RSS: Main: 175116288 04:36:43 INFO - PROCESS | 7284 | 04:36:45 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39971/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:45 INFO - PROCESS | 7284 | RSS: Main: 184541184 04:36:45 INFO - PROCESS | 7284 | 04:36:47 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39971/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:48 INFO - PROCESS | 7284 | RSS: Main: 181592064 04:36:48 INFO - PROCESS | 7284 | 04:36:50 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39971/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:51 INFO - PROCESS | 7284 | RSS: Main: 193634304 04:36:51 INFO - PROCESS | 7284 | 04:36:53 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:54 INFO - PROCESS | 7284 | RSS: Main: 197582848 04:36:54 INFO - PROCESS | 7284 | 04:36:57 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:57 INFO - PROCESS | 7284 | RSS: Main: 198008832 04:36:57 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | Cycle 1(1): loaded http://localhost:39971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39971/tests/kraken/driver.html?testName=ai-astar) 04:36:59 INFO - PROCESS | 7284 | RSS: Main: 260636672 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | __start_tp_report 04:36:59 INFO - PROCESS | 7284 | _x_x_mozilla_page_load 04:36:59 INFO - PROCESS | 7284 | _x_x_mozilla_page_load_details 04:36:59 INFO - PROCESS | 7284 | |i|pagename|runs| 04:36:59 INFO - PROCESS | 7284 | |0;ai-astar;113;113;108;114;114;113;103;113;112;113 04:36:59 INFO - PROCESS | 7284 | |1;audio-beat-detection;159;131;157;188;144;162;171;134;179;133 04:36:59 INFO - PROCESS | 7284 | |2;audio-dft;160;160;160;159;160;162;161;162;160;161 04:36:59 INFO - PROCESS | 7284 | |3;audio-fft;74;76;104;103;74;74;73;114;105;74 04:36:59 INFO - PROCESS | 7284 | |4;audio-oscillator;93;93;136;94;93;96;132;94;94;136 04:36:59 INFO - PROCESS | 7284 | |5;imaging-gaussian-blur;116;117;117;116;117;117;118;117;117;117 04:36:59 INFO - PROCESS | 7284 | |6;imaging-darkroom;146;146;145;145;146;145;147;146;145;147 04:36:59 INFO - PROCESS | 7284 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;96;95 04:36:59 INFO - PROCESS | 7284 | |8;json-parse-financial;65;64;68;65;64;64;65;74;64;62 04:36:59 INFO - PROCESS | 7284 | |9;json-stringify-tinderbox;63;64;64;64;65;65;64;64;64;64 04:36:59 INFO - PROCESS | 7284 | |10;stanford-crypto-aes;83;85;85;86;85;85;86;84;85;83 04:36:59 INFO - PROCESS | 7284 | |11;stanford-crypto-ccm;139;139;136;142;137;146;147;139;140;150 04:36:59 INFO - PROCESS | 7284 | |12;stanford-crypto-pbkdf2;187;171;171;172;173;171;170;169;171;172 04:36:59 INFO - PROCESS | 7284 | |13;stanford-crypto-sha256-iterative;72;74;71;80;72;73;70;70;69;70 04:36:59 INFO - PROCESS | 7284 | __end_tp_report 04:36:59 INFO - PROCESS | 7284 | __start_cc_report 04:36:59 INFO - PROCESS | 7284 | _x_x_mozilla_cycle_collect,1178 04:36:59 INFO - PROCESS | 7284 | __end_cc_report 04:36:59 INFO - PROCESS | 7284 | __startTimestamp1460115419909__endTimestamp 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | ------- Summary: start ------- 04:36:59 INFO - PROCESS | 7284 | Number of tests: 14 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.47 (3.1%) stddev-sans-first:3.64 04:36:59 INFO - PROCESS | 7284 | Values: 113.0 113.0 108.0 114.0 114.0 113.0 103.0 113.0 112.0 113.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:160.50 stddev:20.02 (12.5%) stddev-sans-first:21.20 04:36:59 INFO - PROCESS | 7284 | Values: 159.0 131.0 157.0 188.0 144.0 162.0 171.0 134.0 179.0 133.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 04:36:59 INFO - PROCESS | 7284 | Values: 160.0 160.0 160.0 159.0 160.0 162.0 161.0 162.0 160.0 161.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#3] audio-fft Cycles:10 Average:87.10 Median:74.00 stddev:16.97 (22.9%) stddev-sans-first:17.32 04:36:59 INFO - PROCESS | 7284 | Values: 74.0 76.0 104.0 103.0 74.0 74.0 73.0 114.0 105.0 74.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.50 stddev:19.76 (21.1%) stddev-sans-first:20.38 04:36:59 INFO - PROCESS | 7284 | Values: 93.0 93.0 136.0 94.0 93.0 96.0 132.0 94.0 94.0 136.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 04:36:59 INFO - PROCESS | 7284 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 04:36:59 INFO - PROCESS | 7284 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 147.0 146.0 145.0 147.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:36:59 INFO - PROCESS | 7284 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.00 stddev:3.34 (5.1%) stddev-sans-first:3.54 04:36:59 INFO - PROCESS | 7284 | Values: 65.0 64.0 68.0 65.0 64.0 64.0 65.0 74.0 64.0 62.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 04:36:59 INFO - PROCESS | 7284 | Values: 63.0 64.0 64.0 64.0 65.0 65.0 64.0 64.0 64.0 64.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:1.06 (1.2%) stddev-sans-first:0.93 04:36:59 INFO - PROCESS | 7284 | Values: 83.0 85.0 85.0 86.0 85.0 85.0 86.0 84.0 85.0 83.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:141.00 stddev:4.65 (3.3%) stddev-sans-first:4.84 04:36:59 INFO - PROCESS | 7284 | Values: 139.0 139.0 136.0 142.0 137.0 146.0 147.0 139.0 140.0 150.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:171.50 stddev:5.14 (3.0%) stddev-sans-first:1.17 04:36:59 INFO - PROCESS | 7284 | Values: 187.0 171.0 171.0 172.0 173.0 171.0 170.0 169.0 171.0 172.0 04:36:59 INFO - PROCESS | 7284 | 04:36:59 INFO - PROCESS | 7284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:3.18 (4.4%) stddev-sans-first:3.37 04:36:59 INFO - PROCESS | 7284 | Values: 72.0 74.0 71.0 80.0 72.0 73.0 70.0 70.0 69.0 70.0 04:36:59 INFO - PROCESS | 7284 | -------- Summary: end -------- 04:36:59 INFO - PROCESS | 7284 | 04:37:00 INFO - TEST-INFO | 7284: exit 0 04:37:00 INFO - TEST-OK | kraken | took 62249ms 04:37:00 INFO - SUITE-END | took 1179s 04:37:01 INFO - Completed test suite (00:19:39) 04:37:01 INFO - javascript benchmark 04:37:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.243029521439, 2676.1703871799746, 2681.74523420275, 2690.6233127362175, 2714.5520989036804, 4457.375967364572, 4508.729476231429, 4552.567506086921, 4556.248219043858, 4571.085782843432, 4505.256632655608, 4542.432195975503, 4562.201614717428, 4645.721256724599, 4731.810727570902, 4171.707980441371, 4243.554426785189, 4274.252005898971, 4301.827926882921, 4387.451568553931, 4253.851115210969, 4336.631386332166, 4351.0, 4351.847685331014, 4384.320430333303, 4081.795910204493, 4147.585241475828, 4151.3150330195485, 4243.405923170759, 4317.676174286941, 4261.595148460891, 4280.6361459275995, 4284.485861696585, 4290.270653988799, 4329.112531930947, 4277.286869943995, 4280.250956082704, 4282.42187304713, 4318.978405107954, 4330.155619654169, 4398.626116780046, 4459.888502787424, 4485.596296333346, 4556.7721613919175, 4557.202489564346, 4876.975615121937, 4886.218205087204, 4895.437024742165, 4941.728204948727, 4941.827036053721, 4838.419389673227, 4918.2376731606655, 4920.6309526785635, 4922.483139270396, 4964.900701985976, 4601.861944141681, 4636.211843986531, 4673.439187297546, 4678.8128474861305, 4679.532046795362, 5025.899482010339, 5062.7215503146945, 5068.0, 5068.594512438996, 5111.948880511221, 4732.905341893143, 4810.0, 4862.82980095695, 4869.466118172764, 4870.975645121752, 4961.08219979305, 4967.652264341461, 4971.204607262893, 4995.300657907896, 5025.994801039807, 4925.581325587294, 4939.48135445773, 4945.629077819178, 4947.678400903929, 4993.425756038102, 4720.645951553579, 4904.313396124546, 4925.064237794808, 4983.526564976321, 4989.900201996013, 4224.5353011168745, 4225.133847561243, 4233.238017156941, 4254.085371645111, 4259.61663450291, 3693.169036966715, 3698.167912219783, 3705.27747089315, 3738.8504459821847, 3751.0622344413896, 4202.495700515958, 4265.87202383929, 4285.18581469526, 4294.849680261238, 4371.431713877239, 4890.462049174588, 4896.2655601660035, 4896.608271338356, 4914.213725803854, 4925.0, 4235.53409124996, 4240.427542281753, 4241.978790106092, 4247.5964783345535, 4285.250081235834, 4415.359772832985, 4435.445569303837, 4510.864674059783, 4568.406107206042, 4584.9541504585195, 4669.603083737852, 4682.063587282625, 4700.388949436551, 4705.294205869147, 4746.7863946121815, 4936.3089167515855, 4955.578775803953, 4956.553910148104, 4957.677750946177, 5007.499250074963, 4583.839565615188, 4707.270373092176, 4728.1252968201, 4738.668293219579, 4778.402699662543, 4792.95207047925, 4801.68789028712, 4813.975930120327, 4814.446338671098, 4861.562459378673, 4710.081534100817, 4859.4654587996, 4894.583960363409, 4896.167651499325, 4942.1104201244125, 4761.547652972962, 4777.116233496814, 4791.089692958327, 4813.975930120467, 4831.710097394168, 4738.312944622941, 4772.308015337687, 4779.593734532604, 4781.7609119543185, 4831.033793241296, 4567.748773817472, 4700.670953033392, 4715.292706094114, 4734.100520901018, 4787.521247875185, 4838.153323168502, 4839.443464001685, 4851.878703032452, 4868.196747536758, 4897.755112244302, 4749.216379297515, 4750.073735621659, 4754.21555443348, 4766.356541866804, 4809.95190048109], "value": 4540.604803698023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9193712880195, 585.4730742331901, 606.0757345048803, 611.7400104955394, 633.6071635585935, 26610.33474163147, 27285.863570682144, 27297.181084567444, 27307.180784576445, 33560.66439335606, 39925.0, 40595.0, 40663.79668101655, 40691.0, 40708.79645601768, 7781.572013539253, 7965.920340796576, 7975.880361794578, 7976.361891048702, 7978.880316795253, 7650.8469830603635, 7768.805779855492, 7774.378049756035, 7786.571738554378, 7791.3766898648255, 7788.532688038736, 7814.804629884242, 7825.37397008238, 7843.333316668061, 7843.960780196091, 7734.0, 7772.572508512029, 7780.727674531393, 7781.96109019457, 7789.0, 7823.960880195563, 7913.129555748863, 7915.0, 7929.762107136795, 7933.325667318285, 37975.810120949216, 38513.88173650448, 38538.0365490865, 38602.61397386046, 38683.0, 3046.8933587324336, 3208.0696597986557, 3267.526208699749, 3314.734821214297, 3730.1047748540427, 28303.0, 28995.71004289951, 29355.55966660502, 29423.0, 30051.248718781986, 3097.0863595239457, 3145.9528107078413, 3180.3480286541435, 3245.4969479730444, 3283.40898638245, 231956.0, 234065.0, 234098.4196659343, 234635.8268208665, 234870.0, 32994.67005329916, 34062.829685851415, 51684.0, 51944.22083668748, 51983.48016519862, 31265.374692506477, 31329.686703132676, 31440.842795785873, 31450.842745786125, 31468.37063258722, 13308.667283317995, 13423.798643020362, 13533.902245152018, 13539.45842166322, 13573.796393054112, 11281.774364512663, 11441.771164576661, 11450.770984580262, 11455.541778328774, 11464.770704586028, 8077.434579579373, 8140.837183256302, 8177.632006559719, 8194.057683366489, 8225.136360682041, 3213.50190720434, 3241.9027429177163, 3248.6264079631146, 3269.9509507357407, 3286.7206287465356, 921.7972046149837, 944.6363150187227, 956.7512446763892, 973.4743238651049, 994.0556471352244, 26180.345491362867, 26619.0, 27834.304142396602, 28020.43959120806, 28036.579451308247, 969.7042402067437, 999.4453078541479, 1006.3358183598936, 1027.9206832825503, 1042.6924057403085, 14395.712085758436, 15056.548303550911, 15214.239288035555, 15277.38890444392, 15278.38886444552, 332256.0, 336049.0, 337124.0, 337418.0, 338015.0, 45520.0, 46170.76914615473, 46252.306215406796, 46269.30596040995, 46362.53637463582, 1069.5240617924949, 1213.7815193265296, 1229.8339724137306, 1246.6197809667956, 1254.868238834909, 26700.0, 27777.0, 27866.0, 27896.163115106578, 28233.294167645974, 37332.440013400366, 47566.0, 49154.0, 49194.75402622964, 49211.261831071846, 325506.0, 326362.0, 330253.0, 330556.0, 331169.0, 33229.0, 33447.0, 34165.0, 37375.813120934225, 38130.61869381271, 41749.0, 43430.56569434392, 43849.56150438455, 44213.11573768571, 44833.55166448424, 30909.227269318446, 32257.032289031366, 34940.82529587336, 36777.81611091927, 37193.81403092967, 31085.222869428446, 32413.0, 33428.832855835564, 33582.66417335893, 34198.48702269418, 33532.161695957795, 33928.321433571684, 34118.31763364669, 34416.82791586026, 34500.137496562784, 29263.414731705674, 30602.387952241275, 30657.233569160948, 30711.539326909668, 31034.0, 23540.176093836635, 23975.280741577084, 24414.26757197287, 24430.26709198727, 24654.383640409134], "value": 16315.274971051454, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.06948143271796, 362.4671732553146, 363.25532658051003, 384.52895203375886, 386.277660774352, 16559.751603725937, 17149.056801875893, 17414.825851741494, 17445.3021879125, 17462.388816391427, 16086.678266434665, 16435.2604132814, 16435.424760133366, 16962.151892405393, 16965.660686786257, 5003.324551185579, 5158.845234642967, 5200.063988482072, 5207.375114986207, 5208.921866172011, 3716.5725941516666, 3885.494885664874, 3906.0430194602363, 3925.7448265862627, 5145.974270128663, 3922.0391004203866, 5962.463378295953, 5968.462838344548, 5968.79109231177, 5972.88054238915, 5860.824175274706, 5917.733701983421, 5926.674032928187, 5944.940550594482, 5953.285605727318, 3326.900192994214, 5114.156164232897, 5233.921491177635, 5278.577713782888, 5281.894362112775, 18507.259709611735, 19318.517037074187, 19476.70784938227, 19678.70481942772, 20892.895535522224, 1984.9503762405911, 2041.2345370486069, 2287.4395773035544, 2337.812974961999, 2540.771330580238, 12797.872021279762, 13112.213267203999, 13139.145955512957, 13142.802857957138, 13471.797923031163, 1763.2241813601975, 1808.1456064448676, 1821.9908900455546, 1825.534488705385, 1838.7793464784177, 65188.348116518704, 65865.0, 66505.00242496414, 66846.0, 67066.66466667636, 8961.327900407496, 9176.26589872822, 9596.0, 9656.613735450645, 9883.901160988442, 13501.0, 13646.454141834414, 13663.248521331223, 13675.726485470235, 13716.108452950526, 7417.443691723142, 7471.0, 7509.249075092447, 7665.961670191613, 7668.808279792938, 7215.567065976058, 7248.746293879689, 7249.637518124073, 7392.889106663404, 7421.332080112816, 5781.4218578141845, 5876.265466816648, 5975.282966044103, 5979.1629171915965, 6022.909656355158, 1695.4828777223065, 1697.7198762204098, 1703.608170120879, 1712.5889786451162, 1749.2303386509896, 897.721398178705, 923.2383283790899, 939.699296225215, 951.2342564235856, 1005.6681295172575, 16733.58166045834, 16865.747013794804, 17112.315507379815, 17122.828771712124, 17519.47441576755, 884.0364003236375, 897.5512243878061, 899.2086963472234, 916.8808054952814, 961.4471678784727, 9513.714588562354, 9555.952220238854, 9575.138237558653, 9818.250889750881, 9885.0, 387676.0, 394146.0, 399423.0, 402524.0, 407485.0, 35238.0, 61130.0, 66154.66922665355, 67251.0, 68454.35311963638, 897.3135551303258, 905.343625871238, 927.6335847340263, 930.5347326336831, 959.832029394867, 15651.37394504207, 15693.293801778718, 15770.763438548202, 15886.443974460839, 16214.756778648565, 31550.0, 34930.47604285989, 35236.0, 36651.45022824607, 36881.0, 41444.1711165781, 44182.77908610436, 46560.0, 47009.76495117503, 48222.0, 7421.888671669822, 7512.812179695551, 7620.5808680523105, 7635.00744903159, 7684.269994350528, 10782.622608208674, 10914.126869850552, 11038.724031899266, 11055.447227638746, 11171.52940006978, 9900.20798336117, 9910.950445247727, 9940.1053905146, 9940.652077177265, 10226.670532830982, 9467.715968520955, 9698.175655069399, 9722.513874306398, 9732.513374331114, 9754.707358779247, 9789.9021009789, 9984.35101718386, 10113.544890480092, 10175.949120254352, 10355.689329320132, 6445.452136568444, 7377.631118443949, 7649.120351159688, 7658.7319443821425, 7668.80827979305, 7858.410619203697, 9563.234941204548, 9644.9035509644, 10033.304539303652, 10163.491825408848], "value": 8202.979105375787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.0151583280879, 1371.3211960079761, 1421.1757180835116, 1511.6069821846318, 1762.6562820250056, 6612.86774264515, 6838.281980392062, 7660.770176894688, 7871.527708337504, 7886.487378320405, 7775.339096176832, 7781.144074151839, 7840.7255746048895, 7844.294013538781, 7859.607019649024, 1858.1545396844404, 2142.442964829148, 2195.9451013724624, 2226.1763147635397, 2227.0535022615322, 2227.13141874669, 2238.809701175402, 2242.8766417847014, 2242.9102835886547, 2243.663450482424, 2171.9782802172012, 2181.1711549611127, 2226.4545186429345, 2226.6993955816, 2232.408411770882, 2134.3170185540635, 2147.5597502511946, 2148.4091874734418, 2148.4521447030984, 2168.0894024509744, 2159.406163305088, 2188.1794327127327, 2190.539986602815, 2190.5618876224817, 2190.835687323457, 7838.059432868035, 7867.291943725035, 7967.880481792778, 7969.681212751483, 7986.880196797053, 4504.25679762842, 4526.343680166357, 4602.033572949685, 4618.422697162855, 4705.011947491031, 2853.985730071357, 2867.899623513188, 2915.9708402915912, 2933.9853300733575, 2959.6300462442196, 950.7860731335394, 960.6109525642127, 985.9112679858775, 991.4101109839634, 1010.7624708193568, 10855.402952837512, 10877.728056798644, 10889.727756806064, 10910.181736369805, 10947.178961577914, 4056.9797151014054, 4146.150039241948, 4216.831326746896, 4285.228658841438, 4293.034067334825, 9168.724938251864, 9253.259739220846, 9271.76820579491, 9290.907090929139, 9301.162895339452, 4695.929561056587, 4709.340692303081, 4711.175544279738, 4717.3159891816185, 4723.220668589644, 3707.4994875691436, 4100.446439730657, 4235.576442355801, 4242.257604919127, 4259.1268789897995, 3661.0, 3719.0, 3758.4362345648374, 3766.2844059628583, 3829.2915810574577, 1217.1723228204905, 1234.9567765128177, 1281.1992504684572, 1281.641140480667, 1299.4672184404537, 1196.2702751321688, 1212.3271584270815, 1227.110344999868, 1228.680543058811, 1234.672811704899, 7310.780676579711, 7313.963430182815, 7315.085614298213, 7361.963190184015, 7512.6243687815395, 1060.3478860500736, 1070.812607793633, 1083.2254937719567, 1097.4786976186247, 1099.279971618575, 5368.91946620801, 5617.971910140505, 5766.279215098113, 5812.82561523155, 5817.825465236049, 9316.95341523288, 9778.559964801601, 9804.65683701067, 9811.607535698493, 9834.704958851245, 9460.432374057578, 9514.619415223451, 9678.56446459911, 9691.418514889128, 9951.353162044445, 7392.112946446461, 7545.584992825447, 7558.508696934681, 7573.242675732493, 7638.274363935418, 7201.819954501179, 7281.017062696468, 7332.670029848777, 7352.816179595553, 7379.557226566423, 8712.825743484967, 9045.547722613974, 9080.727578172666, 9105.908940910505, 9260.49067301305, 9140.817183656423, 9153.816923661356, 9303.906960930304, 9321.30090243221, 9377.718668439958, 5650.152477128464, 5816.651000939957, 5828.912566311594, 6452.967525195946, 6563.573367731082, 6629.867402652017, 6680.298568650416, 7346.5592064476305, 7575.166731659623, 7630.8092297693, 6796.694148763417, 6912.55068420551, 6920.134983127109, 7008.5094043416475, 7032.542884712478, 6698.430633396021, 6755.493337999571, 6789.355011273921, 6871.106756121672, 6931.965340173267, 7061.858762824818, 7104.14750229955, 7104.964475177591, 7165.677544510614, 7183.173934997542, 6602.141721576164, 6634.004899265149, 6692.464602831665, 6699.497537684791, 6714.227863795726, 6731.0, 6824.317568243136, 6831.0, 6839.897401538881, 6856.485763567653], "value": 4474.902932134754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.1897994395077, 307.6246978686003, 310.59932686833986, 315.7489795612488, 318.3839271010593, 5020.096382651117, 5023.271625614284, 5025.924611130831, 5038.622103342254, 5084.262781896623, 4993.25101234815, 5007.2489126630935, 5016.623753218505, 5022.146235140026, 5034.949650503494, 3975.642192202701, 3993.0616305168264, 3995.680345572347, 3999.620036096581, 4005.759654420744, 3695.722820788438, 3941.940870886939, 3956.7823769692654, 4003.499562554681, 4014.558398576154, 3886.436466712325, 3890.3580909150096, 3905.628965248297, 3911.2568611963634, 3914.064451661254, 3663.6153203913473, 3886.067343837459, 3889.9416508752392, 3910.706696997708, 3911.3546264866263, 3279.426100432415, 3312.850921708529, 3415.8121303328307, 3420.4698271767916, 3424.6404127566498, 4760.857174284777, 4772.5227477252, 4776.11641846256, 4782.593479554242, 4798.2802579613335, 4186.665066794649, 4228.133232687292, 4462.486814016397, 4467.463904331501, 4489.6408287336935, 5243.449437809013, 5291.28567643367, 5296.232046353296, 5297.708626025567, 5298.682079075229, 3696.1868388954654, 3704.74066815323, 3709.4806727058235, 3709.962900370989, 3720.655986728371, 5367.704776237305, 5514.503694667499, 5515.972420137914, 5580.330360356743, 5580.358258800249, 3778.886633401002, 3794.734368594227, 3822.48396466479, 3827.1771569112775, 3827.196288779332, 3839.6928245740273, 3855.614438556178, 3861.0, 3865.381538953754, 3889.630485103911, 4431.224535706238, 4431.645468362588, 4436.6672499562665, 4443.600075993111, 4449.377087207794, 5033.521815427529, 5290.523852853262, 5291.603129765283, 5300.575953923677, 5308.708021058879, 1341.932903354848, 1348.9190648561118, 1353.2759973414372, 1353.8713822186876, 1359.6600849787553, 888.9066648001867, 907.8592818113203, 923.8845144356956, 924.7919218175857, 925.319889880937, 4663.48701642819, 4673.228917228619, 4679.181143299909, 4685.0, 4690.15577196108, 5423.972880135653, 5424.7016414096815, 5433.701146436984, 5441.183822426668, 5448.673079615236, 4500.437445319335, 4665.206914824488, 4671.43942726875, 4681.180793361148, 4682.484926658065, 2775.2923004634094, 2826.321682796155, 2895.5222388306115, 2923.780716446275, 2929.472694914936, 5195.974020129951, 5206.349206349207, 5213.661112027706, 5213.661112027706, 5218.217267409919, 5398.190271459234, 5588.636738611977, 5595.07681232592, 5608.46719561641, 5613.214150019001, 5170.095233334227, 5198.662086964411, 5202.583793296527, 5212.166053431432, 5213.478652134756, 5428.647137936022, 5430.321209848769, 5446.891062178814, 5462.579729270339, 5464.3442786865835, 5063.392392912874, 5313.388960269618, 5334.7458050589885, 5342.198670199501, 5361.678299302054, 5176.689398635944, 5181.430042695225, 5195.74021298926, 5206.271122042993, 5233.659812112201, 3794.241151769602, 3832.1760821423527, 3836.9808150959066, 3851.9614803851605, 3865.710071744574, 5157.948420515747, 5426.70153141581, 5453.427390124139, 5454.536364409069, 5477.397486276586, 5295.417504074471, 5307.071262529119, 5314.22943673173, 5315.149576067811, 5324.494173053554, 5225.190095535198, 5228.790848366023, 5234.659747116578, 5242.790288388422, 5292.603054770831, 4973.204287314013, 5219.660722053054, 5230.633855630222, 5231.378272735465, 5250.028744682246, 5327.121025030827, 5335.706536140394, 5336.17289320156, 5336.67979921206, 5345.625806193529, 5204.5687435955415, 5206.947930520646, 5215.895682086413, 5216.452272511332, 5235.4502777207845], "value": 3975.392581238245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.797236842763, 665.8634979829136, 736.8415790605019, 740.6592967235072, 756.2286467802842, 11421.828672569907, 12062.638120856378, 12305.753884922318, 12345.25928444294, 12368.628941131768, 11983.101267404936, 12183.269003859774, 12373.381330933462, 12404.069694772905, 12430.813537796941, 648.3872740260456, 782.898223230982, 794.1462927353105, 803.1526739290047, 809.380823669893, 797.4457751862429, 798.9560574168419, 802.6227672993713, 802.9277365037145, 805.1706742055692, 836.1178956201205, 850.6257246811414, 851.2041241439243, 852.3905407633541, 852.9232369086781, 670.4502308107354, 820.9343252539783, 838.8406202821444, 844.3582877013453, 848.2832006954114, 621.8134559632138, 622.1041699952054, 622.2750495672582, 622.5704264057831, 622.6575383539035, 12008.819867701992, 12103.878961210452, 12105.636830895088, 12108.0, 12117.27296362221, 12512.311822849739, 12853.87146128536, 12930.09489335747, 13004.414801333962, 13081.28052957087, 9281.907180928172, 9432.811343773155, 9547.2839537035, 9566.426014439156, 9686.51567421633, 3341.96658033419, 3391.3895498810202, 3418.504316874064, 3419.111031131899, 3435.862565497402, 45423.0, 45774.85562860922, 45908.0, 45920.3111953321, 46007.30989035167, 9102.90897091034, 9129.497877616663, 9328.099515688968, 9486.762830929281, 9602.0, 17455.563610909576, 17663.0, 17763.11184440773, 17860.642787144185, 17894.731579026324, 6644.900326495106, 6652.70062847173, 6665.533412661067, 6690.59856408617, 6983.2318444971015, 3823.751456155341, 3894.552126505488, 3895.824687889052, 3926.509186351706, 4024.215278020816, 2675.665541807274, 2753.7383948524857, 2756.503829310703, 2760.8205466645004, 2761.8204816686853, 412.3299638088107, 500.1123006663202, 518.284767021508, 518.4038355890681, 541.0261529247339, 536.3188750287113, 541.7535021565178, 544.964577302482, 569.9344575373802, 586.5073338395769, 7861.135275119732, 7876.56678882667, 7972.960135199403, 8059.0, 8223.342132629496, 445.1364353154869, 518.8728761453468, 537.2800447400502, 583.6760597868224, 595.6158277910723, 3795.5065841440437, 3813.60803306791, 3863.2466668999277, 3879.359905615598, 3911.5501717302873, 52468.73765631224, 53431.19853202205, 53725.1941220882, 54002.0, 54174.0, 45219.64341069773, 46782.76608616935, 47263.5273647266, 47311.0, 47416.7629161852, 42916.35625465683, 43284.0, 43421.782891085975, 43827.56172438235, 44060.559394406286, 7543.7736867894055, 7556.508826926232, 7758.88361674564, 7787.143414224318, 7843.882341764992, 29989.35165049421, 30907.69092309138, 30942.845285773426, 30962.0, 31231.687683123786, 38266.0, 39156.80421597988, 39315.0, 39487.80256098701, 39869.60130398775, 9873.654422095193, 9948.552315145691, 10042.447665378475, 10161.898381016095, 10191.082802547806, 10673.35959842412, 10886.510107045044, 10967.177461690246, 11028.889711103107, 11444.885551144382, 9880.752981175241, 9885.258605604464, 10024.649137280161, 10169.491525423848, 10487.10859576914, 10106.292559520763, 10213.795724085625, 10464.686059418229, 10541.262111652111, 10773.084287835309, 9932.354396964174, 10362.792744144925, 10520.947395262974, 10526.31578947366, 10668.786624267626, 8191.508509489449, 8372.455790373606, 8406.369522285975, 8743.91256087431, 8855.3801233913, 8038.638261278374, 8681.131886811268, 8753.956230218808, 8756.912430875864, 8774.0], "value": 5805.9335410415415, "unit": "score"}], "name": "dromaeo_css", "value": 6304.147905304438, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 108.0, 114.0, 114.0, 113.0, 103.0, 113.0, 112.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 157.0, 188.0, 144.0, 162.0, 171.0, 134.0, 179.0, 133.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 104.0, 103.0, 74.0, 74.0, 73.0, 114.0, 105.0, 74.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 136.0, 94.0, 93.0, 96.0, 132.0, 94.0, 94.0, 136.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 68.0, 65.0, 64.0, 64.0, 65.0, 74.0, 64.0, 62.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 86.0, 85.0, 85.0, 86.0, 84.0, 85.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 136.0, 142.0, 137.0, 146.0, 147.0, 139.0, 140.0, 150.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 171.0, 171.0, 172.0, 173.0, 171.0, 170.0, 169.0, 171.0, 172.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 71.0, 80.0, 72.0, 73.0, 70.0, 70.0, 69.0, 70.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1579.6, "alertThreshold": 2.0}]} 04:37:01 INFO - Return code: 0 04:37:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:37:01 ERROR - # TBPL SUCCESS # 04:37:01 INFO - Running post-action listener: _resource_record_post_action 04:37:01 INFO - Running post-run listener: _resource_record_post_run 04:37:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 519024640; Read time: 364; Write time: 511928 04:37:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 233467904; Read time: 92; Write time: 314252 04:37:02 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285556736; Read time: 272; Write time: 197676 04:37:02 INFO - Running post-run listener: _upload_blobber_files 04:37:02 INFO - Blob upload gear active. 04:37:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:37:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:37:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:37:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:03 INFO - (blobuploader) - INFO - Done attempting. 04:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:04 INFO - (blobuploader) - INFO - Done attempting. 04:37:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:04 INFO - Return code: 0 04:37:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9d20389c01c76188a54d2de09e9208d020c7db21a2e0bd3c5af62ebfc8254aeefdeadf6c563db090fae666523a3c173feaa02b264ead62f2566bd67f121b741", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b00d0786bea1866956d0127cb44fefcc023e2bb09721e24c62c6e972076ff6640386163accb164871cb1bfdd59cdce9d696e35fa16f0d9ec1338138ac8059ca"} 04:37:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:04 INFO - Contents: 04:37:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9d20389c01c76188a54d2de09e9208d020c7db21a2e0bd3c5af62ebfc8254aeefdeadf6c563db090fae666523a3c173feaa02b264ead62f2566bd67f121b741", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b00d0786bea1866956d0127cb44fefcc023e2bb09721e24c62c6e972076ff6640386163accb164871cb1bfdd59cdce9d696e35fa16f0d9ec1338138ac8059ca"} 04:37:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:04 INFO - Copying logs to upload dir... 04:37:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.650041 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-08 04:37:03.994759) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 04:37:03.998730) ========= 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-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9d20389c01c76188a54d2de09e9208d020c7db21a2e0bd3c5af62ebfc8254aeefdeadf6c563db090fae666523a3c173feaa02b264ead62f2566bd67f121b741", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b00d0786bea1866956d0127cb44fefcc023e2bb09721e24c62c6e972076ff6640386163accb164871cb1bfdd59cdce9d696e35fa16f0d9ec1338138ac8059ca"} build_url:https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9d20389c01c76188a54d2de09e9208d020c7db21a2e0bd3c5af62ebfc8254aeefdeadf6c563db090fae666523a3c173feaa02b264ead62f2566bd67f121b741", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b00d0786bea1866956d0127cb44fefcc023e2bb09721e24c62c6e972076ff6640386163accb164871cb1bfdd59cdce9d696e35fa16f0d9ec1338138ac8059ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 04:37:04.024226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:37:04.024596) ========= 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-1460113255.145727-200028318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:37:04.109079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 04:37:04.109455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 04:37:04.109804) ========= ========= Total master_lag: 0.30 =========