builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1458317490.38 results: success (0) buildid: 20160318075315 builduid: f03ca9809ded4ff1bac0b40c6f5a9324 revision: 9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.377987) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.381870) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.382188) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006388 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.413568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.414078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.473188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.473450) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.526814) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.527108) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.527480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.530854) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 09:11:30-- 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% 41.7M=0s 2016-03-18 09:11:30 (41.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147583 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.691571) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.694913) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018976 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:30.750270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 09:11:30.750585) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2 --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 9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2 --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=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 09:11:31,126 truncating revision to first 12 chars 2016-03-18 09:11:31,126 Setting DEBUG logging. 2016-03-18 09:11:31,126 attempt 1/10 2016-03-18 09:11:31,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9c5d494d0548?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 09:11:32,255 unpacking tar archive at: mozilla-central-9c5d494d0548/testing/mozharness/ program finished with exit code 0 elapsedTime=1.417409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 09:11:32.188193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:32.188504) ========= echo 9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2'] 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=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2 program finished with exit code 0 elapsedTime=0.004680 script_repo_revision: '9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:32.245320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:32.245642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 09:11:32.257561) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-18 09:11:32.257917) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:11:32 INFO - MultiFileLogger online at 20160318 09:11:32 in /builds/slave/test 09:11:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:11:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:11:32 INFO - {'append_to_log': False, 09:11:32 INFO - 'base_work_dir': '/builds/slave/test', 09:11:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:11:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:11:32 INFO - 'branch': 'Firefox-Non-PGO', 09:11:32 INFO - 'buildbot_json_path': 'buildprops.json', 09:11:32 INFO - 'config_files': ('talos/linux_config.py',), 09:11:32 INFO - 'default_actions': ('clobber', 09:11:32 INFO - 'read-buildbot-config', 09:11:32 INFO - 'download-and-extract', 09:11:32 INFO - 'populate-webroot', 09:11:32 INFO - 'create-virtualenv', 09:11:32 INFO - 'install', 09:11:32 INFO - 'run-tests'), 09:11:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:11:32 INFO - 'download_minidump_stackwalk': True, 09:11:32 INFO - 'download_symbols': 'ondemand', 09:11:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:11:32 INFO - 'tooltool.py': '/tools/tooltool.py', 09:11:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:11:32 INFO - '/tools/misc-python/virtualenv.py')}, 09:11:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:11:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:11:32 INFO - 'installer_path': 'installer.exe', 09:11:32 INFO - 'log_level': 'info', 09:11:32 INFO - 'log_name': 'talos', 09:11:32 INFO - 'log_to_console': True, 09:11:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:11:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:11:32 INFO - 'opt_config_files': (), 09:11:32 INFO - 'pip_index': False, 09:11:32 INFO - 'sps_profile': False, 09:11:32 INFO - 'sps_profile_interval': 0, 09:11:32 INFO - 'suite': 'dromaeojs', 09:11:32 INFO - 'system_bits': '32', 09:11:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:11:32 INFO - 'title': 'talos-linux64-ix-049', 09:11:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:11:32 INFO - 'use_talos_json': True, 09:11:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:11:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:11:32 INFO - 'work_dir': 'build'} 09:11:32 INFO - ##### 09:11:32 INFO - ##### Running clobber step. 09:11:32 INFO - ##### 09:11:32 INFO - Running pre-action listener: _resource_record_pre_action 09:11:32 INFO - Running main action method: clobber 09:11:32 INFO - rmtree: /builds/slave/test/build 09:11:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:11:33 INFO - Running post-action listener: _resource_record_post_action 09:11:33 INFO - ##### 09:11:33 INFO - ##### Running read-buildbot-config step. 09:11:33 INFO - ##### 09:11:33 INFO - Running pre-action listener: _resource_record_pre_action 09:11:33 INFO - Running main action method: read_buildbot_config 09:11:33 INFO - Using buildbot properties: 09:11:33 INFO - { 09:11:33 INFO - "project": "", 09:11:33 INFO - "product": "firefox", 09:11:33 INFO - "script_repo_revision": "production", 09:11:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:11:33 INFO - "repository": "", 09:11:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:11:33 INFO - "buildid": "20160318075315", 09:11:33 INFO - "pgo_build": "False", 09:11:33 INFO - "basedir": "/builds/slave/test", 09:11:33 INFO - "buildnumber": 518, 09:11:33 INFO - "slavename": "talos-linux64-ix-049", 09:11:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:11:33 INFO - "platform": "ubuntu64_hw", 09:11:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:11:33 INFO - "branch": "mozilla-central", 09:11:33 INFO - "repo_path": "mozilla-central", 09:11:33 INFO - "revision": "9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2", 09:11:33 INFO - "stage_platform": "linux64", 09:11:33 INFO - "builduid": "f03ca9809ded4ff1bac0b40c6f5a9324", 09:11:33 INFO - "slavebuilddir": "test" 09:11:33 INFO - } 09:11:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:11:33 INFO - Running post-action listener: _resource_record_post_action 09:11:33 INFO - ##### 09:11:33 INFO - ##### Running download-and-extract step. 09:11:33 INFO - ##### 09:11:33 INFO - Running pre-action listener: _resource_record_pre_action 09:11:33 INFO - Running main action method: download_and_extract 09:11:33 INFO - mkdir: /builds/slave/test/build/tests 09:11:33 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')]} 09:11:33 INFO - https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:11:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:11:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:11:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:35 INFO - Downloaded 1361 bytes. 09:11:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:11:35 INFO - Using the following test package requirements: 09:11:35 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:11:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:11:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:11:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:35 INFO - u'jsshell-linux-x86_64.zip'], 09:11:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:11:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:11:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:11:35 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:11:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:11:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:11:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:35 INFO - https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:39 INFO - Downloaded 22009611 bytes. 09:11:39 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'] 09:11:39 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 09:11:40 INFO - Return code: 0 09:11:40 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 09:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:40 INFO - https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:42 INFO - Downloaded 22009611 bytes. 09:11:42 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'] 09:11:42 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 09:11:43 INFO - Return code: 0 09:11:44 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')]} 09:11:44 INFO - https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:46 INFO - Downloaded 10846565 bytes. 09:11:46 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'] 09:11:46 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 09:11:46 INFO - Return code: 0 09:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:46 INFO - https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSVDjI0YSYOkynp32OXF_A/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 09:11:51 INFO - Downloaded 54152300 bytes. 09:11:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:11:51 INFO - mkdir: /builds/slave/test/properties 09:11:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:51 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:51 INFO - Contents: 09:11:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:11:51 INFO - Running post-action listener: _resource_record_post_action 09:11:51 INFO - Running post-action listener: set_extra_try_arguments 09:11:51 INFO - ##### 09:11:51 INFO - ##### Running populate-webroot step. 09:11:51 INFO - ##### 09:11:51 INFO - Running pre-action listener: _resource_record_pre_action 09:11:51 INFO - Running main action method: populate_webroot 09:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:11:51 INFO - '--tppagecycles', 09:11:51 INFO - '7'], 09:11:51 INFO - 'tests': ['tsvgm']}}, 09:11:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:11:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:11:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:11:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:11:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:51 INFO - 'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:51 INFO - 'tests': ['damp', 'tps']}, 09:11:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:51 INFO - 'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['damp', 'tps']}, 09:11:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:51 INFO - 'other': {'tests': ['a11yr', 09:11:51 INFO - 'ts_paint', 09:11:51 INFO - 'tpaint', 09:11:51 INFO - 'sessionrestore', 09:11:51 INFO - 'sessionrestore_no_auto_restore', 09:11:51 INFO - 'tabpaint']}, 09:11:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['a11yr', 09:11:51 INFO - 'ts_paint', 09:11:51 INFO - 'tpaint', 09:11:51 INFO - 'sessionrestore', 09:11:51 INFO - 'sessionrestore_no_auto_restore', 09:11:51 INFO - 'tabpaint']}, 09:11:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['a11yr', 09:11:51 INFO - 'ts_paint', 09:11:51 INFO - 'tpaint', 09:11:51 INFO - 'sessionrestore', 09:11:51 INFO - 'sessionrestore_no_auto_restore', 09:11:51 INFO - 'tabpaint']}, 09:11:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['a11yr', 09:11:51 INFO - 'ts_paint', 09:11:51 INFO - 'tpaint', 09:11:51 INFO - 'sessionrestore', 09:11:51 INFO - 'sessionrestore_no_auto_restore', 09:11:51 INFO - 'tabpaint']}, 09:11:51 INFO - 'other_l64': {'tests': ['a11yr', 09:11:51 INFO - 'ts_paint', 09:11:51 INFO - 'tpaint', 09:11:51 INFO - 'sessionrestore', 09:11:51 INFO - 'sessionrestore_no_auto_restore', 09:11:51 INFO - 'tabpaint']}, 09:11:51 INFO - 'other_nol64': {'tests': ['a11yr', 09:11:51 INFO - 'ts_paint', 09:11:51 INFO - 'tpaint', 09:11:51 INFO - 'sessionrestore', 09:11:51 INFO - 'sessionrestore_no_auto_restore', 09:11:51 INFO - 'tabpaint']}, 09:11:51 INFO - 'svgr': {'tests': ['tsvgx', 09:11:51 INFO - 'tsvgr_opacity', 09:11:51 INFO - 'tart', 09:11:51 INFO - 'tscrollx', 09:11:51 INFO - 'cart']}, 09:11:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['tsvgx', 09:11:51 INFO - 'tsvgr_opacity', 09:11:51 INFO - 'tart', 09:11:51 INFO - 'tscrollx', 09:11:51 INFO - 'cart']}, 09:11:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:51 INFO - 'tests': ['tp5o']}, 09:11:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:51 INFO - 'talos_options': ['--e10s'], 09:11:51 INFO - 'tests': ['tp5o']}, 09:11:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:51 INFO - 'talos_options': ['--xperf_path', 09:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:51 INFO - 'tests': ['tp5n']}, 09:11:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:51 INFO - 'talos_options': ['--e10s', 09:11:51 INFO - '--xperf_path', 09:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:51 INFO - 'tests': ['tp5n']}}, 09:11:51 INFO - 'talos.zip': {'path': '', 09:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:11:51 INFO - Running post-action listener: _resource_record_post_action 09:11:51 INFO - ##### 09:11:51 INFO - ##### Running create-virtualenv step. 09:11:51 INFO - ##### 09:11:51 INFO - Running pre-action listener: _resource_record_pre_action 09:11:51 INFO - Running main action method: create_virtualenv 09:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:51 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 09:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:11:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:52 INFO - Using real prefix '/usr' 09:11:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:52 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:54 INFO - Installing pip.................done. 09:11:54 INFO - Return code: 0 09:11:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11:54 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')]} 09:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:54 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')]} 09:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:54 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 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:11:54 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 09:11:54 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 09:11:54 INFO - Using env: {'DISPLAY': ':0', 09:11:54 INFO - 'HOME': '/home/cltbld', 09:11:54 INFO - 'LANG': 'en_US.UTF-8', 09:11:54 INFO - 'LANGUAGE': 'en_US:en', 09:11:54 INFO - 'LOGNAME': 'cltbld', 09:11:54 INFO - 'MAIL': '/var/mail/cltbld', 09:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:54 INFO - 'MOZ_NO_REMOTE': '1', 09:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:54 INFO - 'NO_EM_RESTART': '1', 09:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:54 INFO - 'PWD': '/builds/slave/test', 09:11:54 INFO - 'SHELL': '/bin/bash', 09:11:54 INFO - 'SHLVL': '1', 09:11:54 INFO - 'TERM': 'linux', 09:11:54 INFO - 'TMOUT': '86400', 09:11:54 INFO - 'USER': 'cltbld', 09:11:54 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:54 INFO - '_': '/tools/buildbot/bin/python'} 09:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:54 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 09:11:54 INFO - Cleaning up... 09:11:54 INFO - Return code: 0 09:11:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:11:54 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')]} 09:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:54 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')]} 09:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:54 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 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:11:54 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 09:11:54 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 09:11:54 INFO - Using env: {'DISPLAY': ':0', 09:11:54 INFO - 'HOME': '/home/cltbld', 09:11:54 INFO - 'LANG': 'en_US.UTF-8', 09:11:54 INFO - 'LANGUAGE': 'en_US:en', 09:11:54 INFO - 'LOGNAME': 'cltbld', 09:11:54 INFO - 'MAIL': '/var/mail/cltbld', 09:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:54 INFO - 'MOZ_NO_REMOTE': '1', 09:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:54 INFO - 'NO_EM_RESTART': '1', 09:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:54 INFO - 'PWD': '/builds/slave/test', 09:11:54 INFO - 'SHELL': '/bin/bash', 09:11:54 INFO - 'SHLVL': '1', 09:11:54 INFO - 'TERM': 'linux', 09:11:54 INFO - 'TMOUT': '86400', 09:11:54 INFO - 'USER': 'cltbld', 09:11:54 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:54 INFO - '_': '/tools/buildbot/bin/python'} 09:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:54 INFO - Downloading/unpacking psutil>=0.7.1 09:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:56 INFO - Installing collected packages: psutil 09:11:56 INFO - Running setup.py install for psutil 09:11:56 INFO - building 'psutil._psutil_linux' extension 09:11:56 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 09:11:57 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 09:11:57 INFO - building 'psutil._psutil_posix' extension 09:11:57 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 09:11:57 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 09:11:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:57 INFO - Successfully installed psutil 09:11:57 INFO - Cleaning up... 09:11:57 INFO - Return code: 0 09:11:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:11:57 INFO - Using env: {'DISPLAY': ':0', 09:11:57 INFO - 'HOME': '/home/cltbld', 09:11:57 INFO - 'LANG': 'en_US.UTF-8', 09:11:57 INFO - 'LANGUAGE': 'en_US:en', 09:11:57 INFO - 'LOGNAME': 'cltbld', 09:11:57 INFO - 'MAIL': '/var/mail/cltbld', 09:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:57 INFO - 'MOZ_NO_REMOTE': '1', 09:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:57 INFO - 'NO_EM_RESTART': '1', 09:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:57 INFO - 'PWD': '/builds/slave/test', 09:11:57 INFO - 'SHELL': '/bin/bash', 09:11:57 INFO - 'SHLVL': '1', 09:11:57 INFO - 'TERM': 'linux', 09:11:57 INFO - 'TMOUT': '86400', 09:11:57 INFO - 'USER': 'cltbld', 09:11:57 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:57 INFO - '_': '/tools/buildbot/bin/python'} 09:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:11:59 INFO - Installing collected packages: mozsystemmonitor 09:11:59 INFO - Running setup.py install for mozsystemmonitor 09:11:59 INFO - Successfully installed mozsystemmonitor 09:11:59 INFO - Cleaning up... 09:11:59 INFO - Return code: 0 09:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11:59 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')]} 09:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:59 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')]} 09:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:59 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 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:11:59 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 09:11:59 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 09:11:59 INFO - Using env: {'DISPLAY': ':0', 09:11:59 INFO - 'HOME': '/home/cltbld', 09:11:59 INFO - 'LANG': 'en_US.UTF-8', 09:11:59 INFO - 'LANGUAGE': 'en_US:en', 09:11:59 INFO - 'LOGNAME': 'cltbld', 09:11:59 INFO - 'MAIL': '/var/mail/cltbld', 09:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:59 INFO - 'MOZ_NO_REMOTE': '1', 09:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:59 INFO - 'NO_EM_RESTART': '1', 09:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:59 INFO - 'PWD': '/builds/slave/test', 09:11:59 INFO - 'SHELL': '/bin/bash', 09:11:59 INFO - 'SHLVL': '1', 09:11:59 INFO - 'TERM': 'linux', 09:11:59 INFO - 'TMOUT': '86400', 09:11:59 INFO - 'USER': 'cltbld', 09:11:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:59 INFO - '_': '/tools/buildbot/bin/python'} 09:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:11:59 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 09:11:59 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 09:11:59 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 09:11:59 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 09:11:59 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 09:11:59 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 09:12:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:12:02 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 09:12:02 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 09:12:02 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 09:12:02 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 09:12:02 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 09:12:02 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 09:12:02 INFO - Downloading docopt-0.6.1.tar.gz 09:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:02 INFO - Running setup.py install for blobuploader 09:12:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:02 INFO - Running setup.py install for requests 09:12:02 INFO - Running setup.py install for docopt 09:12:03 INFO - Successfully installed blobuploader requests docopt 09:12:03 INFO - Cleaning up... 09:12:03 INFO - Return code: 0 09:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:03 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 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:12:03 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 09:12:03 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 09:12:03 INFO - Using env: {'DISPLAY': ':0', 09:12:03 INFO - 'HOME': '/home/cltbld', 09:12:03 INFO - 'LANG': 'en_US.UTF-8', 09:12:03 INFO - 'LANGUAGE': 'en_US:en', 09:12:03 INFO - 'LOGNAME': 'cltbld', 09:12:03 INFO - 'MAIL': '/var/mail/cltbld', 09:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:03 INFO - 'MOZ_NO_REMOTE': '1', 09:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:03 INFO - 'NO_EM_RESTART': '1', 09:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:03 INFO - 'PWD': '/builds/slave/test', 09:12:03 INFO - 'SHELL': '/bin/bash', 09:12:03 INFO - 'SHLVL': '1', 09:12:03 INFO - 'TERM': 'linux', 09:12:03 INFO - 'TMOUT': '86400', 09:12:03 INFO - 'USER': 'cltbld', 09:12:03 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:03 INFO - '_': '/tools/buildbot/bin/python'} 09:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:03 INFO - Running setup.py (path:/tmp/pip-HegnHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:03 INFO - Running setup.py (path:/tmp/pip-FC0rtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:03 INFO - Running setup.py (path:/tmp/pip-7TUiFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:03 INFO - Running setup.py (path:/tmp/pip-CvH8Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:03 INFO - Running setup.py (path:/tmp/pip-CBWUmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:03 INFO - Running setup.py (path:/tmp/pip-wJPgyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:03 INFO - Running setup.py (path:/tmp/pip-5Ij70T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:03 INFO - Running setup.py (path:/tmp/pip-5wHgsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:03 INFO - Running setup.py (path:/tmp/pip-SDT6jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:03 INFO - Running setup.py (path:/tmp/pip-I3a9nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:04 INFO - Running setup.py (path:/tmp/pip-n_Rl_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:04 INFO - Running setup.py (path:/tmp/pip-rMpxRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:04 INFO - Running setup.py (path:/tmp/pip-QynhEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:04 INFO - Running setup.py (path:/tmp/pip-gURfbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:04 INFO - Running setup.py (path:/tmp/pip-NZF0NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:04 INFO - Running setup.py (path:/tmp/pip-YH6igP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:04 INFO - Running setup.py (path:/tmp/pip-8Tv1Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:04 INFO - Running setup.py install for manifestparser 09:12:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:04 INFO - Running setup.py install for mozcrash 09:12:04 INFO - Running setup.py install for mozdebug 09:12:04 INFO - Running setup.py install for mozdevice 09:12:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:12:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Running setup.py install for mozfile 09:12:05 INFO - Running setup.py install for mozhttpd 09:12:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Running setup.py install for mozinfo 09:12:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Running setup.py install for mozInstall 09:12:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Running setup.py install for mozleak 09:12:05 INFO - Running setup.py install for mozlog 09:12:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Running setup.py install for moznetwork 09:12:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Running setup.py install for mozprocess 09:12:05 INFO - Running setup.py install for mozprofile 09:12:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:12:05 INFO - Running setup.py install for mozrunner 09:12:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:12:06 INFO - Running setup.py install for mozscreenshot 09:12:06 INFO - Running setup.py install for moztest 09:12:06 INFO - Running setup.py install for mozversion 09:12:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:12:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:12:06 INFO - Cleaning up... 09:12:06 INFO - Return code: 0 09:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:06 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 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:12:06 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 09:12:06 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 09:12:06 INFO - Using env: {'DISPLAY': ':0', 09:12:06 INFO - 'HOME': '/home/cltbld', 09:12:06 INFO - 'LANG': 'en_US.UTF-8', 09:12:06 INFO - 'LANGUAGE': 'en_US:en', 09:12:06 INFO - 'LOGNAME': 'cltbld', 09:12:06 INFO - 'MAIL': '/var/mail/cltbld', 09:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:06 INFO - 'MOZ_NO_REMOTE': '1', 09:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:06 INFO - 'NO_EM_RESTART': '1', 09:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:06 INFO - 'PWD': '/builds/slave/test', 09:12:06 INFO - 'SHELL': '/bin/bash', 09:12:06 INFO - 'SHLVL': '1', 09:12:06 INFO - 'TERM': 'linux', 09:12:06 INFO - 'TMOUT': '86400', 09:12:06 INFO - 'USER': 'cltbld', 09:12:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:06 INFO - '_': '/tools/buildbot/bin/python'} 09:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:06 INFO - Running setup.py (path:/tmp/pip-sd9kS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:06 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)) 09:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:06 INFO - Running setup.py (path:/tmp/pip-GMtB0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:06 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)) 09:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:06 INFO - Running setup.py (path:/tmp/pip-dVig_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:06 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)) 09:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:06 INFO - Running setup.py (path:/tmp/pip-MIGdv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:06 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)) 09:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:06 INFO - Running setup.py (path:/tmp/pip-flN4P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:06 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)) 09:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:06 INFO - Running setup.py (path:/tmp/pip-g8PsPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:06 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)) 09:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:06 INFO - Running setup.py (path:/tmp/pip-W0j00f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:07 INFO - Running setup.py (path:/tmp/pip-Tu49ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:07 INFO - Running setup.py (path:/tmp/pip-2Zwahu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:07 INFO - Running setup.py (path:/tmp/pip-4uQ3Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:07 INFO - Running setup.py (path:/tmp/pip-hgX9Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:07 INFO - Running setup.py (path:/tmp/pip-cgAHUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:07 INFO - Running setup.py (path:/tmp/pip-N8U9Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:07 INFO - Running setup.py (path:/tmp/pip-HlJgp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:07 INFO - Running setup.py (path:/tmp/pip-hiHsoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:07 INFO - Running setup.py (path:/tmp/pip-xGbOSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:07 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)) 09:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:07 INFO - Running setup.py (path:/tmp/pip-JEdYUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:07 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)) 09:12:07 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)) 09:12:07 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)) 09:12:07 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)) 09:12:07 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)) 09:12:07 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)) 09:12:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:07 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 09:12:07 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 09:12:07 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 09:12:07 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 09:12:07 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 09:12:07 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 09:12:09 INFO - Downloading blessings-1.6.tar.gz 09:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:09 INFO - Installing collected packages: blessings 09:12:09 INFO - Running setup.py install for blessings 09:12:09 INFO - Successfully installed blessings 09:12:09 INFO - Cleaning up... 09:12:09 INFO - Return code: 0 09:12:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:10 INFO - Reading from file tmpfile_stdout 09:12:10 INFO - Current package versions: 09:12:10 INFO - argparse == 1.2.1 09:12:10 INFO - blessings == 1.6 09:12:10 INFO - blobuploader == 1.2.4 09:12:10 INFO - docopt == 0.6.1 09:12:10 INFO - manifestparser == 1.1 09:12:10 INFO - mozInstall == 1.12 09:12:10 INFO - mozcrash == 0.17 09:12:10 INFO - mozdebug == 0.1 09:12:10 INFO - mozdevice == 0.48 09:12:10 INFO - mozfile == 1.2 09:12:10 INFO - mozhttpd == 0.7 09:12:10 INFO - mozinfo == 0.9 09:12:10 INFO - mozleak == 0.1 09:12:10 INFO - mozlog == 3.1 09:12:10 INFO - moznetwork == 0.27 09:12:10 INFO - mozprocess == 0.22 09:12:10 INFO - mozprofile == 0.28 09:12:10 INFO - mozrunner == 6.11 09:12:10 INFO - mozscreenshot == 0.1 09:12:10 INFO - mozsystemmonitor == 0.0 09:12:10 INFO - moztest == 0.7 09:12:10 INFO - mozversion == 1.4 09:12:10 INFO - psutil == 3.1.1 09:12:10 INFO - requests == 1.2.3 09:12:10 INFO - wsgiref == 0.1.2 09:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:10 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')]} 09:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:10 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')]} 09:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:10 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 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:12:10 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 09:12:10 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 09:12:10 INFO - Using env: {'DISPLAY': ':0', 09:12:10 INFO - 'HOME': '/home/cltbld', 09:12:10 INFO - 'LANG': 'en_US.UTF-8', 09:12:10 INFO - 'LANGUAGE': 'en_US:en', 09:12:10 INFO - 'LOGNAME': 'cltbld', 09:12:10 INFO - 'MAIL': '/var/mail/cltbld', 09:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:10 INFO - 'MOZ_NO_REMOTE': '1', 09:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:10 INFO - 'NO_EM_RESTART': '1', 09:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:10 INFO - 'PWD': '/builds/slave/test', 09:12:10 INFO - 'SHELL': '/bin/bash', 09:12:10 INFO - 'SHLVL': '1', 09:12:10 INFO - 'TERM': 'linux', 09:12:10 INFO - 'TMOUT': '86400', 09:12:10 INFO - 'USER': 'cltbld', 09:12:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:10 INFO - '_': '/tools/buildbot/bin/python'} 09:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 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)) 09:12:10 INFO - Cleaning up... 09:12:10 INFO - Return code: 0 09:12:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12:10 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')]} 09:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:10 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')]} 09:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:10 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 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:12:10 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 09:12:10 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 09:12:10 INFO - Using env: {'DISPLAY': ':0', 09:12:10 INFO - 'HOME': '/home/cltbld', 09:12:10 INFO - 'LANG': 'en_US.UTF-8', 09:12:10 INFO - 'LANGUAGE': 'en_US:en', 09:12:10 INFO - 'LOGNAME': 'cltbld', 09:12:10 INFO - 'MAIL': '/var/mail/cltbld', 09:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:10 INFO - 'MOZ_NO_REMOTE': '1', 09:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:10 INFO - 'NO_EM_RESTART': '1', 09:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:10 INFO - 'PWD': '/builds/slave/test', 09:12:10 INFO - 'SHELL': '/bin/bash', 09:12:10 INFO - 'SHLVL': '1', 09:12:10 INFO - 'TERM': 'linux', 09:12:10 INFO - 'TMOUT': '86400', 09:12:10 INFO - 'USER': 'cltbld', 09:12:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:10 INFO - '_': '/tools/buildbot/bin/python'} 09:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:10 INFO - Downloading/unpacking jsonschema 09:12:10 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 09:12:10 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 09:12:10 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 09:12:10 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 09:12:10 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 09:12:10 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 09:12:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:12 INFO - Downloading/unpacking functools32 (from jsonschema) 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:12 INFO - warning: no files found matching '*.txt' 09:12:12 INFO - no previously-included directories found matching 'build' 09:12:12 INFO - no previously-included directories found matching 'dist' 09:12:12 INFO - no previously-included directories found matching '.git*' 09:12:12 INFO - Installing collected packages: jsonschema, functools32 09:12:12 INFO - Running setup.py install for functools32 09:12:12 INFO - warning: no files found matching '*.txt' 09:12:12 INFO - no previously-included directories found matching 'build' 09:12:12 INFO - no previously-included directories found matching 'dist' 09:12:12 INFO - no previously-included directories found matching '.git*' 09:12:12 INFO - Successfully installed jsonschema functools32 09:12:12 INFO - Cleaning up... 09:12:12 INFO - Return code: 0 09:12:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21d5cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', '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 09:12: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', 'flake8'] in /builds/slave/test/build 09:12: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 flake8 09:12:12 INFO - Using env: {'DISPLAY': ':0', 09:12:12 INFO - 'HOME': '/home/cltbld', 09:12:12 INFO - 'LANG': 'en_US.UTF-8', 09:12:12 INFO - 'LANGUAGE': 'en_US:en', 09:12:12 INFO - 'LOGNAME': 'cltbld', 09:12:12 INFO - 'MAIL': '/var/mail/cltbld', 09:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:12 INFO - 'MOZ_NO_REMOTE': '1', 09:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:12 INFO - 'NO_EM_RESTART': '1', 09:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:12 INFO - 'PWD': '/builds/slave/test', 09:12:12 INFO - 'SHELL': '/bin/bash', 09:12:12 INFO - 'SHLVL': '1', 09:12:12 INFO - 'TERM': 'linux', 09:12:12 INFO - 'TMOUT': '86400', 09:12:12 INFO - 'USER': 'cltbld', 09:12:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:12 INFO - '_': '/tools/buildbot/bin/python'} 09:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:13 INFO - Downloading/unpacking flake8 09:12:13 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 09:12:13 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 09:12:13 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 09:12:13 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 09:12:13 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 09:12:13 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 09:12:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:12:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:12:14 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 09:12:14 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 09:12:14 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 09:12:14 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 09:12:14 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 09:12:14 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 09:12:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:12:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:12:15 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 09:12:15 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 09:12:15 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 09:12:15 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 09:12:15 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 09:12:15 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 09:12:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:12:15 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 09:12:15 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 09:12:15 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 09:12:15 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 09:12:15 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 09:12:15 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 09:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:12:15 INFO - no previously-included directories found matching 'docs/_build' 09:12:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:12:15 INFO - Running setup.py install for pep8 09:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:12:15 INFO - no previously-included directories found matching 'docs/_build' 09:12:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:12:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:12:15 INFO - Cleaning up... 09:12:16 INFO - Return code: 0 09:12:16 INFO - Running post-action listener: _resource_record_post_action 09:12:16 INFO - Running post-action listener: _start_resource_monitoring 09:12:16 INFO - Starting resource monitoring. 09:12:16 INFO - ##### 09:12:16 INFO - ##### Running install step. 09:12:16 INFO - ##### 09:12:16 INFO - Running pre-action listener: _resource_record_pre_action 09:12:16 INFO - Running main action method: install 09:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:16 INFO - Reading from file tmpfile_stdout 09:12:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:12:16 INFO - Reading from file tmpfile_stdout 09:12:16 INFO - Output received: 09:12:16 INFO - Usage: mozinstall [options] installer 09:12:16 INFO - Options: 09:12:16 INFO - -h, --help show this help message and exit 09:12:16 INFO - -d DEST, --destination=DEST 09:12:16 INFO - Directory to install application into. [default: 09:12:16 INFO - "/builds/slave/test"] 09:12:16 INFO - --app=APP Application being installed. [default: firefox] 09:12:16 INFO - mkdir: /builds/slave/test/build/application 09:12:16 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'] 09:12:16 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 09:12:32 INFO - Reading from file tmpfile_stdout 09:12:32 INFO - Output received: 09:12:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:12:32 INFO - Running post-action listener: _resource_record_post_action 09:12:32 INFO - ##### 09:12:32 INFO - ##### Running run-tests step. 09:12:32 INFO - ##### 09:12:32 INFO - Running pre-action listener: _resource_record_pre_action 09:12:32 INFO - Running main action method: run_tests 09:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:12:32 INFO - Python 2.7.3 09:12:32 INFO - Return code: 0 09:12:32 INFO - grabbing minidump binary from tooltool 09:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:32 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 0x1988410>, '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 0x1989310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19897a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:12:32 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 09:12:32 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 09:12:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:12:32 INFO - Return code: 0 09:12:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:12:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:12:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:12:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:12:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:12:33 INFO - Return code: 0 09:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:12:33 INFO - Using env: {'DISPLAY': ':0', 09:12:33 INFO - 'HOME': '/home/cltbld', 09:12:33 INFO - 'LANG': 'en_US.UTF-8', 09:12:33 INFO - 'LANGUAGE': 'en_US:en', 09:12:33 INFO - 'LOGNAME': 'cltbld', 09:12:33 INFO - 'MAIL': '/var/mail/cltbld', 09:12:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:12:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:33 INFO - 'MOZ_NO_REMOTE': '1', 09:12:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:33 INFO - 'NO_EM_RESTART': '1', 09:12:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:33 INFO - 'PWD': '/builds/slave/test', 09:12:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:12:33 INFO - 'SHELL': '/bin/bash', 09:12:33 INFO - 'SHLVL': '1', 09:12:33 INFO - 'TERM': 'linux', 09:12:33 INFO - 'TMOUT': '86400', 09:12:33 INFO - 'USER': 'cltbld', 09:12:33 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621', 09:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:33 INFO - '_': '/tools/buildbot/bin/python'} 09:12:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:12:33 INFO - mozversion application_buildid: 20160318075315 09:12:33 INFO - mozversion application_changeset: 9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2 09:12:33 INFO - mozversion application_display_name: Nightly 09:12:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:12:33 INFO - mozversion application_name: Firefox 09:12:33 INFO - mozversion application_remotingname: firefox 09:12:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:12:33 INFO - mozversion application_vendor: Mozilla 09:12:33 INFO - mozversion application_version: 48.0a1 09:12:33 INFO - mozversion platform_buildid: 20160318075315 09:12:33 INFO - mozversion platform_changeset: 9c5d494d05485aebf3fedf649abc0e7ae9d2dcf2 09:12:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:12:33 INFO - mozversion platform_version: 48.0a1 09:12:33 INFO - using testdate: 1458317553 09:12:33 INFO - actual date: 1458317553 09:12:33 INFO - starting webserver on 'localhost:40792' 09:12:33 INFO - SUITE-START | Running 2 tests 09:12:33 INFO - TEST-START | dromaeo_css 09:12:33 INFO - operating with platform_type : linux_ 09:12:33 INFO - Initialising browser for dromaeo_css test... 09:12:33 INFO - TEST-INFO | started process 31253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP81yis/profile http://localhost:40792/getInfo.html) 09:12:37 INFO - PROCESS | 31253 | __metrics Screen width/height:1600/1200 09:12:37 INFO - PROCESS | 31253 | colorDepth:24 09:12:37 INFO - PROCESS | 31253 | Browser inner width/height: 1024/697 09:12:37 INFO - PROCESS | 31253 | __metrics 09:12:38 ERROR - PROCESS | 31253 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:12:39 INFO - TEST-INFO | 31253: exit 0 09:12:39 INFO - Browser initialized. 09:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:39 INFO - TEST-INFO | started process 31346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP81yis/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:51 INFO - PROCESS | 31346 | RSS: Main: 155705344 09:12:51 INFO - PROCESS | 31346 | 09:13:43 INFO - PROCESS | 31346 | 1458317623109 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] 09:15:54 INFO - PROCESS | 31346 | Cycle 1(1): loaded http://localhost:40792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40792/tests/dromaeo/cssquery-ext.html) 09:15:55 INFO - PROCESS | 31346 | RSS: Main: 230645760 09:15:55 INFO - PROCESS | 31346 | 09:18:58 INFO - PROCESS | 31346 | Cycle 1(1): loaded http://localhost:40792/tests/dromaeo/cssquery-ext.html (next: http://localhost:40792/tests/dromaeo/cssquery-jquery.html) 09:18:58 INFO - PROCESS | 31346 | RSS: Main: 245276672 09:18:58 INFO - PROCESS | 31346 | 09:22:00 INFO - PROCESS | 31346 | Cycle 1(1): loaded http://localhost:40792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40792/tests/dromaeo/cssquery-mootools.html) 09:22:01 INFO - PROCESS | 31346 | RSS: Main: 235569152 09:22:01 INFO - PROCESS | 31346 | 09:25:03 INFO - PROCESS | 31346 | Cycle 1(1): loaded http://localhost:40792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40792/tests/dromaeo/cssquery-prototype.html) 09:25:03 INFO - PROCESS | 31346 | RSS: Main: 211996672 09:25:03 INFO - PROCESS | 31346 | 09:28:06 INFO - PROCESS | 31346 | Cycle 1(1): loaded http://localhost:40792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40792/tests/dromaeo/cssquery-yui.html) 09:28:06 INFO - PROCESS | 31346 | RSS: Main: 204582912 09:28:06 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | Cycle 1(1): loaded http://localhost:40792/tests/dromaeo/cssquery-yui.html (next: http://localhost:40792/tests/dromaeo/cssquery-dojo.html) 09:31:09 INFO - PROCESS | 31346 | RSS: Main: 271605760 09:31:09 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | __start_tp_report 09:31:09 INFO - PROCESS | 31346 | _x_x_mozilla_page_load 09:31:09 INFO - PROCESS | 31346 | _x_x_mozilla_page_load_details 09:31:09 INFO - PROCESS | 31346 | |i|pagename|runs| 09:31:09 INFO - PROCESS | 31346 | |0;dojo.html;2601.544729672307;2666.546687063199;2679.9330016749577;2685.328667833042;2704.39151190982;4636.374089497916;4709.364235828162;4724.314974328725;4742.027884283722;4757.999999999995;4734.810607575693;4775.331453596499;4793.5925446337105;4794.448638406584;4881.951180488194;4334.978325108378;4352.325389564622;4361.302191649337;4395.4725432947935;4508.436445444319;4243.575642435762;4398.824047038114;4414.381986521889;4453.198424283628;4463.553644635543;4303.956960430387;4336.046069864625;4394.560543945579;4408.008198155421;4410.867673969786;4303.074838909618;4322.956770432318;4328.069465064995;4362.541933097011;4371.693981421302;4274.487061552633;4298.785060746982;4301.677374196947;4319.352097185448;4374.956250437519;4593.104344652794;4641.907161856778;4756.334113224151;4758.97681998372;4765.046990601893;5033.723145227011;5058.140116180258;5061.392632884041;5069.898602027975;5111.821086262;5086.982603479282;5087.414947281036;5093.286939828427;5137.255098010804;5137.717425541594;4676.976615116902;4731.621470282369;4780.521947805191;4804.8318308859725;4817.759112044384;5216.191490318931;5220.190870415092;5224.50367215114;5226.764795584208;5231.973840130775;4936.456989731127;4989.80040798364;5003.7998480061115;5019.774110165052;5050.015247026868;5018.4981501849525;5048.167052436307;5066.442691303953;5111.591072714174;5118.692878427306;5025.271335656309;5033.823816166417;5040.445550989388;5043.067032598981;5102.183650615958;5004.674696144739;5022.84931452057;5031.547160755549;5033.723145227048;5098.1842905135;4377.190219809346;4400.405945197422;4416.712913660602;4459.241928872099;4468.597826195658;3760.5487341519192;3765.1904840458883;3781.4138808484727;3808.542974842981;3810.542734871833;4276.294411422143;4330.112326972963;4335.6965012449455;4337.891552711208;4373.671974601918;5067.214581739836;5107.642465027487;5142.51146141116;5148.6910785353;5156.948430515722;4346.1090476452255;4353.934690979638;4353.956460435418;4357.847475338348;4385;4534.206513860061;4558.33904083906;4594.931076033862;4606.539346065367;4636.235021221461;4688.484266730657;4738.549837765407;4763.499832517536;4798.47216806151;4809.663323567317;5086.694798312114;5107.361579802525;5110.48895110486;5111.923321150111;5173.508516690908;4772.0455908817685;4779.928301075417;4804;4828.034393121319;4881.975590122027;5005.274235235943;5016.799328026838;5020.573251273537;5027.824026159067;5082.034413461431;5096.541311282002;5098.974505127599;5099.949000509948;5104.872378190575;5148.279240906201;4872.14737420957;4890.119778439915;4921.188003979303;4971.925421118758;4981.526754958273;4934.383202099738;4956.8760780980765;4958.801647934187;4973.47778483254;5002.974985125051;4876.731779752147;4896.877578060577;4904.092742842586;4908.6073114151495;4930.901381972412;4899.387576552931;4924.9507504924495;4965;4993.325901003318;5046.066477701637;4857.295692124551;4872.1717308057005;4883.633727470383;4904.043711476228;4943.110240156806 09:31:09 INFO - PROCESS | 31346 | |1;ext.html;541.8943306055319;549.2310764929099;564.1368705880002;570.9172170035348;575.8071046199526;27584.586231206522;27975.86012069939;34480.4827927581;34964.77623283186;35078;37727.24545509088;38124.80937595315;38166;38205.808970955106;38245.42631860524;7574.734884279065;7827.099883513412;7828.765137045898;7830.765077047698;7833.295003449688;7643.312101910827;7776.961115194416;7783.494072885244;7784.104827944774;7790.571518566477;7932.365410767154;8034.437589368747;8034.839303213932;8038.678452861878;8047.155048719888;7923.2869041786225;7978.680852765882;7990.920090799075;7996.4402491825595;7997.400194985399;7833.49082309648;7945.761627151194;7973.760787176394;7980;7985.96007019967;37345.06637334061;37674.24651506982;37685.24629507394;37727.622723772685;37832.43251351232;3197.7921435106646;3330.633630300665;3357.8992630221132;3376.5441665375106;3715.7956312402807;28332.26977226483;28574.285642858886;28727.71272287271;29188.854055729797;29620.555691664642;3442.4836274558766;3459.9827000864834;3472.94790578139;3526.841292141834;3647.598764135943;231363;231513;231652;232091;232473;41599.5440159599;42391.57608423876;52638.47361526412;53133.46866531362;53218.201726974126;41636;41673;41803.372949405784;41803.7909810449;41890.37164442536;12062;12077.818832717516;12114.878851211375;12116.09129315305;12139.332336721565;10541.631042913461;10587.84118238227;10595;10596.629117980834;10598.25812193139;14244.359003844851;14760.778588321184;14812.259387030605;14828.62928426798;14954.252287385805;6040.879182416327;6054.757809687651;6069.666168360694;6111.727044816654;6162.5378096642935;829.5064436660177;925.8703781470599;951.7192428233687;1004.1765752083221;1021.5249908792299;27013.594796078076;27170.320741981213;27537.31156721098;27551.31121721973;27586.310342241606;1002.6691191906654;1006.5973610555836;1035.9119474844722;1058.5236643510298;1063.8829728729834;13946.651333716738;14257.78613320801;14289.857101428852;14558.4904528341;14577.781333280009;301435;306501;306624;306904;307431;47356.526434735904;47762.76118619385;47869;47933.76033119812;48100.27849582189;1055.155875299757;1158.3108050709814;1256.591607727474;1271.167385362589;1369.5069774881035;24737.628935565623;25350.50440861081;25359.239222823344;25753.227403177934;25768.742312576633;37660.811695941346;37899.621003790715;38001.80999094987;38009.80995095007;38014.42978355272;199876;200417;201057;201319;202556;27264.318392040357;31388.843055785488;31824.204394890312;32242.35515289634;32358.514622281156;34739.652603473645;35112.12219694528;35254.64745352514;43768.34347484854;45003.77498112489;30945.8452707735;31991.84004079965;32058.35883282368;32409.513857291688;32681.673183267863;33546.832265838515;34852.30295394129;35005;35217.47173792446;35336.11659708528;31868.521972169972;35142.29715405728;36847.63152368442;37857.81071094627;37873.05317367088;28266;31389.529157062207;31508.212294692818;31515.52726709147;31573.8421307892;24271.150509732073;24583.631245531687;24682.259532214062;25035.621615946457;25059.624105638795 09:31:09 INFO - PROCESS | 31346 | |2;jquery.html;346.5755743892602;352.6015602369323;360.05485600299215;361.23418353091444;365.4499977533811;15387.846121538782;15794.526164215078;17119.14404279784;17368.47894563162;17438.651226975453;16165.515034548953;16526.917365413155;16730.83269167308;16736.66526669469;16741.83258167421;4852.320675105497;4965.975170124162;4973.602111831045;5012.3483947086825;5035.496450354954;5006.699598024112;5017.573506251973;5026.346574945271;5027.195648696209;5029.446760856303;5014.2227954666905;5015.3730783652045;5016.172331565287;5066.36670416198;5336.866578335554;5610.971945140269;5620.156976453564;5638.577106716972;5653.773849046054;5654.37801841797;4975.179095449246;5038.748062596892;5038.949610503884;5051.343325367716;5051.772670229849;11884.286942783461;12048.698782530419;12216.20594661353;12223.205491643015;12232.877671223263;1987.701844723303;2007.3877467372445;2082.854200205986;2219.345293138528;2393.4495066134714;8747.737567872973;9199.540022998823;9288.721338359792;9362.578683959238;9503.477308748015;1743.111013383171;1767.9734803977951;1776.7779027621548;1808.2766893242808;1811.4384540792264;58420;59866.40133598652;61541.38458615401;64080.679596601716;64425.67787161034;9905.108540231413;9968.152707019985;10151.593936242616;10233.692989210336;10330.328528645614;13064.477420903057;13136.146150500186;13154.60536183916;13170.802437963439;13183.802242966363;7117.217106118323;7158.675645005691;7246.384057355079;7267.345938865527;7358.705651773869;7082.468814838908;7136.393406560397;7142.928570714226;7220.891686624705;7259.165196002422;4352.847650332286;4361.956380436219;4426.225410553205;4437.689361744647;4485.551444855553;1744.8167942366122;1806.6296409236074;1820.8270214329618;1822.1435925115175;1839.7884243311923;407.7573843563075;415.53460124660575;440.62326710662563;862.0818827948215;873.1530415497085;10161.593536258615;10211.7447063824;10358.641169495126;10440.060394564525;10683.465826708634;426.7751553042787;439.77131891416286;889.1863944490848;895.0691281067617;942.4816351006918;8661.696840610675;8895.021547629756;9044.592993315317;9293.860592091123;9885.851712224323;391190;394436;411981;419769;420045;41676.79161604172;48549.51450485521;54225.72887135539;71040.2895971044;72814.63592682003;933.4399360383716;940.5297351324338;951.9619215231452;962.5957098018849;964.71058682395;14793.334299956312;15020.624484387541;15021.399144034553;15129.319180637118;15531.301091450687;32626.83686581552;32718.67281327156;32782.18044548905;33087.50368744519;33487.49768753519;44252.11495770131;46613.53386466228;46894.29658555056;47145.528544714114;47624.761876190394;7173.928260717326;7285.235050319852;7591.810204744926;7699.730509432143;7714.652840622298;11289.548418063185;11405.771884562097;11427.200095993534;11516.30902145874;11565.768684626428;10121.443320617436;10178.440185789557;10202.18382529381;10324.174066074846;10367.688969330931;10098.242631802792;10219.489025548544;10266.897331026594;10298.3820970742;10423.68728938133;9869.161121304482;10004.349717268355;10266.230032747424;10441.738956526147;10511.316764410289;7104.893426598708;7412.851742965003;7441.479096463196;7613.124490683642;7758.92241077582;7386;9082.86464191976;9506.239500840054;9610.135087842127;9652.565634546321 09:31:09 INFO - PROCESS | 31346 | |3;mootools.html;1242.6831158054695;1430.4635761589402;1446.4286606790315;1587.71421144194;1784.5538615346163;6784.694688739006;7246.891296630548;7422.7030918763185;7446.441516886228;7446.702131914717;7383.926160738391;7553.20691327411;7554.320111189992;7560.4707670463085;7576.242375762421;1929.556202073524;1974.891380974046;2154.9353519394363;2274.192661605131;2295.4490922178725;2242.8990695418747;2252.6733623624564;2253.4141123307895;2253.9323820285417;2254.425121593991;2187.8687278763327;2214.1475531920164;2219.644856822909;2258.8644681319092;2262.061244583496;2151;2157.2341818654468;2158.57907707997;2161.103142195987;2163.1131236193164;2214.0590249144047;2236;2241.887905604713;2244.427670943915;2248.7076680031655;7772.106207786064;7895.842083158362;7897.5656338901335;7902.091259505116;7905.802354941115;4644.326572646947;4738;4773.5226477352335;4776.880577985544;4780.1873681474235;3023.6522799878076;3031.6058912341255;3183.0769076967654;3189.2345836999184;3198.552202691625;1010.2372708604956;1022.8210063238903;1809.746635471035;1839.1356062650532;1869.401791426744;10368.948155259252;10390.896091039069;10462.63380781669;10485.9475702621;10503;3988.561258261589;4101.384792281182;4164.083901541656;4167.249895018926;4180.686448516373;8638.870416943751;8695.08701586337;8702.173293537104;8704.173103555153;8709.346798990102;4637.721736695809;4648.767561621973;4658.161530924398;4664.137134630037;4669.509701481364;3629.7822130672243;4064.451299074587;4205.285101532747;4206.726562773471;4272.273713468718;3451.0854623524788;3485.686288234071;3525.383057964846;3550.431930891045;3551.627079156703;960.4477425480237;963.0898800633474;972.9951350243203;1039.3504059962524;1056.7041228456044;980.9460479673686;1019.5208252121491;1167.1188252869028;1224.1920332580632;1227.1348699167065;7096.325849044332;7162.2837716229005;7199.388052015533;7215.098112735908;7241.637918104074;1011.4133802394593;1013.9036791504795;1030.850526673628;1068.5725709716176;1069.850220969065;5472.179173123984;5473.67157970523;5534.52956498694;5553.500184983371;5557.749901254372;9051;9359.532023398802;9587.712368628952;9589.712308630613;9674.661386851567;9444.622215111318;9605.567749451291;9605.759856003655;9635.903640963641;9701.854472182922;7046.859062818715;7146.678399472036;7158.463115266271;7191.424686025105;7208.71165153388;6950.965245173742;6973.267806880204;6976.5465244758925;6978.79063628092;6990.09128813251;8074.905769499111;8320.126386729306;8413.098989054515;8509;8540.316774657887;8635.093315201813;8635.82728345417;8637.524936128573;8772.561371931506;8779.034306226182;5740.540756739534;5912.46787789101;6113.419225173601;6327.418145463634;6542.411182993554;7273.127224733066;7293.562386256842;7298.379637730853;7307.926920730937;7324.340809327186;6344;6511.186101737283;6537.8692426152165;6552.705128269335;6576.638284894186;6400.42396184327;6415.390537898892;6469.967650161907;6527.836804079746;6554.967225164034;6721.731130754715;6754.2570317266045;6785.117934668461;6799.5920244785475;6799.796006119825;6285.77686188999;6311.495080393465;6460.838479037873;6492.285848556749;6505.024246363083;6450.967745161244;6501.8699626008165;6523.445507131947;6540.50946179048;6545.312742162005 09:31:09 INFO - PROCESS | 31346 | |4;prototype.html;315.94313023655747;318.3537419039351;319.0396905315001;324.09577279390504;325.01682410707605;5277.393099793525;5456.6453180543285;5460.989716902376;5469.589780766439;5474.589405794562;5282.683039017652;5360.892782144365;5367;5369.24830523727;5378;3912.9413058804;4052.9189416211657;4142.647874930634;4150.792460376984;4162.313218318981;4144.067584793413;4146.834126634946;4150.43969064177;4154.376843473488;4158.688098392618;4101.569335219804;4102.3026085565525;4108.52751933527;4108.85619003335;4112.835486580548;3866.130120722843;3990.9201815963806;4074.8981275468054;4077.5106987161435;4082.3468245080644;3581.856725730968;3593.047842321787;3595.6044835068383;3600.369935261319;3605.819709014565;5153.252778347119;5167.044096842096;5173.120569503193;5177.922331165036;5186.7147306898105;4738.289256611536;4738.763061846894;4744.3595114659765;4746.715197088186;4749.050189961987;5614.27014488118;5624.775008999676;5625.6905870177125;5627.80302689408;5630.493255606974;3952.505936757905;3959.109200429909;3960.32674445345;3960.960390396088;3962.0689138052535;5699.971500142514;5937.554683398763;5944.940550594482;5945.851353716149;5947.256592925884;3986.8604598839484;4049.028233224005;4052;4052.1085361220485;4059.4519739834745;4118.855840045584;4120.505539335239;4121.196366708463;4123.546409894909;4127.442795222607;4716.339712440261;4718.504557021532;4721;4737.194676904935;4743.217369134123;5642.802501912495;5647.887042259214;5656.745446454919;5663.546916246691;5670.234518340054;1425.3942074618246;1448.8551144885428;1450.4923276853017;1451.6661167931436;1451.7822326650876;882.5940067568862;947.0671388682142;956.583886009588;970.4904924914476;985.2118305355687;4903.975480122576;4919.286703428054;4929.975350123226;4934.1611925972675;4935.358403407534;5804.332501762267;5826.82519524415;5835.095560188178;5870.26621672291;5877.265341832271;4905.0189962007025;4923.556879880828;4928.581070608967;4929.901401971941;4934.7285899275885;3093.1648454917045;3131.6242050953574;3133.248020475115;3133.8903138390046;3137.905862824119;5409.350877894678;5434.891302174014;5446.319210098738;5451.046066938349;5463.2078348639225;5748.827535173951;5908.291005079418;5934.673592952429;5938.28740551128;5949.762009519571;5399.379071406838;5414.458554144554;5429.294191755047;5440.374356948843;5447.019536483471;5739.62692424991;5782.2483077199695;5801.970990145022;5803.65178089316;5807.62250453736;5673.8865222694485;5687.033204355187;5689.402612725769;5693.345265294544;5695.544356451391;5417;5430.185472179205;5430.782768689208;5438.592105592175;5440.347158341025;3924.8233829478313;4034.1326614777963;4042.4946881639794;4055.4322394864153;4056.513218413809;5740.995325817881;5767.423257674367;5773.16289138081;5783.479486846204;5788.0739081746715;5519.530839878495;5521.3926468087675;5521.4478552144465;5528.364238112668;5548.306461692288;5508.889822203613;5526.889462210653;5531.474509921551;5536.169574563686;5594.104943209067;5492.80775172867;5506.091494903456;5507.504324610804;5513.751881165437;5513.862153446196;5533.6403133796175;5731.19763233156;5745.597808153389;5749.54003679713;5754.3382511010095;5564.638298510584;5588.552915766648;5597.964376590344;5600.495955363874;5604.439556044526 09:31:09 INFO - PROCESS | 31346 | |5;yui.html;713.3757961783436;730.3645828129528;747.9177290498046;761.8780995040795;778.338412349503;11835.940820295897;11978.940105299462;11995.400229988509;12019.399030048484;12364.196327238724;11853.525858965631;11866.347350895698;11899.52401903925;11998.820017699742;12011.7597648047;634.0900807341479;786.9685212591489;792.8057625881667;803.7709252862935;808.870580707087;799.4483806173722;799.7001124578284;799.7880561651167;799.9160088190744;803.8553060449117;852.8294341131767;855.4696088425154;856.6787454704486;856.7986523167051;856.8157846063095;681.8568100698859;690.5683947532792;839.5382539603255;844.02515095065;857.6740838481337;625.5371025441186;628.4783629587478;628.8459327464755;629.326620516048;629.4618101523178;12226.266424014588;12317.815232771516;12388.31864247466;12389.318587477685;12392.56626018085;12129.332886691229;12351.876481235162;12497.625071247878;12643.114981951267;12658.81011784824;10175.898241017643;10207.591696332138;10322.071013608811;10347.379157250589;10351.896481035168;3343.063942096217;3379.9662003380145;3416.829158542063;3428.434308339121;3505.404081306159;44200.77899610514;44258.77870610626;44345;44389.33415998763;44622.77688611536;10101.220601369485;10107.545160467796;10109.545070471846;10186.337888037402;10474.73813154662;18105.366312179012;18233.635327293647;18270.908645456955;18280.360187393377;18289;6825.48808839339;6923;6992.370686638227;6999.405050570758;7067.858642827115;3804.2581696569455;3888.0474283800086;3901.5708272090046;3927.7446965947124;3967.80160991955;2994.2215024093457;2997.8950736724546;3001.2046807596003;3023.56158357037;3026.7881248312406;538.8706710389479;549.6454786662661;554.0304467182431;555.5583311267552;561.0322194214947;465.20914445442884;518.8910328830988;557.1976354050155;584.4155844155844;614.7602435050334;7515.436342274351;7780.18308077655;7852.411069169721;7860.724874629361;7877.094134174643;531.6889619572594;634.7429291137005;637.7098420218789;641.1568787045114;641.2945759664332;3516.5252690886914;3597.334493118781;3723.8696645617274;3804.2801885712693;3858.8649397271524;48894.266586001235;49102.5089749098;49201.26198107031;55760.442395576334;55895;47841;48191;48704;49365.75317123391;49499.25751113664;43561.34657980133;43688;43897.12205755867;43977.56022439799;44483.55516444794;7142.321479459443;7182.138143422822;7204.71181152748;7306.342429181399;7369.705211791468;32603.510947336283;33885.66114338825;34085.48871766975;34386.14034649054;34635;39869.60130398659;42271.365929510466;42991.1401771969;43479.565204348815;43484.34773478337;8474.703385381483;8602.440841345293;8834.558272086499;8966.775830604287;8968.148025937526;10227.48862556884;10265.076143147153;10268.58925642966;10638.52126654287;10640.787184256425;8448.788780280542;8712.722913232328;10042;10365.33391480165;10422.270441069053;9886.307958443127;10067.74830629211;10075.944058038847;10119.494025298853;10234.771827380762;9609.636404193454;9895.851562226717;9965.40207587547;10142.239332049978;10430.73923151897;8897.777555561162;8996.457384418352;9196.641070546404;9268.119528644767;9443.386179898285;8960.354976364848;9103.36276460668;9381.174936415242;9389.108034736963;9601.759956001157 09:31:09 INFO - PROCESS | 31346 | __end_tp_report 09:31:09 INFO - PROCESS | 31346 | __start_cc_report 09:31:09 INFO - PROCESS | 31346 | _x_x_mozilla_cycle_collect,1006 09:31:09 INFO - PROCESS | 31346 | __end_cc_report 09:31:09 INFO - PROCESS | 31346 | __startTimestamp1458318669739__endTimestamp 09:31:09 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | ------- Summary: start ------- 09:31:09 INFO - PROCESS | 31346 | Number of tests: 6 09:31:09 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | [#0] dojo.html Cycles:165 Average:4700.16 Median:4828.03 stddev:491.09 (10.2%) stddev-sans-first:464.18 09:31:09 INFO - PROCESS | 31346 | Values: 2601.5 2666.5 2679.9 2685.3 2704.4 4636.4 4709.4 4724.3 4742.0 4758.0 4734.8 4775.3 4793.6 4794.4 4882.0 4335.0 4352.3 4361.3 4395.5 4508.4 4243.6 4398.8 4414.4 4453.2 4463.6 4304.0 4336.0 4394.6 4408.0 4410.9 4303.1 4323.0 4328.1 4362.5 4371.7 4274.5 4298.8 4301.7 4319.4 4375.0 4593.1 4641.9 4756.3 4759.0 4765.0 5033.7 5058.1 5061.4 5069.9 5111.8 5087.0 5087.4 5093.3 5137.3 5137.7 4677.0 4731.6 4780.5 4804.8 4817.8 5216.2 5220.2 5224.5 5226.8 5232.0 4936.5 4989.8 5003.8 5019.8 5050.0 5018.5 5048.2 5066.4 5111.6 5118.7 5025.3 5033.8 5040.4 5043.1 5102.2 5004.7 5022.8 5031.5 5033.7 5098.2 4377.2 4400.4 4416.7 4459.2 4468.6 3760.5 3765.2 3781.4 3808.5 3810.5 4276.3 4330.1 4335.7 4337.9 4373.7 5067.2 5107.6 5142.5 5148.7 5156.9 4346.1 4353.9 4354.0 4357.8 4385.0 4534.2 4558.3 4594.9 4606.5 4636.2 4688.5 4738.5 4763.5 4798.5 4809.7 5086.7 5107.4 5110.5 5111.9 5173.5 4772.0 4779.9 4804.0 4828.0 4882.0 5005.3 5016.8 5020.6 5027.8 5082.0 5096.5 5099.0 5099.9 5104.9 5148.3 4872.1 4890.1 4921.2 4971.9 4981.5 4934.4 4956.9 4958.8 4973.5 5003.0 4876.7 4896.9 4904.1 4908.6 4930.9 4899.4 4925.0 4965.0 4993.3 5046.1 4857.3 4872.2 4883.6 4904.0 4943.1 09:31:09 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | [#1] ext.html Cycles:180 Average:40005.46 Median:18961.48 stddev:65306.83 (344.4%) stddev-sans-first:65422.81 09:31:09 INFO - PROCESS | 31346 | Values: 541.9 549.2 564.1 570.9 575.8 27584.6 27975.9 34480.5 34964.8 35078.0 37727.2 38124.8 38166.0 38205.8 38245.4 7574.7 7827.1 7828.8 7830.8 7833.3 7643.3 7777.0 7783.5 7784.1 7790.6 7932.4 8034.4 8034.8 8038.7 8047.2 7923.3 7978.7 7990.9 7996.4 7997.4 7833.5 7945.8 7973.8 7980.0 7986.0 37345.1 37674.2 37685.2 37727.6 37832.4 3197.8 3330.6 3357.9 3376.5 3715.8 28332.3 28574.3 28727.7 29188.9 29620.6 3442.5 3460.0 3472.9 3526.8 3647.6 231363.0 231513.0 231652.0 232091.0 232473.0 41599.5 42391.6 52638.5 53133.5 53218.2 41636.0 41673.0 41803.4 41803.8 41890.4 12062.0 12077.8 12114.9 12116.1 12139.3 10541.6 10587.8 10595.0 10596.6 10598.3 14244.4 14760.8 14812.3 14828.6 14954.3 6040.9 6054.8 6069.7 6111.7 6162.5 829.5 925.9 951.7 1004.2 1021.5 27013.6 27170.3 27537.3 27551.3 27586.3 1002.7 1006.6 1035.9 1058.5 1063.9 13946.7 14257.8 14289.9 14558.5 14577.8 301435.0 306501.0 306624.0 306904.0 307431.0 47356.5 47762.8 47869.0 47933.8 48100.3 1055.2 1158.3 1256.6 1271.2 1369.5 24737.6 25350.5 25359.2 25753.2 25768.7 37660.8 37899.6 38001.8 38009.8 38014.4 199876.0 200417.0 201057.0 201319.0 202556.0 27264.3 31388.8 31824.2 32242.4 32358.5 34739.7 35112.1 35254.6 43768.3 45003.8 30945.8 31991.8 32058.4 32409.5 32681.7 33546.8 34852.3 35005.0 35217.5 35336.1 31868.5 35142.3 36847.6 37857.8 37873.1 28266.0 31389.5 31508.2 31515.5 31573.8 24271.2 24583.6 24682.3 25035.6 25059.6 09:31:09 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | [#2] jquery.html Cycles:180 Average:23271.25 Median:24339.17 stddev:66773.75 (274.3%) stddev-sans-first:66938.88 09:31:09 INFO - PROCESS | 31346 | Values: 346.6 352.6 360.1 361.2 365.4 15387.8 15794.5 17119.1 17368.5 17438.7 16165.5 16526.9 16730.8 16736.7 16741.8 4852.3 4966.0 4973.6 5012.3 5035.5 5006.7 5017.6 5026.3 5027.2 5029.4 5014.2 5015.4 5016.2 5066.4 5336.9 5611.0 5620.2 5638.6 5653.8 5654.4 4975.2 5038.7 5038.9 5051.3 5051.8 11884.3 12048.7 12216.2 12223.2 12232.9 1987.7 2007.4 2082.9 2219.3 2393.4 8747.7 9199.5 9288.7 9362.6 9503.5 1743.1 1768.0 1776.8 1808.3 1811.4 58420.0 59866.4 61541.4 64080.7 64425.7 9905.1 9968.2 10151.6 10233.7 10330.3 13064.5 13136.1 13154.6 13170.8 13183.8 7117.2 7158.7 7246.4 7267.3 7358.7 7082.5 7136.4 7142.9 7220.9 7259.2 4352.8 4362.0 4426.2 4437.7 4485.6 1744.8 1806.6 1820.8 1822.1 1839.8 407.8 415.5 440.6 862.1 873.2 10161.6 10211.7 10358.6 10440.1 10683.5 426.8 439.8 889.2 895.1 942.5 8661.7 8895.0 9044.6 9293.9 9885.9 391190.0 394436.0 411981.0 419769.0 420045.0 41676.8 48549.5 54225.7 71040.3 72814.6 933.4 940.5 952.0 962.6 964.7 14793.3 15020.6 15021.4 15129.3 15531.3 32626.8 32718.7 32782.2 33087.5 33487.5 44252.1 46613.5 46894.3 47145.5 47624.8 7173.9 7285.2 7591.8 7699.7 7714.7 11289.5 11405.8 11427.2 11516.3 11565.8 10121.4 10178.4 10202.2 10324.2 10367.7 10098.2 10219.5 10266.9 10298.4 10423.7 9869.2 10004.3 10266.2 10441.7 10511.3 7104.9 7412.9 7441.5 7613.1 7758.9 7386.0 9082.9 9506.2 9610.1 9652.6 09:31:09 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | [#3] mootools.html Cycles:180 Average:5340.17 Median:6319.46 stddev:2773.03 (43.9%) stddev-sans-first:2763.70 09:31:09 INFO - PROCESS | 31346 | Values: 1242.7 1430.5 1446.4 1587.7 1784.6 6784.7 7246.9 7422.7 7446.4 7446.7 7383.9 7553.2 7554.3 7560.5 7576.2 1929.6 1974.9 2154.9 2274.2 2295.4 2242.9 2252.7 2253.4 2253.9 2254.4 2187.9 2214.1 2219.6 2258.9 2262.1 2151.0 2157.2 2158.6 2161.1 2163.1 2214.1 2236.0 2241.9 2244.4 2248.7 7772.1 7895.8 7897.6 7902.1 7905.8 4644.3 4738.0 4773.5 4776.9 4780.2 3023.7 3031.6 3183.1 3189.2 3198.6 1010.2 1022.8 1809.7 1839.1 1869.4 10368.9 10390.9 10462.6 10485.9 10503.0 3988.6 4101.4 4164.1 4167.2 4180.7 8638.9 8695.1 8702.2 8704.2 8709.3 4637.7 4648.8 4658.2 4664.1 4669.5 3629.8 4064.5 4205.3 4206.7 4272.3 3451.1 3485.7 3525.4 3550.4 3551.6 960.4 963.1 973.0 1039.4 1056.7 980.9 1019.5 1167.1 1224.2 1227.1 7096.3 7162.3 7199.4 7215.1 7241.6 1011.4 1013.9 1030.9 1068.6 1069.9 5472.2 5473.7 5534.5 5553.5 5557.7 9051.0 9359.5 9587.7 9589.7 9674.7 9444.6 9605.6 9605.8 9635.9 9701.9 7046.9 7146.7 7158.5 7191.4 7208.7 6951.0 6973.3 6976.5 6978.8 6990.1 8074.9 8320.1 8413.1 8509.0 8540.3 8635.1 8635.8 8637.5 8772.6 8779.0 5740.5 5912.5 6113.4 6327.4 6542.4 7273.1 7293.6 7298.4 7307.9 7324.3 6344.0 6511.2 6537.9 6552.7 6576.6 6400.4 6415.4 6470.0 6527.8 6555.0 6721.7 6754.3 6785.1 6799.6 6799.8 6285.8 6311.5 6460.8 6492.3 6505.0 6451.0 6501.9 6523.4 6540.5 6545.3 09:31:09 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | [#4] prototype.html Cycles:180 Average:4653.82 Median:5388.69 stddev:1365.63 (25.3%) stddev-sans-first:1330.08 09:31:09 INFO - PROCESS | 31346 | Values: 315.9 318.4 319.0 324.1 325.0 5277.4 5456.6 5461.0 5469.6 5474.6 5282.7 5360.9 5367.0 5369.2 5378.0 3912.9 4052.9 4142.6 4150.8 4162.3 4144.1 4146.8 4150.4 4154.4 4158.7 4101.6 4102.3 4108.5 4108.9 4112.8 3866.1 3990.9 4074.9 4077.5 4082.3 3581.9 3593.0 3595.6 3600.4 3605.8 5153.3 5167.0 5173.1 5177.9 5186.7 4738.3 4738.8 4744.4 4746.7 4749.1 5614.3 5624.8 5625.7 5627.8 5630.5 3952.5 3959.1 3960.3 3961.0 3962.1 5700.0 5937.6 5944.9 5945.9 5947.3 3986.9 4049.0 4052.0 4052.1 4059.5 4118.9 4120.5 4121.2 4123.5 4127.4 4716.3 4718.5 4721.0 4737.2 4743.2 5642.8 5647.9 5656.7 5663.5 5670.2 1425.4 1448.9 1450.5 1451.7 1451.8 882.6 947.1 956.6 970.5 985.2 4904.0 4919.3 4930.0 4934.2 4935.4 5804.3 5826.8 5835.1 5870.3 5877.3 4905.0 4923.6 4928.6 4929.9 4934.7 3093.2 3131.6 3133.2 3133.9 3137.9 5409.4 5434.9 5446.3 5451.0 5463.2 5748.8 5908.3 5934.7 5938.3 5949.8 5399.4 5414.5 5429.3 5440.4 5447.0 5739.6 5782.2 5802.0 5803.7 5807.6 5673.9 5687.0 5689.4 5693.3 5695.5 5417.0 5430.2 5430.8 5438.6 5440.3 3924.8 4034.1 4042.5 4055.4 4056.5 5741.0 5767.4 5773.2 5783.5 5788.1 5519.5 5521.4 5521.4 5528.4 5548.3 5508.9 5526.9 5531.5 5536.2 5594.1 5492.8 5506.1 5507.5 5513.8 5513.9 5533.6 5731.2 5745.6 5749.5 5754.3 5564.6 5588.6 5598.0 5600.5 5604.4 09:31:09 INFO - PROCESS | 31346 | 09:31:09 INFO - PROCESS | 31346 | [#5] yui.html Cycles:180 Average:12838.81 Median:48016.00 stddev:14933.26 (31.1%) stddev-sans-first:14947.39 09:31:09 INFO - PROCESS | 31346 | Values: 713.4 730.4 747.9 761.9 778.3 11835.9 11978.9 11995.4 12019.4 12364.2 11853.5 11866.3 11899.5 11998.8 12011.8 634.1 787.0 792.8 803.8 808.9 799.4 799.7 799.8 799.9 803.9 852.8 855.5 856.7 856.8 856.8 681.9 690.6 839.5 844.0 857.7 625.5 628.5 628.8 629.3 629.5 12226.3 12317.8 12388.3 12389.3 12392.6 12129.3 12351.9 12497.6 12643.1 12658.8 10175.9 10207.6 10322.1 10347.4 10351.9 3343.1 3380.0 3416.8 3428.4 3505.4 44200.8 44258.8 44345.0 44389.3 44622.8 10101.2 10107.5 10109.5 10186.3 10474.7 18105.4 18233.6 18270.9 18280.4 18289.0 6825.5 6923.0 6992.4 6999.4 7067.9 3804.3 3888.0 3901.6 3927.7 3967.8 2994.2 2997.9 3001.2 3023.6 3026.8 538.9 549.6 554.0 555.6 561.0 465.2 518.9 557.2 584.4 614.8 7515.4 7780.2 7852.4 7860.7 7877.1 531.7 634.7 637.7 641.2 641.3 3516.5 3597.3 3723.9 3804.3 3858.9 48894.3 49102.5 49201.3 55760.4 55895.0 47841.0 48191.0 48704.0 49365.8 49499.3 43561.3 43688.0 43897.1 43977.6 44483.6 7142.3 7182.1 7204.7 7306.3 7369.7 32603.5 33885.7 34085.5 34386.1 34635.0 39869.6 42271.4 42991.1 43479.6 43484.3 8474.7 8602.4 8834.6 8966.8 8968.1 10227.5 10265.1 10268.6 10638.5 10640.8 8448.8 8712.7 10042.0 10365.3 10422.3 9886.3 10067.7 10075.9 10119.5 10234.8 9609.6 9895.9 9965.4 10142.2 10430.7 8897.8 8996.5 9196.6 9268.1 9443.4 8960.4 9103.4 9381.2 9389.1 9601.8 09:31:09 INFO - PROCESS | 31346 | -------- Summary: end -------- 09:31:09 INFO - PROCESS | 31346 | 09:31:10 INFO - TEST-INFO | 31346: exit 0 09:31:10 INFO - TEST-OK | dromaeo_css | took 1116998ms 09:31:10 INFO - TEST-START | kraken 09:31:10 INFO - operating with platform_type : linux_ 09:31:10 INFO - Initialising browser for kraken test... 09:31:10 INFO - TEST-INFO | started process 31525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNJZe9w/profile http://localhost:40792/getInfo.html) 09:31:14 INFO - PROCESS | 31525 | __metrics Screen width/height:1600/1200 09:31:14 INFO - PROCESS | 31525 | colorDepth:24 09:31:14 INFO - PROCESS | 31525 | Browser inner width/height: 1024/697 09:31:14 INFO - PROCESS | 31525 | __metrics 09:31:15 ERROR - PROCESS | 31525 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:31:16 INFO - TEST-INFO | 31525: exit 0 09:31:16 INFO - Browser initialized. 09:31:16 INFO - Running cycle 1/1 for kraken test... 09:31:16 INFO - TEST-INFO | started process 31606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNJZe9w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:28 INFO - PROCESS | 31606 | RSS: Main: 155480064 09:31:28 INFO - PROCESS | 31606 | 09:31:30 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40792/tests/kraken/driver.html?testName=audio-beat-detection) 09:31:31 INFO - PROCESS | 31606 | RSS: Main: 195760128 09:31:31 INFO - PROCESS | 31606 | 09:31:34 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40792/tests/kraken/driver.html?testName=audio-dft) 09:31:34 INFO - PROCESS | 31606 | RSS: Main: 186478592 09:31:34 INFO - PROCESS | 31606 | 09:31:37 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40792/tests/kraken/driver.html?testName=audio-fft) 09:31:38 INFO - PROCESS | 31606 | RSS: Main: 173559808 09:31:38 INFO - PROCESS | 31606 | 09:31:40 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40792/tests/kraken/driver.html?testName=audio-oscillator) 09:31:40 INFO - PROCESS | 31606 | RSS: Main: 173572096 09:31:40 INFO - PROCESS | 31606 | 09:31:43 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:31:43 INFO - PROCESS | 31606 | RSS: Main: 176140288 09:31:43 INFO - PROCESS | 31606 | 09:31:46 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40792/tests/kraken/driver.html?testName=imaging-darkroom) 09:31:47 INFO - PROCESS | 31606 | RSS: Main: 175656960 09:31:47 INFO - PROCESS | 31606 | 09:31:50 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40792/tests/kraken/driver.html?testName=imaging-desaturate) 09:31:51 INFO - PROCESS | 31606 | RSS: Main: 176357376 09:31:51 INFO - PROCESS | 31606 | 09:31:54 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40792/tests/kraken/driver.html?testName=json-parse-financial) 09:31:54 INFO - PROCESS | 31606 | RSS: Main: 175845376 09:31:54 INFO - PROCESS | 31606 | 09:31:56 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:31:57 INFO - PROCESS | 31606 | RSS: Main: 189317120 09:31:57 INFO - PROCESS | 31606 | 09:31:59 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40792/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:31:59 INFO - PROCESS | 31606 | RSS: Main: 185942016 09:31:59 INFO - PROCESS | 31606 | 09:32:01 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:02 INFO - PROCESS | 31606 | RSS: Main: 194166784 09:32:02 INFO - PROCESS | 31606 | 09:32:04 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:05 INFO - PROCESS | 31606 | RSS: Main: 197763072 09:32:05 INFO - PROCESS | 31606 | 09:32:08 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:32:08 INFO - PROCESS | 31606 | RSS: Main: 197652480 09:32:08 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | Cycle 1(1): loaded http://localhost:40792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40792/tests/kraken/driver.html?testName=ai-astar) 09:32:10 INFO - PROCESS | 31606 | RSS: Main: 257802240 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | __start_tp_report 09:32:10 INFO - PROCESS | 31606 | _x_x_mozilla_page_load 09:32:10 INFO - PROCESS | 31606 | _x_x_mozilla_page_load_details 09:32:10 INFO - PROCESS | 31606 | |i|pagename|runs| 09:32:10 INFO - PROCESS | 31606 | |0;ai-astar;110;111;107;111;111;111;100;110;111;112 09:32:10 INFO - PROCESS | 31606 | |1;audio-beat-detection;151;129;157;173;130;153;158;130;177;139 09:32:10 INFO - PROCESS | 31606 | |2;audio-dft;163;161;161;162;160;161;165;162;162;163 09:32:10 INFO - PROCESS | 31606 | |3;audio-fft;73;74;96;92;76;73;76;103;91;72 09:32:10 INFO - PROCESS | 31606 | |4;audio-oscillator;94;94;132;93;95;94;141;94;95;136 09:32:10 INFO - PROCESS | 31606 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 09:32:10 INFO - PROCESS | 31606 | |6;imaging-darkroom;146;147;146;146;147;147;146;146;146;146 09:32:10 INFO - PROCESS | 31606 | |7;imaging-desaturate;95;95;95;95;95;96;96;96;95;96 09:32:10 INFO - PROCESS | 31606 | |8;json-parse-financial;65;67;67;66;66;77;65;75;63;64 09:32:10 INFO - PROCESS | 31606 | |9;json-stringify-tinderbox;64;64;64;65;65;65;64;65;64;65 09:32:10 INFO - PROCESS | 31606 | |10;stanford-crypto-aes;90;83;83;85;83;82;83;81;81;83 09:32:10 INFO - PROCESS | 31606 | |11;stanford-crypto-ccm;115;119;116;122;120;114;124;121;119;117 09:32:10 INFO - PROCESS | 31606 | |12;stanford-crypto-pbkdf2;140;129;140;139;139;128;139;142;138;140 09:32:10 INFO - PROCESS | 31606 | |13;stanford-crypto-sha256-iterative;67;66;67;68;65;67;66;70;68;68 09:32:10 INFO - PROCESS | 31606 | __end_tp_report 09:32:10 INFO - PROCESS | 31606 | __start_cc_report 09:32:10 INFO - PROCESS | 31606 | _x_x_mozilla_cycle_collect,1140 09:32:10 INFO - PROCESS | 31606 | __end_cc_report 09:32:10 INFO - PROCESS | 31606 | __startTimestamp1458318730680__endTimestamp 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | ------- Summary: start ------- 09:32:10 INFO - PROCESS | 31606 | Number of tests: 14 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.57 (3.2%) stddev-sans-first:3.77 09:32:10 INFO - PROCESS | 31606 | Values: 110.0 111.0 107.0 111.0 111.0 111.0 100.0 110.0 111.0 112.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:155.00 stddev:17.46 (11.3%) stddev-sans-first:18.51 09:32:10 INFO - PROCESS | 31606 | Values: 151.0 129.0 157.0 173.0 130.0 153.0 158.0 130.0 177.0 139.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 09:32:10 INFO - PROCESS | 31606 | Values: 163.0 161.0 161.0 162.0 160.0 161.0 165.0 162.0 162.0 163.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:11.61 (15.3%) stddev-sans-first:11.78 09:32:10 INFO - PROCESS | 31606 | Values: 73.0 74.0 96.0 92.0 76.0 73.0 76.0 103.0 91.0 72.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:94.00 stddev:20.50 (21.8%) stddev-sans-first:21.21 09:32:10 INFO - PROCESS | 31606 | Values: 94.0 94.0 132.0 93.0 95.0 94.0 141.0 94.0 95.0 136.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:32:10 INFO - PROCESS | 31606 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:32:10 INFO - PROCESS | 31606 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:32:10 INFO - PROCESS | 31606 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:66.50 stddev:4.67 (7.0%) stddev-sans-first:4.87 09:32:10 INFO - PROCESS | 31606 | Values: 65.0 67.0 67.0 66.0 66.0 77.0 65.0 75.0 63.0 64.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:32:10 INFO - PROCESS | 31606 | Values: 64.0 64.0 64.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.59 (3.1%) stddev-sans-first:1.22 09:32:10 INFO - PROCESS | 31606 | Values: 90.0 83.0 83.0 85.0 83.0 82.0 83.0 81.0 81.0 83.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.50 stddev:3.20 (2.7%) stddev-sans-first:3.10 09:32:10 INFO - PROCESS | 31606 | Values: 115.0 119.0 116.0 122.0 120.0 114.0 124.0 121.0 119.0 117.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.40 Median:139.50 stddev:4.81 (3.4%) stddev-sans-first:5.01 09:32:10 INFO - PROCESS | 31606 | Values: 140.0 129.0 140.0 139.0 139.0 128.0 139.0 142.0 138.0 140.0 09:32:10 INFO - PROCESS | 31606 | 09:32:10 INFO - PROCESS | 31606 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.40 (2.1%) stddev-sans-first:1.48 09:32:10 INFO - PROCESS | 31606 | Values: 67.0 66.0 67.0 68.0 65.0 67.0 66.0 70.0 68.0 68.0 09:32:10 INFO - PROCESS | 31606 | -------- Summary: end -------- 09:32:10 INFO - PROCESS | 31606 | 09:32:11 INFO - TEST-INFO | 31606: exit 0 09:32:11 INFO - TEST-OK | kraken | took 61199ms 09:32:11 INFO - SUITE-END | took 1178s 09:32:11 INFO - Completed test suite (00:19:38) 09:32:11 INFO - javascript benchmark 09:32:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2601.544729672307, 2666.546687063199, 2679.9330016749577, 2685.328667833042, 2704.39151190982, 4636.374089497916, 4709.364235828162, 4724.314974328725, 4742.027884283722, 4757.999999999995, 4734.810607575693, 4775.331453596499, 4793.5925446337105, 4794.448638406584, 4881.951180488194, 4334.978325108378, 4352.325389564622, 4361.302191649337, 4395.4725432947935, 4508.436445444319, 4243.575642435762, 4398.824047038114, 4414.381986521889, 4453.198424283628, 4463.553644635543, 4303.956960430387, 4336.046069864625, 4394.560543945579, 4408.008198155421, 4410.867673969786, 4303.074838909618, 4322.956770432318, 4328.069465064995, 4362.541933097011, 4371.693981421302, 4274.487061552633, 4298.785060746982, 4301.677374196947, 4319.352097185448, 4374.956250437519, 4593.104344652794, 4641.907161856778, 4756.334113224151, 4758.97681998372, 4765.046990601893, 5033.723145227011, 5058.140116180258, 5061.392632884041, 5069.898602027975, 5111.821086262, 5086.982603479282, 5087.414947281036, 5093.286939828427, 5137.255098010804, 5137.717425541594, 4676.976615116902, 4731.621470282369, 4780.521947805191, 4804.8318308859725, 4817.759112044384, 5216.191490318931, 5220.190870415092, 5224.50367215114, 5226.764795584208, 5231.973840130775, 4936.456989731127, 4989.80040798364, 5003.7998480061115, 5019.774110165052, 5050.015247026868, 5018.4981501849525, 5048.167052436307, 5066.442691303953, 5111.591072714174, 5118.692878427306, 5025.271335656309, 5033.823816166417, 5040.445550989388, 5043.067032598981, 5102.183650615958, 5004.674696144739, 5022.84931452057, 5031.547160755549, 5033.723145227048, 5098.1842905135, 4377.190219809346, 4400.405945197422, 4416.712913660602, 4459.241928872099, 4468.597826195658, 3760.5487341519192, 3765.1904840458883, 3781.4138808484727, 3808.542974842981, 3810.542734871833, 4276.294411422143, 4330.112326972963, 4335.6965012449455, 4337.891552711208, 4373.671974601918, 5067.214581739836, 5107.642465027487, 5142.51146141116, 5148.6910785353, 5156.948430515722, 4346.1090476452255, 4353.934690979638, 4353.956460435418, 4357.847475338348, 4385.0, 4534.206513860061, 4558.33904083906, 4594.931076033862, 4606.539346065367, 4636.235021221461, 4688.484266730657, 4738.549837765407, 4763.499832517536, 4798.47216806151, 4809.663323567317, 5086.694798312114, 5107.361579802525, 5110.48895110486, 5111.923321150111, 5173.508516690908, 4772.0455908817685, 4779.928301075417, 4804.0, 4828.034393121319, 4881.975590122027, 5005.274235235943, 5016.799328026838, 5020.573251273537, 5027.824026159067, 5082.034413461431, 5096.541311282002, 5098.974505127599, 5099.949000509948, 5104.872378190575, 5148.279240906201, 4872.14737420957, 4890.119778439915, 4921.188003979303, 4971.925421118758, 4981.526754958273, 4934.383202099738, 4956.8760780980765, 4958.801647934187, 4973.47778483254, 5002.974985125051, 4876.731779752147, 4896.877578060577, 4904.092742842586, 4908.6073114151495, 4930.901381972412, 4899.387576552931, 4924.9507504924495, 4965.0, 4993.325901003318, 5046.066477701637, 4857.295692124551, 4872.1717308057005, 4883.633727470383, 4904.043711476228, 4943.110240156806], "unit": "score", "name": "dojo.html", "value": 4668.923482002454}, {"lowerIsBetter": false, "replicates": [541.8943306055319, 549.2310764929099, 564.1368705880002, 570.9172170035348, 575.8071046199526, 27584.586231206522, 27975.86012069939, 34480.4827927581, 34964.77623283186, 35078.0, 37727.24545509088, 38124.80937595315, 38166.0, 38205.808970955106, 38245.42631860524, 7574.734884279065, 7827.099883513412, 7828.765137045898, 7830.765077047698, 7833.295003449688, 7643.312101910827, 7776.961115194416, 7783.494072885244, 7784.104827944774, 7790.571518566477, 7932.365410767154, 8034.437589368747, 8034.839303213932, 8038.678452861878, 8047.155048719888, 7923.2869041786225, 7978.680852765882, 7990.920090799075, 7996.4402491825595, 7997.400194985399, 7833.49082309648, 7945.761627151194, 7973.760787176394, 7980.0, 7985.96007019967, 37345.06637334061, 37674.24651506982, 37685.24629507394, 37727.622723772685, 37832.43251351232, 3197.7921435106646, 3330.633630300665, 3357.8992630221132, 3376.5441665375106, 3715.7956312402807, 28332.26977226483, 28574.285642858886, 28727.71272287271, 29188.854055729797, 29620.555691664642, 3442.4836274558766, 3459.9827000864834, 3472.94790578139, 3526.841292141834, 3647.598764135943, 231363.0, 231513.0, 231652.0, 232091.0, 232473.0, 41599.5440159599, 42391.57608423876, 52638.47361526412, 53133.46866531362, 53218.201726974126, 41636.0, 41673.0, 41803.372949405784, 41803.7909810449, 41890.37164442536, 12062.0, 12077.818832717516, 12114.878851211375, 12116.09129315305, 12139.332336721565, 10541.631042913461, 10587.84118238227, 10595.0, 10596.629117980834, 10598.25812193139, 14244.359003844851, 14760.778588321184, 14812.259387030605, 14828.62928426798, 14954.252287385805, 6040.879182416327, 6054.757809687651, 6069.666168360694, 6111.727044816654, 6162.5378096642935, 829.5064436660177, 925.8703781470599, 951.7192428233687, 1004.1765752083221, 1021.5249908792299, 27013.594796078076, 27170.320741981213, 27537.31156721098, 27551.31121721973, 27586.310342241606, 1002.6691191906654, 1006.5973610555836, 1035.9119474844722, 1058.5236643510298, 1063.8829728729834, 13946.651333716738, 14257.78613320801, 14289.857101428852, 14558.4904528341, 14577.781333280009, 301435.0, 306501.0, 306624.0, 306904.0, 307431.0, 47356.526434735904, 47762.76118619385, 47869.0, 47933.76033119812, 48100.27849582189, 1055.155875299757, 1158.3108050709814, 1256.591607727474, 1271.167385362589, 1369.5069774881035, 24737.628935565623, 25350.50440861081, 25359.239222823344, 25753.227403177934, 25768.742312576633, 37660.811695941346, 37899.621003790715, 38001.80999094987, 38009.80995095007, 38014.42978355272, 199876.0, 200417.0, 201057.0, 201319.0, 202556.0, 27264.318392040357, 31388.843055785488, 31824.204394890312, 32242.35515289634, 32358.514622281156, 34739.652603473645, 35112.12219694528, 35254.64745352514, 43768.34347484854, 45003.77498112489, 30945.8452707735, 31991.84004079965, 32058.35883282368, 32409.513857291688, 32681.673183267863, 33546.832265838515, 34852.30295394129, 35005.0, 35217.47173792446, 35336.11659708528, 31868.521972169972, 35142.29715405728, 36847.63152368442, 37857.81071094627, 37873.05317367088, 28266.0, 31389.529157062207, 31508.212294692818, 31515.52726709147, 31573.8421307892, 24271.150509732073, 24583.631245531687, 24682.259532214062, 25035.621615946457, 25059.624105638795], "unit": "score", "name": "ext.html", "value": 16527.943919454796}, {"lowerIsBetter": false, "replicates": [346.5755743892602, 352.6015602369323, 360.05485600299215, 361.23418353091444, 365.4499977533811, 15387.846121538782, 15794.526164215078, 17119.14404279784, 17368.47894563162, 17438.651226975453, 16165.515034548953, 16526.917365413155, 16730.83269167308, 16736.66526669469, 16741.83258167421, 4852.320675105497, 4965.975170124162, 4973.602111831045, 5012.3483947086825, 5035.496450354954, 5006.699598024112, 5017.573506251973, 5026.346574945271, 5027.195648696209, 5029.446760856303, 5014.2227954666905, 5015.3730783652045, 5016.172331565287, 5066.36670416198, 5336.866578335554, 5610.971945140269, 5620.156976453564, 5638.577106716972, 5653.773849046054, 5654.37801841797, 4975.179095449246, 5038.748062596892, 5038.949610503884, 5051.343325367716, 5051.772670229849, 11884.286942783461, 12048.698782530419, 12216.20594661353, 12223.205491643015, 12232.877671223263, 1987.701844723303, 2007.3877467372445, 2082.854200205986, 2219.345293138528, 2393.4495066134714, 8747.737567872973, 9199.540022998823, 9288.721338359792, 9362.578683959238, 9503.477308748015, 1743.111013383171, 1767.9734803977951, 1776.7779027621548, 1808.2766893242808, 1811.4384540792264, 58420.0, 59866.40133598652, 61541.38458615401, 64080.679596601716, 64425.67787161034, 9905.108540231413, 9968.152707019985, 10151.593936242616, 10233.692989210336, 10330.328528645614, 13064.477420903057, 13136.146150500186, 13154.60536183916, 13170.802437963439, 13183.802242966363, 7117.217106118323, 7158.675645005691, 7246.384057355079, 7267.345938865527, 7358.705651773869, 7082.468814838908, 7136.393406560397, 7142.928570714226, 7220.891686624705, 7259.165196002422, 4352.847650332286, 4361.956380436219, 4426.225410553205, 4437.689361744647, 4485.551444855553, 1744.8167942366122, 1806.6296409236074, 1820.8270214329618, 1822.1435925115175, 1839.7884243311923, 407.7573843563075, 415.53460124660575, 440.62326710662563, 862.0818827948215, 873.1530415497085, 10161.593536258615, 10211.7447063824, 10358.641169495126, 10440.060394564525, 10683.465826708634, 426.7751553042787, 439.77131891416286, 889.1863944490848, 895.0691281067617, 942.4816351006918, 8661.696840610675, 8895.021547629756, 9044.592993315317, 9293.860592091123, 9885.851712224323, 391190.0, 394436.0, 411981.0, 419769.0, 420045.0, 41676.79161604172, 48549.51450485521, 54225.72887135539, 71040.2895971044, 72814.63592682003, 933.4399360383716, 940.5297351324338, 951.9619215231452, 962.5957098018849, 964.71058682395, 14793.334299956312, 15020.624484387541, 15021.399144034553, 15129.319180637118, 15531.301091450687, 32626.83686581552, 32718.67281327156, 32782.18044548905, 33087.50368744519, 33487.49768753519, 44252.11495770131, 46613.53386466228, 46894.29658555056, 47145.528544714114, 47624.761876190394, 7173.928260717326, 7285.235050319852, 7591.810204744926, 7699.730509432143, 7714.652840622298, 11289.548418063185, 11405.771884562097, 11427.200095993534, 11516.30902145874, 11565.768684626428, 10121.443320617436, 10178.440185789557, 10202.18382529381, 10324.174066074846, 10367.688969330931, 10098.242631802792, 10219.489025548544, 10266.897331026594, 10298.3820970742, 10423.68728938133, 9869.161121304482, 10004.349717268355, 10266.230032747424, 10441.738956526147, 10511.316764410289, 7104.893426598708, 7412.851742965003, 7441.479096463196, 7613.124490683642, 7758.92241077582, 7386.0, 9082.86464191976, 9506.239500840054, 9610.135087842127, 9652.565634546321], "unit": "score", "name": "jquery.html", "value": 7659.12512614019}, {"lowerIsBetter": false, "replicates": [1242.6831158054695, 1430.4635761589402, 1446.4286606790315, 1587.71421144194, 1784.5538615346163, 6784.694688739006, 7246.891296630548, 7422.7030918763185, 7446.441516886228, 7446.702131914717, 7383.926160738391, 7553.20691327411, 7554.320111189992, 7560.4707670463085, 7576.242375762421, 1929.556202073524, 1974.891380974046, 2154.9353519394363, 2274.192661605131, 2295.4490922178725, 2242.8990695418747, 2252.6733623624564, 2253.4141123307895, 2253.9323820285417, 2254.425121593991, 2187.8687278763327, 2214.1475531920164, 2219.644856822909, 2258.8644681319092, 2262.061244583496, 2151.0, 2157.2341818654468, 2158.57907707997, 2161.103142195987, 2163.1131236193164, 2214.0590249144047, 2236.0, 2241.887905604713, 2244.427670943915, 2248.7076680031655, 7772.106207786064, 7895.842083158362, 7897.5656338901335, 7902.091259505116, 7905.802354941115, 4644.326572646947, 4738.0, 4773.5226477352335, 4776.880577985544, 4780.1873681474235, 3023.6522799878076, 3031.6058912341255, 3183.0769076967654, 3189.2345836999184, 3198.552202691625, 1010.2372708604956, 1022.8210063238903, 1809.746635471035, 1839.1356062650532, 1869.401791426744, 10368.948155259252, 10390.896091039069, 10462.63380781669, 10485.9475702621, 10503.0, 3988.561258261589, 4101.384792281182, 4164.083901541656, 4167.249895018926, 4180.686448516373, 8638.870416943751, 8695.08701586337, 8702.173293537104, 8704.173103555153, 8709.346798990102, 4637.721736695809, 4648.767561621973, 4658.161530924398, 4664.137134630037, 4669.509701481364, 3629.7822130672243, 4064.451299074587, 4205.285101532747, 4206.726562773471, 4272.273713468718, 3451.0854623524788, 3485.686288234071, 3525.383057964846, 3550.431930891045, 3551.627079156703, 960.4477425480237, 963.0898800633474, 972.9951350243203, 1039.3504059962524, 1056.7041228456044, 980.9460479673686, 1019.5208252121491, 1167.1188252869028, 1224.1920332580632, 1227.1348699167065, 7096.325849044332, 7162.2837716229005, 7199.388052015533, 7215.098112735908, 7241.637918104074, 1011.4133802394593, 1013.9036791504795, 1030.850526673628, 1068.5725709716176, 1069.850220969065, 5472.179173123984, 5473.67157970523, 5534.52956498694, 5553.500184983371, 5557.749901254372, 9051.0, 9359.532023398802, 9587.712368628952, 9589.712308630613, 9674.661386851567, 9444.622215111318, 9605.567749451291, 9605.759856003655, 9635.903640963641, 9701.854472182922, 7046.859062818715, 7146.678399472036, 7158.463115266271, 7191.424686025105, 7208.71165153388, 6950.965245173742, 6973.267806880204, 6976.5465244758925, 6978.79063628092, 6990.09128813251, 8074.905769499111, 8320.126386729306, 8413.098989054515, 8509.0, 8540.316774657887, 8635.093315201813, 8635.82728345417, 8637.524936128573, 8772.561371931506, 8779.034306226182, 5740.540756739534, 5912.46787789101, 6113.419225173601, 6327.418145463634, 6542.411182993554, 7273.127224733066, 7293.562386256842, 7298.379637730853, 7307.926920730937, 7324.340809327186, 6344.0, 6511.186101737283, 6537.8692426152165, 6552.705128269335, 6576.638284894186, 6400.42396184327, 6415.390537898892, 6469.967650161907, 6527.836804079746, 6554.967225164034, 6721.731130754715, 6754.2570317266045, 6785.117934668461, 6799.5920244785475, 6799.796006119825, 6285.77686188999, 6311.495080393465, 6460.838479037873, 6492.285848556749, 6505.024246363083, 6450.967745161244, 6501.8699626008165, 6523.445507131947, 6540.50946179048, 6545.312742162005], "unit": "score", "name": "mootools.html", "value": 4403.815570129934}, {"lowerIsBetter": false, "replicates": [315.94313023655747, 318.3537419039351, 319.0396905315001, 324.09577279390504, 325.01682410707605, 5277.393099793525, 5456.6453180543285, 5460.989716902376, 5469.589780766439, 5474.589405794562, 5282.683039017652, 5360.892782144365, 5367.0, 5369.24830523727, 5378.0, 3912.9413058804, 4052.9189416211657, 4142.647874930634, 4150.792460376984, 4162.313218318981, 4144.067584793413, 4146.834126634946, 4150.43969064177, 4154.376843473488, 4158.688098392618, 4101.569335219804, 4102.3026085565525, 4108.52751933527, 4108.85619003335, 4112.835486580548, 3866.130120722843, 3990.9201815963806, 4074.8981275468054, 4077.5106987161435, 4082.3468245080644, 3581.856725730968, 3593.047842321787, 3595.6044835068383, 3600.369935261319, 3605.819709014565, 5153.252778347119, 5167.044096842096, 5173.120569503193, 5177.922331165036, 5186.7147306898105, 4738.289256611536, 4738.763061846894, 4744.3595114659765, 4746.715197088186, 4749.050189961987, 5614.27014488118, 5624.775008999676, 5625.6905870177125, 5627.80302689408, 5630.493255606974, 3952.505936757905, 3959.109200429909, 3960.32674445345, 3960.960390396088, 3962.0689138052535, 5699.971500142514, 5937.554683398763, 5944.940550594482, 5945.851353716149, 5947.256592925884, 3986.8604598839484, 4049.028233224005, 4052.0, 4052.1085361220485, 4059.4519739834745, 4118.855840045584, 4120.505539335239, 4121.196366708463, 4123.546409894909, 4127.442795222607, 4716.339712440261, 4718.504557021532, 4721.0, 4737.194676904935, 4743.217369134123, 5642.802501912495, 5647.887042259214, 5656.745446454919, 5663.546916246691, 5670.234518340054, 1425.3942074618246, 1448.8551144885428, 1450.4923276853017, 1451.6661167931436, 1451.7822326650876, 882.5940067568862, 947.0671388682142, 956.583886009588, 970.4904924914476, 985.2118305355687, 4903.975480122576, 4919.286703428054, 4929.975350123226, 4934.1611925972675, 4935.358403407534, 5804.332501762267, 5826.82519524415, 5835.095560188178, 5870.26621672291, 5877.265341832271, 4905.0189962007025, 4923.556879880828, 4928.581070608967, 4929.901401971941, 4934.7285899275885, 3093.1648454917045, 3131.6242050953574, 3133.248020475115, 3133.8903138390046, 3137.905862824119, 5409.350877894678, 5434.891302174014, 5446.319210098738, 5451.046066938349, 5463.2078348639225, 5748.827535173951, 5908.291005079418, 5934.673592952429, 5938.28740551128, 5949.762009519571, 5399.379071406838, 5414.458554144554, 5429.294191755047, 5440.374356948843, 5447.019536483471, 5739.62692424991, 5782.2483077199695, 5801.970990145022, 5803.65178089316, 5807.62250453736, 5673.8865222694485, 5687.033204355187, 5689.402612725769, 5693.345265294544, 5695.544356451391, 5417.0, 5430.185472179205, 5430.782768689208, 5438.592105592175, 5440.347158341025, 3924.8233829478313, 4034.1326614777963, 4042.4946881639794, 4055.4322394864153, 4056.513218413809, 5740.995325817881, 5767.423257674367, 5773.16289138081, 5783.479486846204, 5788.0739081746715, 5519.530839878495, 5521.3926468087675, 5521.4478552144465, 5528.364238112668, 5548.306461692288, 5508.889822203613, 5526.889462210653, 5531.474509921551, 5536.169574563686, 5594.104943209067, 5492.80775172867, 5506.091494903456, 5507.504324610804, 5513.751881165437, 5513.862153446196, 5533.6403133796175, 5731.19763233156, 5745.597808153389, 5749.54003679713, 5754.3382511010095, 5564.638298510584, 5588.552915766648, 5597.964376590344, 5600.495955363874, 5604.439556044526], "unit": "score", "name": "prototype.html", "value": 4217.511539945526}, {"lowerIsBetter": false, "replicates": [713.3757961783436, 730.3645828129528, 747.9177290498046, 761.8780995040795, 778.338412349503, 11835.940820295897, 11978.940105299462, 11995.400229988509, 12019.399030048484, 12364.196327238724, 11853.525858965631, 11866.347350895698, 11899.52401903925, 11998.820017699742, 12011.7597648047, 634.0900807341479, 786.9685212591489, 792.8057625881667, 803.7709252862935, 808.870580707087, 799.4483806173722, 799.7001124578284, 799.7880561651167, 799.9160088190744, 803.8553060449117, 852.8294341131767, 855.4696088425154, 856.6787454704486, 856.7986523167051, 856.8157846063095, 681.8568100698859, 690.5683947532792, 839.5382539603255, 844.02515095065, 857.6740838481337, 625.5371025441186, 628.4783629587478, 628.8459327464755, 629.326620516048, 629.4618101523178, 12226.266424014588, 12317.815232771516, 12388.31864247466, 12389.318587477685, 12392.56626018085, 12129.332886691229, 12351.876481235162, 12497.625071247878, 12643.114981951267, 12658.81011784824, 10175.898241017643, 10207.591696332138, 10322.071013608811, 10347.379157250589, 10351.896481035168, 3343.063942096217, 3379.9662003380145, 3416.829158542063, 3428.434308339121, 3505.404081306159, 44200.77899610514, 44258.77870610626, 44345.0, 44389.33415998763, 44622.77688611536, 10101.220601369485, 10107.545160467796, 10109.545070471846, 10186.337888037402, 10474.73813154662, 18105.366312179012, 18233.635327293647, 18270.908645456955, 18280.360187393377, 18289.0, 6825.48808839339, 6923.0, 6992.370686638227, 6999.405050570758, 7067.858642827115, 3804.2581696569455, 3888.0474283800086, 3901.5708272090046, 3927.7446965947124, 3967.80160991955, 2994.2215024093457, 2997.8950736724546, 3001.2046807596003, 3023.56158357037, 3026.7881248312406, 538.8706710389479, 549.6454786662661, 554.0304467182431, 555.5583311267552, 561.0322194214947, 465.20914445442884, 518.8910328830988, 557.1976354050155, 584.4155844155844, 614.7602435050334, 7515.436342274351, 7780.18308077655, 7852.411069169721, 7860.724874629361, 7877.094134174643, 531.6889619572594, 634.7429291137005, 637.7098420218789, 641.1568787045114, 641.2945759664332, 3516.5252690886914, 3597.334493118781, 3723.8696645617274, 3804.2801885712693, 3858.8649397271524, 48894.266586001235, 49102.5089749098, 49201.26198107031, 55760.442395576334, 55895.0, 47841.0, 48191.0, 48704.0, 49365.75317123391, 49499.25751113664, 43561.34657980133, 43688.0, 43897.12205755867, 43977.56022439799, 44483.55516444794, 7142.321479459443, 7182.138143422822, 7204.71181152748, 7306.342429181399, 7369.705211791468, 32603.510947336283, 33885.66114338825, 34085.48871766975, 34386.14034649054, 34635.0, 39869.60130398659, 42271.365929510466, 42991.1401771969, 43479.565204348815, 43484.34773478337, 8474.703385381483, 8602.440841345293, 8834.558272086499, 8966.775830604287, 8968.148025937526, 10227.48862556884, 10265.076143147153, 10268.58925642966, 10638.52126654287, 10640.787184256425, 8448.788780280542, 8712.722913232328, 10042.0, 10365.33391480165, 10422.270441069053, 9886.307958443127, 10067.74830629211, 10075.944058038847, 10119.494025298853, 10234.771827380762, 9609.636404193454, 9895.851562226717, 9965.40207587547, 10142.239332049978, 10430.73923151897, 8897.777555561162, 8996.457384418352, 9196.641070546404, 9268.119528644767, 9443.386179898285, 8960.354976364848, 9103.36276460668, 9381.174936415242, 9389.108034736963, 9601.759956001157], "unit": "score", "name": "yui.html", "value": 5871.42470507269}], "name": "dromaeo_css", "value": 6332.092924017787}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 111.0, 111.0, 111.0, 100.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [151.0, 129.0, 157.0, 173.0, 130.0, 153.0, 158.0, 130.0, 177.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 162.0, 160.0, 161.0, 165.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 96.0, 92.0, 76.0, 73.0, 76.0, 103.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 132.0, 93.0, 95.0, 94.0, 141.0, 94.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 67.0, 66.0, 66.0, 77.0, 65.0, 75.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 67.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [90.0, 83.0, 83.0, 85.0, 83.0, 82.0, 83.0, 81.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [115.0, 119.0, 116.0, 122.0, 120.0, 114.0, 124.0, 121.0, 119.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [140.0, 129.0, 140.0, 139.0, 139.0, 128.0, 139.0, 142.0, 138.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.4}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 68.0, 65.0, 67.0, 66.0, 70.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1507.8000000000002}]} 09:32:11 INFO - Return code: 0 09:32:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:32:12 ERROR - # TBPL SUCCESS # 09:32:12 INFO - Running post-action listener: _resource_record_post_action 09:32:12 INFO - Running post-run listener: _resource_record_post_run 09:32:13 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462467072; Read time: 12; Write time: 470016 09:32:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 102387712; Read time: 0; Write time: 112896 09:32:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287248384; Read time: 12; Write time: 220372 09:32:13 INFO - Running post-run listener: _upload_blobber_files 09:32:13 INFO - Blob upload gear active. 09:32:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:32:13 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 09:32:13 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'] 09:32:13 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 09:32:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:32:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:32:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:32:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:14 INFO - (blobuploader) - INFO - Done attempting. 09:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:32:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:15 INFO - (blobuploader) - INFO - Done attempting. 09:32:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:32:15 INFO - Return code: 0 09:32:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:32:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:32:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d21a1f1be95e41f8703d1a25087408a2b4fe99b778f0388922567d86081c9966ff215fa849c27e9fa7f143648dda056cd4e65d8d5de3783c48b04eb87bb2ae0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf6637de347dedf55f2f523f9334491210337685bec098aee88dc2881dcd13d3af86241d1e030bfcb11053293a9da5fb1e0a0d88b16082932e41e639532e404b"} 09:32:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:32:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:32:15 INFO - Contents: 09:32:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d21a1f1be95e41f8703d1a25087408a2b4fe99b778f0388922567d86081c9966ff215fa849c27e9fa7f143648dda056cd4e65d8d5de3783c48b04eb87bb2ae0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf6637de347dedf55f2f523f9334491210337685bec098aee88dc2881dcd13d3af86241d1e030bfcb11053293a9da5fb1e0a0d88b16082932e41e639532e404b"} 09:32:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:32:15 INFO - Copying logs to upload dir... 09:32:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:32:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.672696 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-18 09:32:14.942311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:32:14.946044) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d21a1f1be95e41f8703d1a25087408a2b4fe99b778f0388922567d86081c9966ff215fa849c27e9fa7f143648dda056cd4e65d8d5de3783c48b04eb87bb2ae0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf6637de347dedf55f2f523f9334491210337685bec098aee88dc2881dcd13d3af86241d1e030bfcb11053293a9da5fb1e0a0d88b16082932e41e639532e404b"} build_url:https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/HSVDjI0YSYOkynp32OXF_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d21a1f1be95e41f8703d1a25087408a2b4fe99b778f0388922567d86081c9966ff215fa849c27e9fa7f143648dda056cd4e65d8d5de3783c48b04eb87bb2ae0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf6637de347dedf55f2f523f9334491210337685bec098aee88dc2881dcd13d3af86241d1e030bfcb11053293a9da5fb1e0a0d88b16082932e41e639532e404b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:32:14.972263) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:32:14.972552) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458316655.492942-308867621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:32:15.059038) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:32:15.059332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:32:15.059619) ========= ========= Total master_lag: 0.30 =========