builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1460027446.36 results: success (0) buildid: 20160407025248 builduid: 51b7caafd87f49248e1e920545a4762f revision: b6683e141c47c022598c0caac3ea8ba8c6236d42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.359296) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.359808) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.360140) ========= 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=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006302 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.409816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.410142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.451864) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.452154) ========= 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=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012375 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.498935) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.499228) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.499640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.499911) ========= 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=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 04:10:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 94.8M=0s 2016-04-07 04:10:46 (94.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.245497 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.758475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.758830) ========= 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=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.051065 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:46.821682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 04:10:46.822055) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b6683e141c47c022598c0caac3ea8ba8c6236d42 --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 b6683e141c47c022598c0caac3ea8ba8c6236d42 --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=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 04:10:46,830 truncating revision to first 12 chars 2016-04-07 04:10:46,830 Setting DEBUG logging. 2016-04-07 04:10:46,830 attempt 1/10 2016-04-07 04:10:46,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b6683e141c47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 04:10:47,652 unpacking tar archive at: mozilla-central-b6683e141c47/testing/mozharness/ program finished with exit code 0 elapsedTime=1.089898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 04:10:47.925101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:47.925625) ========= echo b6683e141c47c022598c0caac3ea8ba8c6236d42 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b6683e141c47c022598c0caac3ea8ba8c6236d42'] 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=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b6683e141c47c022598c0caac3ea8ba8c6236d42 program finished with exit code 0 elapsedTime=0.004685 script_repo_revision: 'b6683e141c47c022598c0caac3ea8ba8c6236d42' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:47.978170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:47.978576) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 04:10:47.989001) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-07 04:10:47.989398) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:10:48 INFO - MultiFileLogger online at 20160407 04:10:48 in /builds/slave/test 04:10:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:10:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:48 INFO - {'append_to_log': False, 04:10:48 INFO - 'base_work_dir': '/builds/slave/test', 04:10:48 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:10:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:48 INFO - 'branch': 'Firefox-Non-PGO', 04:10:48 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:48 INFO - 'config_files': ('talos/linux_config.py',), 04:10:48 INFO - 'default_actions': ('clobber', 04:10:48 INFO - 'read-buildbot-config', 04:10:48 INFO - 'download-and-extract', 04:10:48 INFO - 'populate-webroot', 04:10:48 INFO - 'create-virtualenv', 04:10:48 INFO - 'install', 04:10:48 INFO - 'run-tests'), 04:10:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:48 INFO - 'download_minidump_stackwalk': True, 04:10:48 INFO - 'download_symbols': 'ondemand', 04:10:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:48 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:48 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:48 INFO - 'installer_path': 'installer.exe', 04:10:48 INFO - 'log_level': 'info', 04:10:48 INFO - 'log_name': 'talos', 04:10:48 INFO - 'log_to_console': True, 04:10:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:10:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:10:48 INFO - 'opt_config_files': (), 04:10:48 INFO - 'pip_index': False, 04:10:48 INFO - 'sps_profile': False, 04:10:48 INFO - 'sps_profile_interval': 0, 04:10:48 INFO - 'suite': 'dromaeojs-e10s', 04:10:48 INFO - 'system_bits': '32', 04:10:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:48 INFO - 'title': 'talos-linux64-ix-031', 04:10:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:48 INFO - 'use_talos_json': True, 04:10:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:48 INFO - 'work_dir': 'build'} 04:10:48 INFO - ##### 04:10:48 INFO - ##### Running clobber step. 04:10:48 INFO - ##### 04:10:48 INFO - Running pre-action listener: _resource_record_pre_action 04:10:48 INFO - Running main action method: clobber 04:10:48 INFO - rmtree: /builds/slave/test/build 04:10:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:51 INFO - Running post-action listener: _resource_record_post_action 04:10:51 INFO - ##### 04:10:51 INFO - ##### Running read-buildbot-config step. 04:10:51 INFO - ##### 04:10:51 INFO - Running pre-action listener: _resource_record_pre_action 04:10:51 INFO - Running main action method: read_buildbot_config 04:10:51 INFO - Using buildbot properties: 04:10:51 INFO - { 04:10:51 INFO - "project": "", 04:10:51 INFO - "product": "firefox", 04:10:51 INFO - "script_repo_revision": "production", 04:10:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:10:51 INFO - "repository": "", 04:10:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:10:51 INFO - "buildid": "20160407025248", 04:10:51 INFO - "pgo_build": "False", 04:10:51 INFO - "basedir": "/builds/slave/test", 04:10:51 INFO - "buildnumber": 20, 04:10:51 INFO - "slavename": "talos-linux64-ix-031", 04:10:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:10:51 INFO - "platform": "ubuntu64_hw", 04:10:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:10:51 INFO - "branch": "mozilla-central", 04:10:51 INFO - "repo_path": "mozilla-central", 04:10:51 INFO - "revision": "b6683e141c47c022598c0caac3ea8ba8c6236d42", 04:10:51 INFO - "stage_platform": "linux64", 04:10:51 INFO - "builduid": "51b7caafd87f49248e1e920545a4762f", 04:10:51 INFO - "slavebuilddir": "test" 04:10:51 INFO - } 04:10:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:10:51 INFO - Running post-action listener: _resource_record_post_action 04:10:51 INFO - ##### 04:10:51 INFO - ##### Running download-and-extract step. 04:10:51 INFO - ##### 04:10:51 INFO - Running pre-action listener: _resource_record_pre_action 04:10:51 INFO - Running main action method: download_and_extract 04:10:51 INFO - mkdir: /builds/slave/test/build/tests 04:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:51 INFO - https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:10:53 INFO - Downloaded 1361 bytes. 04:10:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:10:53 INFO - Using the following test package requirements: 04:10:53 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:10:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:10:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:53 INFO - u'jsshell-linux-x86_64.zip'], 04:10:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:10:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:10:53 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:10:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:10:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:10:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:10:53 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:10:53 INFO - https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:10:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:10:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:11:01 INFO - Downloaded 22142874 bytes. 04:11:01 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:11:01 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:11:02 INFO - Return code: 0 04:11:02 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:11:02 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:11:02 INFO - https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:11:03 INFO - Downloaded 22142874 bytes. 04:11:03 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:11:03 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:11:04 INFO - Return code: 0 04:11:04 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:11:04 INFO - https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:11:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:11:05 INFO - Downloaded 10847693 bytes. 04:11:05 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:11:05 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:11:06 INFO - Return code: 0 04:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:06 INFO - https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:11:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:11:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUEJcBKyQ-me2YLxKMGKCg/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:11:07 INFO - Downloaded 54198039 bytes. 04:11:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:11:07 INFO - mkdir: /builds/slave/test/properties 04:11:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:07 INFO - Contents: 04:11:07 INFO - build_url:https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:11:08 INFO - Running post-action listener: _resource_record_post_action 04:11:08 INFO - Running post-action listener: set_extra_try_arguments 04:11:08 INFO - ##### 04:11:08 INFO - ##### Running populate-webroot step. 04:11:08 INFO - ##### 04:11:08 INFO - Running pre-action listener: _resource_record_pre_action 04:11:08 INFO - Running main action method: populate_webroot 04:11:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:08 INFO - '--tppagecycles', 04:11:08 INFO - '7'], 04:11:08 INFO - 'tests': ['tsvgm']}}, 04:11:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:08 INFO - 'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:08 INFO - 'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['damp', 'tps']}, 04:11:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:08 INFO - 'tests': ['damp', 'tps']}, 04:11:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['dromaeo_dom']}, 04:11:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['a11yr', 04:11:08 INFO - 'ts_paint', 04:11:08 INFO - 'tpaint', 04:11:08 INFO - 'sessionrestore', 04:11:08 INFO - 'sessionrestore_no_auto_restore', 04:11:08 INFO - 'tabpaint']}, 04:11:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:08 INFO - 'ts_paint', 04:11:08 INFO - 'tpaint', 04:11:08 INFO - 'sessionrestore', 04:11:08 INFO - 'sessionrestore_no_auto_restore', 04:11:08 INFO - 'tabpaint']}, 04:11:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:08 INFO - 'ts_paint', 04:11:08 INFO - 'tpaint', 04:11:08 INFO - 'sessionrestore', 04:11:08 INFO - 'sessionrestore_no_auto_restore', 04:11:08 INFO - 'tabpaint']}, 04:11:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:08 INFO - 'ts_paint', 04:11:08 INFO - 'tpaint', 04:11:08 INFO - 'sessionrestore', 04:11:08 INFO - 'sessionrestore_no_auto_restore', 04:11:08 INFO - 'tabpaint']}, 04:11:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['a11yr', 04:11:08 INFO - 'ts_paint', 04:11:08 INFO - 'tpaint', 04:11:08 INFO - 'sessionrestore', 04:11:08 INFO - 'sessionrestore_no_auto_restore', 04:11:08 INFO - 'tabpaint']}, 04:11:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['a11yr', 04:11:08 INFO - 'ts_paint', 04:11:08 INFO - 'tpaint', 04:11:08 INFO - 'sessionrestore', 04:11:08 INFO - 'sessionrestore_no_auto_restore', 04:11:08 INFO - 'tabpaint']}, 04:11:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['tsvgx', 04:11:08 INFO - 'tsvgr_opacity', 04:11:08 INFO - 'tart', 04:11:08 INFO - 'tscrollx', 04:11:08 INFO - 'cart']}, 04:11:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:08 INFO - 'tsvgr_opacity', 04:11:08 INFO - 'tart', 04:11:08 INFO - 'tscrollx', 04:11:08 INFO - 'cart']}, 04:11:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:08 INFO - 'talos_options': ['--disable-e10s'], 04:11:08 INFO - 'tests': ['tp5o']}, 04:11:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:08 INFO - 'tests': ['tp5o']}, 04:11:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:08 INFO - 'talos_options': ['--disable-e10s', 04:11:08 INFO - '--xperf_path', 04:11:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:08 INFO - 'tests': ['tp5n']}, 04:11:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:08 INFO - 'talos_options': ['--xperf_path', 04:11:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:08 INFO - 'tests': ['tp5n']}}, 04:11:08 INFO - 'talos.zip': {'path': '', 04:11:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:08 INFO - Running post-action listener: _resource_record_post_action 04:11:08 INFO - ##### 04:11:08 INFO - ##### Running create-virtualenv step. 04:11:08 INFO - ##### 04:11:08 INFO - Running pre-action listener: _resource_record_pre_action 04:11:08 INFO - Running main action method: create_virtualenv 04:11:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:08 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:11:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:09 INFO - Using real prefix '/usr' 04:11:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:12 INFO - Installing pip.................done. 04:11:12 INFO - Return code: 0 04:11:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:12 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:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:12 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:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:12 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 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:12 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:11:12 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:11:12 INFO - Using env: {'DISPLAY': ':0', 04:11:12 INFO - 'HOME': '/home/cltbld', 04:11:12 INFO - 'LANG': 'en_US.UTF-8', 04:11:12 INFO - 'LANGUAGE': 'en_US:en', 04:11:12 INFO - 'LOGNAME': 'cltbld', 04:11:12 INFO - 'MAIL': '/var/mail/cltbld', 04:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:12 INFO - 'MOZ_NO_REMOTE': '1', 04:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:12 INFO - 'NO_EM_RESTART': '1', 04:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:12 INFO - 'PWD': '/builds/slave/test', 04:11:12 INFO - 'SHELL': '/bin/bash', 04:11:12 INFO - 'SHLVL': '1', 04:11:12 INFO - 'TERM': 'linux', 04:11:12 INFO - 'TMOUT': '86400', 04:11:12 INFO - 'USER': 'cltbld', 04:11:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:12 INFO - '_': '/tools/buildbot/bin/python'} 04:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:12 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:11:12 INFO - Cleaning up... 04:11:12 INFO - Return code: 0 04:11:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:11:12 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:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:12 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:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:12 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 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:12 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:11:12 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:11:12 INFO - Using env: {'DISPLAY': ':0', 04:11:12 INFO - 'HOME': '/home/cltbld', 04:11:12 INFO - 'LANG': 'en_US.UTF-8', 04:11:12 INFO - 'LANGUAGE': 'en_US:en', 04:11:12 INFO - 'LOGNAME': 'cltbld', 04:11:12 INFO - 'MAIL': '/var/mail/cltbld', 04:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:12 INFO - 'MOZ_NO_REMOTE': '1', 04:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:12 INFO - 'NO_EM_RESTART': '1', 04:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:12 INFO - 'PWD': '/builds/slave/test', 04:11:12 INFO - 'SHELL': '/bin/bash', 04:11:12 INFO - 'SHLVL': '1', 04:11:12 INFO - 'TERM': 'linux', 04:11:12 INFO - 'TMOUT': '86400', 04:11:12 INFO - 'USER': 'cltbld', 04:11:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:12 INFO - '_': '/tools/buildbot/bin/python'} 04:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:12 INFO - Downloading/unpacking psutil>=0.7.1 04:11:12 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:11:12 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:11:12 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:11:12 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:11:12 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:11:12 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:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:14 INFO - Installing collected packages: psutil 04:11:14 INFO - Running setup.py install for psutil 04:11:14 INFO - building 'psutil._psutil_linux' extension 04:11:14 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:11:15 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:11:16 INFO - building 'psutil._psutil_posix' extension 04:11:16 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:11:16 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:11:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:16 INFO - Successfully installed psutil 04:11:16 INFO - Cleaning up... 04:11:16 INFO - Return code: 0 04:11:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:16 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 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:16 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:11:16 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:11:16 INFO - Using env: {'DISPLAY': ':0', 04:11:16 INFO - 'HOME': '/home/cltbld', 04:11:16 INFO - 'LANG': 'en_US.UTF-8', 04:11:16 INFO - 'LANGUAGE': 'en_US:en', 04:11:16 INFO - 'LOGNAME': 'cltbld', 04:11:16 INFO - 'MAIL': '/var/mail/cltbld', 04:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:16 INFO - 'MOZ_NO_REMOTE': '1', 04:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:16 INFO - 'NO_EM_RESTART': '1', 04:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:16 INFO - 'PWD': '/builds/slave/test', 04:11:16 INFO - 'SHELL': '/bin/bash', 04:11:16 INFO - 'SHLVL': '1', 04:11:16 INFO - 'TERM': 'linux', 04:11:16 INFO - 'TMOUT': '86400', 04:11:16 INFO - 'USER': 'cltbld', 04:11:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:16 INFO - '_': '/tools/buildbot/bin/python'} 04:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:11:16 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:11:16 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:11:16 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:11:16 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:11:16 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:11:16 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:11:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:18 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:11:18 INFO - Installing collected packages: mozsystemmonitor 04:11:18 INFO - Running setup.py install for mozsystemmonitor 04:11:18 INFO - Successfully installed mozsystemmonitor 04:11:18 INFO - Cleaning up... 04:11:18 INFO - Return code: 0 04:11:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11: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:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:18 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 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:18 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:11:18 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:11:18 INFO - Using env: {'DISPLAY': ':0', 04:11:18 INFO - 'HOME': '/home/cltbld', 04:11:18 INFO - 'LANG': 'en_US.UTF-8', 04:11:18 INFO - 'LANGUAGE': 'en_US:en', 04:11:18 INFO - 'LOGNAME': 'cltbld', 04:11:18 INFO - 'MAIL': '/var/mail/cltbld', 04:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:18 INFO - 'MOZ_NO_REMOTE': '1', 04:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:18 INFO - 'NO_EM_RESTART': '1', 04:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:18 INFO - 'PWD': '/builds/slave/test', 04:11:18 INFO - 'SHELL': '/bin/bash', 04:11:18 INFO - 'SHLVL': '1', 04:11:18 INFO - 'TERM': 'linux', 04:11:18 INFO - 'TMOUT': '86400', 04:11:18 INFO - 'USER': 'cltbld', 04:11:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:18 INFO - '_': '/tools/buildbot/bin/python'} 04:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:18 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:11:18 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:11:18 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:11:18 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:11:18 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:11:18 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:11:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:20 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:11:20 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:11:20 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:11:20 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:11:20 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:11:20 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:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:21 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:11:21 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:11:21 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:11:21 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:11:21 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:11:21 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:11:21 INFO - Downloading docopt-0.6.1.tar.gz 04:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:21 INFO - Running setup.py install for blobuploader 04:11:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:21 INFO - Running setup.py install for requests 04:11:21 INFO - Running setup.py install for docopt 04:11:22 INFO - Successfully installed blobuploader requests docopt 04:11:22 INFO - Cleaning up... 04:11:22 INFO - Return code: 0 04:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:22 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 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:22 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:11:22 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:11:22 INFO - Using env: {'DISPLAY': ':0', 04:11:22 INFO - 'HOME': '/home/cltbld', 04:11:22 INFO - 'LANG': 'en_US.UTF-8', 04:11:22 INFO - 'LANGUAGE': 'en_US:en', 04:11:22 INFO - 'LOGNAME': 'cltbld', 04:11:22 INFO - 'MAIL': '/var/mail/cltbld', 04:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:22 INFO - 'MOZ_NO_REMOTE': '1', 04:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:22 INFO - 'NO_EM_RESTART': '1', 04:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:22 INFO - 'PWD': '/builds/slave/test', 04:11:22 INFO - 'SHELL': '/bin/bash', 04:11:22 INFO - 'SHLVL': '1', 04:11:22 INFO - 'TERM': 'linux', 04:11:22 INFO - 'TMOUT': '86400', 04:11:22 INFO - 'USER': 'cltbld', 04:11:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:22 INFO - '_': '/tools/buildbot/bin/python'} 04:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:22 INFO - Running setup.py (path:/tmp/pip-GyYlCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:22 INFO - Running setup.py (path:/tmp/pip-7S4eae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:22 INFO - Running setup.py (path:/tmp/pip-AmPj86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:22 INFO - Running setup.py (path:/tmp/pip-MIQ49F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:22 INFO - Running setup.py (path:/tmp/pip-jyM0s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:22 INFO - Running setup.py (path:/tmp/pip-JswaA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:22 INFO - Running setup.py (path:/tmp/pip-EAUYO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:22 INFO - Running setup.py (path:/tmp/pip-ZL7XhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:22 INFO - Running setup.py (path:/tmp/pip-KPDWvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:22 INFO - Running setup.py (path:/tmp/pip-ZLWQ8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:23 INFO - Running setup.py (path:/tmp/pip-5aJb6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:23 INFO - Running setup.py (path:/tmp/pip-rPZgfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:23 INFO - Running setup.py (path:/tmp/pip-Cy573I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:23 INFO - Running setup.py (path:/tmp/pip-1s4NGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:23 INFO - Running setup.py (path:/tmp/pip-mcIKxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:23 INFO - Running setup.py (path:/tmp/pip-PWc9rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:23 INFO - Running setup.py (path:/tmp/pip-bJpGR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:23 INFO - Running setup.py install for manifestparser 04:11:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Running setup.py install for mozcrash 04:11:23 INFO - Running setup.py install for mozdebug 04:11:23 INFO - Running setup.py install for mozdevice 04:11:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Running setup.py install for mozfile 04:11:24 INFO - Running setup.py install for mozhttpd 04:11:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Running setup.py install for mozinfo 04:11:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Running setup.py install for mozInstall 04:11:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Running setup.py install for mozleak 04:11:24 INFO - Running setup.py install for mozlog 04:11:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Running setup.py install for moznetwork 04:11:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Running setup.py install for mozprocess 04:11:24 INFO - Running setup.py install for mozprofile 04:11:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Running setup.py install for mozrunner 04:11:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:25 INFO - Running setup.py install for mozscreenshot 04:11:25 INFO - Running setup.py install for moztest 04:11:25 INFO - Running setup.py install for mozversion 04:11:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:25 INFO - Cleaning up... 04:11:25 INFO - Return code: 0 04:11:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:25 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 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:25 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:11:25 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:11:25 INFO - Using env: {'DISPLAY': ':0', 04:11:25 INFO - 'HOME': '/home/cltbld', 04:11:25 INFO - 'LANG': 'en_US.UTF-8', 04:11:25 INFO - 'LANGUAGE': 'en_US:en', 04:11:25 INFO - 'LOGNAME': 'cltbld', 04:11:25 INFO - 'MAIL': '/var/mail/cltbld', 04:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:25 INFO - 'MOZ_NO_REMOTE': '1', 04:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:25 INFO - 'NO_EM_RESTART': '1', 04:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:25 INFO - 'PWD': '/builds/slave/test', 04:11:25 INFO - 'SHELL': '/bin/bash', 04:11:25 INFO - 'SHLVL': '1', 04:11:25 INFO - 'TERM': 'linux', 04:11:25 INFO - 'TMOUT': '86400', 04:11:25 INFO - 'USER': 'cltbld', 04:11:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:25 INFO - '_': '/tools/buildbot/bin/python'} 04:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:25 INFO - Running setup.py (path:/tmp/pip-KnzKQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:25 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:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:25 INFO - Running setup.py (path:/tmp/pip-wg0TcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:25 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:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:25 INFO - Running setup.py (path:/tmp/pip-EGXO_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:25 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:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:25 INFO - Running setup.py (path:/tmp/pip-c76E_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:25 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:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:25 INFO - Running setup.py (path:/tmp/pip-LtpzFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:25 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:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:25 INFO - Running setup.py (path:/tmp/pip-1QK4xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:25 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:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:25 INFO - Running setup.py (path:/tmp/pip-vNhqeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:26 INFO - Running setup.py (path:/tmp/pip-azKF2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:26 INFO - Running setup.py (path:/tmp/pip-GUS4Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:26 INFO - Running setup.py (path:/tmp/pip-Z4x0Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:26 INFO - Running setup.py (path:/tmp/pip-WzL3jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:26 INFO - Running setup.py (path:/tmp/pip-lK3vAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:26 INFO - Running setup.py (path:/tmp/pip-joOxRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:26 INFO - Running setup.py (path:/tmp/pip-KEFP4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:26 INFO - Running setup.py (path:/tmp/pip-C_sPTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:26 INFO - Running setup.py (path:/tmp/pip-oufXA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:26 INFO - Running setup.py (path:/tmp/pip-_aoF6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:28 INFO - Downloading blessings-1.6.tar.gz 04:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:28 INFO - Installing collected packages: blessings 04:11:28 INFO - Running setup.py install for blessings 04:11:28 INFO - Successfully installed blessings 04:11:28 INFO - Cleaning up... 04:11:28 INFO - Return code: 0 04:11:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:29 INFO - Reading from file tmpfile_stdout 04:11:29 INFO - Current package versions: 04:11:29 INFO - argparse == 1.2.1 04:11:29 INFO - blessings == 1.6 04:11:29 INFO - blobuploader == 1.2.4 04:11:29 INFO - docopt == 0.6.1 04:11:29 INFO - manifestparser == 1.1 04:11:29 INFO - mozInstall == 1.12 04:11:29 INFO - mozcrash == 0.17 04:11:29 INFO - mozdebug == 0.1 04:11:29 INFO - mozdevice == 0.48 04:11:29 INFO - mozfile == 1.2 04:11:29 INFO - mozhttpd == 0.7 04:11:29 INFO - mozinfo == 0.9 04:11:29 INFO - mozleak == 0.1 04:11:29 INFO - mozlog == 3.1 04:11:29 INFO - moznetwork == 0.27 04:11:29 INFO - mozprocess == 0.22 04:11:29 INFO - mozprofile == 0.28 04:11:29 INFO - mozrunner == 6.11 04:11:29 INFO - mozscreenshot == 0.1 04:11:29 INFO - mozsystemmonitor == 0.0 04:11:29 INFO - moztest == 0.7 04:11:29 INFO - mozversion == 1.4 04:11:29 INFO - psutil == 3.1.1 04:11:29 INFO - requests == 1.2.3 04:11:29 INFO - wsgiref == 0.1.2 04:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:29 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 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:29 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:11:29 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:11:29 INFO - Using env: {'DISPLAY': ':0', 04:11:29 INFO - 'HOME': '/home/cltbld', 04:11:29 INFO - 'LANG': 'en_US.UTF-8', 04:11:29 INFO - 'LANGUAGE': 'en_US:en', 04:11:29 INFO - 'LOGNAME': 'cltbld', 04:11:29 INFO - 'MAIL': '/var/mail/cltbld', 04:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:29 INFO - 'MOZ_NO_REMOTE': '1', 04:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:29 INFO - 'NO_EM_RESTART': '1', 04:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:29 INFO - 'PWD': '/builds/slave/test', 04:11:29 INFO - 'SHELL': '/bin/bash', 04:11:29 INFO - 'SHLVL': '1', 04:11:29 INFO - 'TERM': 'linux', 04:11:29 INFO - 'TMOUT': '86400', 04:11:29 INFO - 'USER': 'cltbld', 04:11:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:29 INFO - '_': '/tools/buildbot/bin/python'} 04:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 INFO - Cleaning up... 04:11:29 INFO - Return code: 0 04:11:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:11:29 INFO - Using env: {'DISPLAY': ':0', 04:11:29 INFO - 'HOME': '/home/cltbld', 04:11:29 INFO - 'LANG': 'en_US.UTF-8', 04:11:29 INFO - 'LANGUAGE': 'en_US:en', 04:11:29 INFO - 'LOGNAME': 'cltbld', 04:11:29 INFO - 'MAIL': '/var/mail/cltbld', 04:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:29 INFO - 'MOZ_NO_REMOTE': '1', 04:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:29 INFO - 'NO_EM_RESTART': '1', 04:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:29 INFO - 'PWD': '/builds/slave/test', 04:11:29 INFO - 'SHELL': '/bin/bash', 04:11:29 INFO - 'SHLVL': '1', 04:11:29 INFO - 'TERM': 'linux', 04:11:29 INFO - 'TMOUT': '86400', 04:11:29 INFO - 'USER': 'cltbld', 04:11:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:29 INFO - '_': '/tools/buildbot/bin/python'} 04:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:29 INFO - Downloading/unpacking jsonschema 04:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:31 INFO - Downloading/unpacking functools32 (from jsonschema) 04:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:31 INFO - warning: no files found matching '*.txt' 04:11:31 INFO - no previously-included directories found matching 'build' 04:11:31 INFO - no previously-included directories found matching 'dist' 04:11:31 INFO - no previously-included directories found matching '.git*' 04:11:31 INFO - Installing collected packages: jsonschema, functools32 04:11:31 INFO - Running setup.py install for functools32 04:11:31 INFO - warning: no files found matching '*.txt' 04:11:31 INFO - no previously-included directories found matching 'build' 04:11:31 INFO - no previously-included directories found matching 'dist' 04:11:31 INFO - no previously-included directories found matching '.git*' 04:11:31 INFO - Successfully installed jsonschema functools32 04:11:31 INFO - Cleaning up... 04:11:31 INFO - Return code: 0 04:11:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:11: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:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdef9cf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', '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:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:11:31 INFO - Using env: {'DISPLAY': ':0', 04:11:31 INFO - 'HOME': '/home/cltbld', 04:11:31 INFO - 'LANG': 'en_US.UTF-8', 04:11:31 INFO - 'LANGUAGE': 'en_US:en', 04:11:31 INFO - 'LOGNAME': 'cltbld', 04:11:31 INFO - 'MAIL': '/var/mail/cltbld', 04:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:31 INFO - 'MOZ_NO_REMOTE': '1', 04:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:31 INFO - 'NO_EM_RESTART': '1', 04:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:31 INFO - 'PWD': '/builds/slave/test', 04:11:31 INFO - 'SHELL': '/bin/bash', 04:11:31 INFO - 'SHLVL': '1', 04:11:31 INFO - 'TERM': 'linux', 04:11:31 INFO - 'TMOUT': '86400', 04:11:31 INFO - 'USER': 'cltbld', 04:11:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:31 INFO - '_': '/tools/buildbot/bin/python'} 04:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:32 INFO - Downloading/unpacking flake8 04:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:11:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:11:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:11:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:11:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:11:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:11:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:11:34 INFO - no previously-included directories found matching 'docs/_build' 04:11:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:11:34 INFO - Running setup.py install for pep8 04:11:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:11:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:11:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:11:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:11:34 INFO - no previously-included directories found matching 'docs/_build' 04:11:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:11:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:11:34 INFO - Cleaning up... 04:11:35 INFO - Return code: 0 04:11:35 INFO - Running post-action listener: _resource_record_post_action 04:11:35 INFO - Running post-action listener: _start_resource_monitoring 04:11:35 INFO - Starting resource monitoring. 04:11:35 INFO - ##### 04:11:35 INFO - ##### Running install step. 04:11:35 INFO - ##### 04:11:35 INFO - Running pre-action listener: _resource_record_pre_action 04:11:35 INFO - Running main action method: install 04:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:35 INFO - Reading from file tmpfile_stdout 04:11:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:35 INFO - Reading from file tmpfile_stdout 04:11:35 INFO - Output received: 04:11:35 INFO - Usage: mozinstall [options] installer 04:11:35 INFO - Options: 04:11:35 INFO - -h, --help show this help message and exit 04:11:35 INFO - -d DEST, --destination=DEST 04:11:35 INFO - Directory to install application into. [default: 04:11:35 INFO - "/builds/slave/test"] 04:11:35 INFO - --app=APP Application being installed. [default: firefox] 04:11:35 INFO - mkdir: /builds/slave/test/build/application 04:11:35 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:11:35 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:11:50 INFO - Reading from file tmpfile_stdout 04:11:50 INFO - Output received: 04:11:50 INFO - /builds/slave/test/build/application/firefox/firefox 04:11:50 INFO - Running post-action listener: _resource_record_post_action 04:11:50 INFO - ##### 04:11:50 INFO - ##### Running run-tests step. 04:11:50 INFO - ##### 04:11:50 INFO - Running pre-action listener: _resource_record_pre_action 04:11:50 INFO - Running main action method: run_tests 04:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:11:50 INFO - Python 2.7.3 04:11:50 INFO - Return code: 0 04:11:50 INFO - grabbing minidump binary from tooltool 04:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:50 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 0x166b410>, '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 0x166c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:11:50 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:11:50 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:11:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:11:51 INFO - Return code: 0 04:11:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:11:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:11:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:11:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:11:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:11:52 INFO - Return code: 0 04:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:11:52 INFO - Using env: {'DISPLAY': ':0', 04:11:52 INFO - 'HOME': '/home/cltbld', 04:11:52 INFO - 'LANG': 'en_US.UTF-8', 04:11:52 INFO - 'LANGUAGE': 'en_US:en', 04:11:52 INFO - 'LOGNAME': 'cltbld', 04:11:52 INFO - 'MAIL': '/var/mail/cltbld', 04:11:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:11:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:52 INFO - 'MOZ_NO_REMOTE': '1', 04:11:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:52 INFO - 'NO_EM_RESTART': '1', 04:11:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:52 INFO - 'PWD': '/builds/slave/test', 04:11:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:11:52 INFO - 'SHELL': '/bin/bash', 04:11:52 INFO - 'SHLVL': '1', 04:11:52 INFO - 'TERM': 'linux', 04:11:52 INFO - 'TMOUT': '86400', 04:11:52 INFO - 'USER': 'cltbld', 04:11:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186', 04:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:52 INFO - '_': '/tools/buildbot/bin/python'} 04:11:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:11:52 INFO - mozversion application_buildid: 20160407025248 04:11:52 INFO - mozversion application_changeset: b6683e141c47c022598c0caac3ea8ba8c6236d42 04:11:52 INFO - mozversion application_display_name: Nightly 04:11:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:11:52 INFO - mozversion application_name: Firefox 04:11:52 INFO - mozversion application_remotingname: firefox 04:11:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:11:52 INFO - mozversion application_vendor: Mozilla 04:11:52 INFO - mozversion application_version: 48.0a1 04:11:52 INFO - mozversion platform_buildid: 20160407025248 04:11:52 INFO - mozversion platform_changeset: b6683e141c47c022598c0caac3ea8ba8c6236d42 04:11:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:11:52 INFO - mozversion platform_version: 48.0a1 04:11:52 INFO - using testdate: 1460027512 04:11:52 INFO - actual date: 1460027512 04:11:52 INFO - starting webserver on 'localhost:55195' 04:11:52 INFO - SUITE-START | Running 2 tests 04:11:52 INFO - TEST-START | dromaeo_css 04:11:52 INFO - operating with platform_type : linux_ 04:11:52 INFO - Initialising browser for dromaeo_css test... 04:11:52 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkT1A9t/profile http://localhost:55195/getInfo.html) 04:11:57 INFO - PROCESS | 3340 | 04:11:57 INFO - PROCESS | 3340 | (process:3409): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:11:57 INFO - PROCESS | 3340 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 04:11:58 INFO - PROCESS | 3340 | __metrics Screen width/height:1600/1200 04:11:58 INFO - PROCESS | 3340 | colorDepth:24 04:11:58 INFO - PROCESS | 3340 | Browser inner width/height: 1024/697 04:11:58 INFO - PROCESS | 3340 | __metrics 04:11:59 ERROR - PROCESS | 3340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 04:12:00 INFO - TEST-INFO | 3340: exit 0 04:12:00 INFO - Browser initialized. 04:12:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:00 INFO - TEST-INFO | started process 3460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkT1A9t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:01 INFO - PROCESS | 3460 | 04:12:01 INFO - PROCESS | 3460 | (process:3518): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:12:11 INFO - PROCESS | 3460 | RSS: Main: 163770368 04:12:11 INFO - PROCESS | 3460 | 04:13:01 INFO - PROCESS | 3460 | 1460027581563 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:15:13 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55195/tests/dromaeo/cssquery-ext.html) 04:15:14 INFO - PROCESS | 3460 | RSS: Main: 168210432 04:15:14 INFO - PROCESS | 3460 | 04:18:16 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55195/tests/dromaeo/cssquery-ext.html (next: http://localhost:55195/tests/dromaeo/cssquery-jquery.html) 04:18:16 INFO - PROCESS | 3460 | RSS: Main: 165097472 04:18:16 INFO - PROCESS | 3460 | 04:21:18 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55195/tests/dromaeo/cssquery-mootools.html) 04:21:19 INFO - PROCESS | 3460 | RSS: Main: 165683200 04:21:19 INFO - PROCESS | 3460 | 04:24:20 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55195/tests/dromaeo/cssquery-prototype.html) 04:24:21 INFO - PROCESS | 3460 | RSS: Main: 163573760 04:24:21 INFO - PROCESS | 3460 | 04:27:24 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55195/tests/dromaeo/cssquery-yui.html) 04:27:24 INFO - PROCESS | 3460 | RSS: Main: 164798464 04:27:24 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55195/tests/dromaeo/cssquery-yui.html (next: http://localhost:55195/tests/dromaeo/cssquery-dojo.html) 04:30:27 INFO - PROCESS | 3460 | RSS: Main: 166854656 04:30:27 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | __start_tp_report 04:30:27 INFO - PROCESS | 3460 | _x_x_mozilla_page_load 04:30:27 INFO - PROCESS | 3460 | _x_x_mozilla_page_load_details 04:30:27 INFO - PROCESS | 3460 | |i|pagename|runs| 04:30:27 INFO - PROCESS | 3460 | |0;dojo.html;2654.8539830309337;2693.4747724193785;2700.7164247754;2748.752612264897;2753.7934654900873;4571.542845715423;4588.197065513535;4590.586847183753;4593.173228818811;4632.444106707191;4591.4260717410325;4700.85897423077;4718.740469274188;4742.383490146276;4796.088743138801;4332.0469496710675;4366.170427618758;4409.603135717784;4415.403920470728;4419.690621656486;4345.435093437849;4352.216601011816;4407;4418.801153948064;4459.821607135711;4286.142771445708;4329.870103896888;4331.501877284121;4341.717788343779;4399.73601583906;4323.3947247385395;4324.805383757738;4326.329418940069;4365.367021781855;4365.43249377582;4234.724742891703;4282.421873047161;4291.957080429187;4319.97840010798;4336.067745434747;4589.678722489427;4591.242444996572;4602.6548008899135;4615.353850460904;4642.558956899089;5030.170021946375;5057.9494205057845;5060.696358218519;5062.949370506285;5066.594672426197;4952.777125029383;5038.521340472649;5085.669431486978;5116.923246151311;5121.4622464641425;4665.906681866344;4678.695884767547;4695.577398034194;4725.527447255247;4750.477447480775;5060.51925067118;5093.363329583802;5116.283720279164;5124.052050370693;5144.996725638464;4852.272159176152;4877.829275975324;4929.580985616191;4963;4983.825566105169;4928.260760885824;5008.273800298936;5079;5098.923516147261;5185.403678576937;4906.9263961040615;4915.926261106087;4948.233023881304;4955.430125535538;4966.478519755446;4892.535209155125;4935.555799978019;4951.430585482715;5006.69959802413;5043.117454445457;4316.611504964569;4321.9135617287475;4329.523752387235;4337.1976184405985;4362.498312694081;3732.682721968609;3772.3775577029483;3777.414500752388;3792.563855156637;3807.257584770943;4272.423222864935;4349.826006959686;4408.426904502394;4410.360497727876;4486.6186374157905;5047.798088076509;5049.798008079636;5052.216906379517;5053.873653158627;5089.923651145235;4353.25994580922;4360.760158191267;4364.934525982113;4407.713498622579;4421.137878113801;4539.319102134707;4575.9084818303445;4587.220172570671;4652.790624421909;4690.53094690535;4800.3279540864305;4806.927896081562;4819.469858315652;4831;4885.633577481774;5078.009788091286;5095.312132862016;5099.260607212008;5101.260317254051;5149.562287205629;4691.225947718588;4836.951630483791;4879.682820616648;4905.190643543775;4920.089783390084;4984.451710311935;4995.625328100335;5010.924836127534;5025.7989680412375;5061.114304996685;4903.387076615423;5076.6446348755235;5098.260752190986;5098.796048158032;5139.100657385017;4889.706617602955;4915.5330243626795;4935.185694360391;4967.329410529533;4986.675866068694;4870.975645121752;4888.242322440027;4888.682235654671;4893.363862697826;4952.77712502931;4667.9263769332565;4793.945332026949;4798.7360695160705;4803.135435621622;4854.441739200037;4906.435759887516;4959.70241785494;4968.900621987467;4982.576480999156;5021.824236151717;4802.111609352281;4856.247281671346;4863.124637565272;4864.610831133572;4916.115099282163 04:30:27 INFO - PROCESS | 3460 | |1;ext.html;499.7526224518866;537.8516866490044;557.1837258416421;573.6128113523373;600.9308929473112;34769.652303476956;35262.823685881536;35305;35503.11242218946;35562.64437355626;38060.23879522415;38314.42528362077;38398.424023639665;38534;38675.80662096693;7390.224026477224;7566.243375662445;7573.053368328959;7601.049868766404;7635.580043097628;7683.5005724628;7777.922220777777;7782.59913215621;7785.688572457095;7826.843463130734;7913.1691172426645;7983.720569780059;7984.281414672679;7988.241117093867;7996.240357166089;7928.682852685885;7936.285734283884;7977.601119944009;7984;7994;7854.253845884689;7953;7964.044314682275;8005.039395272604;8005.359571234288;37432.251354972745;37989.81005094957;38005.619943800484;38346.42480362797;38365.80817095897;2510.4226028013477;2889.1188187602775;2908.2002449326606;2922.956155657667;2982.910512684623;25697.140840098924;25720.356991075187;26091.478170436676;26092.34769130768;26097.478050439076;3350.2964377480757;3427.4405145658666;3472.4791281307753;3520;3552.7690700104667;164353.9999999988;165040.17479912643;165174;165424;165525;55397.1690424644;55753;55901.72049139728;56049.71975140098;56282.71858640681;64561.677191613744;64945.350546494876;65301.34698653048;65319;65533;14098.436062557588;14183;14201.502947396792;14277.64305892361;14341.498047568284;11312.151588630886;11460.770784584261;11466.2546934449;11469.770604587862;11483.368414737102;20076.799232007786;20544.486387840123;20611.793882061287;20658.483537911372;20730.06714697842;7413.406927445899;7504.6212562840565;7597.5821329826285;7733.370653977675;7755.7673269802;899.5906862377602;904.2991681446931;921.801812610292;975.4293738163112;991.1129539062499;26159;26725.599116013276;26763.86618066936;27276.727232727815;27408.725912740618;957.0142752964458;958.1233171647864;1004.2969921055145;1050.9647996723222;1095.7972775036485;13658.863411365759;13727.519536816164;13864.930675346559;13910.165390076425;14316.713665726835;333748;339770;341667;342204;342278;50365.496345036816;50375.74812125916;50910.23634645483;51063.7446812771;51177;1252.3425201768962;1271.6884363331044;1276.342683517989;1276.4000919567789;1285.0683254640312;26024.60963085593;26410.207693769218;26461.60307595349;26630.467390652466;26663.866680666473;37625.62374376221;37842.243155137294;38129;38164.23671526498;38319.808400957816;273708;275097;276484;278171;278453;31462.370752585277;32308.19229519281;32514.674853252112;32709.509357360133;32716.345673086882;39705.80147099246;40929.77210683684;41172.79413602913;41186.38220426756;41221;34611.4808277871;35374.46938295876;35586;35591.64408355987;35887.28225435424;34330.82834585811;34673.826630866686;34929.825350873085;35018.824905875306;35184;31709.524357135124;35498.467522987696;37407;37963.43054854124;38061.2387752249;27686.723132768413;29103.85448072746;30713.232169195056;31937.520937185494;32038.83980580082;24686;24998.125065623342;25309.87345063263;25389.238322850342;25895.352616184748 04:30:27 INFO - PROCESS | 3460 | |2;jquery.html;337.97803142795715;349.74119151827637;351.50437882585544;357.19809028730486;362.764203267876;14976.17631030293;15305.617359566002;15995.760063599055;16049.598760031005;16054.518364449055;16056.518304450856;16159;16165.676686466264;16488.83511164888;16630.584235394123;4996.500349965002;5050.040492306468;5211.114110601206;5212.4266330703595;5215.113430716769;5224.843254702346;5262.105442074837;5279;5286.04851126797;5293.8941221175555;5107.974460127694;5259.5529380002745;5436.700981446039;5438.021156191884;5443.1835224716215;5387.622866399353;5438.646487978289;5444.346678398598;5445.727713614343;5447.891042179174;5234.7644356004075;5238.5023422774775;5255.395629502618;5323.707196104213;5369.516743493065;11985.400729963467;12121.696957576043;12151.939240303831;12309.69225769354;12958.48166073356;1870.7661542307212;1890.5651700109051;1897.9371551930963;2092.7384076990375;2356;9020.77448063797;10623.309484883535;11913.583024594098;12347.382630868511;12696.873031269753;1744.9651006979916;1754.6929287374785;1803.9007854567994;1808.8824226425372;1825.4979880532826;59079.70460147715;60795;62059.379406205815;62399.37600623981;62432.375676243566;9451.243900487945;9538.666146684971;9598.856017159747;9626.855597166048;9841.950790246003;12998.155119917175;13079.542216022584;13094.345282735825;13104.541341053018;13143.408546615425;7013;7042.823929401806;7138.678759455837;7139.286571222973;7161.283871612797;6869.381755642016;6891.517593768488;6939.479539034492;7043.506954513237;7103.076600041962;4096.979515102465;4140.296149654566;4167.10407262434;4177.394277829698;4243.936340954888;1732.6534693061437;1776.9555761106076;1805.4312891439417;1822.4077174917938;1844.8708590398812;878.0560897035712;879.5821984557411;909.1363204955319;930.2790337488366;959.9872134897611;15431.459898903484;15764.211789410483;15932.044077355396;16193.595160120856;16362.918185409235;903.7966457547;920.5259291464901;964.6430820596283;991.6826615482976;993.8906720260766;9007.81984360309;9082.18260356571;9140.6800761973;9249.491277979776;9373.765655858522;408934;412536;419988;422211;424918;42075.57924420717;44366.11267774626;60088;65057.67471162614;67402.66298668475;938.4275591888942;947.5972711597682;951.785848184153;970.8592254123113;975.7121649113528;14120.576382708536;14192.787108193179;14374;14376.856231437552;14614.780778288121;31009;32871.67128328782;33476.33047339088;33731.66268337285;34418.48372274468;41626.58373416227;43234.78382608067;43518.185810676994;47680;48139.277910830664;7439;7574.431917606092;7595.278448547379;7656.502327348704;7693.730719424793;7011.4390848733;10074.798504030025;10413.47932603382;10712.732181695208;12061.216020958609;9918;10103.191744660557;10278.794424111325;10282.640107596199;10372.792544148924;10150.898491014996;10169.796604068026;10437.425941573287;10452.111570516592;10634.8936510637;9464.432134071978;10373.636922707668;10395;10891.346519208873;10991;7616.314531692175;7636.961815190888;7700.807479813049;7805.8829117562145;7864.2922137007945;8128.715494957884;10275.897241027495;10554.419506927192;10722.946385268024;10823.458827058774 04:30:27 INFO - PROCESS | 3460 | |3;mootools.html;1432.3411230833817;1444.5882923366837;1598.2807736518562;1730.1089938681573;1763.8236176382363;6565.376289252526;7148.499605027637;7456.328930396263;7639.121501027384;7648.1587025427225;7340.155882073564;7351.338379545839;7373.446991475634;7383.667734951927;7417.703291868333;2257.1084421653477;2277.20297895736;2279.0200213908015;2283.4633861042644;2285.3715228312262;2195.6047911375945;2235.5417139486367;2236.8434209605334;2241.932742017742;2242.473018840571;2227.7883601057956;2248.8650680959113;2253.2902135827244;2259.548090381922;2292.5529521743265;2217.1020736601704;2241.9775802241934;2242.473018840571;2250.032486031006;2255.041607316892;2195;2205.8014778669835;2207;2210.9447263818374;2219.1345375303645;7398.889016664754;7491.063617047869;7493.288137626972;7493.737719179802;7545.849083018309;4512.706674066175;4603.930941035887;4605.470370907355;4609.400777898885;4620.445546534404;2941.3970136122043;3062.127293721279;3069.0946170879643;3071.3396619726864;3091.3044564972924;888.8533391990314;922.9307801914883;934.0799312677008;956.067833861986;966.4925913895261;10192.847107293397;10213.642522511676;10224.182065434747;10229.488525573766;10290.331128476626;4095.467589213443;4112.136451345191;4163.375493675912;4210.2842516772225;4218.78906054696;8931.821363572823;8941.284697224337;9003.459792412345;9007.774805629911;9111.45331280112;4558.2251017327135;4616.976915115403;4623.630109591225;4630.28230624247;4632.837850675211;3598.586162591283;4092.877213683594;4132.152908653718;4150.750954942713;4159.1265834175165;3556.751027428107;3604.9639503604626;3606.026372879308;3612.512310838056;3676.1361080146144;1159.13644334971;1173.5188572685158;1196.1088988703298;1223.1193540650718;1226.4419689041465;1182.4324324324373;1187.2638963842473;1196.922200057011;1210.0077936092496;1211.8606360268507;6687.899681504781;6731.326867313327;6743.561668491532;6753.15585551806;6971.268016858156;456.21530966737157;456.5366153354348;459.5661536007611;462.95370462953434;463.5850913432459;5299.5760339172775;5326.97336513315;5336.733163341817;5337.973310133502;5346.8395948121615;8745.781355466037;8926.152015558511;9002.414843035182;9055.773605659779;9368.953155234316;8827.382083254239;8892.644294228288;8904.376693631513;8983.101689831095;9000;6994.685239164148;7070.858582828418;7151.249118842551;7161.283871612797;7222.638868056576;7038.2609825969585;7124.715011399693;7136.464765142531;7143.035690181759;7191.280871912767;8039.638216280165;8288.129746376784;8291.917080829115;8349.540775257175;8377.287930525974;8268.214519620626;8630.050694423482;8638.222559969632;8641.783955401166;8674.089220631742;6665.633390163393;6676.766313179015;6711.832204194934;6718.865622687616;6792.320767923168;7221.53060051095;7295.708171673074;7297.525660832029;7318.158411782713;7366.521176123535;6436.645984470899;6709.329067093252;6717.865642687217;6815.863682726417;6869.862602747817;6455.0317452382515;6473.902891456538;6516.934830651822;6585.868282634417;6628.801135965736;6827.453803695593;6851.48613853953;6858.177018757581;6982.476314276348;7041.260667629826;6304.905426418516;6364.07720880479;6367.745290188341;6426.164598602339;6505.41451269388;6342.429181373698;6371.776987805404;6380.840478987877;6382.840428989312;6402.935970640234 04:30:27 INFO - PROCESS | 3460 | |4;prototype.html;302.5280562322776;307.86453960257484;313.683179988212;316.6627541668123;317.1199920221384;5606.635568688032;5643.46387093226;5714.171445140452;5720.628159169651;5736.713164341787;5531.0873705838485;5557.527610153142;5590.776368945248;5600.691961942091;5611.887762244753;4137.420761093449;4225.915481690365;4271.914561708764;4320.1143765527995;4325.675574331922;4305.827766889321;4314.719543229696;4317.395564620955;4327.199468098412;4347.956490442287;4292.849750258742;4293.334533147367;4297.548757380477;4298.140371925611;4317.4819021717285;4316.54676258993;4316.740995540277;4317.395564620955;4318.4170137031415;4335.6965012449145;3749.2876353492748;3751.3435148848844;3754.4931434256573;3762.849486020556;3763.0968567543864;5404.864878378072;5413.188021796723;5416.729163541847;5428.4842939920645;5430.945690543123;4890.437599676047;4895.755212239374;5002.499750025005;5018.222175562793;5021.899562008739;5972.163897054415;5997.820065398045;5999.190109335271;6004.099385092228;6007.369226231226;4100.323446631302;4111.568285330027;4116;4125.401816736587;4128.525219599725;6236.968815155895;6267.2165979252595;6327.335629758855;6335.271443783978;6347.96826015867;4218.2196293685765;4223.049813791872;4223.556526564728;4224.345226489899;4237.258479766028;4274.337477690963;4280.293751531025;4282.314829627245;4283.31466965284;4288.892777680583;4794.352762377034;4933.481984391659;4969.751512424436;4969.801207951641;4986.825461108916;5944.197533332945;5997.820065398045;6007.339192688801;6022.36765139654;6030.487408570233;1492.6119209005738;1510.4033906606828;1512.4933147395745;1513.712394645036;1523.8704710099544;961.4808003677936;980.5221919288707;998.0668075349571;1002.14817405205;1005.1857995023908;5210.843674689765;5241.266222728821;5247.685138891678;5260.316158899395;5262.184361423985;6255.093011513305;6256.7810126645345;6259.499240060784;6262.060690896402;6270.372962703785;5050.141475949097;5218.165093585084;5236.895262094813;5246.685198888079;5250.3962044364625;3315.5026745988293;3357.664233576623;3358.8488518016748;3361.4957756336744;3405.6083550391527;5963.5527335450015;5978.521718262616;5978.521718262616;5978.760849566055;5980.252468441445;6484.773032943919;6488;6489.480841532666;6497.902531462032;6513.967430162819;5921.230240068763;5947.524198064145;5953.553483488756;5955.970220148785;5964.105384192319;6072.696365181811;6291;6317;6324.083007963727;6343.794679010974;6136.23297087864;6173.382661733791;6211.099390588249;6216.875662486635;6218.378162183745;5943.881122377615;5964.165016897725;5964.761409543569;5974;5987.850303742442;4209.536950935456;4235.767032813102;4246.808893599858;4255;4257.723247988871;6201.906971395523;6254.8123556293385;6285.43431091204;6288.371162883675;6308.243010838729;5859.677717725566;6050.697465126638;6055.576109672281;6065.120557519223;6071.787487437919;6018.398160183947;6051.697415129314;6052.092186172109;6063.909041364295;6072.1498990140535;5882.235309409921;5927.4665280125;5930.822075337746;5936.28764548257;5956.612820166675;6061.969690151521;6069.332373439007;6083.726232319467;6102.328743838263;6107.297660768891;5751.8562035949435;5885.55858310637;5925.851853703692;5944.464998150187;5958.463738263577 04:30:27 INFO - PROCESS | 3460 | |5;yui.html;660.686174067318;664.0603545982435;684.4011489946297;777.657830554556;795.9562224077673;10684.893151068487;12142.878571214285;12313.261204327746;12566.183198092129;13484.460621575125;12729.490820367175;12758.234505929651;12814.807777883316;12893.419796109174;12900.354982250898;799.2526987266924;814.6008455856647;816.4692949582789;820.5158956215831;822.3544517553721;821.9013718353806;822.5064961023368;822.7038266224155;822.8560001999656;823.259066839843;853.9829203415928;857.2584714222215;860.109786371106;861.2033868671454;861.9698310559131;852.5992783391765;852.6589364254286;853.2491407561306;855.6149732620314;855.8331125430543;627.109504503606;628.4281304013372;628.9937100628981;629.2794750011258;630.8990561510183;11592.188546801728;11633.94183029088;12871.935640321739;13170.407331670098;13207.207567545882;12211.26732396059;12220.572279970158;12236.510539578407;12659.620211393672;12975.545855894998;9812.215022798231;9892.208623310118;9900.455474948874;10512.894871051345;10563.313384629975;3405.1487128217946;3457.567804024497;3483.8083905385192;3519.982400087983;3609.350316942949;37567.436488452695;37627.68303109378;37905.81047094774;38206.42690359647;44176.33735493938;9807.754806129904;10076.345037572535;10097.394156350643;10163.390196588229;10183.490825458697;17873.553161171076;18194.727079093824;18255.452336429928;18260.634787304178;18263.72604410935;6904.965475172592;6946.479014073965;6989.440844732511;6991.230964593992;7000.7549735759;3520.331137083946;3612.187257866959;3674.4855720199193;3685.594584595692;3696.334659761269;2939.1476471823357;2940.617719696426;2943.190622578765;2955.866985985636;2957.1128661401494;543.7227014222696;545.5580979406693;549.7608540284989;563.7744902039217;566.8894565559759;515.6004096824915;548.6954740119272;596.0403749962557;603.7554790309931;627.6767464755654;7672.309492145734;7843.607819608997;8128.349732021424;8160.387970902206;8185.181481851767;614.797116951405;616.0328284593146;625.5683578330937;634.9650769207645;637.2957881540831;3477.7217822574135;3577.3203091412547;3602.2975519773395;3618.5476815398074;3776.527934008249;46536.30195547069;46857.76571117191;51671.741641291555;53623.73188134035;53700.462995370326;45260.3210951836;45468.54531454709;45883.770581147546;45884.311735323994;46699.76650116796;42630.78684606619;42832.143357132685;43096.784516077845;43593.34609980853;45856.3121553177;8594.183552562497;8622.698205562776;8667.133286671282;8741.562921854009;8759.16787905148;31584.684153158174;32214.677853222107;32978.34043319072;33107.172320692174;33325.33349332951;40407.79796101001;41300.173996520505;42037.78981105075;42219.57780422157;42475.36286955636;10805.243632945932;10820.89179108199;10828.296160749525;10927.071198948179;11004.559817607525;11254.94372528132;11993;12100.092493063232;12181.695457613276;12426.192297500633;10759.623413180501;11060.446977651247;11133.276337038067;11434.94282528582;11713.941430292794;11201.43992800373;11279.379634120201;11315.094792416752;11685.298882067103;11980.58067967617;10809.189310801565;11379.374134422686;12005.219660722025;12010.33943133136;12074.215176013531;9533.674647740721;9866.654667086617;9880.752981175241;9943.900560994298;10025.097741203326;9819.754506137404;9909.355891867006;10016.849747253942;10035.09684128432;10071 04:30:27 INFO - PROCESS | 3460 | __end_tp_report 04:30:27 INFO - PROCESS | 3460 | __start_cc_report 04:30:27 INFO - PROCESS | 3460 | _x_x_mozilla_cycle_collect,369 04:30:27 INFO - PROCESS | 3460 | __end_cc_report 04:30:27 INFO - PROCESS | 3460 | __startTimestamp1460028627479__endTimestamp 04:30:27 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | ------- Summary: start ------- 04:30:27 INFO - PROCESS | 3460 | Number of tests: 6 04:30:27 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | [#0] dojo.html Cycles:165 Average:4668.18 Median:4806.93 stddev:472.26 (9.8%) stddev-sans-first:446.52 04:30:27 INFO - PROCESS | 3460 | Values: 2654.9 2693.5 2700.7 2748.8 2753.8 4571.5 4588.2 4590.6 4593.2 4632.4 4591.4 4700.9 4718.7 4742.4 4796.1 4332.0 4366.2 4409.6 4415.4 4419.7 4345.4 4352.2 4407.0 4418.8 4459.8 4286.1 4329.9 4331.5 4341.7 4399.7 4323.4 4324.8 4326.3 4365.4 4365.4 4234.7 4282.4 4292.0 4320.0 4336.1 4589.7 4591.2 4602.7 4615.4 4642.6 5030.2 5057.9 5060.7 5062.9 5066.6 4952.8 5038.5 5085.7 5116.9 5121.5 4665.9 4678.7 4695.6 4725.5 4750.5 5060.5 5093.4 5116.3 5124.1 5145.0 4852.3 4877.8 4929.6 4963.0 4983.8 4928.3 5008.3 5079.0 5098.9 5185.4 4906.9 4915.9 4948.2 4955.4 4966.5 4892.5 4935.6 4951.4 5006.7 5043.1 4316.6 4321.9 4329.5 4337.2 4362.5 3732.7 3772.4 3777.4 3792.6 3807.3 4272.4 4349.8 4408.4 4410.4 4486.6 5047.8 5049.8 5052.2 5053.9 5089.9 4353.3 4360.8 4364.9 4407.7 4421.1 4539.3 4575.9 4587.2 4652.8 4690.5 4800.3 4806.9 4819.5 4831.0 4885.6 5078.0 5095.3 5099.3 5101.3 5149.6 4691.2 4837.0 4879.7 4905.2 4920.1 4984.5 4995.6 5010.9 5025.8 5061.1 4903.4 5076.6 5098.3 5098.8 5139.1 4889.7 4915.5 4935.2 4967.3 4986.7 4871.0 4888.2 4888.7 4893.4 4952.8 4667.9 4793.9 4798.7 4803.1 4854.4 4906.4 4959.7 4968.9 4982.6 5021.8 4802.1 4856.2 4863.1 4864.6 4916.1 04:30:27 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | [#1] ext.html Cycles:180 Average:42618.30 Median:35283.91 stddev:71077.87 (201.4%) stddev-sans-first:71206.91 04:30:27 INFO - PROCESS | 3460 | Values: 499.8 537.9 557.2 573.6 600.9 34769.7 35262.8 35305.0 35503.1 35562.6 38060.2 38314.4 38398.4 38534.0 38675.8 7390.2 7566.2 7573.1 7601.0 7635.6 7683.5 7777.9 7782.6 7785.7 7826.8 7913.2 7983.7 7984.3 7988.2 7996.2 7928.7 7936.3 7977.6 7984.0 7994.0 7854.3 7953.0 7964.0 8005.0 8005.4 37432.3 37989.8 38005.6 38346.4 38365.8 2510.4 2889.1 2908.2 2923.0 2982.9 25697.1 25720.4 26091.5 26092.3 26097.5 3350.3 3427.4 3472.5 3520.0 3552.8 164354.0 165040.2 165174.0 165424.0 165525.0 55397.2 55753.0 55901.7 56049.7 56282.7 64561.7 64945.4 65301.3 65319.0 65533.0 14098.4 14183.0 14201.5 14277.6 14341.5 11312.2 11460.8 11466.3 11469.8 11483.4 20076.8 20544.5 20611.8 20658.5 20730.1 7413.4 7504.6 7597.6 7733.4 7755.8 899.6 904.3 921.8 975.4 991.1 26159.0 26725.6 26763.9 27276.7 27408.7 957.0 958.1 1004.3 1051.0 1095.8 13658.9 13727.5 13864.9 13910.2 14316.7 333748.0 339770.0 341667.0 342204.0 342278.0 50365.5 50375.7 50910.2 51063.7 51177.0 1252.3 1271.7 1276.3 1276.4 1285.1 26024.6 26410.2 26461.6 26630.5 26663.9 37625.6 37842.2 38129.0 38164.2 38319.8 273708.0 275097.0 276484.0 278171.0 278453.0 31462.4 32308.2 32514.7 32709.5 32716.3 39705.8 40929.8 41172.8 41186.4 41221.0 34611.5 35374.5 35586.0 35591.6 35887.3 34330.8 34673.8 34929.8 35018.8 35184.0 31709.5 35498.5 37407.0 37963.4 38061.2 27686.7 29103.9 30713.2 31937.5 32038.8 24686.0 24998.1 25309.9 25389.2 25895.4 04:30:27 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | [#2] jquery.html Cycles:180 Average:23624.48 Median:214580.97 stddev:68310.01 (31.8%) stddev-sans-first:68479.26 04:30:27 INFO - PROCESS | 3460 | Values: 338.0 349.7 351.5 357.2 362.8 14976.2 15305.6 15995.8 16049.6 16054.5 16056.5 16159.0 16165.7 16488.8 16630.6 4996.5 5050.0 5211.1 5212.4 5215.1 5224.8 5262.1 5279.0 5286.0 5293.9 5108.0 5259.6 5436.7 5438.0 5443.2 5387.6 5438.6 5444.3 5445.7 5447.9 5234.8 5238.5 5255.4 5323.7 5369.5 11985.4 12121.7 12151.9 12309.7 12958.5 1870.8 1890.6 1897.9 2092.7 2356.0 9020.8 10623.3 11913.6 12347.4 12696.9 1745.0 1754.7 1803.9 1808.9 1825.5 59079.7 60795.0 62059.4 62399.4 62432.4 9451.2 9538.7 9598.9 9626.9 9842.0 12998.2 13079.5 13094.3 13104.5 13143.4 7013.0 7042.8 7138.7 7139.3 7161.3 6869.4 6891.5 6939.5 7043.5 7103.1 4097.0 4140.3 4167.1 4177.4 4243.9 1732.7 1777.0 1805.4 1822.4 1844.9 878.1 879.6 909.1 930.3 960.0 15431.5 15764.2 15932.0 16193.6 16362.9 903.8 920.5 964.6 991.7 993.9 9007.8 9082.2 9140.7 9249.5 9373.8 408934.0 412536.0 419988.0 422211.0 424918.0 42075.6 44366.1 60088.0 65057.7 67402.7 938.4 947.6 951.8 970.9 975.7 14120.6 14192.8 14374.0 14376.9 14614.8 31009.0 32871.7 33476.3 33731.7 34418.5 41626.6 43234.8 43518.2 47680.0 48139.3 7439.0 7574.4 7595.3 7656.5 7693.7 7011.4 10074.8 10413.5 10712.7 12061.2 9918.0 10103.2 10278.8 10282.6 10372.8 10150.9 10169.8 10437.4 10452.1 10634.9 9464.4 10373.6 10395.0 10891.3 10991.0 7616.3 7637.0 7700.8 7805.9 7864.3 8128.7 10275.9 10554.4 10722.9 10823.5 04:30:27 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | [#3] mootools.html Cycles:180 Average:5280.31 Median:6381.84 stddev:2744.39 (43.0%) stddev-sans-first:2736.85 04:30:27 INFO - PROCESS | 3460 | Values: 1432.3 1444.6 1598.3 1730.1 1763.8 6565.4 7148.5 7456.3 7639.1 7648.2 7340.2 7351.3 7373.4 7383.7 7417.7 2257.1 2277.2 2279.0 2283.5 2285.4 2195.6 2235.5 2236.8 2241.9 2242.5 2227.8 2248.9 2253.3 2259.5 2292.6 2217.1 2242.0 2242.5 2250.0 2255.0 2195.0 2205.8 2207.0 2210.9 2219.1 7398.9 7491.1 7493.3 7493.7 7545.8 4512.7 4603.9 4605.5 4609.4 4620.4 2941.4 3062.1 3069.1 3071.3 3091.3 888.9 922.9 934.1 956.1 966.5 10192.8 10213.6 10224.2 10229.5 10290.3 4095.5 4112.1 4163.4 4210.3 4218.8 8931.8 8941.3 9003.5 9007.8 9111.5 4558.2 4617.0 4623.6 4630.3 4632.8 3598.6 4092.9 4132.2 4150.8 4159.1 3556.8 3605.0 3606.0 3612.5 3676.1 1159.1 1173.5 1196.1 1223.1 1226.4 1182.4 1187.3 1196.9 1210.0 1211.9 6687.9 6731.3 6743.6 6753.2 6971.3 456.2 456.5 459.6 463.0 463.6 5299.6 5327.0 5336.7 5338.0 5346.8 8745.8 8926.2 9002.4 9055.8 9369.0 8827.4 8892.6 8904.4 8983.1 9000.0 6994.7 7070.9 7151.2 7161.3 7222.6 7038.3 7124.7 7136.5 7143.0 7191.3 8039.6 8288.1 8291.9 8349.5 8377.3 8268.2 8630.1 8638.2 8641.8 8674.1 6665.6 6676.8 6711.8 6718.9 6792.3 7221.5 7295.7 7297.5 7318.2 7366.5 6436.6 6709.3 6717.9 6815.9 6869.9 6455.0 6473.9 6516.9 6585.9 6628.8 6827.5 6851.5 6858.2 6982.5 7041.3 6304.9 6364.1 6367.7 6426.2 6505.4 6342.4 6371.8 6380.8 6382.8 6402.9 04:30:27 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | [#4] prototype.html Cycles:180 Average:4962.97 Median:5603.66 stddev:1494.17 (26.7%) stddev-sans-first:1456.84 04:30:27 INFO - PROCESS | 3460 | Values: 302.5 307.9 313.7 316.7 317.1 5606.6 5643.5 5714.2 5720.6 5736.7 5531.1 5557.5 5590.8 5600.7 5611.9 4137.4 4225.9 4271.9 4320.1 4325.7 4305.8 4314.7 4317.4 4327.2 4348.0 4292.8 4293.3 4297.5 4298.1 4317.5 4316.5 4316.7 4317.4 4318.4 4335.7 3749.3 3751.3 3754.5 3762.8 3763.1 5404.9 5413.2 5416.7 5428.5 5430.9 4890.4 4895.8 5002.5 5018.2 5021.9 5972.2 5997.8 5999.2 6004.1 6007.4 4100.3 4111.6 4116.0 4125.4 4128.5 6237.0 6267.2 6327.3 6335.3 6348.0 4218.2 4223.0 4223.6 4224.3 4237.3 4274.3 4280.3 4282.3 4283.3 4288.9 4794.4 4933.5 4969.8 4969.8 4986.8 5944.2 5997.8 6007.3 6022.4 6030.5 1492.6 1510.4 1512.5 1513.7 1523.9 961.5 980.5 998.1 1002.1 1005.2 5210.8 5241.3 5247.7 5260.3 5262.2 6255.1 6256.8 6259.5 6262.1 6270.4 5050.1 5218.2 5236.9 5246.7 5250.4 3315.5 3357.7 3358.8 3361.5 3405.6 5963.6 5978.5 5978.5 5978.8 5980.3 6484.8 6488.0 6489.5 6497.9 6514.0 5921.2 5947.5 5953.6 5956.0 5964.1 6072.7 6291.0 6317.0 6324.1 6343.8 6136.2 6173.4 6211.1 6216.9 6218.4 5943.9 5964.2 5964.8 5974.0 5987.9 4209.5 4235.8 4246.8 4255.0 4257.7 6201.9 6254.8 6285.4 6288.4 6308.2 5859.7 6050.7 6055.6 6065.1 6071.8 6018.4 6051.7 6052.1 6063.9 6072.1 5882.2 5927.5 5930.8 5936.3 5956.6 6062.0 6069.3 6083.7 6102.3 6107.3 5751.9 5885.6 5925.9 5944.5 5958.5 04:30:27 INFO - PROCESS | 3460 | 04:30:27 INFO - PROCESS | 3460 | [#5] yui.html Cycles:180 Average:12849.28 Median:41668.98 stddev:14193.26 (34.1%) stddev-sans-first:14203.56 04:30:27 INFO - PROCESS | 3460 | Values: 660.7 664.1 684.4 777.7 796.0 10684.9 12142.9 12313.3 12566.2 13484.5 12729.5 12758.2 12814.8 12893.4 12900.4 799.3 814.6 816.5 820.5 822.4 821.9 822.5 822.7 822.9 823.3 854.0 857.3 860.1 861.2 862.0 852.6 852.7 853.2 855.6 855.8 627.1 628.4 629.0 629.3 630.9 11592.2 11633.9 12871.9 13170.4 13207.2 12211.3 12220.6 12236.5 12659.6 12975.5 9812.2 9892.2 9900.5 10512.9 10563.3 3405.1 3457.6 3483.8 3520.0 3609.4 37567.4 37627.7 37905.8 38206.4 44176.3 9807.8 10076.3 10097.4 10163.4 10183.5 17873.6 18194.7 18255.5 18260.6 18263.7 6905.0 6946.5 6989.4 6991.2 7000.8 3520.3 3612.2 3674.5 3685.6 3696.3 2939.1 2940.6 2943.2 2955.9 2957.1 543.7 545.6 549.8 563.8 566.9 515.6 548.7 596.0 603.8 627.7 7672.3 7843.6 8128.3 8160.4 8185.2 614.8 616.0 625.6 635.0 637.3 3477.7 3577.3 3602.3 3618.5 3776.5 46536.3 46857.8 51671.7 53623.7 53700.5 45260.3 45468.5 45883.8 45884.3 46699.8 42630.8 42832.1 43096.8 43593.3 45856.3 8594.2 8622.7 8667.1 8741.6 8759.2 31584.7 32214.7 32978.3 33107.2 33325.3 40407.8 41300.2 42037.8 42219.6 42475.4 10805.2 10820.9 10828.3 10927.1 11004.6 11254.9 11993.0 12100.1 12181.7 12426.2 10759.6 11060.4 11133.3 11434.9 11713.9 11201.4 11279.4 11315.1 11685.3 11980.6 10809.2 11379.4 12005.2 12010.3 12074.2 9533.7 9866.7 9880.8 9943.9 10025.1 9819.8 9909.4 10016.8 10035.1 10071.0 04:30:27 INFO - PROCESS | 3460 | -------- Summary: end -------- 04:30:27 INFO - PROCESS | 3460 | 04:30:28 INFO - TEST-INFO | 3460: exit 0 04:30:28 INFO - TEST-OK | dromaeo_css | took 1115871ms 04:30:28 INFO - TEST-START | kraken 04:30:28 INFO - operating with platform_type : linux_ 04:30:28 INFO - Initialising browser for kraken test... 04:30:28 INFO - TEST-INFO | started process 3697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcflvq/profile http://localhost:55195/getInfo.html) 04:30:31 INFO - PROCESS | 3697 | 04:30:31 INFO - PROCESS | 3697 | (process:3765): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:30:31 INFO - PROCESS | 3697 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 04:30:32 INFO - PROCESS | 3697 | __metrics Screen width/height:1600/1200 04:30:32 INFO - PROCESS | 3697 | colorDepth:24 04:30:32 INFO - PROCESS | 3697 | Browser inner width/height: 1024/697 04:30:32 INFO - PROCESS | 3697 | __metrics 04:30:32 ERROR - PROCESS | 3697 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 04:30:33 INFO - TEST-INFO | 3697: exit 0 04:30:33 INFO - Browser initialized. 04:30:33 INFO - Running cycle 1/1 for kraken test... 04:30:33 INFO - TEST-INFO | started process 3816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcflvq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:35 INFO - PROCESS | 3816 | 04:30:35 INFO - PROCESS | 3816 | (process:3876): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:30:45 INFO - PROCESS | 3816 | RSS: Main: 163708928 04:30:45 INFO - PROCESS | 3816 | 04:30:48 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55195/tests/kraken/driver.html?testName=audio-beat-detection) 04:30:49 INFO - PROCESS | 3816 | RSS: Main: 168099840 04:30:49 INFO - PROCESS | 3816 | 04:30:51 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55195/tests/kraken/driver.html?testName=audio-dft) 04:30:52 INFO - PROCESS | 3816 | RSS: Main: 171950080 04:30:52 INFO - PROCESS | 3816 | 04:30:55 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55195/tests/kraken/driver.html?testName=audio-fft) 04:30:55 INFO - PROCESS | 3816 | RSS: Main: 162349056 04:30:55 INFO - PROCESS | 3816 | 04:30:58 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55195/tests/kraken/driver.html?testName=audio-oscillator) 04:30:58 INFO - PROCESS | 3816 | RSS: Main: 162541568 04:30:58 INFO - PROCESS | 3816 | 04:31:00 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:01 INFO - PROCESS | 3816 | RSS: Main: 164065280 04:31:01 INFO - PROCESS | 3816 | 04:31:04 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55195/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:05 INFO - PROCESS | 3816 | RSS: Main: 164814848 04:31:05 INFO - PROCESS | 3816 | 04:31:08 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55195/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:09 INFO - PROCESS | 3816 | RSS: Main: 163999744 04:31:09 INFO - PROCESS | 3816 | 04:31:12 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55195/tests/kraken/driver.html?testName=json-parse-financial) 04:31:13 INFO - PROCESS | 3816 | RSS: Main: 164306944 04:31:13 INFO - PROCESS | 3816 | 04:31:14 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:15 INFO - PROCESS | 3816 | RSS: Main: 164810752 04:31:15 INFO - PROCESS | 3816 | 04:31:17 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55195/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:17 INFO - PROCESS | 3816 | RSS: Main: 164921344 04:31:17 INFO - PROCESS | 3816 | 04:31:20 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:21 INFO - PROCESS | 3816 | RSS: Main: 165646336 04:31:21 INFO - PROCESS | 3816 | 04:31:23 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:24 INFO - PROCESS | 3816 | RSS: Main: 165629952 04:31:24 INFO - PROCESS | 3816 | 04:31:26 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:27 INFO - PROCESS | 3816 | RSS: Main: 165695488 04:31:27 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55195/tests/kraken/driver.html?testName=ai-astar) 04:31:29 INFO - PROCESS | 3816 | RSS: Main: 167133184 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | __start_tp_report 04:31:29 INFO - PROCESS | 3816 | _x_x_mozilla_page_load 04:31:29 INFO - PROCESS | 3816 | _x_x_mozilla_page_load_details 04:31:29 INFO - PROCESS | 3816 | |i|pagename|runs| 04:31:29 INFO - PROCESS | 3816 | |0;ai-astar;116;106;114;111;114;124;113;115;115;114 04:31:29 INFO - PROCESS | 3816 | |1;audio-beat-detection;162;133;164;183;138;160;161;134;182;134 04:31:29 INFO - PROCESS | 3816 | |2;audio-dft;162;162;163;164;162;166;167;163;165;163 04:31:29 INFO - PROCESS | 3816 | |3;audio-fft;77;78;77;74;74;78;73;144;74;73 04:31:29 INFO - PROCESS | 3816 | |4;audio-oscillator;94;94;141;94;94;94;139;95;93;145 04:31:29 INFO - PROCESS | 3816 | |5;imaging-gaussian-blur;117;117;118;117;117;118;117;117;117;118 04:31:29 INFO - PROCESS | 3816 | |6;imaging-darkroom;148;147;148;147;147;148;147;147;147;146 04:31:29 INFO - PROCESS | 3816 | |7;imaging-desaturate;98;96;95;97;95;96;96;95;95;95 04:31:29 INFO - PROCESS | 3816 | |8;json-parse-financial;65;64;66;65;65;68;64;64;64;61 04:31:29 INFO - PROCESS | 3816 | |9;json-stringify-tinderbox;64;64;64;64;64;64;65;64;63;64 04:31:29 INFO - PROCESS | 3816 | |10;stanford-crypto-aes;82;82;83;84;83;84;83;84;82;83 04:31:29 INFO - PROCESS | 3816 | |11;stanford-crypto-ccm;123;119;115;123;119;117;132;127;121;121 04:31:29 INFO - PROCESS | 3816 | |12;stanford-crypto-pbkdf2;136;140;145;143;146;133;147;143;145;143 04:31:29 INFO - PROCESS | 3816 | |13;stanford-crypto-sha256-iterative;67;69;74;67;69;67;68;70;66;68 04:31:29 INFO - PROCESS | 3816 | __end_tp_report 04:31:29 INFO - PROCESS | 3816 | __start_cc_report 04:31:29 INFO - PROCESS | 3816 | _x_x_mozilla_cycle_collect,940 04:31:29 INFO - PROCESS | 3816 | __end_cc_report 04:31:29 INFO - PROCESS | 3816 | __startTimestamp1460028689398__endTimestamp 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | ------- Summary: start ------- 04:31:29 INFO - PROCESS | 3816 | Number of tests: 14 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:4.47 (3.9%) stddev-sans-first:4.69 04:31:29 INFO - PROCESS | 3816 | Values: 116.0 106.0 114.0 111.0 114.0 124.0 113.0 115.0 115.0 114.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:161.50 stddev:19.32 (12.0%) stddev-sans-first:20.33 04:31:29 INFO - PROCESS | 3816 | Values: 162.0 133.0 164.0 183.0 138.0 160.0 161.0 134.0 182.0 134.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.77 (1.1%) stddev-sans-first:1.76 04:31:29 INFO - PROCESS | 3816 | Values: 162.0 162.0 163.0 164.0 162.0 166.0 167.0 163.0 165.0 163.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.50 stddev:21.81 (28.9%) stddev-sans-first:23.05 04:31:29 INFO - PROCESS | 3816 | Values: 77.0 78.0 77.0 74.0 74.0 78.0 73.0 144.0 74.0 73.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:23.07 (24.5%) stddev-sans-first:23.89 04:31:29 INFO - PROCESS | 3816 | Values: 94.0 94.0 141.0 94.0 94.0 94.0 139.0 95.0 93.0 145.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:31:29 INFO - PROCESS | 3816 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:31:29 INFO - PROCESS | 3816 | Values: 148.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 146.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:0.73 04:31:29 INFO - PROCESS | 3816 | Values: 98.0 96.0 95.0 97.0 95.0 96.0 96.0 95.0 95.0 95.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.78 (2.7%) stddev-sans-first:1.88 04:31:29 INFO - PROCESS | 3816 | Values: 65.0 64.0 66.0 65.0 65.0 68.0 64.0 64.0 64.0 61.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 04:31:29 INFO - PROCESS | 3816 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 63.0 64.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 04:31:29 INFO - PROCESS | 3816 | Values: 82.0 82.0 83.0 84.0 83.0 84.0 83.0 84.0 82.0 83.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.00 stddev:4.95 (4.1%) stddev-sans-first:5.22 04:31:29 INFO - PROCESS | 3816 | Values: 123.0 119.0 115.0 123.0 119.0 117.0 132.0 127.0 121.0 121.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.10 Median:144.00 stddev:4.51 (3.1%) stddev-sans-first:4.21 04:31:29 INFO - PROCESS | 3816 | Values: 136.0 140.0 145.0 143.0 146.0 133.0 147.0 143.0 145.0 143.0 04:31:29 INFO - PROCESS | 3816 | 04:31:29 INFO - PROCESS | 3816 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:2.27 (3.3%) stddev-sans-first:2.35 04:31:29 INFO - PROCESS | 3816 | Values: 67.0 69.0 74.0 67.0 69.0 67.0 68.0 70.0 66.0 68.0 04:31:29 INFO - PROCESS | 3816 | -------- Summary: end -------- 04:31:29 INFO - PROCESS | 3816 | 04:31:30 INFO - TEST-INFO | 3816: exit 0 04:31:30 INFO - TEST-OK | kraken | took 62244ms 04:31:30 INFO - SUITE-END | took 1178s 04:31:30 INFO - Completed test suite (00:19:38) 04:31:30 INFO - javascript benchmark 04:31:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.8539830309337, 2693.4747724193785, 2700.7164247754, 2748.752612264897, 2753.7934654900873, 4571.542845715423, 4588.197065513535, 4590.586847183753, 4593.173228818811, 4632.444106707191, 4591.4260717410325, 4700.85897423077, 4718.740469274188, 4742.383490146276, 4796.088743138801, 4332.0469496710675, 4366.170427618758, 4409.603135717784, 4415.403920470728, 4419.690621656486, 4345.435093437849, 4352.216601011816, 4407.0, 4418.801153948064, 4459.821607135711, 4286.142771445708, 4329.870103896888, 4331.501877284121, 4341.717788343779, 4399.73601583906, 4323.3947247385395, 4324.805383757738, 4326.329418940069, 4365.367021781855, 4365.43249377582, 4234.724742891703, 4282.421873047161, 4291.957080429187, 4319.97840010798, 4336.067745434747, 4589.678722489427, 4591.242444996572, 4602.6548008899135, 4615.353850460904, 4642.558956899089, 5030.170021946375, 5057.9494205057845, 5060.696358218519, 5062.949370506285, 5066.594672426197, 4952.777125029383, 5038.521340472649, 5085.669431486978, 5116.923246151311, 5121.4622464641425, 4665.906681866344, 4678.695884767547, 4695.577398034194, 4725.527447255247, 4750.477447480775, 5060.51925067118, 5093.363329583802, 5116.283720279164, 5124.052050370693, 5144.996725638464, 4852.272159176152, 4877.829275975324, 4929.580985616191, 4963.0, 4983.825566105169, 4928.260760885824, 5008.273800298936, 5079.0, 5098.923516147261, 5185.403678576937, 4906.9263961040615, 4915.926261106087, 4948.233023881304, 4955.430125535538, 4966.478519755446, 4892.535209155125, 4935.555799978019, 4951.430585482715, 5006.69959802413, 5043.117454445457, 4316.611504964569, 4321.9135617287475, 4329.523752387235, 4337.1976184405985, 4362.498312694081, 3732.682721968609, 3772.3775577029483, 3777.414500752388, 3792.563855156637, 3807.257584770943, 4272.423222864935, 4349.826006959686, 4408.426904502394, 4410.360497727876, 4486.6186374157905, 5047.798088076509, 5049.798008079636, 5052.216906379517, 5053.873653158627, 5089.923651145235, 4353.25994580922, 4360.760158191267, 4364.934525982113, 4407.713498622579, 4421.137878113801, 4539.319102134707, 4575.9084818303445, 4587.220172570671, 4652.790624421909, 4690.53094690535, 4800.3279540864305, 4806.927896081562, 4819.469858315652, 4831.0, 4885.633577481774, 5078.009788091286, 5095.312132862016, 5099.260607212008, 5101.260317254051, 5149.562287205629, 4691.225947718588, 4836.951630483791, 4879.682820616648, 4905.190643543775, 4920.089783390084, 4984.451710311935, 4995.625328100335, 5010.924836127534, 5025.7989680412375, 5061.114304996685, 4903.387076615423, 5076.6446348755235, 5098.260752190986, 5098.796048158032, 5139.100657385017, 4889.706617602955, 4915.5330243626795, 4935.185694360391, 4967.329410529533, 4986.675866068694, 4870.975645121752, 4888.242322440027, 4888.682235654671, 4893.363862697826, 4952.77712502931, 4667.9263769332565, 4793.945332026949, 4798.7360695160705, 4803.135435621622, 4854.441739200037, 4906.435759887516, 4959.70241785494, 4968.900621987467, 4982.576480999156, 5021.824236151717, 4802.111609352281, 4856.247281671346, 4863.124637565272, 4864.610831133572, 4916.115099282163], "value": 4639.381478888903, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.7526224518866, 537.8516866490044, 557.1837258416421, 573.6128113523373, 600.9308929473112, 34769.652303476956, 35262.823685881536, 35305.0, 35503.11242218946, 35562.64437355626, 38060.23879522415, 38314.42528362077, 38398.424023639665, 38534.0, 38675.80662096693, 7390.224026477224, 7566.243375662445, 7573.053368328959, 7601.049868766404, 7635.580043097628, 7683.5005724628, 7777.922220777777, 7782.59913215621, 7785.688572457095, 7826.843463130734, 7913.1691172426645, 7983.720569780059, 7984.281414672679, 7988.241117093867, 7996.240357166089, 7928.682852685885, 7936.285734283884, 7977.601119944009, 7984.0, 7994.0, 7854.253845884689, 7953.0, 7964.044314682275, 8005.039395272604, 8005.359571234288, 37432.251354972745, 37989.81005094957, 38005.619943800484, 38346.42480362797, 38365.80817095897, 2510.4226028013477, 2889.1188187602775, 2908.2002449326606, 2922.956155657667, 2982.910512684623, 25697.140840098924, 25720.356991075187, 26091.478170436676, 26092.34769130768, 26097.478050439076, 3350.2964377480757, 3427.4405145658666, 3472.4791281307753, 3520.0, 3552.7690700104667, 164353.9999999988, 165040.17479912643, 165174.0, 165424.0, 165525.0, 55397.1690424644, 55753.0, 55901.72049139728, 56049.71975140098, 56282.71858640681, 64561.677191613744, 64945.350546494876, 65301.34698653048, 65319.0, 65533.0, 14098.436062557588, 14183.0, 14201.502947396792, 14277.64305892361, 14341.498047568284, 11312.151588630886, 11460.770784584261, 11466.2546934449, 11469.770604587862, 11483.368414737102, 20076.799232007786, 20544.486387840123, 20611.793882061287, 20658.483537911372, 20730.06714697842, 7413.406927445899, 7504.6212562840565, 7597.5821329826285, 7733.370653977675, 7755.7673269802, 899.5906862377602, 904.2991681446931, 921.801812610292, 975.4293738163112, 991.1129539062499, 26159.0, 26725.599116013276, 26763.86618066936, 27276.727232727815, 27408.725912740618, 957.0142752964458, 958.1233171647864, 1004.2969921055145, 1050.9647996723222, 1095.7972775036485, 13658.863411365759, 13727.519536816164, 13864.930675346559, 13910.165390076425, 14316.713665726835, 333748.0, 339770.0, 341667.0, 342204.0, 342278.0, 50365.496345036816, 50375.74812125916, 50910.23634645483, 51063.7446812771, 51177.0, 1252.3425201768962, 1271.6884363331044, 1276.342683517989, 1276.4000919567789, 1285.0683254640312, 26024.60963085593, 26410.207693769218, 26461.60307595349, 26630.467390652466, 26663.866680666473, 37625.62374376221, 37842.243155137294, 38129.0, 38164.23671526498, 38319.808400957816, 273708.0, 275097.0, 276484.0, 278171.0, 278453.0, 31462.370752585277, 32308.19229519281, 32514.674853252112, 32709.509357360133, 32716.345673086882, 39705.80147099246, 40929.77210683684, 41172.79413602913, 41186.38220426756, 41221.0, 34611.4808277871, 35374.46938295876, 35586.0, 35591.64408355987, 35887.28225435424, 34330.82834585811, 34673.826630866686, 34929.825350873085, 35018.824905875306, 35184.0, 31709.524357135124, 35498.467522987696, 37407.0, 37963.43054854124, 38061.2387752249, 27686.723132768413, 29103.85448072746, 30713.232169195056, 31937.520937185494, 32038.83980580082, 24686.0, 24998.125065623342, 25309.87345063263, 25389.238322850342, 25895.352616184748], "value": 17233.223396058063, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.97803142795715, 349.74119151827637, 351.50437882585544, 357.19809028730486, 362.764203267876, 14976.17631030293, 15305.617359566002, 15995.760063599055, 16049.598760031005, 16054.518364449055, 16056.518304450856, 16159.0, 16165.676686466264, 16488.83511164888, 16630.584235394123, 4996.500349965002, 5050.040492306468, 5211.114110601206, 5212.4266330703595, 5215.113430716769, 5224.843254702346, 5262.105442074837, 5279.0, 5286.04851126797, 5293.8941221175555, 5107.974460127694, 5259.5529380002745, 5436.700981446039, 5438.021156191884, 5443.1835224716215, 5387.622866399353, 5438.646487978289, 5444.346678398598, 5445.727713614343, 5447.891042179174, 5234.7644356004075, 5238.5023422774775, 5255.395629502618, 5323.707196104213, 5369.516743493065, 11985.400729963467, 12121.696957576043, 12151.939240303831, 12309.69225769354, 12958.48166073356, 1870.7661542307212, 1890.5651700109051, 1897.9371551930963, 2092.7384076990375, 2356.0, 9020.77448063797, 10623.309484883535, 11913.583024594098, 12347.382630868511, 12696.873031269753, 1744.9651006979916, 1754.6929287374785, 1803.9007854567994, 1808.8824226425372, 1825.4979880532826, 59079.70460147715, 60795.0, 62059.379406205815, 62399.37600623981, 62432.375676243566, 9451.243900487945, 9538.666146684971, 9598.856017159747, 9626.855597166048, 9841.950790246003, 12998.155119917175, 13079.542216022584, 13094.345282735825, 13104.541341053018, 13143.408546615425, 7013.0, 7042.823929401806, 7138.678759455837, 7139.286571222973, 7161.283871612797, 6869.381755642016, 6891.517593768488, 6939.479539034492, 7043.506954513237, 7103.076600041962, 4096.979515102465, 4140.296149654566, 4167.10407262434, 4177.394277829698, 4243.936340954888, 1732.6534693061437, 1776.9555761106076, 1805.4312891439417, 1822.4077174917938, 1844.8708590398812, 878.0560897035712, 879.5821984557411, 909.1363204955319, 930.2790337488366, 959.9872134897611, 15431.459898903484, 15764.211789410483, 15932.044077355396, 16193.595160120856, 16362.918185409235, 903.7966457547, 920.5259291464901, 964.6430820596283, 991.6826615482976, 993.8906720260766, 9007.81984360309, 9082.18260356571, 9140.6800761973, 9249.491277979776, 9373.765655858522, 408934.0, 412536.0, 419988.0, 422211.0, 424918.0, 42075.57924420717, 44366.11267774626, 60088.0, 65057.67471162614, 67402.66298668475, 938.4275591888942, 947.5972711597682, 951.785848184153, 970.8592254123113, 975.7121649113528, 14120.576382708536, 14192.787108193179, 14374.0, 14376.856231437552, 14614.780778288121, 31009.0, 32871.67128328782, 33476.33047339088, 33731.66268337285, 34418.48372274468, 41626.58373416227, 43234.78382608067, 43518.185810676994, 47680.0, 48139.277910830664, 7439.0, 7574.431917606092, 7595.278448547379, 7656.502327348704, 7693.730719424793, 7011.4390848733, 10074.798504030025, 10413.47932603382, 10712.732181695208, 12061.216020958609, 9918.0, 10103.191744660557, 10278.794424111325, 10282.640107596199, 10372.792544148924, 10150.898491014996, 10169.796604068026, 10437.425941573287, 10452.111570516592, 10634.8936510637, 9464.432134071978, 10373.636922707668, 10395.0, 10891.346519208873, 10991.0, 7616.314531692175, 7636.961815190888, 7700.807479813049, 7805.8829117562145, 7864.2922137007945, 8128.715494957884, 10275.897241027495, 10554.419506927192, 10722.946385268024, 10823.458827058774], "value": 7907.61748916225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.3411230833817, 1444.5882923366837, 1598.2807736518562, 1730.1089938681573, 1763.8236176382363, 6565.376289252526, 7148.499605027637, 7456.328930396263, 7639.121501027384, 7648.1587025427225, 7340.155882073564, 7351.338379545839, 7373.446991475634, 7383.667734951927, 7417.703291868333, 2257.1084421653477, 2277.20297895736, 2279.0200213908015, 2283.4633861042644, 2285.3715228312262, 2195.6047911375945, 2235.5417139486367, 2236.8434209605334, 2241.932742017742, 2242.473018840571, 2227.7883601057956, 2248.8650680959113, 2253.2902135827244, 2259.548090381922, 2292.5529521743265, 2217.1020736601704, 2241.9775802241934, 2242.473018840571, 2250.032486031006, 2255.041607316892, 2195.0, 2205.8014778669835, 2207.0, 2210.9447263818374, 2219.1345375303645, 7398.889016664754, 7491.063617047869, 7493.288137626972, 7493.737719179802, 7545.849083018309, 4512.706674066175, 4603.930941035887, 4605.470370907355, 4609.400777898885, 4620.445546534404, 2941.3970136122043, 3062.127293721279, 3069.0946170879643, 3071.3396619726864, 3091.3044564972924, 888.8533391990314, 922.9307801914883, 934.0799312677008, 956.067833861986, 966.4925913895261, 10192.847107293397, 10213.642522511676, 10224.182065434747, 10229.488525573766, 10290.331128476626, 4095.467589213443, 4112.136451345191, 4163.375493675912, 4210.2842516772225, 4218.78906054696, 8931.821363572823, 8941.284697224337, 9003.459792412345, 9007.774805629911, 9111.45331280112, 4558.2251017327135, 4616.976915115403, 4623.630109591225, 4630.28230624247, 4632.837850675211, 3598.586162591283, 4092.877213683594, 4132.152908653718, 4150.750954942713, 4159.1265834175165, 3556.751027428107, 3604.9639503604626, 3606.026372879308, 3612.512310838056, 3676.1361080146144, 1159.13644334971, 1173.5188572685158, 1196.1088988703298, 1223.1193540650718, 1226.4419689041465, 1182.4324324324373, 1187.2638963842473, 1196.922200057011, 1210.0077936092496, 1211.8606360268507, 6687.899681504781, 6731.326867313327, 6743.561668491532, 6753.15585551806, 6971.268016858156, 456.21530966737157, 456.5366153354348, 459.5661536007611, 462.95370462953434, 463.5850913432459, 5299.5760339172775, 5326.97336513315, 5336.733163341817, 5337.973310133502, 5346.8395948121615, 8745.781355466037, 8926.152015558511, 9002.414843035182, 9055.773605659779, 9368.953155234316, 8827.382083254239, 8892.644294228288, 8904.376693631513, 8983.101689831095, 9000.0, 6994.685239164148, 7070.858582828418, 7151.249118842551, 7161.283871612797, 7222.638868056576, 7038.2609825969585, 7124.715011399693, 7136.464765142531, 7143.035690181759, 7191.280871912767, 8039.638216280165, 8288.129746376784, 8291.917080829115, 8349.540775257175, 8377.287930525974, 8268.214519620626, 8630.050694423482, 8638.222559969632, 8641.783955401166, 8674.089220631742, 6665.633390163393, 6676.766313179015, 6711.832204194934, 6718.865622687616, 6792.320767923168, 7221.53060051095, 7295.708171673074, 7297.525660832029, 7318.158411782713, 7366.521176123535, 6436.645984470899, 6709.329067093252, 6717.865642687217, 6815.863682726417, 6869.862602747817, 6455.0317452382515, 6473.902891456538, 6516.934830651822, 6585.868282634417, 6628.801135965736, 6827.453803695593, 6851.48613853953, 6858.177018757581, 6982.476314276348, 7041.260667629826, 6304.905426418516, 6364.07720880479, 6367.745290188341, 6426.164598602339, 6505.41451269388, 6342.429181373698, 6371.776987805404, 6380.840478987877, 6382.840428989312, 6402.935970640234], "value": 4273.296678367725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5280562322776, 307.86453960257484, 313.683179988212, 316.6627541668123, 317.1199920221384, 5606.635568688032, 5643.46387093226, 5714.171445140452, 5720.628159169651, 5736.713164341787, 5531.0873705838485, 5557.527610153142, 5590.776368945248, 5600.691961942091, 5611.887762244753, 4137.420761093449, 4225.915481690365, 4271.914561708764, 4320.1143765527995, 4325.675574331922, 4305.827766889321, 4314.719543229696, 4317.395564620955, 4327.199468098412, 4347.956490442287, 4292.849750258742, 4293.334533147367, 4297.548757380477, 4298.140371925611, 4317.4819021717285, 4316.54676258993, 4316.740995540277, 4317.395564620955, 4318.4170137031415, 4335.6965012449145, 3749.2876353492748, 3751.3435148848844, 3754.4931434256573, 3762.849486020556, 3763.0968567543864, 5404.864878378072, 5413.188021796723, 5416.729163541847, 5428.4842939920645, 5430.945690543123, 4890.437599676047, 4895.755212239374, 5002.499750025005, 5018.222175562793, 5021.899562008739, 5972.163897054415, 5997.820065398045, 5999.190109335271, 6004.099385092228, 6007.369226231226, 4100.323446631302, 4111.568285330027, 4116.0, 4125.401816736587, 4128.525219599725, 6236.968815155895, 6267.2165979252595, 6327.335629758855, 6335.271443783978, 6347.96826015867, 4218.2196293685765, 4223.049813791872, 4223.556526564728, 4224.345226489899, 4237.258479766028, 4274.337477690963, 4280.293751531025, 4282.314829627245, 4283.31466965284, 4288.892777680583, 4794.352762377034, 4933.481984391659, 4969.751512424436, 4969.801207951641, 4986.825461108916, 5944.197533332945, 5997.820065398045, 6007.339192688801, 6022.36765139654, 6030.487408570233, 1492.6119209005738, 1510.4033906606828, 1512.4933147395745, 1513.712394645036, 1523.8704710099544, 961.4808003677936, 980.5221919288707, 998.0668075349571, 1002.14817405205, 1005.1857995023908, 5210.843674689765, 5241.266222728821, 5247.685138891678, 5260.316158899395, 5262.184361423985, 6255.093011513305, 6256.7810126645345, 6259.499240060784, 6262.060690896402, 6270.372962703785, 5050.141475949097, 5218.165093585084, 5236.895262094813, 5246.685198888079, 5250.3962044364625, 3315.5026745988293, 3357.664233576623, 3358.8488518016748, 3361.4957756336744, 3405.6083550391527, 5963.5527335450015, 5978.521718262616, 5978.521718262616, 5978.760849566055, 5980.252468441445, 6484.773032943919, 6488.0, 6489.480841532666, 6497.902531462032, 6513.967430162819, 5921.230240068763, 5947.524198064145, 5953.553483488756, 5955.970220148785, 5964.105384192319, 6072.696365181811, 6291.0, 6317.0, 6324.083007963727, 6343.794679010974, 6136.23297087864, 6173.382661733791, 6211.099390588249, 6216.875662486635, 6218.378162183745, 5943.881122377615, 5964.165016897725, 5964.761409543569, 5974.0, 5987.850303742442, 4209.536950935456, 4235.767032813102, 4246.808893599858, 4255.0, 4257.723247988871, 6201.906971395523, 6254.8123556293385, 6285.43431091204, 6288.371162883675, 6308.243010838729, 5859.677717725566, 6050.697465126638, 6055.576109672281, 6065.120557519223, 6071.787487437919, 6018.398160183947, 6051.697415129314, 6052.092186172109, 6063.909041364295, 6072.1498990140535, 5882.235309409921, 5927.4665280125, 5930.822075337746, 5936.28764548257, 5956.612820166675, 6061.969690151521, 6069.332373439007, 6083.726232319467, 6102.328743838263, 6107.297660768891, 5751.8562035949435, 5885.55858310637, 5925.851853703692, 5944.464998150187, 5958.463738263577], "value": 4475.421849265302, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.686174067318, 664.0603545982435, 684.4011489946297, 777.657830554556, 795.9562224077673, 10684.893151068487, 12142.878571214285, 12313.261204327746, 12566.183198092129, 13484.460621575125, 12729.490820367175, 12758.234505929651, 12814.807777883316, 12893.419796109174, 12900.354982250898, 799.2526987266924, 814.6008455856647, 816.4692949582789, 820.5158956215831, 822.3544517553721, 821.9013718353806, 822.5064961023368, 822.7038266224155, 822.8560001999656, 823.259066839843, 853.9829203415928, 857.2584714222215, 860.109786371106, 861.2033868671454, 861.9698310559131, 852.5992783391765, 852.6589364254286, 853.2491407561306, 855.6149732620314, 855.8331125430543, 627.109504503606, 628.4281304013372, 628.9937100628981, 629.2794750011258, 630.8990561510183, 11592.188546801728, 11633.94183029088, 12871.935640321739, 13170.407331670098, 13207.207567545882, 12211.26732396059, 12220.572279970158, 12236.510539578407, 12659.620211393672, 12975.545855894998, 9812.215022798231, 9892.208623310118, 9900.455474948874, 10512.894871051345, 10563.313384629975, 3405.1487128217946, 3457.567804024497, 3483.8083905385192, 3519.982400087983, 3609.350316942949, 37567.436488452695, 37627.68303109378, 37905.81047094774, 38206.42690359647, 44176.33735493938, 9807.754806129904, 10076.345037572535, 10097.394156350643, 10163.390196588229, 10183.490825458697, 17873.553161171076, 18194.727079093824, 18255.452336429928, 18260.634787304178, 18263.72604410935, 6904.965475172592, 6946.479014073965, 6989.440844732511, 6991.230964593992, 7000.7549735759, 3520.331137083946, 3612.187257866959, 3674.4855720199193, 3685.594584595692, 3696.334659761269, 2939.1476471823357, 2940.617719696426, 2943.190622578765, 2955.866985985636, 2957.1128661401494, 543.7227014222696, 545.5580979406693, 549.7608540284989, 563.7744902039217, 566.8894565559759, 515.6004096824915, 548.6954740119272, 596.0403749962557, 603.7554790309931, 627.6767464755654, 7672.309492145734, 7843.607819608997, 8128.349732021424, 8160.387970902206, 8185.181481851767, 614.797116951405, 616.0328284593146, 625.5683578330937, 634.9650769207645, 637.2957881540831, 3477.7217822574135, 3577.3203091412547, 3602.2975519773395, 3618.5476815398074, 3776.527934008249, 46536.30195547069, 46857.76571117191, 51671.741641291555, 53623.73188134035, 53700.462995370326, 45260.3210951836, 45468.54531454709, 45883.770581147546, 45884.311735323994, 46699.76650116796, 42630.78684606619, 42832.143357132685, 43096.784516077845, 43593.34609980853, 45856.3121553177, 8594.183552562497, 8622.698205562776, 8667.133286671282, 8741.562921854009, 8759.16787905148, 31584.684153158174, 32214.677853222107, 32978.34043319072, 33107.172320692174, 33325.33349332951, 40407.79796101001, 41300.173996520505, 42037.78981105075, 42219.57780422157, 42475.36286955636, 10805.243632945932, 10820.89179108199, 10828.296160749525, 10927.071198948179, 11004.559817607525, 11254.94372528132, 11993.0, 12100.092493063232, 12181.695457613276, 12426.192297500633, 10759.623413180501, 11060.446977651247, 11133.276337038067, 11434.94282528582, 11713.941430292794, 11201.43992800373, 11279.379634120201, 11315.094792416752, 11685.298882067103, 11980.58067967617, 10809.189310801565, 11379.374134422686, 12005.219660722025, 12010.33943133136, 12074.215176013531, 9533.674647740721, 9866.654667086617, 9880.752981175241, 9943.900560994298, 10025.097741203326, 9819.754506137404, 9909.355891867006, 10016.849747253942, 10035.09684128432, 10071.0], "value": 6047.835656275815, "unit": "score"}], "name": "dromaeo_css", "value": 6466.735308552742, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 106.0, 114.0, 111.0, 114.0, 124.0, 113.0, 115.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 164.0, 183.0, 138.0, 160.0, 161.0, 134.0, 182.0, 134.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 162.0, 166.0, 167.0, 163.0, 165.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 74.0, 74.0, 78.0, 73.0, 144.0, 74.0, 73.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 141.0, 94.0, 94.0, 94.0, 139.0, 95.0, 93.0, 145.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 95.0, 97.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 65.0, 68.0, 64.0, 64.0, 64.0, 61.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 84.0, 83.0, 84.0, 83.0, 84.0, 82.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 119.0, 115.0, 123.0, 119.0, 117.0, 132.0, 127.0, 121.0, 121.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 145.0, 143.0, 146.0, 133.0, 147.0, 143.0, 145.0, 143.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 74.0, 67.0, 69.0, 67.0, 68.0, 70.0, 66.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1527.6999999999998, "alertThreshold": 2.0}]} 04:31:30 INFO - Return code: 0 04:31:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:31:30 ERROR - # TBPL SUCCESS # 04:31:30 INFO - Running post-action listener: _resource_record_post_action 04:31:30 INFO - Running post-run listener: _resource_record_post_run 04:31:31 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8073216; Write bytes: 481226752; Read time: 2448; Write time: 390024 04:31:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115974144; Read time: 124; Write time: 64956 04:31:31 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 6332416; Write bytes: 365252608; Read time: 2276; Write time: 325068 04:31:31 INFO - Running post-run listener: _upload_blobber_files 04:31:31 INFO - Blob upload gear active. 04:31:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:31:31 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:31:31 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:31:31 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:31:32 INFO - (blobuploader) - INFO - Open directory for files ... 04:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:31:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:33 INFO - (blobuploader) - INFO - Done attempting. 04:31:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:31:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:31:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:34 INFO - (blobuploader) - INFO - Done attempting. 04:31:34 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:34 INFO - Return code: 0 04:31:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d62a46c4c11de300c2543b36a56f35ef735b7d002f73e6d4d3c36ebdf5c64846b512a0ff27af58b6291ea8e82bed73d799f21fcdc728bb226cf0e99404390526", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f82f4ec3c35d91f8cf4453f136dda39299cffa03a8876e94a86dcb88c5195c0cf98741a72eb6eb7ce576854a40e4b6e7ff1eb9a546817128f1f1aafc2f1aab0"} 04:31:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:34 INFO - Contents: 04:31:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d62a46c4c11de300c2543b36a56f35ef735b7d002f73e6d4d3c36ebdf5c64846b512a0ff27af58b6291ea8e82bed73d799f21fcdc728bb226cf0e99404390526", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f82f4ec3c35d91f8cf4453f136dda39299cffa03a8876e94a86dcb88c5195c0cf98741a72eb6eb7ce576854a40e4b6e7ff1eb9a546817128f1f1aafc2f1aab0"} 04:31:34 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:34 INFO - Copying logs to upload dir... 04:31:34 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.150060 ========= master_lag: 4.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-07 04:31:39.013556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 04:31:39.016680) ========= 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=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d62a46c4c11de300c2543b36a56f35ef735b7d002f73e6d4d3c36ebdf5c64846b512a0ff27af58b6291ea8e82bed73d799f21fcdc728bb226cf0e99404390526", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f82f4ec3c35d91f8cf4453f136dda39299cffa03a8876e94a86dcb88c5195c0cf98741a72eb6eb7ce576854a40e4b6e7ff1eb9a546817128f1f1aafc2f1aab0"} build_url:https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/KUEJcBKyQ-me2YLxKMGKCg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d62a46c4c11de300c2543b36a56f35ef735b7d002f73e6d4d3c36ebdf5c64846b512a0ff27af58b6291ea8e82bed73d799f21fcdc728bb226cf0e99404390526", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f82f4ec3c35d91f8cf4453f136dda39299cffa03a8876e94a86dcb88c5195c0cf98741a72eb6eb7ce576854a40e4b6e7ff1eb9a546817128f1f1aafc2f1aab0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 04:31:39.043757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:31:39.044072) ========= 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=db0483c52d987ecb441a263b000001ad-1460025216.897038-1944378186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:31:39.104668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 04:31:39.105008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 04:31:39.105349) ========= ========= Total master_lag: 5.11 =========