builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1457025951.44 results: success (0) buildid: 20160301053641 builduid: 4ed4d0b337e24c078facd395c588a4a4 revision: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.440714) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.441112) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.441419) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006327 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.482555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.482848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.505317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.505876) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.558543) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.558825) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.559169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.559481) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 09:25:51-- 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% 90.2M=0s 2016-03-03 09:25:51 (90.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.670806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.671098) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.720701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 09:25:51.721035) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a4929411c0aa3ec6b727e2bc2fc050c8199c6573 --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 a4929411c0aa3ec6b727e2bc2fc050c8199c6573 --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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 09:25:51,895 truncating revision to first 12 chars 2016-03-03 09:25:51,895 Setting DEBUG logging. 2016-03-03 09:25:51,895 attempt 1/10 2016-03-03 09:25:51,895 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a4929411c0aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 09:25:52,961 unpacking tar archive at: mozilla-central-a4929411c0aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.398706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 09:25:53.132572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:53.132929) ========= echo a4929411c0aa3ec6b727e2bc2fc050c8199c6573 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a4929411c0aa3ec6b727e2bc2fc050c8199c6573'] 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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a4929411c0aa3ec6b727e2bc2fc050c8199c6573 program finished with exit code 0 elapsedTime=0.004735 script_repo_revision: 'a4929411c0aa3ec6b727e2bc2fc050c8199c6573' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:53.183988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:53.184360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:53.194612) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-03 09:25:53.194956) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:25:53 INFO - MultiFileLogger online at 20160303 09:25:53 in /builds/slave/test 09:25:53 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:25:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:25:53 INFO - {'append_to_log': False, 09:25:53 INFO - 'base_work_dir': '/builds/slave/test', 09:25:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:25:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:25:53 INFO - 'branch': 'Firefox-Non-PGO', 09:25:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:25:53 INFO - 'config_files': ('talos/linux_config.py',), 09:25:53 INFO - 'default_actions': ('clobber', 09:25:53 INFO - 'read-buildbot-config', 09:25:53 INFO - 'download-and-extract', 09:25:53 INFO - 'populate-webroot', 09:25:53 INFO - 'create-virtualenv', 09:25:53 INFO - 'install', 09:25:53 INFO - 'run-tests'), 09:25:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:25:53 INFO - 'download_minidump_stackwalk': True, 09:25:53 INFO - 'download_symbols': 'ondemand', 09:25:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:25:53 INFO - 'tooltool.py': '/tools/tooltool.py', 09:25:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:25:53 INFO - '/tools/misc-python/virtualenv.py')}, 09:25:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:25:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:25:53 INFO - 'installer_path': 'installer.exe', 09:25:53 INFO - 'log_level': 'info', 09:25:53 INFO - 'log_name': 'talos', 09:25:53 INFO - 'log_to_console': True, 09:25:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:25:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:25:53 INFO - 'opt_config_files': (), 09:25:53 INFO - 'pip_index': False, 09:25:53 INFO - 'sps_profile': False, 09:25:53 INFO - 'sps_profile_interval': 0, 09:25:53 INFO - 'suite': 'dromaeojs', 09:25:53 INFO - 'system_bits': '32', 09:25:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:25:53 INFO - 'title': 'talos-linux64-ix-068', 09:25:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:25:53 INFO - 'use_talos_json': True, 09:25:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:25:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:25:53 INFO - 'work_dir': 'build'} 09:25:53 INFO - ##### 09:25:53 INFO - ##### Running clobber step. 09:25:53 INFO - ##### 09:25:53 INFO - Running pre-action listener: _resource_record_pre_action 09:25:53 INFO - Running main action method: clobber 09:25:53 INFO - rmtree: /builds/slave/test/build 09:25:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:25:54 INFO - Running post-action listener: _resource_record_post_action 09:25:54 INFO - ##### 09:25:54 INFO - ##### Running read-buildbot-config step. 09:25:54 INFO - ##### 09:25:54 INFO - Running pre-action listener: _resource_record_pre_action 09:25:54 INFO - Running main action method: read_buildbot_config 09:25:54 INFO - Using buildbot properties: 09:25:54 INFO - { 09:25:54 INFO - "project": "", 09:25:54 INFO - "product": "firefox", 09:25:54 INFO - "script_repo_revision": "production", 09:25:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:25:54 INFO - "repository": "", 09:25:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:25:54 INFO - "buildid": "20160301053641", 09:25:54 INFO - "pgo_build": "False", 09:25:54 INFO - "basedir": "/builds/slave/test", 09:25:54 INFO - "buildnumber": 15, 09:25:54 INFO - "slavename": "talos-linux64-ix-068", 09:25:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:25:54 INFO - "platform": "ubuntu64_hw", 09:25:54 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:25:54 INFO - "branch": "mozilla-central", 09:25:54 INFO - "repo_path": "mozilla-central", 09:25:54 INFO - "revision": "a4929411c0aa3ec6b727e2bc2fc050c8199c6573", 09:25:54 INFO - "stage_platform": "linux64", 09:25:54 INFO - "builduid": "4ed4d0b337e24c078facd395c588a4a4", 09:25:54 INFO - "slavebuilddir": "test" 09:25:54 INFO - } 09:25:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:25:54 INFO - Running post-action listener: _resource_record_post_action 09:25:54 INFO - ##### 09:25:54 INFO - ##### Running download-and-extract step. 09:25:54 INFO - ##### 09:25:54 INFO - Running pre-action listener: _resource_record_pre_action 09:25:54 INFO - Running main action method: download_and_extract 09:25:54 INFO - mkdir: /builds/slave/test/build/tests 09:25: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:25:54 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:25:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:25:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:25:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:25:56 INFO - Downloaded 1448 bytes. 09:25:56 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:25:56 INFO - Using the following test package requirements: 09:25:56 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:56 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:56 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:25:56 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:56 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:25:56 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:56 INFO - u'jsshell-linux-x86_64.zip'], 09:25:56 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:56 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:25:56 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:56 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:56 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:25:56 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:56 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:25:56 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:56 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:25:56 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:56 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:56 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:25:56 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:25:56 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:25:56 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:25:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:25:57 INFO - Downloaded 22077766 bytes. 09:25:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:25:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:25:58 INFO - Return code: 0 09:25:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:58 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:25:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:26:03 INFO - Downloaded 22077766 bytes. 09:26:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:26:04 INFO - Return code: 0 09:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:04 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:26:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:26:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:26:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:26:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:26:06 INFO - Downloaded 10713413 bytes. 09:26:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:26:06 INFO - Return code: 0 09:26: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:26:06 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:26:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:26:07 INFO - Downloaded 54835652 bytes. 09:26:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:07 INFO - mkdir: /builds/slave/test/properties 09:26:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:26:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:26:07 INFO - Contents: 09:26:07 INFO - build_url:https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:08 INFO - Running post-action listener: _resource_record_post_action 09:26:08 INFO - Running post-action listener: set_extra_try_arguments 09:26:08 INFO - ##### 09:26:08 INFO - ##### Running populate-webroot step. 09:26:08 INFO - ##### 09:26:08 INFO - Running pre-action listener: _resource_record_pre_action 09:26:08 INFO - Running main action method: populate_webroot 09:26:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:26:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:26:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:26:08 INFO - '--tppagecycles', 09:26:08 INFO - '7'], 09:26:08 INFO - 'tests': ['tsvgm']}}, 09:26:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:26:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:26:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:26:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:26:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:08 INFO - 'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:08 INFO - 'tests': ['damp', 'tps']}, 09:26:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:08 INFO - 'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['damp', 'tps']}, 09:26:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:26:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:26:08 INFO - 'other': {'tests': ['a11yr', 09:26:08 INFO - 'ts_paint', 09:26:08 INFO - 'tpaint', 09:26:08 INFO - 'sessionrestore', 09:26:08 INFO - 'sessionrestore_no_auto_restore']}, 09:26:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['a11yr', 09:26:08 INFO - 'ts_paint', 09:26:08 INFO - 'tpaint', 09:26:08 INFO - 'sessionrestore', 09:26:08 INFO - 'sessionrestore_no_auto_restore']}, 09:26:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['a11yr', 09:26:08 INFO - 'ts_paint', 09:26:08 INFO - 'tpaint', 09:26:08 INFO - 'sessionrestore', 09:26:08 INFO - 'sessionrestore_no_auto_restore']}, 09:26:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['a11yr', 09:26:08 INFO - 'ts_paint', 09:26:08 INFO - 'tpaint', 09:26:08 INFO - 'sessionrestore', 09:26:08 INFO - 'sessionrestore_no_auto_restore']}, 09:26:08 INFO - 'other_l64': {'tests': ['a11yr', 09:26:08 INFO - 'ts_paint', 09:26:08 INFO - 'tpaint', 09:26:08 INFO - 'sessionrestore', 09:26:08 INFO - 'sessionrestore_no_auto_restore']}, 09:26:08 INFO - 'other_nol64': {'tests': ['a11yr', 09:26:08 INFO - 'ts_paint', 09:26:08 INFO - 'tpaint', 09:26:08 INFO - 'sessionrestore', 09:26:08 INFO - 'sessionrestore_no_auto_restore']}, 09:26:08 INFO - 'svgr': {'tests': ['tsvgx', 09:26:08 INFO - 'tsvgr_opacity', 09:26:08 INFO - 'tart', 09:26:08 INFO - 'tscrollx', 09:26:08 INFO - 'cart']}, 09:26:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['tsvgx', 09:26:08 INFO - 'tsvgr_opacity', 09:26:08 INFO - 'tart', 09:26:08 INFO - 'tscrollx', 09:26:08 INFO - 'cart']}, 09:26:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:08 INFO - 'tests': ['tp5o']}, 09:26:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:08 INFO - 'talos_options': ['--e10s'], 09:26:08 INFO - 'tests': ['tp5o']}, 09:26:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:08 INFO - 'talos_options': ['--xperf_path', 09:26:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:08 INFO - 'tests': ['tp5n']}, 09:26:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:08 INFO - 'talos_options': ['--e10s', 09:26:08 INFO - '--xperf_path', 09:26:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:08 INFO - 'tests': ['tp5n']}}, 09:26:08 INFO - 'talos.zip': {'path': '', 09:26:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:26:08 INFO - Running post-action listener: _resource_record_post_action 09:26:08 INFO - ##### 09:26:08 INFO - ##### Running create-virtualenv step. 09:26:08 INFO - ##### 09:26:08 INFO - Running pre-action listener: _resource_record_pre_action 09:26:08 INFO - Running main action method: create_virtualenv 09:26:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:26:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:26:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:26:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:26:08 INFO - Using real prefix '/usr' 09:26:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:26:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:26:11 INFO - Installing pip.................done. 09:26:11 INFO - Return code: 0 09:26:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:26:11 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:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:11 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:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:11 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 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:11 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:26:11 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:26:11 INFO - Using env: {'DISPLAY': ':0', 09:26:11 INFO - 'HOME': '/home/cltbld', 09:26:11 INFO - 'LANG': 'en_US.UTF-8', 09:26:11 INFO - 'LANGUAGE': 'en_US:en', 09:26:11 INFO - 'LOGNAME': 'cltbld', 09:26:11 INFO - 'MAIL': '/var/mail/cltbld', 09:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:11 INFO - 'MOZ_NO_REMOTE': '1', 09:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:11 INFO - 'NO_EM_RESTART': '1', 09:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:11 INFO - 'PWD': '/builds/slave/test', 09:26:11 INFO - 'SHELL': '/bin/bash', 09:26:11 INFO - 'SHLVL': '1', 09:26:11 INFO - 'TERM': 'linux', 09:26:11 INFO - 'TMOUT': '86400', 09:26:11 INFO - 'USER': 'cltbld', 09:26:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:11 INFO - '_': '/tools/buildbot/bin/python'} 09:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:11 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:26:11 INFO - Cleaning up... 09:26:11 INFO - Return code: 0 09:26:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:26:11 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:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:11 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:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:11 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 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:11 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:26:11 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:26:11 INFO - Using env: {'DISPLAY': ':0', 09:26:11 INFO - 'HOME': '/home/cltbld', 09:26:11 INFO - 'LANG': 'en_US.UTF-8', 09:26:11 INFO - 'LANGUAGE': 'en_US:en', 09:26:11 INFO - 'LOGNAME': 'cltbld', 09:26:11 INFO - 'MAIL': '/var/mail/cltbld', 09:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:11 INFO - 'MOZ_NO_REMOTE': '1', 09:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:11 INFO - 'NO_EM_RESTART': '1', 09:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:11 INFO - 'PWD': '/builds/slave/test', 09:26:11 INFO - 'SHELL': '/bin/bash', 09:26:11 INFO - 'SHLVL': '1', 09:26:11 INFO - 'TERM': 'linux', 09:26:11 INFO - 'TMOUT': '86400', 09:26:11 INFO - 'USER': 'cltbld', 09:26:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:11 INFO - '_': '/tools/buildbot/bin/python'} 09:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:11 INFO - Downloading/unpacking psutil>=0.7.1 09:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:26:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:13 INFO - Installing collected packages: psutil 09:26:13 INFO - Running setup.py install for psutil 09:26:13 INFO - building 'psutil._psutil_linux' extension 09:26:13 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:26:13 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:26:13 INFO - building 'psutil._psutil_posix' extension 09:26:13 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:26:13 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:26:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:13 INFO - Successfully installed psutil 09:26:13 INFO - Cleaning up... 09:26:14 INFO - Return code: 0 09:26:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:26:14 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:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:14 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:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:14 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 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:14 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:26:14 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:26:14 INFO - Using env: {'DISPLAY': ':0', 09:26:14 INFO - 'HOME': '/home/cltbld', 09:26:14 INFO - 'LANG': 'en_US.UTF-8', 09:26:14 INFO - 'LANGUAGE': 'en_US:en', 09:26:14 INFO - 'LOGNAME': 'cltbld', 09:26:14 INFO - 'MAIL': '/var/mail/cltbld', 09:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:14 INFO - 'MOZ_NO_REMOTE': '1', 09:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:14 INFO - 'NO_EM_RESTART': '1', 09:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:14 INFO - 'PWD': '/builds/slave/test', 09:26:14 INFO - 'SHELL': '/bin/bash', 09:26:14 INFO - 'SHLVL': '1', 09:26:14 INFO - 'TERM': 'linux', 09:26:14 INFO - 'TMOUT': '86400', 09:26:14 INFO - 'USER': 'cltbld', 09:26:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:14 INFO - '_': '/tools/buildbot/bin/python'} 09:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:26: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:26: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:26: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:26: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:26: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:26: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:26:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:26:16 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:26:16 INFO - Installing collected packages: mozsystemmonitor 09:26:16 INFO - Running setup.py install for mozsystemmonitor 09:26:16 INFO - Successfully installed mozsystemmonitor 09:26:16 INFO - Cleaning up... 09:26:16 INFO - Return code: 0 09:26:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:26:16 INFO - Using env: {'DISPLAY': ':0', 09:26:16 INFO - 'HOME': '/home/cltbld', 09:26:16 INFO - 'LANG': 'en_US.UTF-8', 09:26:16 INFO - 'LANGUAGE': 'en_US:en', 09:26:16 INFO - 'LOGNAME': 'cltbld', 09:26:16 INFO - 'MAIL': '/var/mail/cltbld', 09:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:16 INFO - 'MOZ_NO_REMOTE': '1', 09:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:16 INFO - 'NO_EM_RESTART': '1', 09:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:16 INFO - 'PWD': '/builds/slave/test', 09:26:16 INFO - 'SHELL': '/bin/bash', 09:26:16 INFO - 'SHLVL': '1', 09:26:16 INFO - 'TERM': 'linux', 09:26:16 INFO - 'TMOUT': '86400', 09:26:16 INFO - 'USER': 'cltbld', 09:26:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:16 INFO - '_': '/tools/buildbot/bin/python'} 09:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:16 INFO - Downloading/unpacking blobuploader==1.2.4 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:18 INFO - Downloading blobuploader-1.2.4.tar.gz 09:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:26:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:26:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:18 INFO - Downloading docopt-0.6.1.tar.gz 09:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:26:19 INFO - Installing collected packages: blobuploader, requests, docopt 09:26:19 INFO - Running setup.py install for blobuploader 09:26:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:26:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:26:19 INFO - Running setup.py install for requests 09:26:19 INFO - Running setup.py install for docopt 09:26:19 INFO - Successfully installed blobuploader requests docopt 09:26:19 INFO - Cleaning up... 09:26:19 INFO - Return code: 0 09:26:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:19 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:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:19 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:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:19 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 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:19 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:26:19 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:26:19 INFO - Using env: {'DISPLAY': ':0', 09:26:19 INFO - 'HOME': '/home/cltbld', 09:26:19 INFO - 'LANG': 'en_US.UTF-8', 09:26:19 INFO - 'LANGUAGE': 'en_US:en', 09:26:19 INFO - 'LOGNAME': 'cltbld', 09:26:19 INFO - 'MAIL': '/var/mail/cltbld', 09:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:19 INFO - 'MOZ_NO_REMOTE': '1', 09:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:19 INFO - 'NO_EM_RESTART': '1', 09:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:19 INFO - 'PWD': '/builds/slave/test', 09:26:19 INFO - 'SHELL': '/bin/bash', 09:26:19 INFO - 'SHLVL': '1', 09:26:19 INFO - 'TERM': 'linux', 09:26:19 INFO - 'TMOUT': '86400', 09:26:19 INFO - 'USER': 'cltbld', 09:26:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:19 INFO - '_': '/tools/buildbot/bin/python'} 09:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:19 INFO - Running setup.py (path:/tmp/pip-7a61q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:19 INFO - Running setup.py (path:/tmp/pip-ezjSw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:19 INFO - Running setup.py (path:/tmp/pip-DVxmu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:20 INFO - Running setup.py (path:/tmp/pip-9Vvcsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:20 INFO - Running setup.py (path:/tmp/pip-MVxQ5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:20 INFO - Running setup.py (path:/tmp/pip-4SWhAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:20 INFO - Running setup.py (path:/tmp/pip-UVL_ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:20 INFO - Running setup.py (path:/tmp/pip-nPVhun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:20 INFO - Running setup.py (path:/tmp/pip-_NyT0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:20 INFO - Running setup.py (path:/tmp/pip-_Fp_9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:20 INFO - Running setup.py (path:/tmp/pip-uX9VLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:20 INFO - Running setup.py (path:/tmp/pip-ORdeXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:20 INFO - Running setup.py (path:/tmp/pip-XsCjRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:20 INFO - Running setup.py (path:/tmp/pip-gHr3Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:20 INFO - Running setup.py (path:/tmp/pip-pMyV6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:20 INFO - Running setup.py (path:/tmp/pip-8beuiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:20 INFO - Running setup.py (path:/tmp/pip-8M0ZAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:26:21 INFO - Running setup.py install for manifestparser 09:26:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Running setup.py install for mozcrash 09:26:21 INFO - Running setup.py install for mozdebug 09:26:21 INFO - Running setup.py install for mozdevice 09:26:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Running setup.py install for mozfile 09:26:21 INFO - Running setup.py install for mozhttpd 09:26:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Running setup.py install for mozinfo 09:26:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Running setup.py install for mozInstall 09:26:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:26:21 INFO - Running setup.py install for mozleak 09:26:21 INFO - Running setup.py install for mozlog 09:26:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:26:22 INFO - Running setup.py install for moznetwork 09:26:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:26:22 INFO - Running setup.py install for mozprocess 09:26:22 INFO - Running setup.py install for mozprofile 09:26:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:26:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:26:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:26:22 INFO - Running setup.py install for mozrunner 09:26:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:26:22 INFO - Running setup.py install for mozscreenshot 09:26:22 INFO - Running setup.py install for moztest 09:26:22 INFO - Running setup.py install for mozversion 09:26:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:26:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:26:22 INFO - Cleaning up... 09:26:22 INFO - Return code: 0 09:26:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:22 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 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:22 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:26:22 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:26:22 INFO - Using env: {'DISPLAY': ':0', 09:26:22 INFO - 'HOME': '/home/cltbld', 09:26:22 INFO - 'LANG': 'en_US.UTF-8', 09:26:22 INFO - 'LANGUAGE': 'en_US:en', 09:26:22 INFO - 'LOGNAME': 'cltbld', 09:26:22 INFO - 'MAIL': '/var/mail/cltbld', 09:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:22 INFO - 'MOZ_NO_REMOTE': '1', 09:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:22 INFO - 'NO_EM_RESTART': '1', 09:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:22 INFO - 'PWD': '/builds/slave/test', 09:26:22 INFO - 'SHELL': '/bin/bash', 09:26:22 INFO - 'SHLVL': '1', 09:26:22 INFO - 'TERM': 'linux', 09:26:22 INFO - 'TMOUT': '86400', 09:26:22 INFO - 'USER': 'cltbld', 09:26:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:22 INFO - '_': '/tools/buildbot/bin/python'} 09:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:23 INFO - Running setup.py (path:/tmp/pip-7hen25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:23 INFO - Running setup.py (path:/tmp/pip-pg8FQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:23 INFO - Running setup.py (path:/tmp/pip-NDydtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:23 INFO - Running setup.py (path:/tmp/pip-f93E9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:23 INFO - Running setup.py (path:/tmp/pip-oS8hpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:23 INFO - Running setup.py (path:/tmp/pip-hnCD_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:23 INFO - Running setup.py (path:/tmp/pip-YHe9zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:23 INFO - Running setup.py (path:/tmp/pip-fi3KuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:23 INFO - Running setup.py (path:/tmp/pip-BVOaOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:23 INFO - Running setup.py (path:/tmp/pip-1jDHTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:23 INFO - Running setup.py (path:/tmp/pip-K3hqkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:23 INFO - Running setup.py (path:/tmp/pip-VmnAUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:23 INFO - Running setup.py (path:/tmp/pip-TnwR96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:24 INFO - Running setup.py (path:/tmp/pip-1IEDHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:24 INFO - Running setup.py (path:/tmp/pip-sqNAGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:24 INFO - Running setup.py (path:/tmp/pip-8_QJvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:24 INFO - Running setup.py (path:/tmp/pip-lpJsyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:24 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:26:24 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:24 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:24 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:26:24 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:26:24 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:26:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:24 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:26:24 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:26:24 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:26:24 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:26:24 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:26:24 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:26:26 INFO - Downloading blessings-1.6.tar.gz 09:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:26:26 INFO - Installing collected packages: blessings 09:26:26 INFO - Running setup.py install for blessings 09:26:26 INFO - Successfully installed blessings 09:26:26 INFO - Cleaning up... 09:26:26 INFO - Return code: 0 09:26:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:26 INFO - Reading from file tmpfile_stdout 09:26:26 INFO - Current package versions: 09:26:26 INFO - argparse == 1.2.1 09:26:26 INFO - blessings == 1.6 09:26:26 INFO - blobuploader == 1.2.4 09:26:26 INFO - docopt == 0.6.1 09:26:26 INFO - manifestparser == 1.1 09:26:26 INFO - mozInstall == 1.12 09:26:26 INFO - mozcrash == 0.16 09:26:26 INFO - mozdebug == 0.1 09:26:26 INFO - mozdevice == 0.48 09:26:26 INFO - mozfile == 1.2 09:26:26 INFO - mozhttpd == 0.7 09:26:26 INFO - mozinfo == 0.9 09:26:26 INFO - mozleak == 0.1 09:26:26 INFO - mozlog == 3.1 09:26:26 INFO - moznetwork == 0.27 09:26:26 INFO - mozprocess == 0.22 09:26:26 INFO - mozprofile == 0.28 09:26:26 INFO - mozrunner == 6.11 09:26:26 INFO - mozscreenshot == 0.1 09:26:26 INFO - mozsystemmonitor == 0.0 09:26:26 INFO - moztest == 0.7 09:26:26 INFO - mozversion == 1.4 09:26:26 INFO - psutil == 3.1.1 09:26:26 INFO - requests == 1.2.3 09:26:26 INFO - wsgiref == 0.1.2 09:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:26 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 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:26 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:26:26 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:26:26 INFO - Using env: {'DISPLAY': ':0', 09:26:26 INFO - 'HOME': '/home/cltbld', 09:26:26 INFO - 'LANG': 'en_US.UTF-8', 09:26:26 INFO - 'LANGUAGE': 'en_US:en', 09:26:26 INFO - 'LOGNAME': 'cltbld', 09:26:26 INFO - 'MAIL': '/var/mail/cltbld', 09:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:26 INFO - 'MOZ_NO_REMOTE': '1', 09:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:26 INFO - 'NO_EM_RESTART': '1', 09:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:26 INFO - 'PWD': '/builds/slave/test', 09:26:26 INFO - 'SHELL': '/bin/bash', 09:26:26 INFO - 'SHLVL': '1', 09:26:26 INFO - 'TERM': 'linux', 09:26:26 INFO - 'TMOUT': '86400', 09:26:26 INFO - 'USER': 'cltbld', 09:26:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:26 INFO - '_': '/tools/buildbot/bin/python'} 09:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:26 INFO - Cleaning up... 09:26:26 INFO - Return code: 0 09:26:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:26 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 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:26 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:26:26 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:26:26 INFO - Using env: {'DISPLAY': ':0', 09:26:26 INFO - 'HOME': '/home/cltbld', 09:26:26 INFO - 'LANG': 'en_US.UTF-8', 09:26:26 INFO - 'LANGUAGE': 'en_US:en', 09:26:26 INFO - 'LOGNAME': 'cltbld', 09:26:26 INFO - 'MAIL': '/var/mail/cltbld', 09:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:26 INFO - 'MOZ_NO_REMOTE': '1', 09:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:26 INFO - 'NO_EM_RESTART': '1', 09:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:26 INFO - 'PWD': '/builds/slave/test', 09:26:26 INFO - 'SHELL': '/bin/bash', 09:26:26 INFO - 'SHLVL': '1', 09:26:26 INFO - 'TERM': 'linux', 09:26:26 INFO - 'TMOUT': '86400', 09:26:26 INFO - 'USER': 'cltbld', 09:26:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:26 INFO - '_': '/tools/buildbot/bin/python'} 09:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:27 INFO - Downloading/unpacking jsonschema 09:26:27 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:26:27 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:26:27 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:26:27 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:26:27 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:26:27 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:26:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:26:28 INFO - Downloading/unpacking functools32 (from jsonschema) 09:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:26:29 INFO - warning: no files found matching '*.txt' 09:26:29 INFO - no previously-included directories found matching 'build' 09:26:29 INFO - no previously-included directories found matching 'dist' 09:26:29 INFO - no previously-included directories found matching '.git*' 09:26:29 INFO - Installing collected packages: jsonschema, functools32 09:26:29 INFO - Running setup.py install for functools32 09:26:29 INFO - warning: no files found matching '*.txt' 09:26:29 INFO - no previously-included directories found matching 'build' 09:26:29 INFO - no previously-included directories found matching 'dist' 09:26:29 INFO - no previously-included directories found matching '.git*' 09:26:29 INFO - Successfully installed jsonschema functools32 09:26:29 INFO - Cleaning up... 09:26:29 INFO - Return code: 0 09:26:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ecb0bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1233410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', '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:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:26:29 INFO - Using env: {'DISPLAY': ':0', 09:26:29 INFO - 'HOME': '/home/cltbld', 09:26:29 INFO - 'LANG': 'en_US.UTF-8', 09:26:29 INFO - 'LANGUAGE': 'en_US:en', 09:26:29 INFO - 'LOGNAME': 'cltbld', 09:26:29 INFO - 'MAIL': '/var/mail/cltbld', 09:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:29 INFO - 'MOZ_NO_REMOTE': '1', 09:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:29 INFO - 'NO_EM_RESTART': '1', 09:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:29 INFO - 'PWD': '/builds/slave/test', 09:26:29 INFO - 'SHELL': '/bin/bash', 09:26:29 INFO - 'SHLVL': '1', 09:26:29 INFO - 'TERM': 'linux', 09:26:29 INFO - 'TMOUT': '86400', 09:26:29 INFO - 'USER': 'cltbld', 09:26:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:29 INFO - '_': '/tools/buildbot/bin/python'} 09:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:29 INFO - Downloading/unpacking flake8 09:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:26:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:26:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:26:32 INFO - no previously-included directories found matching 'docs/_build' 09:26:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:26:32 INFO - Running setup.py install for pep8 09:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:26:32 INFO - no previously-included directories found matching 'docs/_build' 09:26:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:26:32 INFO - Cleaning up... 09:26:32 INFO - Return code: 0 09:26:32 INFO - Running post-action listener: _resource_record_post_action 09:26:32 INFO - Running post-action listener: _start_resource_monitoring 09:26:32 INFO - Starting resource monitoring. 09:26:32 INFO - ##### 09:26:32 INFO - ##### Running install step. 09:26:32 INFO - ##### 09:26:32 INFO - Running pre-action listener: _resource_record_pre_action 09:26:32 INFO - Running main action method: install 09:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:32 INFO - Reading from file tmpfile_stdout 09:26:32 INFO - Detecting whether we're running mozinstall >=1.0... 09:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:26:32 INFO - Reading from file tmpfile_stdout 09:26:32 INFO - Output received: 09:26:32 INFO - Usage: mozinstall [options] installer 09:26:32 INFO - Options: 09:26:32 INFO - -h, --help show this help message and exit 09:26:32 INFO - -d DEST, --destination=DEST 09:26:32 INFO - Directory to install application into. [default: 09:26:32 INFO - "/builds/slave/test"] 09:26:32 INFO - --app=APP Application being installed. [default: firefox] 09:26:32 INFO - mkdir: /builds/slave/test/build/application 09:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:26:48 INFO - Reading from file tmpfile_stdout 09:26:48 INFO - Output received: 09:26:48 INFO - /builds/slave/test/build/application/firefox/firefox 09:26:48 INFO - Running post-action listener: _resource_record_post_action 09:26:48 INFO - ##### 09:26:48 INFO - ##### Running run-tests step. 09:26:48 INFO - ##### 09:26:48 INFO - Running pre-action listener: _resource_record_pre_action 09:26:48 INFO - Running main action method: run_tests 09:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:26:48 INFO - Python 2.7.3 09:26:48 INFO - Return code: 0 09:26:48 INFO - grabbing minidump binary from tooltool 09:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:48 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 0x12c2160>, '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 0x12c3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c34f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:26:48 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:26:48 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:26:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:26:48 INFO - Return code: 0 09:26:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:26:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:26:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:26:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:26:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:26:49 INFO - Return code: 0 09:26:49 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/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:26:49 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/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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:26:49 INFO - Using env: {'DISPLAY': ':0', 09:26:49 INFO - 'HOME': '/home/cltbld', 09:26:49 INFO - 'LANG': 'en_US.UTF-8', 09:26:49 INFO - 'LANGUAGE': 'en_US:en', 09:26:49 INFO - 'LOGNAME': 'cltbld', 09:26:49 INFO - 'MAIL': '/var/mail/cltbld', 09:26:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:26:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:49 INFO - 'MOZ_NO_REMOTE': '1', 09:26:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:49 INFO - 'NO_EM_RESTART': '1', 09:26:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:49 INFO - 'PWD': '/builds/slave/test', 09:26:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:26:49 INFO - 'SHELL': '/bin/bash', 09:26:49 INFO - 'SHLVL': '1', 09:26:49 INFO - 'TERM': 'linux', 09:26:49 INFO - 'TMOUT': '86400', 09:26:49 INFO - 'USER': 'cltbld', 09:26:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019', 09:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:49 INFO - '_': '/tools/buildbot/bin/python'} 09:26:49 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/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:26:49 INFO - mozversion application_buildid: 20160301053641 09:26:49 INFO - mozversion application_changeset: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 09:26:49 INFO - mozversion application_display_name: Nightly 09:26:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:26:49 INFO - mozversion application_name: Firefox 09:26:49 INFO - mozversion application_remotingname: firefox 09:26:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:26:49 INFO - mozversion application_vendor: Mozilla 09:26:49 INFO - mozversion application_version: 47.0a1 09:26:49 INFO - mozversion platform_buildid: 20160301053641 09:26:49 INFO - mozversion platform_changeset: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 09:26:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:26:49 INFO - mozversion platform_version: 47.0a1 09:26:49 INFO - using testdate: 1457026009 09:26:49 INFO - actual date: 1457026009 09:26:49 INFO - starting webserver on 'localhost:36548' 09:26:49 INFO - SUITE-START | Running 2 tests 09:26:49 INFO - TEST-START | dromaeo_css 09:26:49 INFO - operating with platform_type : linux_ 09:26:49 INFO - Initialising browser for dromaeo_css test... 09:26:49 INFO - TEST-INFO | started process 22573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplJNafT/profile http://localhost:36548/getInfo.html) 09:26:54 INFO - PROCESS | 22573 | __metrics Screen width/height:1600/1200 09:26:54 INFO - PROCESS | 22573 | colorDepth:24 09:26:54 INFO - PROCESS | 22573 | Browser inner width/height: 1024/697 09:26:54 INFO - PROCESS | 22573 | __metrics 09:26:55 INFO - PROCESS | 22573 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:55 INFO - PROCESS | 22573 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:55 INFO - PROCESS | 22573 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:55 INFO - PROCESS | 22573 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:55 INFO - PROCESS | 22573 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:55 INFO - PROCESS | 22573 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:55 INFO - PROCESS | 22573 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:55 INFO - PROCESS | 22573 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:26:56 INFO - TEST-INFO | 22573: exit 0 09:26:56 INFO - Browser initialized. 09:26:56 INFO - Running cycle 1/1 for dromaeo_css test... 09:26:56 INFO - TEST-INFO | started process 22668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplJNafT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:08 INFO - PROCESS | 22668 | RSS: Main: 152891392 09:27:08 INFO - PROCESS | 22668 | 09:27:59 INFO - PROCESS | 22668 | 1457026079577 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:30:11 INFO - PROCESS | 22668 | Cycle 1(1): loaded http://localhost:36548/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36548/tests/dromaeo/cssquery-ext.html) 09:30:12 INFO - PROCESS | 22668 | RSS: Main: 248963072 09:30:12 INFO - PROCESS | 22668 | 09:33:14 INFO - PROCESS | 22668 | Cycle 1(1): loaded http://localhost:36548/tests/dromaeo/cssquery-ext.html (next: http://localhost:36548/tests/dromaeo/cssquery-jquery.html) 09:33:14 INFO - PROCESS | 22668 | RSS: Main: 240410624 09:33:14 INFO - PROCESS | 22668 | 09:36:16 INFO - PROCESS | 22668 | Cycle 1(1): loaded http://localhost:36548/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36548/tests/dromaeo/cssquery-mootools.html) 09:36:17 INFO - PROCESS | 22668 | RSS: Main: 240693248 09:36:17 INFO - PROCESS | 22668 | 09:39:19 INFO - PROCESS | 22668 | Cycle 1(1): loaded http://localhost:36548/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36548/tests/dromaeo/cssquery-prototype.html) 09:39:20 INFO - PROCESS | 22668 | RSS: Main: 209174528 09:39:20 INFO - PROCESS | 22668 | 09:42:22 INFO - PROCESS | 22668 | Cycle 1(1): loaded http://localhost:36548/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36548/tests/dromaeo/cssquery-yui.html) 09:42:23 INFO - PROCESS | 22668 | RSS: Main: 226672640 09:42:23 INFO - PROCESS | 22668 | 09:45:25 INFO - PROCESS | 22668 | Cycle 1(1): loaded http://localhost:36548/tests/dromaeo/cssquery-yui.html (next: http://localhost:36548/tests/dromaeo/cssquery-dojo.html) 09:45:26 INFO - PROCESS | 22668 | RSS: Main: 270807040 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | __start_tp_report 09:45:26 INFO - PROCESS | 22668 | _x_x_mozilla_page_load 09:45:26 INFO - PROCESS | 22668 | _x_x_mozilla_page_load_details 09:45:26 INFO - PROCESS | 22668 | |i|pagename|runs| 09:45:26 INFO - PROCESS | 22668 | |0;dojo.html;2576.008236828821;2654.9601755973654;2675.9197224083287;2680.6515153030105;2701.122135306026;4342.109867477167;4437.134758722051;4470;4481.86554403368;4490.326451032342;4369.912601747963;4393.912121757563;4441.400410944521;4459.799309031093;4468.709533880296;4075.6535694465933;4084.366923126905;4106.589341065885;4122.484689413824;4213.452251207339;4153.148604536078;4175.749455032693;4183.811728472226;4205.726627769185;4218.303979843337;4051.311277082903;4063.5936406359424;4119.649829764474;4133.42132101506;4151.750894946313;4109.404136400205;4125.773082480462;4139.379093136024;4149.983254102734;4163.208990291835;4093.774842383668;4096.05790668145;4098.569650186717;4103.384492326145;4138.937915931264;4249.298865687158;4274.209271284792;4318.179545886303;4445.777711114463;4475.283954567253;4718.646101542398;4737.834175803865;4741.715497070187;4762.261849413347;4781.497942716;4749;4759.785809638574;4765.189917713962;4765.404324459442;4812.446568644581;4327.307630779061;4407.338899165086;4475.239209334421;4488.4613846338325;4496.033352829125;4843.297721830315;4866.537678920497;4866.805327786919;4871.196252618349;4889.144399730033;4610.654200934943;4670.953290467051;4672.415948006499;4704.553067458586;4723.905521889543;4613.976930115395;4697.459792123881;4755.976220118877;4773.188557945157;4797.280407938767;4693.78877950493;4705.435347758223;4719.38647975761;4724.527547245317;4770.856874293777;4675.859724208279;4695.037517308943;4696.389469369028;4696.835610753607;4732.763361831963;3902.648761611412;3971.0270983608625;3977.622125898035;3981.163955569305;3983.661388781928;3445.3626079175433;3456.1359660084977;3461.44616861301;3468.3756923753967;3479.1128262292955;4106.322456794595;4107.096438783463;4117.094239267356;4146.896327591834;4163.042500224965;4706.88232794176;4718.457377401643;4724.4094488188975;4726.621870250372;4764.4520880099235;4010.7593544387432;4064.7357921734992;4101.630853223224;4138.048248902769;4139.668826493873;4211.925958880466;4225;4231.386448964883;4254.574542545721;4267.871963841089;4503.842365517191;4511.413516242867;4517.322401639714;4522.29904364824;4552.772361381918;4556.5443455655495;4709.105269998689;4769.737664428351;4780.880477988078;4794.113089078532;4494.955050449454;4523.411956445641;4528.796204170886;4543.114092752014;4552.9772351138035;4670.673052886265;4671.346011558452;4679.2279273920785;4682.227432473604;4711.575958163782;4651.511591282867;4701.03628756111;4732.550407711399;4792.520747925179;4797.95202047989;4612.400387949545;4618.861434156981;4647.16351056813;4648.511906249795;4688.249880019181;4642.744649044335;4666.533346665442;4667.159911216014;4668.183067963025;4706.670533062653;4417.315316126005;4428.623566996841;4487.057717879282;4524.411826462539;4527.592516673515;4609.101225261042;4618.907621847611;4626.930596041129;4639.141758774637;4658.114958157939;4395.769184628181;4520.434945631796;4523.11799199153;4547.63618910493;4556.339330797082 09:45:26 INFO - PROCESS | 22668 | |1;ext.html;499.34835040272446;503.1848405582956;509.9158638824594;524.3838489774514;539.8596364945115;31048.84475577622;31411.528827067614;31422;31481.68518314816;31661;33946;34361.65638343616;34372.31255374891;34381.31237375251;35174;7443.962780186105;7647.273509016634;7650.732224372148;7652.464327497078;7653.387728981668;7510.6620202091035;7671.386289096887;7673.2326767323375;7675.194104619019;7679.078510578711;7458.589777562232;7462.813429664275;7522.172561018311;7530.058742657168;7534.660940257674;7756.108047574517;7862.646180921873;7877.842443151105;7877.921220787776;7878.330341920886;7563.205863384375;7720.112187098443;7758.612069396508;7834.020747406575;7840.568768717718;34777.82611086954;35238;35301.64698353035;35329.470057949155;35377.823110884536;2670.27902466333;2746.6703995520465;2844.8862045518154;3140.4661207594536;3213.0682102190335;26527.46945061088;27556.586651200247;27632.861835690896;28152.577711334347;28339.57490637642;3361.83190840457;3436.9484457733156;3491.162121090945;3570.4644303354444;3578.838952247129;218400;219046;219133;219144;219298;36321.45517817235;36934.261314773554;36934.63065369312;49122.26316605254;49488.75255623699;34860.12849678778;34914.47628285578;34983.475247871305;35047.299054018775;35124.64875351265;11444.256123352123;11601.941990290163;11612.535498580131;11636.36000020007;11657.533698652129;8328.791780205544;8341.958290208631;8346.8330633387;8354.122817104238;8357.038940521796;12524.937375313066;12577.874221257853;12620.55828046014;12640.367981600883;12719.745605087846;5029.974850125726;5064.620153488503;5067.569256613156;5129.769160387791;5138.640295179302;717.9784606461815;847.766864112374;925.9536723502533;928.9953550232341;996.2080146283722;24243.393915151908;25551;25766;25804.483910322066;25828;830.3606223208096;841.7685136587487;855.8502262104231;874.9912500875037;891.919727224553;12898.548550800677;13054.527843102094;13087.607371778862;13181.670458238621;13349.264595602705;245937;249044;249535;249630;249849;40060.19879602391;41183.1763364731;41455.79272103681;41475;41577.168456631305;978.9118979291898;1093.3658478082693;1113.0427832064418;1114.816055350858;1134.3364131982883;24154.275371738877;24594.13920512845;25104;25253.873730631964;25263.494730105664;37500.43749343707;37738;37781.622183777814;37932.62067379291;37934.24131517409;246770;249065;249700;250867;250883;27291.454170916073;27774.583381248893;28388.432231354844;28706.425871482872;28899.855500722362;36054.4591831128;36092.27815443729;36349.27301454009;36807.89576312715;37267;31222;31483.52774708427;31640.36719265648;31717.68282317147;31821.20446988844;30847.383052339275;31388;31754.36491270208;31837.20406989844;32172;24474.26577202687;26057.348566285993;31550.842245788623;31752.206194845312;32235.838820805748;25863.741362586134;26957.73042269552;27614.309642259104;27629.171124866287;27718.86140569365;21920.561588767818;22129.889350553145;22151.224707135818;22186.44533886601;22227.333180004625 09:45:26 INFO - PROCESS | 22668 | |2;jquery.html;300.186494599635;303.9802412843165;306.38111015748206;315.95734575832256;316.90809665197094;11429.485673144707;12695.365231738422;14591.854081459196;15056.924715376408;15071.397144114237;10969.670909872697;11077.723056923582;11465.254758440695;11478;13526.32368381582;4777.307290442884;4864.7324397158145;4966.230234313669;4972.776225069862;4974.079795237874;4861.440934292548;4888.046830867982;4990.30135780991;5019.598432125421;5023.196288593826;3493.7030352420074;4962.776675049631;5522.116461366182;5769.105788602752;5770;5725.599208055438;5739.196512488255;5740.368559458435;5759.078547432412;5762.9135562966585;4928.48250933654;4947.431045429786;5018.5985121190215;5058.2412638104215;5068.26510156029;17534.561635959202;17883.512715020577;18003.459896203134;18070.728939065924;18165.54586135344;1833.972490412645;1965.1255191439816;1989.7313862628505;2006.3780228129326;2090.6550419180817;5953.553483488756;11743.882561174365;11767.764644707058;11973.786737527673;12241.755164896653;1698.4649835301964;1709.034395566501;1732.913354332291;1780.1188411736273;1809.9185536650882;54084;54376.72811635956;54605.45394546043;54655.453445465835;55425.445745542434;8574.22831945128;9072.228860546928;9077.591508382138;9639.168557974102;9641.614335426644;11912.821307680391;12082;12182.329971851455;12184.451699673536;12184.451699673536;6308.432241098231;6316.084167795644;6356.491480681534;6374.075759014917;6402.551821372459;5027.145385284511;5516.862078448071;5788.507976822018;5789.768409263666;5793.478586927196;3997.9400308995387;3998.8400463981698;4009.6190861868076;4058.9594104059174;4083.612056854594;1568.1845440371171;1690.6027083635336;1700.698965291553;1710.2218490586754;1751.3169863753146;793.6983946100445;825.7233826668133;865.446114486729;904.5974541329177;928.6981730937472;14217.19138297939;14489.420423182955;14663.56009319722;14687;15078.0199287046;788.8501184774874;803.9718609848744;814.9633266503022;871.3987348729484;889.350773935031;8228.21831925966;8282.296004839656;8412.411131220755;8445.746627601182;8552.315814734806;355335;357059;360410;362292;364986;60323.39676603178;61581;64089.67955160288;64156.67921660455;65020;857.811281518065;863.6459051788736;866.9956650216709;872.5462759365095;872.8777971084053;12980.415881285177;13262.867371326163;13336.333183340601;13421.731565368833;13506;30614.693853061184;31661.683383166794;32128.839355803073;32335.514967275038;32739.34521309513;43017.78491107524;43053;43244.351334730636;43640;43878;5422.349318081855;6688.331166883468;6802.965985170043;6873.690683919136;6954.408875245458;8691.608877600396;9819.214462842812;10068.24488163376;10245;10305.896941030494;9178.67874624385;9316.627334906529;9760.46317452547;9838.60645574169;9974.20206383502;7596.81007974805;8831.60257788414;8986.68546600866;9414.105659962293;9496.620135194515;9472.668456603986;9621.08599683029;9638.903610964082;9716.708498745049;9893.50532473359;6709.899351509634;6726.159230096238;6885.758998435031;7073.045138906182;7363.116426028911;9897.802043959224;9942.850857237003;9997.350172238781;10076.798464030824;10101.747456313651 09:45:26 INFO - PROCESS | 22668 | |3;mootools.html;1037.108087045141;1098.9340639561626;1121.6130434999925;1138.755167638958;1178.9410529473535;6007.339192688801;6639.435647969923;6787.7624283150035;6797.456203503708;6798.660066996655;6419.101325814389;6584.14406127204;6606.504512161583;6612.735490580371;6620.404163625273;1648.5796121988876;1671.7575951487088;1672.841080097395;1969.9015049247553;2000.9599808003832;1998.2306811877459;2020.9696854547194;2031.3296612117965;2040.8265297449734;2041.9081141348674;1926.807319268069;1927.5181204698824;1932.1788239998016;1932.3043704266522;1934.8548858835572;1931.1502938707065;1933.7679478462603;1934.796846331129;1935.8354539864129;1938.3797184900836;1908.761404824397;1917.1851962915844;1958.6474434601766;2002.91988320467;2009.5378063045434;6886.965565172192;6889.069975553286;6916;6926.030355750199;6953.6523173841615;3748.269087527933;3832.8466861325514;3837.0407398150464;3844.5770965193806;3846.11539345952;2570.961435578468;2645.8412495250154;2646.8147229693927;2658.0563899815675;2694.568868980973;867.5055218525443;869.395769939892;870.3298460185684;913.9634414623407;1761.3659082730208;9028.187463128284;9175.632974681004;9190.264778817678;9195.908040919572;9197.908020919773;3541.2740388220354;3635.1093981974586;3711;3712;3721.1627383838963;7674.232576742281;7759.806004849924;7779.7666070017995;7786.610669466618;7790.376769858398;3879.2241551689776;3923.1172986077904;3925.293447179535;3928.980355098206;3940.665043471337;2955.6305461817274;3393.7285017198565;3436.810975396327;3474.861005559749;3479.7912125272564;3173;3221.500667396557;3242.416365054313;3251.219707270285;3254.625718042408;994.7562847102362;1046.6075221791828;1047.6228557719214;1056.2183983851894;1059.2320567588438;1003.645079143151;1012.2863381316155;1034.5189486888482;1040.1678657074463;1047.0314958663207;6177.166082578884;6319.747210111544;6337.04944258365;6342.873142537123;6344.968275158687;884.9778755531034;886.6813283264346;896.171041786345;927.0127314410266;971.4220039076738;4969.801207951714;5074.391073071255;5078.060558796635;5148.279240906276;5149.613778966593;7837.725679601187;8112.553809540532;8130.552819594861;8157.632906519221;8209.79475513105;7963.601819909098;7968.083670377865;8037.316828069563;8050.11448740638;8130.552819594861;6430.3891130342545;6465.77369792055;6495.382938620918;6548.574342667806;6573.57271777333;6401.775937842153;6460.903086453801;6482.513811464065;6506.219253689587;6508.568115014689;7222.855542889218;7439.628018599156;7498.437617178843;7572.886406703794;7706.190849960673;7729.961350193213;7933.642986065756;7946.721864734706;7977.082635496992;8076.798080048045;5067.721275329893;5487.149491828773;5878.265216847894;5974.103884417372;6004.099385092271;6234.719437625227;6252.3122456530655;6271.216097987752;6299.905501417574;6300.2754683212015;5435.701036443033;5458.808941687022;5484.1773733938635;5595.440455954372;5611.466910643482;5252.9737351313;5271.551918086852;5304.761285742074;5419.674819510842;5739.942600573941;5955.344912059583;5971.462568368867;5977.342492325927;6065.969670151621;6102.420270074336;5401.594880384066;5451.291332126957;5496.258005169411;5506.366767821752;5613.326400831927;5598.832035038955;5631.577631677723;5633.6619802811965;5640.351359593536;5668.886622267614 09:45:26 INFO - PROCESS | 22668 | |4;prototype.html;281.8914717833634;282.43231105477986;285.97855160862935;288.76465680470415;292.49836530350444;5208.088584497712;5208.895822083556;5210.062188806009;5257.526822585966;5266.5786737061035;5080;5147.871303217412;5161.793528258874;5161.793528258874;5169.09540830355;3812.3137835189655;3840.2511510255513;3905.258000979819;3959.8614048508307;4003.9799801001027;3952.940705889414;3964.306246406867;3985.880423587297;4004.619561141687;4005.259027079985;3949.526056873179;3956.406539019156;3961.445397644332;3961.722679412442;3965.543962444327;3779.584245732981;3876.8449262029485;3899.1032062625472;3899.7465164764485;3953.6639385651965;3469.392856250146;3496.7027802636553;3502.527158833576;3506.3513250048823;3514.244437445936;5002.049610573979;5020.648554601179;5024.899502009939;5027.296178535008;5031.018951304497;4593.885152871205;4598.609118224955;4601.516840731709;4604.861854144381;4605.378273933044;5415.241866138744;5423.593230507728;5424.945750542483;5428.240046393508;5430.022595932731;3835.5780864104927;3836.673882719972;3839.2897313997;3839.808009599537;3840.2511510255513;5520.447955204448;5677.120046392815;5704.486596206361;5707.457791509842;5716.114002329604;3921.4706014687654;3940.192260586573;3945.822437990297;3946.7039972002217;3975.7216994810087;3994.580569040209;3996.900077498086;3997.220541994341;3997.420374045747;4000.4799376081505;4562.61217796491;4563.54364563541;4563.589276965089;4568.1548913451115;4573.3368661544555;5434.70109143993;5440.347158341025;5441.156620723794;5491.341039075257;5502.257195278667;1379.344811214685;1420.5454254638416;1422.07565082695;1423.288355822089;1423.6440889777555;892.9107089291019;924.1497822003772;962.5812771444444;979.4955597867104;980.789130336981;4730.219513780187;4743.762811859393;4750.714957102585;4752.596029337545;4766.022965292107;5547.639403438763;5606.579506537026;5642;5676.659400435987;5677.37548869624;4748.026654535812;4764.904701906012;4767.070421267819;4770.7853146607795;4776.23580227162;2988.4321978823955;3021.8640161192798;3022.168903551497;3022.712842280024;3024.9243768905953;5294.7352632369;5317.654352467077;5322.0308485859705;5322.707251101227;5331.733413329318;5665.9716701417055;5739.569532285095;5858.179854820243;5866.765329386777;5874.559408044413;5398.757055932492;5423.159410291411;5424.376196737347;5424.972875135678;5427.810026649048;5717.656940583578;5718.399568045462;5722.914156287742;5723.627964182315;5724.284464441945;5579.46995035471;5586.16207568868;5589.217509548747;5593;5593.664380137205;5416.295881535375;5419.729013549386;5427.918581221364;5468.371137319259;5477.890442191054;3645.799481028569;3738.0841693785196;3744.194998075427;3756.417755247941;3759.8684046058256;5454.400015998316;5692.6299790513485;5711.914321285101;5741.196232527366;5763.36602973681;5335.386430560535;5504.80733174337;5558.860433611181;5562.110062389998;5578.944210557843;5464.371597266365;5500.642458240201;5504.697241651747;5504.981578408007;5507.7246137693755;5370.382406023357;5380.677159370451;5382.165764306539;5382.596305277199;5384.434634363335;5540.75066622011;5546.112621980464;5547.195656629686;5550.833474995757;5553.777848885999;5226.555742761908;5382.9192562112385;5384.353877534721;5385.40760516335;5385.461453854583 09:45:26 INFO - PROCESS | 22668 | |5;yui.html;536.7826030457666;583.2039266401362;598.1685457214472;623.7754408412972;624.4972796898501;10743.355398676074;10743.78512429751;10764.515596798143;10826.24216304858;10941.1247100232;10831.29596576222;10857.837132442999;10918.07196388306;10973;11080.501377438015;549.0117787981617;653.7646447278987;661.4576047640936;664.3622122762154;666.3902529185789;638.629594834997;654.1300070905708;656;657.0964923230558;657.3656421553201;690.0442886602067;691.4986634689835;691.7855464805926;692.0415224913506;693.6809067828805;563.352145033211;662.4336192555392;681.1757773094537;681.4480270980497;681.4752640466837;495.14587336844016;497.0506332904136;497.25163628738517;498.1581127893848;498.3446767500725;10703.304285221435;10741.087007604363;10784.245102842804;10830.079443247334;10838.620648277272;10555.78888422235;10690.144788416908;10717.732056698567;10755.83866242007;11040.503177357039;8916.631295098736;9038.367314288002;9144.588493517807;9158.358914875962;9302.116298951589;3060;3137.82741949195;3141.6544180140168;3149.653538110806;3220.516922461626;40099.19801603952;40124.59875401267;40415;40728.79635601833;41842.58157418448;7476.401887848959;7736.187700291501;7844.529328240324;7888.881666775003;8139.4709343892455;12965.481380744854;13021.283829389475;13043.608691739262;13045.412956416983;13122.212667239995;5838.211841401441;5877.853053673693;5886.6173698709445;5907.616004959664;6017.759289628366;3493;3501.6914950442083;3502.667246611568;3566.268914872445;3600.063983364344;2424.1878970545067;2435.0868424340874;2445.205308274818;2473.146764366327;2496.962545561818;448.5514485514486;453.11190067467476;466.05158502448035;467.58852210055613;477.6417686734949;413.74968144272884;433.5989209980755;439.0998453170987;482.68143025602933;498.1755195152029;6433.774817881352;6848.554843935129;6983.406410455168;7048;7049.506534542636;424.4249042547366;491.52813299232423;495.7719449053404;516.4087120247295;528.7771035538387;3174.698403651649;3180.427523045828;3270;3272.149241197306;3284.4744840825833;47707.28439073417;47899.281510777364;47976.28035579469;48124.27813582799;48589.028219435415;41473.377899331535;42066.57933420688;42531.36202956958;42701.57298426976;43343;37752.62247377546;38194.42708359377;38408.42387364192;39209.41185882214;39334.80332598319;7134.108236470442;7174.677139528838;7228.385587225145;7342.70629174827;7381.8523629526035;29370.412591748474;29397.85301073481;29917.10248692543;30282;30300.848495757382;33986.66013339934;34033;34058.489122662686;35971.64028359787;36873.44689829601;8082.313003394542;8570.700025499078;8698.47809131454;8832.425892316978;8965.865512017195;9960.950195248977;9965.551550180404;10187.898121018696;10189;10338.586456541654;7918.802029949297;9790.80418391614;9798.706038818847;9872.802543948937;10299.330543514647;9056.558923592724;9114.954425227832;9678.322517423712;9854.47894715908;9992.400455972665;9337.903193572798;9476.147146756824;9638.662646807328;9864.5560949756;10616.416097114732;7669.61651917413;7692.730754423568;7791.28839433069;7808.726694565663;7909.485883417559;7412.518186317872;7555.622218889143;7562.508436951581;7709.383249339927;7714.228577142465 09:45:26 INFO - PROCESS | 22668 | __end_tp_report 09:45:26 INFO - PROCESS | 22668 | __start_cc_report 09:45:26 INFO - PROCESS | 22668 | _x_x_mozilla_cycle_collect,876 09:45:26 INFO - PROCESS | 22668 | __end_cc_report 09:45:26 INFO - PROCESS | 22668 | __startTimestamp1457027126188__endTimestamp 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | ------- Summary: start ------- 09:45:26 INFO - PROCESS | 22668 | Number of tests: 6 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | [#0] dojo.html Cycles:165 Average:4391.47 Median:4517.32 stddev:435.46 (9.6%) stddev-sans-first:412.85 09:45:26 INFO - PROCESS | 22668 | Values: 2576.0 2655.0 2675.9 2680.7 2701.1 4342.1 4437.1 4470.0 4481.9 4490.3 4369.9 4393.9 4441.4 4459.8 4468.7 4075.7 4084.4 4106.6 4122.5 4213.5 4153.1 4175.7 4183.8 4205.7 4218.3 4051.3 4063.6 4119.6 4133.4 4151.8 4109.4 4125.8 4139.4 4150.0 4163.2 4093.8 4096.1 4098.6 4103.4 4138.9 4249.3 4274.2 4318.2 4445.8 4475.3 4718.6 4737.8 4741.7 4762.3 4781.5 4749.0 4759.8 4765.2 4765.4 4812.4 4327.3 4407.3 4475.2 4488.5 4496.0 4843.3 4866.5 4866.8 4871.2 4889.1 4610.7 4671.0 4672.4 4704.6 4723.9 4614.0 4697.5 4756.0 4773.2 4797.3 4693.8 4705.4 4719.4 4724.5 4770.9 4675.9 4695.0 4696.4 4696.8 4732.8 3902.6 3971.0 3977.6 3981.2 3983.7 3445.4 3456.1 3461.4 3468.4 3479.1 4106.3 4107.1 4117.1 4146.9 4163.0 4706.9 4718.5 4724.4 4726.6 4764.5 4010.8 4064.7 4101.6 4138.0 4139.7 4211.9 4225.0 4231.4 4254.6 4267.9 4503.8 4511.4 4517.3 4522.3 4552.8 4556.5 4709.1 4769.7 4780.9 4794.1 4495.0 4523.4 4528.8 4543.1 4553.0 4670.7 4671.3 4679.2 4682.2 4711.6 4651.5 4701.0 4732.6 4792.5 4798.0 4612.4 4618.9 4647.2 4648.5 4688.2 4642.7 4666.5 4667.2 4668.2 4706.7 4417.3 4428.6 4487.1 4524.4 4527.6 4609.1 4618.9 4626.9 4639.1 4658.1 4395.8 4520.4 4523.1 4547.6 4556.3 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | [#1] ext.html Cycles:180 Average:37699.96 Median:18691.47 stddev:62444.87 (334.1%) stddev-sans-first:62557.58 09:45:26 INFO - PROCESS | 22668 | Values: 499.3 503.2 509.9 524.4 539.9 31048.8 31411.5 31422.0 31481.7 31661.0 33946.0 34361.7 34372.3 34381.3 35174.0 7444.0 7647.3 7650.7 7652.5 7653.4 7510.7 7671.4 7673.2 7675.2 7679.1 7458.6 7462.8 7522.2 7530.1 7534.7 7756.1 7862.6 7877.8 7877.9 7878.3 7563.2 7720.1 7758.6 7834.0 7840.6 34777.8 35238.0 35301.6 35329.5 35377.8 2670.3 2746.7 2844.9 3140.5 3213.1 26527.5 27556.6 27632.9 28152.6 28339.6 3361.8 3436.9 3491.2 3570.5 3578.8 218400.0 219046.0 219133.0 219144.0 219298.0 36321.5 36934.3 36934.6 49122.3 49488.8 34860.1 34914.5 34983.5 35047.3 35124.6 11444.3 11601.9 11612.5 11636.4 11657.5 8328.8 8342.0 8346.8 8354.1 8357.0 12524.9 12577.9 12620.6 12640.4 12719.7 5030.0 5064.6 5067.6 5129.8 5138.6 718.0 847.8 926.0 929.0 996.2 24243.4 25551.0 25766.0 25804.5 25828.0 830.4 841.8 855.9 875.0 891.9 12898.5 13054.5 13087.6 13181.7 13349.3 245937.0 249044.0 249535.0 249630.0 249849.0 40060.2 41183.2 41455.8 41475.0 41577.2 978.9 1093.4 1113.0 1114.8 1134.3 24154.3 24594.1 25104.0 25253.9 25263.5 37500.4 37738.0 37781.6 37932.6 37934.2 246770.0 249065.0 249700.0 250867.0 250883.0 27291.5 27774.6 28388.4 28706.4 28899.9 36054.5 36092.3 36349.3 36807.9 37267.0 31222.0 31483.5 31640.4 31717.7 31821.2 30847.4 31388.0 31754.4 31837.2 32172.0 24474.3 26057.3 31550.8 31752.2 32235.8 25863.7 26957.7 27614.3 27629.2 27718.9 21920.6 22129.9 22151.2 22186.4 22227.3 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | [#2] jquery.html Cycles:180 Average:21559.66 Median:5004.45 stddev:59090.45 (1180.8%) stddev-sans-first:59234.66 09:45:26 INFO - PROCESS | 22668 | Values: 300.2 304.0 306.4 316.0 316.9 11429.5 12695.4 14591.9 15056.9 15071.4 10969.7 11077.7 11465.3 11478.0 13526.3 4777.3 4864.7 4966.2 4972.8 4974.1 4861.4 4888.0 4990.3 5019.6 5023.2 3493.7 4962.8 5522.1 5769.1 5770.0 5725.6 5739.2 5740.4 5759.1 5762.9 4928.5 4947.4 5018.6 5058.2 5068.3 17534.6 17883.5 18003.5 18070.7 18165.5 1834.0 1965.1 1989.7 2006.4 2090.7 5953.6 11743.9 11767.8 11973.8 12241.8 1698.5 1709.0 1732.9 1780.1 1809.9 54084.0 54376.7 54605.5 54655.5 55425.4 8574.2 9072.2 9077.6 9639.2 9641.6 11912.8 12082.0 12182.3 12184.5 12184.5 6308.4 6316.1 6356.5 6374.1 6402.6 5027.1 5516.9 5788.5 5789.8 5793.5 3997.9 3998.8 4009.6 4059.0 4083.6 1568.2 1690.6 1700.7 1710.2 1751.3 793.7 825.7 865.4 904.6 928.7 14217.2 14489.4 14663.6 14687.0 15078.0 788.9 804.0 815.0 871.4 889.4 8228.2 8282.3 8412.4 8445.7 8552.3 355335.0 357059.0 360410.0 362292.0 364986.0 60323.4 61581.0 64089.7 64156.7 65020.0 857.8 863.6 867.0 872.5 872.9 12980.4 13262.9 13336.3 13421.7 13506.0 30614.7 31661.7 32128.8 32335.5 32739.3 43017.8 43053.0 43244.4 43640.0 43878.0 5422.3 6688.3 6803.0 6873.7 6954.4 8691.6 9819.2 10068.2 10245.0 10305.9 9178.7 9316.6 9760.5 9838.6 9974.2 7596.8 8831.6 8986.7 9414.1 9496.6 9472.7 9621.1 9638.9 9716.7 9893.5 6709.9 6726.2 6885.8 7073.0 7363.1 9897.8 9942.9 9997.4 10076.8 10101.7 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | [#3] mootools.html Cycles:180 Average:4676.20 Median:5612.40 stddev:2456.13 (43.8%) stddev-sans-first:2447.78 09:45:26 INFO - PROCESS | 22668 | Values: 1037.1 1098.9 1121.6 1138.8 1178.9 6007.3 6639.4 6787.8 6797.5 6798.7 6419.1 6584.1 6606.5 6612.7 6620.4 1648.6 1671.8 1672.8 1969.9 2001.0 1998.2 2021.0 2031.3 2040.8 2041.9 1926.8 1927.5 1932.2 1932.3 1934.9 1931.2 1933.8 1934.8 1935.8 1938.4 1908.8 1917.2 1958.6 2002.9 2009.5 6887.0 6889.1 6916.0 6926.0 6953.7 3748.3 3832.8 3837.0 3844.6 3846.1 2571.0 2645.8 2646.8 2658.1 2694.6 867.5 869.4 870.3 914.0 1761.4 9028.2 9175.6 9190.3 9195.9 9197.9 3541.3 3635.1 3711.0 3712.0 3721.2 7674.2 7759.8 7779.8 7786.6 7790.4 3879.2 3923.1 3925.3 3929.0 3940.7 2955.6 3393.7 3436.8 3474.9 3479.8 3173.0 3221.5 3242.4 3251.2 3254.6 994.8 1046.6 1047.6 1056.2 1059.2 1003.6 1012.3 1034.5 1040.2 1047.0 6177.2 6319.7 6337.0 6342.9 6345.0 885.0 886.7 896.2 927.0 971.4 4969.8 5074.4 5078.1 5148.3 5149.6 7837.7 8112.6 8130.6 8157.6 8209.8 7963.6 7968.1 8037.3 8050.1 8130.6 6430.4 6465.8 6495.4 6548.6 6573.6 6401.8 6460.9 6482.5 6506.2 6508.6 7222.9 7439.6 7498.4 7572.9 7706.2 7730.0 7933.6 7946.7 7977.1 8076.8 5067.7 5487.1 5878.3 5974.1 6004.1 6234.7 6252.3 6271.2 6299.9 6300.3 5435.7 5458.8 5484.2 5595.4 5611.5 5253.0 5271.6 5304.8 5419.7 5739.9 5955.3 5971.5 5977.3 6066.0 6102.4 5401.6 5451.3 5496.3 5506.4 5613.3 5598.8 5631.6 5633.7 5640.4 5668.9 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | [#4] prototype.html Cycles:180 Average:4525.18 Median:5208.49 stddev:1342.92 (25.8%) stddev-sans-first:1308.37 09:45:26 INFO - PROCESS | 22668 | Values: 281.9 282.4 286.0 288.8 292.5 5208.1 5208.9 5210.1 5257.5 5266.6 5080.0 5147.9 5161.8 5161.8 5169.1 3812.3 3840.3 3905.3 3959.9 4004.0 3952.9 3964.3 3985.9 4004.6 4005.3 3949.5 3956.4 3961.4 3961.7 3965.5 3779.6 3876.8 3899.1 3899.7 3953.7 3469.4 3496.7 3502.5 3506.4 3514.2 5002.0 5020.6 5024.9 5027.3 5031.0 4593.9 4598.6 4601.5 4604.9 4605.4 5415.2 5423.6 5424.9 5428.2 5430.0 3835.6 3836.7 3839.3 3839.8 3840.3 5520.4 5677.1 5704.5 5707.5 5716.1 3921.5 3940.2 3945.8 3946.7 3975.7 3994.6 3996.9 3997.2 3997.4 4000.5 4562.6 4563.5 4563.6 4568.2 4573.3 5434.7 5440.3 5441.2 5491.3 5502.3 1379.3 1420.5 1422.1 1423.3 1423.6 892.9 924.1 962.6 979.5 980.8 4730.2 4743.8 4750.7 4752.6 4766.0 5547.6 5606.6 5642.0 5676.7 5677.4 4748.0 4764.9 4767.1 4770.8 4776.2 2988.4 3021.9 3022.2 3022.7 3024.9 5294.7 5317.7 5322.0 5322.7 5331.7 5666.0 5739.6 5858.2 5866.8 5874.6 5398.8 5423.2 5424.4 5425.0 5427.8 5717.7 5718.4 5722.9 5723.6 5724.3 5579.5 5586.2 5589.2 5593.0 5593.7 5416.3 5419.7 5427.9 5468.4 5477.9 3645.8 3738.1 3744.2 3756.4 3759.9 5454.4 5692.6 5711.9 5741.2 5763.4 5335.4 5504.8 5558.9 5562.1 5578.9 5464.4 5500.6 5504.7 5505.0 5507.7 5370.4 5380.7 5382.2 5382.6 5384.4 5540.8 5546.1 5547.2 5550.8 5553.8 5226.6 5382.9 5384.4 5385.4 5385.5 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | [#5] yui.html Cycles:180 Average:11341.57 Median:493.34 stddev:13233.92 (2682.5%) stddev-sans-first:13246.17 09:45:26 INFO - PROCESS | 22668 | Values: 536.8 583.2 598.2 623.8 624.5 10743.4 10743.8 10764.5 10826.2 10941.1 10831.3 10857.8 10918.1 10973.0 11080.5 549.0 653.8 661.5 664.4 666.4 638.6 654.1 656.0 657.1 657.4 690.0 691.5 691.8 692.0 693.7 563.4 662.4 681.2 681.4 681.5 495.1 497.1 497.3 498.2 498.3 10703.3 10741.1 10784.2 10830.1 10838.6 10555.8 10690.1 10717.7 10755.8 11040.5 8916.6 9038.4 9144.6 9158.4 9302.1 3060.0 3137.8 3141.7 3149.7 3220.5 40099.2 40124.6 40415.0 40728.8 41842.6 7476.4 7736.2 7844.5 7888.9 8139.5 12965.5 13021.3 13043.6 13045.4 13122.2 5838.2 5877.9 5886.6 5907.6 6017.8 3493.0 3501.7 3502.7 3566.3 3600.1 2424.2 2435.1 2445.2 2473.1 2497.0 448.6 453.1 466.1 467.6 477.6 413.7 433.6 439.1 482.7 498.2 6433.8 6848.6 6983.4 7048.0 7049.5 424.4 491.5 495.8 516.4 528.8 3174.7 3180.4 3270.0 3272.1 3284.5 47707.3 47899.3 47976.3 48124.3 48589.0 41473.4 42066.6 42531.4 42701.6 43343.0 37752.6 38194.4 38408.4 39209.4 39334.8 7134.1 7174.7 7228.4 7342.7 7381.9 29370.4 29397.9 29917.1 30282.0 30300.8 33986.7 34033.0 34058.5 35971.6 36873.4 8082.3 8570.7 8698.5 8832.4 8965.9 9961.0 9965.6 10187.9 10189.0 10338.6 7918.8 9790.8 9798.7 9872.8 10299.3 9056.6 9115.0 9678.3 9854.5 9992.4 9337.9 9476.1 9638.7 9864.6 10616.4 7669.6 7692.7 7791.3 7808.7 7909.5 7412.5 7555.6 7562.5 7709.4 7714.2 09:45:26 INFO - PROCESS | 22668 | -------- Summary: end -------- 09:45:26 INFO - PROCESS | 22668 | 09:45:26 INFO - PROCESS | 22668 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:26 INFO - PROCESS | 22668 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:26 INFO - PROCESS | 22668 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:26 INFO - PROCESS | 22668 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:26 INFO - PROCESS | 22668 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:26 INFO - TEST-INFO | 22668: exit 0 09:45:27 INFO - TEST-OK | dromaeo_css | took 1117117ms 09:45:27 INFO - TEST-START | kraken 09:45:27 INFO - operating with platform_type : linux_ 09:45:27 INFO - Initialising browser for kraken test... 09:45:27 INFO - TEST-INFO | started process 22851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLO2qiO/profile http://localhost:36548/getInfo.html) 09:45:31 INFO - PROCESS | 22851 | __metrics Screen width/height:1600/1200 09:45:31 INFO - PROCESS | 22851 | colorDepth:24 09:45:31 INFO - PROCESS | 22851 | Browser inner width/height: 1024/697 09:45:31 INFO - PROCESS | 22851 | __metrics 09:45:32 INFO - PROCESS | 22851 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:45:32 INFO - PROCESS | 22851 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:32 INFO - PROCESS | 22851 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:32 INFO - PROCESS | 22851 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:32 INFO - PROCESS | 22851 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:32 INFO - PROCESS | 22851 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:32 INFO - PROCESS | 22851 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:32 INFO - PROCESS | 22851 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:32 INFO - PROCESS | 22851 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:32 INFO - PROCESS | 22851 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:45:33 INFO - TEST-INFO | 22851: exit 0 09:45:33 INFO - Browser initialized. 09:45:33 INFO - Running cycle 1/1 for kraken test... 09:45:33 INFO - TEST-INFO | started process 22935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLO2qiO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:45:45 INFO - PROCESS | 22935 | RSS: Main: 153432064 09:45:45 INFO - PROCESS | 22935 | 09:45:47 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36548/tests/kraken/driver.html?testName=audio-beat-detection) 09:45:48 INFO - PROCESS | 22935 | RSS: Main: 196775936 09:45:48 INFO - PROCESS | 22935 | 09:45:51 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36548/tests/kraken/driver.html?testName=audio-dft) 09:45:51 INFO - PROCESS | 22935 | RSS: Main: 187109376 09:45:51 INFO - PROCESS | 22935 | 09:45:54 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36548/tests/kraken/driver.html?testName=audio-fft) 09:45:55 INFO - PROCESS | 22935 | RSS: Main: 173019136 09:45:55 INFO - PROCESS | 22935 | 09:45:57 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36548/tests/kraken/driver.html?testName=audio-oscillator) 09:45:58 INFO - PROCESS | 22935 | RSS: Main: 173846528 09:45:58 INFO - PROCESS | 22935 | 09:46:00 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36548/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:46:00 INFO - PROCESS | 22935 | RSS: Main: 174481408 09:46:00 INFO - PROCESS | 22935 | 09:46:04 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36548/tests/kraken/driver.html?testName=imaging-darkroom) 09:46:04 INFO - PROCESS | 22935 | RSS: Main: 176504832 09:46:04 INFO - PROCESS | 22935 | 09:46:08 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36548/tests/kraken/driver.html?testName=imaging-desaturate) 09:46:08 INFO - PROCESS | 22935 | RSS: Main: 172879872 09:46:08 INFO - PROCESS | 22935 | 09:46:11 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36548/tests/kraken/driver.html?testName=json-parse-financial) 09:46:12 INFO - PROCESS | 22935 | RSS: Main: 174723072 09:46:12 INFO - PROCESS | 22935 | 09:46:13 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36548/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:46:14 INFO - PROCESS | 22935 | RSS: Main: 189194240 09:46:14 INFO - PROCESS | 22935 | 09:46:16 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36548/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:46:17 INFO - PROCESS | 22935 | RSS: Main: 186388480 09:46:17 INFO - PROCESS | 22935 | 09:46:19 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36548/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:46:19 INFO - PROCESS | 22935 | RSS: Main: 196653056 09:46:19 INFO - PROCESS | 22935 | 09:46:22 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:46:22 INFO - PROCESS | 22935 | RSS: Main: 200126464 09:46:22 INFO - PROCESS | 22935 | 09:46:25 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:46:26 INFO - PROCESS | 22935 | RSS: Main: 199864320 09:46:26 INFO - PROCESS | 22935 | 09:46:27 INFO - PROCESS | 22935 | Cycle 1(1): loaded http://localhost:36548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36548/tests/kraken/driver.html?testName=ai-astar) 09:46:28 INFO - PROCESS | 22935 | RSS: Main: 258953216 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | __start_tp_report 09:46:28 INFO - PROCESS | 22935 | _x_x_mozilla_page_load 09:46:28 INFO - PROCESS | 22935 | _x_x_mozilla_page_load_details 09:46:28 INFO - PROCESS | 22935 | |i|pagename|runs| 09:46:28 INFO - PROCESS | 22935 | |0;ai-astar;114;116;109;114;115;113;105;116;115;116 09:46:28 INFO - PROCESS | 22935 | |1;audio-beat-detection;156;134;154;173;143;161;157;134;172;141 09:46:28 INFO - PROCESS | 22935 | |2;audio-dft;162;161;161;161;160;163;161;160;163;162 09:46:28 INFO - PROCESS | 22935 | |3;audio-fft;75;74;97;93;73;73;72;111;97;75 09:46:28 INFO - PROCESS | 22935 | |4;audio-oscillator;97;96;144;97;95;95;145;95;95;128 09:46:28 INFO - PROCESS | 22935 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;116;117;117 09:46:28 INFO - PROCESS | 22935 | |6;imaging-darkroom;147;146;147;146;147;146;146;147;146;146 09:46:28 INFO - PROCESS | 22935 | |7;imaging-desaturate;97;97;97;96;96;96;96;96;96;96 09:46:28 INFO - PROCESS | 22935 | |8;json-parse-financial;66;67;69;68;68;66;67;76;64;65 09:46:28 INFO - PROCESS | 22935 | |9;json-stringify-tinderbox;71;70;70;71;71;71;70;70;71;71 09:46:28 INFO - PROCESS | 22935 | |10;stanford-crypto-aes;85;82;85;83;85;83;83;84;83;86 09:46:28 INFO - PROCESS | 22935 | |11;stanford-crypto-ccm;121;120;119;124;117;127;132;138;123;131 09:46:28 INFO - PROCESS | 22935 | |12;stanford-crypto-pbkdf2;155;139;164;149;147;140;152;150;148;154 09:46:28 INFO - PROCESS | 22935 | |13;stanford-crypto-sha256-iterative;71;70;75;70;72;74;70;73;72;70 09:46:28 INFO - PROCESS | 22935 | __end_tp_report 09:46:28 INFO - PROCESS | 22935 | __start_cc_report 09:46:28 INFO - PROCESS | 22935 | _x_x_mozilla_cycle_collect,1189 09:46:28 INFO - PROCESS | 22935 | __end_cc_report 09:46:28 INFO - PROCESS | 22935 | __startTimestamp1457027188241__endTimestamp 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | ------- Summary: start ------- 09:46:28 INFO - PROCESS | 22935 | Number of tests: 14 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.59 (3.1%) stddev-sans-first:3.80 09:46:28 INFO - PROCESS | 22935 | Values: 114.0 116.0 109.0 114.0 115.0 113.0 105.0 116.0 115.0 116.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:156.50 stddev:14.20 (9.1%) stddev-sans-first:15.00 09:46:28 INFO - PROCESS | 22935 | Values: 156.0 134.0 154.0 173.0 143.0 161.0 157.0 134.0 172.0 141.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 09:46:28 INFO - PROCESS | 22935 | Values: 162.0 161.0 161.0 161.0 160.0 163.0 161.0 160.0 163.0 162.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.00 stddev:14.13 (18.8%) stddev-sans-first:14.60 09:46:28 INFO - PROCESS | 22935 | Values: 75.0 74.0 97.0 93.0 73.0 73.0 72.0 111.0 97.0 75.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:21.40 (22.5%) stddev-sans-first:22.28 09:46:28 INFO - PROCESS | 22935 | Values: 97.0 96.0 144.0 97.0 95.0 95.0 145.0 95.0 95.0 128.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 09:46:28 INFO - PROCESS | 22935 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:46:28 INFO - PROCESS | 22935 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:46:28 INFO - PROCESS | 22935 | Values: 97.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.50 stddev:3.31 (4.9%) stddev-sans-first:3.46 09:46:28 INFO - PROCESS | 22935 | Values: 66.0 67.0 69.0 68.0 68.0 66.0 67.0 76.0 64.0 65.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 09:46:28 INFO - PROCESS | 22935 | Values: 71.0 70.0 70.0 71.0 71.0 71.0 70.0 70.0 71.0 71.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.50 stddev:1.29 (1.5%) stddev-sans-first:1.30 09:46:28 INFO - PROCESS | 22935 | Values: 85.0 82.0 85.0 83.0 85.0 83.0 83.0 84.0 83.0 86.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:125.50 stddev:6.70 (5.3%) stddev-sans-first:6.93 09:46:28 INFO - PROCESS | 22935 | Values: 121.0 120.0 119.0 124.0 117.0 127.0 132.0 138.0 123.0 131.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.00 stddev:7.27 (4.8%) stddev-sans-first:7.46 09:46:28 INFO - PROCESS | 22935 | Values: 155.0 139.0 164.0 149.0 147.0 140.0 152.0 150.0 148.0 154.0 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.83 (2.5%) stddev-sans-first:1.92 09:46:28 INFO - PROCESS | 22935 | Values: 71.0 70.0 75.0 70.0 72.0 74.0 70.0 73.0 72.0 70.0 09:46:28 INFO - PROCESS | 22935 | -------- Summary: end -------- 09:46:28 INFO - PROCESS | 22935 | 09:46:28 INFO - PROCESS | 22935 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:28 INFO - PROCESS | 22935 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:28 INFO - PROCESS | 22935 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:28 INFO - PROCESS | 22935 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:28 INFO - PROCESS | 22935 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:29 INFO - TEST-INFO | 22935: exit 0 09:46:29 INFO - TEST-OK | kraken | took 62241ms 09:46:29 INFO - SUITE-END | took 1179s 09:46:29 INFO - Completed test suite (00:19:39) 09:46:29 INFO - Working with test: dromaeo_css 09:46:29 INFO - Generating results file: dromaeo_css 09:46:29 INFO - Working with test: kraken 09:46:29 INFO - Generating results file: kraken 09:46:29 INFO - javascript benchmark 09:46:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 09:46:29 INFO - process_Request line: dromaeo_css 5832.03 graph.html#tests=[[72,94,35]] 09:46:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:29 INFO - process_Request line: kraken 1548.50 graph.html#tests=[[232,94,35]] 09:46:29 INFO - RETURN: dromaeo_css: 5832.03 09:46:29 INFO - RETURN: kraken: 1548.50 09:46:29 INFO - javascript benchmark 09:46:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2576.008236828821, 2654.9601755973654, 2675.9197224083287, 2680.6515153030105, 2701.122135306026, 4342.109867477167, 4437.134758722051, 4470.0, 4481.86554403368, 4490.326451032342, 4369.912601747963, 4393.912121757563, 4441.400410944521, 4459.799309031093, 4468.709533880296, 4075.6535694465933, 4084.366923126905, 4106.589341065885, 4122.484689413824, 4213.452251207339, 4153.148604536078, 4175.749455032693, 4183.811728472226, 4205.726627769185, 4218.303979843337, 4051.311277082903, 4063.5936406359424, 4119.649829764474, 4133.42132101506, 4151.750894946313, 4109.404136400205, 4125.773082480462, 4139.379093136024, 4149.983254102734, 4163.208990291835, 4093.774842383668, 4096.05790668145, 4098.569650186717, 4103.384492326145, 4138.937915931264, 4249.298865687158, 4274.209271284792, 4318.179545886303, 4445.777711114463, 4475.283954567253, 4718.646101542398, 4737.834175803865, 4741.715497070187, 4762.261849413347, 4781.497942716, 4749.0, 4759.785809638574, 4765.189917713962, 4765.404324459442, 4812.446568644581, 4327.307630779061, 4407.338899165086, 4475.239209334421, 4488.4613846338325, 4496.033352829125, 4843.297721830315, 4866.537678920497, 4866.805327786919, 4871.196252618349, 4889.144399730033, 4610.654200934943, 4670.953290467051, 4672.415948006499, 4704.553067458586, 4723.905521889543, 4613.976930115395, 4697.459792123881, 4755.976220118877, 4773.188557945157, 4797.280407938767, 4693.78877950493, 4705.435347758223, 4719.38647975761, 4724.527547245317, 4770.856874293777, 4675.859724208279, 4695.037517308943, 4696.389469369028, 4696.835610753607, 4732.763361831963, 3902.648761611412, 3971.0270983608625, 3977.622125898035, 3981.163955569305, 3983.661388781928, 3445.3626079175433, 3456.1359660084977, 3461.44616861301, 3468.3756923753967, 3479.1128262292955, 4106.322456794595, 4107.096438783463, 4117.094239267356, 4146.896327591834, 4163.042500224965, 4706.88232794176, 4718.457377401643, 4724.4094488188975, 4726.621870250372, 4764.4520880099235, 4010.7593544387432, 4064.7357921734992, 4101.630853223224, 4138.048248902769, 4139.668826493873, 4211.925958880466, 4225.0, 4231.386448964883, 4254.574542545721, 4267.871963841089, 4503.842365517191, 4511.413516242867, 4517.322401639714, 4522.29904364824, 4552.772361381918, 4556.5443455655495, 4709.105269998689, 4769.737664428351, 4780.880477988078, 4794.113089078532, 4494.955050449454, 4523.411956445641, 4528.796204170886, 4543.114092752014, 4552.9772351138035, 4670.673052886265, 4671.346011558452, 4679.2279273920785, 4682.227432473604, 4711.575958163782, 4651.511591282867, 4701.03628756111, 4732.550407711399, 4792.520747925179, 4797.95202047989, 4612.400387949545, 4618.861434156981, 4647.16351056813, 4648.511906249795, 4688.249880019181, 4642.744649044335, 4666.533346665442, 4667.159911216014, 4668.183067963025, 4706.670533062653, 4417.315316126005, 4428.623566996841, 4487.057717879282, 4524.411826462539, 4527.592516673515, 4609.101225261042, 4618.907621847611, 4626.930596041129, 4639.141758774637, 4658.114958157939, 4395.769184628181, 4520.434945631796, 4523.11799199153, 4547.63618910493, 4556.339330797082], "unit": "score", "name": "dojo.html", "value": 4366.003560891389}, {"lowerIsBetter": false, "replicates": [499.34835040272446, 503.1848405582956, 509.9158638824594, 524.3838489774514, 539.8596364945115, 31048.84475577622, 31411.528827067614, 31422.0, 31481.68518314816, 31661.0, 33946.0, 34361.65638343616, 34372.31255374891, 34381.31237375251, 35174.0, 7443.962780186105, 7647.273509016634, 7650.732224372148, 7652.464327497078, 7653.387728981668, 7510.6620202091035, 7671.386289096887, 7673.2326767323375, 7675.194104619019, 7679.078510578711, 7458.589777562232, 7462.813429664275, 7522.172561018311, 7530.058742657168, 7534.660940257674, 7756.108047574517, 7862.646180921873, 7877.842443151105, 7877.921220787776, 7878.330341920886, 7563.205863384375, 7720.112187098443, 7758.612069396508, 7834.020747406575, 7840.568768717718, 34777.82611086954, 35238.0, 35301.64698353035, 35329.470057949155, 35377.823110884536, 2670.27902466333, 2746.6703995520465, 2844.8862045518154, 3140.4661207594536, 3213.0682102190335, 26527.46945061088, 27556.586651200247, 27632.861835690896, 28152.577711334347, 28339.57490637642, 3361.83190840457, 3436.9484457733156, 3491.162121090945, 3570.4644303354444, 3578.838952247129, 218400.0, 219046.0, 219133.0, 219144.0, 219298.0, 36321.45517817235, 36934.261314773554, 36934.63065369312, 49122.26316605254, 49488.75255623699, 34860.12849678778, 34914.47628285578, 34983.475247871305, 35047.299054018775, 35124.64875351265, 11444.256123352123, 11601.941990290163, 11612.535498580131, 11636.36000020007, 11657.533698652129, 8328.791780205544, 8341.958290208631, 8346.8330633387, 8354.122817104238, 8357.038940521796, 12524.937375313066, 12577.874221257853, 12620.55828046014, 12640.367981600883, 12719.745605087846, 5029.974850125726, 5064.620153488503, 5067.569256613156, 5129.769160387791, 5138.640295179302, 717.9784606461815, 847.766864112374, 925.9536723502533, 928.9953550232341, 996.2080146283722, 24243.393915151908, 25551.0, 25766.0, 25804.483910322066, 25828.0, 830.3606223208096, 841.7685136587487, 855.8502262104231, 874.9912500875037, 891.919727224553, 12898.548550800677, 13054.527843102094, 13087.607371778862, 13181.670458238621, 13349.264595602705, 245937.0, 249044.0, 249535.0, 249630.0, 249849.0, 40060.19879602391, 41183.1763364731, 41455.79272103681, 41475.0, 41577.168456631305, 978.9118979291898, 1093.3658478082693, 1113.0427832064418, 1114.816055350858, 1134.3364131982883, 24154.275371738877, 24594.13920512845, 25104.0, 25253.873730631964, 25263.494730105664, 37500.43749343707, 37738.0, 37781.622183777814, 37932.62067379291, 37934.24131517409, 246770.0, 249065.0, 249700.0, 250867.0, 250883.0, 27291.454170916073, 27774.583381248893, 28388.432231354844, 28706.425871482872, 28899.855500722362, 36054.4591831128, 36092.27815443729, 36349.27301454009, 36807.89576312715, 37267.0, 31222.0, 31483.52774708427, 31640.36719265648, 31717.68282317147, 31821.20446988844, 30847.383052339275, 31388.0, 31754.36491270208, 31837.20406989844, 32172.0, 24474.26577202687, 26057.348566285993, 31550.842245788623, 31752.206194845312, 32235.838820805748, 25863.741362586134, 26957.73042269552, 27614.309642259104, 27629.171124866287, 27718.86140569365, 21920.561588767818, 22129.889350553145, 22151.224707135818, 22186.44533886601, 22227.333180004625], "unit": "score", "name": "ext.html", "value": 15196.374072634924}, {"lowerIsBetter": false, "replicates": [300.186494599635, 303.9802412843165, 306.38111015748206, 315.95734575832256, 316.90809665197094, 11429.485673144707, 12695.365231738422, 14591.854081459196, 15056.924715376408, 15071.397144114237, 10969.670909872697, 11077.723056923582, 11465.254758440695, 11478.0, 13526.32368381582, 4777.307290442884, 4864.7324397158145, 4966.230234313669, 4972.776225069862, 4974.079795237874, 4861.440934292548, 4888.046830867982, 4990.30135780991, 5019.598432125421, 5023.196288593826, 3493.7030352420074, 4962.776675049631, 5522.116461366182, 5769.105788602752, 5770.0, 5725.599208055438, 5739.196512488255, 5740.368559458435, 5759.078547432412, 5762.9135562966585, 4928.48250933654, 4947.431045429786, 5018.5985121190215, 5058.2412638104215, 5068.26510156029, 17534.561635959202, 17883.512715020577, 18003.459896203134, 18070.728939065924, 18165.54586135344, 1833.972490412645, 1965.1255191439816, 1989.7313862628505, 2006.3780228129326, 2090.6550419180817, 5953.553483488756, 11743.882561174365, 11767.764644707058, 11973.786737527673, 12241.755164896653, 1698.4649835301964, 1709.034395566501, 1732.913354332291, 1780.1188411736273, 1809.9185536650882, 54084.0, 54376.72811635956, 54605.45394546043, 54655.453445465835, 55425.445745542434, 8574.22831945128, 9072.228860546928, 9077.591508382138, 9639.168557974102, 9641.614335426644, 11912.821307680391, 12082.0, 12182.329971851455, 12184.451699673536, 12184.451699673536, 6308.432241098231, 6316.084167795644, 6356.491480681534, 6374.075759014917, 6402.551821372459, 5027.145385284511, 5516.862078448071, 5788.507976822018, 5789.768409263666, 5793.478586927196, 3997.9400308995387, 3998.8400463981698, 4009.6190861868076, 4058.9594104059174, 4083.612056854594, 1568.1845440371171, 1690.6027083635336, 1700.698965291553, 1710.2218490586754, 1751.3169863753146, 793.6983946100445, 825.7233826668133, 865.446114486729, 904.5974541329177, 928.6981730937472, 14217.19138297939, 14489.420423182955, 14663.56009319722, 14687.0, 15078.0199287046, 788.8501184774874, 803.9718609848744, 814.9633266503022, 871.3987348729484, 889.350773935031, 8228.21831925966, 8282.296004839656, 8412.411131220755, 8445.746627601182, 8552.315814734806, 355335.0, 357059.0, 360410.0, 362292.0, 364986.0, 60323.39676603178, 61581.0, 64089.67955160288, 64156.67921660455, 65020.0, 857.811281518065, 863.6459051788736, 866.9956650216709, 872.5462759365095, 872.8777971084053, 12980.415881285177, 13262.867371326163, 13336.333183340601, 13421.731565368833, 13506.0, 30614.693853061184, 31661.683383166794, 32128.839355803073, 32335.514967275038, 32739.34521309513, 43017.78491107524, 43053.0, 43244.351334730636, 43640.0, 43878.0, 5422.349318081855, 6688.331166883468, 6802.965985170043, 6873.690683919136, 6954.408875245458, 8691.608877600396, 9819.214462842812, 10068.24488163376, 10245.0, 10305.896941030494, 9178.67874624385, 9316.627334906529, 9760.46317452547, 9838.60645574169, 9974.20206383502, 7596.81007974805, 8831.60257788414, 8986.68546600866, 9414.105659962293, 9496.620135194515, 9472.668456603986, 9621.08599683029, 9638.903610964082, 9716.708498745049, 9893.50532473359, 6709.899351509634, 6726.159230096238, 6885.758998435031, 7073.045138906182, 7363.116426028911, 9897.802043959224, 9942.850857237003, 9997.350172238781, 10076.798464030824, 10101.747456313651], "unit": "score", "name": "jquery.html", "value": 7409.393292233756}, {"lowerIsBetter": false, "replicates": [1037.108087045141, 1098.9340639561626, 1121.6130434999925, 1138.755167638958, 1178.9410529473535, 6007.339192688801, 6639.435647969923, 6787.7624283150035, 6797.456203503708, 6798.660066996655, 6419.101325814389, 6584.14406127204, 6606.504512161583, 6612.735490580371, 6620.404163625273, 1648.5796121988876, 1671.7575951487088, 1672.841080097395, 1969.9015049247553, 2000.9599808003832, 1998.2306811877459, 2020.9696854547194, 2031.3296612117965, 2040.8265297449734, 2041.9081141348674, 1926.807319268069, 1927.5181204698824, 1932.1788239998016, 1932.3043704266522, 1934.8548858835572, 1931.1502938707065, 1933.7679478462603, 1934.796846331129, 1935.8354539864129, 1938.3797184900836, 1908.761404824397, 1917.1851962915844, 1958.6474434601766, 2002.91988320467, 2009.5378063045434, 6886.965565172192, 6889.069975553286, 6916.0, 6926.030355750199, 6953.6523173841615, 3748.269087527933, 3832.8466861325514, 3837.0407398150464, 3844.5770965193806, 3846.11539345952, 2570.961435578468, 2645.8412495250154, 2646.8147229693927, 2658.0563899815675, 2694.568868980973, 867.5055218525443, 869.395769939892, 870.3298460185684, 913.9634414623407, 1761.3659082730208, 9028.187463128284, 9175.632974681004, 9190.264778817678, 9195.908040919572, 9197.908020919773, 3541.2740388220354, 3635.1093981974586, 3711.0, 3712.0, 3721.1627383838963, 7674.232576742281, 7759.806004849924, 7779.7666070017995, 7786.610669466618, 7790.376769858398, 3879.2241551689776, 3923.1172986077904, 3925.293447179535, 3928.980355098206, 3940.665043471337, 2955.6305461817274, 3393.7285017198565, 3436.810975396327, 3474.861005559749, 3479.7912125272564, 3173.0, 3221.500667396557, 3242.416365054313, 3251.219707270285, 3254.625718042408, 994.7562847102362, 1046.6075221791828, 1047.6228557719214, 1056.2183983851894, 1059.2320567588438, 1003.645079143151, 1012.2863381316155, 1034.5189486888482, 1040.1678657074463, 1047.0314958663207, 6177.166082578884, 6319.747210111544, 6337.04944258365, 6342.873142537123, 6344.968275158687, 884.9778755531034, 886.6813283264346, 896.171041786345, 927.0127314410266, 971.4220039076738, 4969.801207951714, 5074.391073071255, 5078.060558796635, 5148.279240906276, 5149.613778966593, 7837.725679601187, 8112.553809540532, 8130.552819594861, 8157.632906519221, 8209.79475513105, 7963.601819909098, 7968.083670377865, 8037.316828069563, 8050.11448740638, 8130.552819594861, 6430.3891130342545, 6465.77369792055, 6495.382938620918, 6548.574342667806, 6573.57271777333, 6401.775937842153, 6460.903086453801, 6482.513811464065, 6506.219253689587, 6508.568115014689, 7222.855542889218, 7439.628018599156, 7498.437617178843, 7572.886406703794, 7706.190849960673, 7729.961350193213, 7933.642986065756, 7946.721864734706, 7977.082635496992, 8076.798080048045, 5067.721275329893, 5487.149491828773, 5878.265216847894, 5974.103884417372, 6004.099385092271, 6234.719437625227, 6252.3122456530655, 6271.216097987752, 6299.905501417574, 6300.2754683212015, 5435.701036443033, 5458.808941687022, 5484.1773733938635, 5595.440455954372, 5611.466910643482, 5252.9737351313, 5271.551918086852, 5304.761285742074, 5419.674819510842, 5739.942600573941, 5955.344912059583, 5971.462568368867, 5977.342492325927, 6065.969670151621, 6102.420270074336, 5401.594880384066, 5451.291332126957, 5496.258005169411, 5506.366767821752, 5613.326400831927, 5598.832035038955, 5631.577631677723, 5633.6619802811965, 5640.351359593536, 5668.886622267614], "unit": "score", "name": "mootools.html", "value": 3836.9131917753803}, {"lowerIsBetter": false, "replicates": [281.8914717833634, 282.43231105477986, 285.97855160862935, 288.76465680470415, 292.49836530350444, 5208.088584497712, 5208.895822083556, 5210.062188806009, 5257.526822585966, 5266.5786737061035, 5080.0, 5147.871303217412, 5161.793528258874, 5161.793528258874, 5169.09540830355, 3812.3137835189655, 3840.2511510255513, 3905.258000979819, 3959.8614048508307, 4003.9799801001027, 3952.940705889414, 3964.306246406867, 3985.880423587297, 4004.619561141687, 4005.259027079985, 3949.526056873179, 3956.406539019156, 3961.445397644332, 3961.722679412442, 3965.543962444327, 3779.584245732981, 3876.8449262029485, 3899.1032062625472, 3899.7465164764485, 3953.6639385651965, 3469.392856250146, 3496.7027802636553, 3502.527158833576, 3506.3513250048823, 3514.244437445936, 5002.049610573979, 5020.648554601179, 5024.899502009939, 5027.296178535008, 5031.018951304497, 4593.885152871205, 4598.609118224955, 4601.516840731709, 4604.861854144381, 4605.378273933044, 5415.241866138744, 5423.593230507728, 5424.945750542483, 5428.240046393508, 5430.022595932731, 3835.5780864104927, 3836.673882719972, 3839.2897313997, 3839.808009599537, 3840.2511510255513, 5520.447955204448, 5677.120046392815, 5704.486596206361, 5707.457791509842, 5716.114002329604, 3921.4706014687654, 3940.192260586573, 3945.822437990297, 3946.7039972002217, 3975.7216994810087, 3994.580569040209, 3996.900077498086, 3997.220541994341, 3997.420374045747, 4000.4799376081505, 4562.61217796491, 4563.54364563541, 4563.589276965089, 4568.1548913451115, 4573.3368661544555, 5434.70109143993, 5440.347158341025, 5441.156620723794, 5491.341039075257, 5502.257195278667, 1379.344811214685, 1420.5454254638416, 1422.07565082695, 1423.288355822089, 1423.6440889777555, 892.9107089291019, 924.1497822003772, 962.5812771444444, 979.4955597867104, 980.789130336981, 4730.219513780187, 4743.762811859393, 4750.714957102585, 4752.596029337545, 4766.022965292107, 5547.639403438763, 5606.579506537026, 5642.0, 5676.659400435987, 5677.37548869624, 4748.026654535812, 4764.904701906012, 4767.070421267819, 4770.7853146607795, 4776.23580227162, 2988.4321978823955, 3021.8640161192798, 3022.168903551497, 3022.712842280024, 3024.9243768905953, 5294.7352632369, 5317.654352467077, 5322.0308485859705, 5322.707251101227, 5331.733413329318, 5665.9716701417055, 5739.569532285095, 5858.179854820243, 5866.765329386777, 5874.559408044413, 5398.757055932492, 5423.159410291411, 5424.376196737347, 5424.972875135678, 5427.810026649048, 5717.656940583578, 5718.399568045462, 5722.914156287742, 5723.627964182315, 5724.284464441945, 5579.46995035471, 5586.16207568868, 5589.217509548747, 5593.0, 5593.664380137205, 5416.295881535375, 5419.729013549386, 5427.918581221364, 5468.371137319259, 5477.890442191054, 3645.799481028569, 3738.0841693785196, 3744.194998075427, 3756.417755247941, 3759.8684046058256, 5454.400015998316, 5692.6299790513485, 5711.914321285101, 5741.196232527366, 5763.36602973681, 5335.386430560535, 5504.80733174337, 5558.860433611181, 5562.110062389998, 5578.944210557843, 5464.371597266365, 5500.642458240201, 5504.697241651747, 5504.981578408007, 5507.7246137693755, 5370.382406023357, 5380.677159370451, 5382.165764306539, 5382.596305277199, 5384.434634363335, 5540.75066622011, 5546.112621980464, 5547.195656629686, 5550.833474995757, 5553.777848885999, 5226.555742761908, 5382.9192562112385, 5384.353877534721, 5385.40760516335, 5385.461453854583], "unit": "score", "name": "prototype.html", "value": 4091.0307697125513}, {"lowerIsBetter": false, "replicates": [536.7826030457666, 583.2039266401362, 598.1685457214472, 623.7754408412972, 624.4972796898501, 10743.355398676074, 10743.78512429751, 10764.515596798143, 10826.24216304858, 10941.1247100232, 10831.29596576222, 10857.837132442999, 10918.07196388306, 10973.0, 11080.501377438015, 549.0117787981617, 653.7646447278987, 661.4576047640936, 664.3622122762154, 666.3902529185789, 638.629594834997, 654.1300070905708, 656.0, 657.0964923230558, 657.3656421553201, 690.0442886602067, 691.4986634689835, 691.7855464805926, 692.0415224913506, 693.6809067828805, 563.352145033211, 662.4336192555392, 681.1757773094537, 681.4480270980497, 681.4752640466837, 495.14587336844016, 497.0506332904136, 497.25163628738517, 498.1581127893848, 498.3446767500725, 10703.304285221435, 10741.087007604363, 10784.245102842804, 10830.079443247334, 10838.620648277272, 10555.78888422235, 10690.144788416908, 10717.732056698567, 10755.83866242007, 11040.503177357039, 8916.631295098736, 9038.367314288002, 9144.588493517807, 9158.358914875962, 9302.116298951589, 3060.0, 3137.82741949195, 3141.6544180140168, 3149.653538110806, 3220.516922461626, 40099.19801603952, 40124.59875401267, 40415.0, 40728.79635601833, 41842.58157418448, 7476.401887848959, 7736.187700291501, 7844.529328240324, 7888.881666775003, 8139.4709343892455, 12965.481380744854, 13021.283829389475, 13043.608691739262, 13045.412956416983, 13122.212667239995, 5838.211841401441, 5877.853053673693, 5886.6173698709445, 5907.616004959664, 6017.759289628366, 3493.0, 3501.6914950442083, 3502.667246611568, 3566.268914872445, 3600.063983364344, 2424.1878970545067, 2435.0868424340874, 2445.205308274818, 2473.146764366327, 2496.962545561818, 448.5514485514486, 453.11190067467476, 466.05158502448035, 467.58852210055613, 477.6417686734949, 413.74968144272884, 433.5989209980755, 439.0998453170987, 482.68143025602933, 498.1755195152029, 6433.774817881352, 6848.554843935129, 6983.406410455168, 7048.0, 7049.506534542636, 424.4249042547366, 491.52813299232423, 495.7719449053404, 516.4087120247295, 528.7771035538387, 3174.698403651649, 3180.427523045828, 3270.0, 3272.149241197306, 3284.4744840825833, 47707.28439073417, 47899.281510777364, 47976.28035579469, 48124.27813582799, 48589.028219435415, 41473.377899331535, 42066.57933420688, 42531.36202956958, 42701.57298426976, 43343.0, 37752.62247377546, 38194.42708359377, 38408.42387364192, 39209.41185882214, 39334.80332598319, 7134.108236470442, 7174.677139528838, 7228.385587225145, 7342.70629174827, 7381.8523629526035, 29370.412591748474, 29397.85301073481, 29917.10248692543, 30282.0, 30300.848495757382, 33986.66013339934, 34033.0, 34058.489122662686, 35971.64028359787, 36873.44689829601, 8082.313003394542, 8570.700025499078, 8698.47809131454, 8832.425892316978, 8965.865512017195, 9960.950195248977, 9965.551550180404, 10187.898121018696, 10189.0, 10338.586456541654, 7918.802029949297, 9790.80418391614, 9798.706038818847, 9872.802543948937, 10299.330543514647, 9056.558923592724, 9114.954425227832, 9678.322517423712, 9854.47894715908, 9992.400455972665, 9337.903193572798, 9476.147146756824, 9638.662646807328, 9864.5560949756, 10616.416097114732, 7669.61651917413, 7692.730754423568, 7791.28839433069, 7808.726694565663, 7909.485883417559, 7412.518186317872, 7555.622218889143, 7562.508436951581, 7709.383249339927, 7714.228577142465], "unit": "score", "name": "yui.html", "value": 5098.613772166512}], "name": "dromaeo_css", "value": 5832.028702613996}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 116.0, 109.0, 114.0, 115.0, 113.0, 105.0, 116.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [156.0, 134.0, 154.0, 173.0, 143.0, 161.0, 157.0, 134.0, 172.0, 141.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 163.0, 161.0, 160.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 97.0, 93.0, 73.0, 73.0, 72.0, 111.0, 97.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 144.0, 97.0, 95.0, 95.0, 145.0, 95.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 68.0, 68.0, 66.0, 67.0, 76.0, 64.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.6}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 71.0, 71.0, 71.0, 70.0, 70.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.6}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 85.0, 83.0, 85.0, 83.0, 83.0, 84.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 119.0, 124.0, 117.0, 127.0, 132.0, 138.0, 123.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [155.0, 139.0, 164.0, 149.0, 147.0, 140.0, 152.0, 150.0, 148.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 75.0, 70.0, 72.0, 74.0, 70.0, 73.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1548.5}]} 09:46:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1548.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5832.03"}}} 09:46:29 INFO - Return code: 0 09:46:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:46:29 INFO - # TBPL SUCCESS # 09:46:29 INFO - Running post-action listener: _resource_record_post_action 09:46:29 INFO - Running post-run listener: _resource_record_post_run 09:46:30 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 16384; Write bytes: 525324288; Read time: 136; Write time: 752164 09:46:30 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233570304; Read time: 0; Write time: 438628 09:46:30 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 16384; Write bytes: 290422784; Read time: 136; Write time: 312148 09:46:30 INFO - Running post-run listener: _upload_blobber_files 09:46:30 INFO - Blob upload gear active. 09:46:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:46:30 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:46:30 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:46:30 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:46:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:46:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:46:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:46:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:31 INFO - (blobuploader) - INFO - Done attempting. 09:46:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:46:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:46:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:32 INFO - (blobuploader) - INFO - Done attempting. 09:46:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:46:32 INFO - Return code: 0 09:46:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:46:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:46:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3be78fd452d64edc6db5e1fd2deadec9b80bc6866cc556c7a18f97d3f810ba54c29d77f37a98e23dd022973b0ef35f8cba148b49eb7b06f6ba5bd06d87919e02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90871f9197e7075219621fda39f03bae58ef5b59793dbb2ae6a2da710bd2b5cceeccc02464575f958d1beb793af7ff8e6378e823514ab6c7c014c7a48a28ab15"} 09:46:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:46:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:46:32 INFO - Contents: 09:46:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3be78fd452d64edc6db5e1fd2deadec9b80bc6866cc556c7a18f97d3f810ba54c29d77f37a98e23dd022973b0ef35f8cba148b49eb7b06f6ba5bd06d87919e02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90871f9197e7075219621fda39f03bae58ef5b59793dbb2ae6a2da710bd2b5cceeccc02464575f958d1beb793af7ff8e6378e823514ab6c7c014c7a48a28ab15"} 09:46:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:46:32 INFO - Copying logs to upload dir... 09:46:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:46:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.490348 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-03 09:46:32.686889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 09:46:32.690830) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 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/3be78fd452d64edc6db5e1fd2deadec9b80bc6866cc556c7a18f97d3f810ba54c29d77f37a98e23dd022973b0ef35f8cba148b49eb7b06f6ba5bd06d87919e02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90871f9197e7075219621fda39f03bae58ef5b59793dbb2ae6a2da710bd2b5cceeccc02464575f958d1beb793af7ff8e6378e823514ab6c7c014c7a48a28ab15"} build_url:https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.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/3be78fd452d64edc6db5e1fd2deadec9b80bc6866cc556c7a18f97d3f810ba54c29d77f37a98e23dd022973b0ef35f8cba148b49eb7b06f6ba5bd06d87919e02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90871f9197e7075219621fda39f03bae58ef5b59793dbb2ae6a2da710bd2b5cceeccc02464575f958d1beb793af7ff8e6378e823514ab6c7c014c7a48a28ab15"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 09:46:32.716738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:46:32.717116) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457025557.301284-1590326019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:46:32.802788) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 09:46:32.803170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 09:46:32.803581) ========= ========= Total master_lag: 0.29 =========