builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1460067676.05 results: success (0) buildid: 20160407134248 builduid: 008a4e2cd1654c119cca4289d47dd39d revision: 06678484909cc3712756f82d070548ac144d09c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.053142) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.053517) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.053813) ========= 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=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007412 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.077723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.077999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.091814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.092075) ========= 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=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.150323) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.150583) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.150899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.151170) ========= 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=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 15:21:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 34.1M=0s 2016-04-07 15:21:16 (34.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155588 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.319245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.319546) ========= 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=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017231 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.405095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.405457) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 06678484909cc3712756f82d070548ac144d09c0 --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 06678484909cc3712756f82d070548ac144d09c0 --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=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 15:21:16,766 truncating revision to first 12 chars 2016-04-07 15:21:16,766 Setting DEBUG logging. 2016-04-07 15:21:16,766 attempt 1/10 2016-04-07 15:21:16,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/06678484909c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 15:21:17,014 unpacking tar archive at: mozilla-central-06678484909c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539847 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.958967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:16.959365) ========= echo 06678484909cc3712756f82d070548ac144d09c0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'06678484909cc3712756f82d070548ac144d09c0'] 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=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06678484909cc3712756f82d070548ac144d09c0 program finished with exit code 0 elapsedTime=0.004080 script_repo_revision: '06678484909cc3712756f82d070548ac144d09c0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:17.008478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:17.008800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 15:21:17.020405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-07 15:21:17.020702) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:21:17 INFO - MultiFileLogger online at 20160407 15:21:17 in /builds/slave/test 15:21:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:21:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:21:17 INFO - {'append_to_log': False, 15:21:17 INFO - 'base_work_dir': '/builds/slave/test', 15:21:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:21:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:21:17 INFO - 'branch': 'Firefox-Non-PGO', 15:21:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:21:17 INFO - 'config_files': ('talos/linux_config.py',), 15:21:17 INFO - 'default_actions': ('clobber', 15:21:17 INFO - 'read-buildbot-config', 15:21:17 INFO - 'download-and-extract', 15:21:17 INFO - 'populate-webroot', 15:21:17 INFO - 'create-virtualenv', 15:21:17 INFO - 'install', 15:21:17 INFO - 'run-tests'), 15:21:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:21:17 INFO - 'download_minidump_stackwalk': True, 15:21:17 INFO - 'download_symbols': 'ondemand', 15:21:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:21:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:21:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:21:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:21:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:21:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:21:17 INFO - 'installer_path': 'installer.exe', 15:21:17 INFO - 'log_level': 'info', 15:21:17 INFO - 'log_name': 'talos', 15:21:17 INFO - 'log_to_console': True, 15:21:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:21:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:21:17 INFO - 'opt_config_files': (), 15:21:17 INFO - 'pip_index': False, 15:21:17 INFO - 'sps_profile': False, 15:21:17 INFO - 'sps_profile_interval': 0, 15:21:17 INFO - 'suite': 'dromaeojs-e10s', 15:21:17 INFO - 'system_bits': '32', 15:21:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:21:17 INFO - 'title': 'talos-linux64-ix-025', 15:21:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:21:17 INFO - 'use_talos_json': True, 15:21:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:21:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:21:17 INFO - 'work_dir': 'build'} 15:21:17 INFO - ##### 15:21:17 INFO - ##### Running clobber step. 15:21:17 INFO - ##### 15:21:17 INFO - Running pre-action listener: _resource_record_pre_action 15:21:17 INFO - Running main action method: clobber 15:21:17 INFO - rmtree: /builds/slave/test/build 15:21:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:21:17 INFO - Running post-action listener: _resource_record_post_action 15:21:17 INFO - ##### 15:21:17 INFO - ##### Running read-buildbot-config step. 15:21:17 INFO - ##### 15:21:17 INFO - Running pre-action listener: _resource_record_pre_action 15:21:17 INFO - Running main action method: read_buildbot_config 15:21:17 INFO - Using buildbot properties: 15:21:17 INFO - { 15:21:17 INFO - "project": "", 15:21:17 INFO - "product": "firefox", 15:21:17 INFO - "script_repo_revision": "production", 15:21:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:21:17 INFO - "repository": "", 15:21:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:21:17 INFO - "buildid": "20160407134248", 15:21:17 INFO - "pgo_build": "False", 15:21:17 INFO - "basedir": "/builds/slave/test", 15:21:17 INFO - "buildnumber": 276, 15:21:17 INFO - "slavename": "talos-linux64-ix-025", 15:21:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:21:17 INFO - "platform": "ubuntu64_hw", 15:21:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:21:17 INFO - "branch": "mozilla-central", 15:21:17 INFO - "repo_path": "mozilla-central", 15:21:17 INFO - "revision": "06678484909cc3712756f82d070548ac144d09c0", 15:21:17 INFO - "stage_platform": "linux64", 15:21:17 INFO - "builduid": "008a4e2cd1654c119cca4289d47dd39d", 15:21:17 INFO - "slavebuilddir": "test" 15:21:17 INFO - } 15:21:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:21:17 INFO - Running post-action listener: _resource_record_post_action 15:21:17 INFO - ##### 15:21:17 INFO - ##### Running download-and-extract step. 15:21:17 INFO - ##### 15:21:17 INFO - Running pre-action listener: _resource_record_pre_action 15:21:17 INFO - Running main action method: download_and_extract 15:21:17 INFO - mkdir: /builds/slave/test/build/tests 15:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:17 INFO - https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:21:19 INFO - Downloaded 1361 bytes. 15:21:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:21:19 INFO - Using the following test package requirements: 15:21:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:21:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:21:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:19 INFO - u'jsshell-linux-x86_64.zip'], 15:21:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:21:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:21:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:21:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:21:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:21:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:21: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')]} 15:21:19 INFO - https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:21:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:21:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:21:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:21:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:21:21 INFO - Downloaded 22186012 bytes. 15:21:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:21:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:21:22 INFO - Return code: 0 15:21:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:21: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')]} 15:21:22 INFO - https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:21:23 INFO - Downloaded 22186012 bytes. 15:21:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:21:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:21:24 INFO - Return code: 0 15:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:24 INFO - https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:21:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:21:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:21:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:21:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:21:25 INFO - Downloaded 10847693 bytes. 15:21:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:21:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:21:26 INFO - Return code: 0 15:21: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')]} 15:21:26 INFO - https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:21:29 INFO - Downloaded 54037378 bytes. 15:21:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:21:29 INFO - mkdir: /builds/slave/test/properties 15:21:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:21:29 INFO - Writing to file /builds/slave/test/properties/build_url 15:21:29 INFO - Contents: 15:21:29 INFO - build_url:https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:21:30 INFO - Running post-action listener: _resource_record_post_action 15:21:30 INFO - Running post-action listener: set_extra_try_arguments 15:21:30 INFO - ##### 15:21:30 INFO - ##### Running populate-webroot step. 15:21:30 INFO - ##### 15:21:30 INFO - Running pre-action listener: _resource_record_pre_action 15:21:30 INFO - Running main action method: populate_webroot 15:21:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:21:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:21:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:21:30 INFO - '--tppagecycles', 15:21:30 INFO - '7'], 15:21:30 INFO - 'tests': ['tsvgm']}}, 15:21:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:21:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:21:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:21:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:21:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:30 INFO - 'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:30 INFO - 'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['damp', 'tps']}, 15:21:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:30 INFO - 'tests': ['damp', 'tps']}, 15:21:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['dromaeo_dom']}, 15:21:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:21:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['a11yr', 15:21:30 INFO - 'ts_paint', 15:21:30 INFO - 'tpaint', 15:21:30 INFO - 'sessionrestore', 15:21:30 INFO - 'sessionrestore_no_auto_restore', 15:21:30 INFO - 'tabpaint']}, 15:21:30 INFO - 'other-e10s': {'tests': ['a11yr', 15:21:30 INFO - 'ts_paint', 15:21:30 INFO - 'tpaint', 15:21:30 INFO - 'sessionrestore', 15:21:30 INFO - 'sessionrestore_no_auto_restore', 15:21:30 INFO - 'tabpaint']}, 15:21:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:21:30 INFO - 'ts_paint', 15:21:30 INFO - 'tpaint', 15:21:30 INFO - 'sessionrestore', 15:21:30 INFO - 'sessionrestore_no_auto_restore', 15:21:30 INFO - 'tabpaint']}, 15:21:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:21:30 INFO - 'ts_paint', 15:21:30 INFO - 'tpaint', 15:21:30 INFO - 'sessionrestore', 15:21:30 INFO - 'sessionrestore_no_auto_restore', 15:21:30 INFO - 'tabpaint']}, 15:21:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['a11yr', 15:21:30 INFO - 'ts_paint', 15:21:30 INFO - 'tpaint', 15:21:30 INFO - 'sessionrestore', 15:21:30 INFO - 'sessionrestore_no_auto_restore', 15:21:30 INFO - 'tabpaint']}, 15:21:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['a11yr', 15:21:30 INFO - 'ts_paint', 15:21:30 INFO - 'tpaint', 15:21:30 INFO - 'sessionrestore', 15:21:30 INFO - 'sessionrestore_no_auto_restore', 15:21:30 INFO - 'tabpaint']}, 15:21:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['tsvgx', 15:21:30 INFO - 'tsvgr_opacity', 15:21:30 INFO - 'tart', 15:21:30 INFO - 'tscrollx', 15:21:30 INFO - 'cart']}, 15:21:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:21:30 INFO - 'tsvgr_opacity', 15:21:30 INFO - 'tart', 15:21:30 INFO - 'tscrollx', 15:21:30 INFO - 'cart']}, 15:21:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:30 INFO - 'talos_options': ['--disable-e10s'], 15:21:30 INFO - 'tests': ['tp5o']}, 15:21:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:30 INFO - 'tests': ['tp5o']}, 15:21:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:30 INFO - 'talos_options': ['--disable-e10s', 15:21:30 INFO - '--xperf_path', 15:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:30 INFO - 'tests': ['tp5n']}, 15:21:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:30 INFO - 'talos_options': ['--xperf_path', 15:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:30 INFO - 'tests': ['tp5n']}}, 15:21:30 INFO - 'talos.zip': {'path': '', 15:21:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:21:30 INFO - Running post-action listener: _resource_record_post_action 15:21:30 INFO - ##### 15:21:30 INFO - ##### Running create-virtualenv step. 15:21:30 INFO - ##### 15:21:30 INFO - Running pre-action listener: _resource_record_pre_action 15:21:30 INFO - Running main action method: create_virtualenv 15:21:30 INFO - Creating virtualenv /builds/slave/test/build/venv 15:21:30 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 15:21:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:21:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:21:30 INFO - Using real prefix '/usr' 15:21:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:21:30 INFO - Installing distribute.............................................................................................................................................................................................done. 15:21:32 INFO - Installing pip.................done. 15:21:32 INFO - Return code: 0 15:21:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:32 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:32 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 15:21:32 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 15:21:32 INFO - Using env: {'DISPLAY': ':0', 15:21:32 INFO - 'HOME': '/home/cltbld', 15:21:32 INFO - 'LANG': 'en_US.UTF-8', 15:21:32 INFO - 'LANGUAGE': 'en_US:en', 15:21:32 INFO - 'LOGNAME': 'cltbld', 15:21:32 INFO - 'MAIL': '/var/mail/cltbld', 15:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:32 INFO - 'MOZ_NO_REMOTE': '1', 15:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:32 INFO - 'NO_EM_RESTART': '1', 15:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:32 INFO - 'PWD': '/builds/slave/test', 15:21:32 INFO - 'SHELL': '/bin/bash', 15:21:32 INFO - 'SHLVL': '1', 15:21:32 INFO - 'TERM': 'linux', 15:21:32 INFO - 'TMOUT': '86400', 15:21:32 INFO - 'USER': 'cltbld', 15:21:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:32 INFO - '_': '/tools/buildbot/bin/python'} 15:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:32 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 15:21:32 INFO - Cleaning up... 15:21:32 INFO - Return code: 0 15:21:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:32 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:32 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 15:21:32 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 15:21:32 INFO - Using env: {'DISPLAY': ':0', 15:21:32 INFO - 'HOME': '/home/cltbld', 15:21:32 INFO - 'LANG': 'en_US.UTF-8', 15:21:32 INFO - 'LANGUAGE': 'en_US:en', 15:21:32 INFO - 'LOGNAME': 'cltbld', 15:21:32 INFO - 'MAIL': '/var/mail/cltbld', 15:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:32 INFO - 'MOZ_NO_REMOTE': '1', 15:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:32 INFO - 'NO_EM_RESTART': '1', 15:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:32 INFO - 'PWD': '/builds/slave/test', 15:21:32 INFO - 'SHELL': '/bin/bash', 15:21:32 INFO - 'SHLVL': '1', 15:21:32 INFO - 'TERM': 'linux', 15:21:32 INFO - 'TMOUT': '86400', 15:21:32 INFO - 'USER': 'cltbld', 15:21:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:32 INFO - '_': '/tools/buildbot/bin/python'} 15:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:33 INFO - Downloading/unpacking psutil>=0.7.1 15:21:33 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 15:21:33 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 15:21:33 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 15:21:33 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 15:21:33 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 15:21:33 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 15:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:21:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:36 INFO - Installing collected packages: psutil 15:21:36 INFO - Running setup.py install for psutil 15:21:36 INFO - building 'psutil._psutil_linux' extension 15:21:36 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 15:21:36 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 15:21:36 INFO - building 'psutil._psutil_posix' extension 15:21:36 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 15:21:36 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 15:21:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:36 INFO - Successfully installed psutil 15:21:36 INFO - Cleaning up... 15:21:36 INFO - Return code: 0 15:21:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:21:36 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')]} 15:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:36 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')]} 15:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:36 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:36 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 15:21:36 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 15:21:36 INFO - Using env: {'DISPLAY': ':0', 15:21:36 INFO - 'HOME': '/home/cltbld', 15:21:36 INFO - 'LANG': 'en_US.UTF-8', 15:21:36 INFO - 'LANGUAGE': 'en_US:en', 15:21:36 INFO - 'LOGNAME': 'cltbld', 15:21:36 INFO - 'MAIL': '/var/mail/cltbld', 15:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:36 INFO - 'MOZ_NO_REMOTE': '1', 15:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:36 INFO - 'NO_EM_RESTART': '1', 15:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:36 INFO - 'PWD': '/builds/slave/test', 15:21:36 INFO - 'SHELL': '/bin/bash', 15:21:36 INFO - 'SHLVL': '1', 15:21:36 INFO - 'TERM': 'linux', 15:21:36 INFO - 'TMOUT': '86400', 15:21:36 INFO - 'USER': 'cltbld', 15:21:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:36 INFO - '_': '/tools/buildbot/bin/python'} 15:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:21:36 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 15:21:36 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 15:21:36 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 15:21:36 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 15:21:36 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 15:21:36 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 15:21:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:21:39 INFO - Installing collected packages: mozsystemmonitor 15:21:39 INFO - Running setup.py install for mozsystemmonitor 15:21:39 INFO - Successfully installed mozsystemmonitor 15:21:39 INFO - Cleaning up... 15:21:39 INFO - Return code: 0 15:21:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:21:39 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')]} 15:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:39 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')]} 15:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:39 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:39 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 15:21:39 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 15:21:39 INFO - Using env: {'DISPLAY': ':0', 15:21:39 INFO - 'HOME': '/home/cltbld', 15:21:39 INFO - 'LANG': 'en_US.UTF-8', 15:21:39 INFO - 'LANGUAGE': 'en_US:en', 15:21:39 INFO - 'LOGNAME': 'cltbld', 15:21:39 INFO - 'MAIL': '/var/mail/cltbld', 15:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:39 INFO - 'MOZ_NO_REMOTE': '1', 15:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:39 INFO - 'NO_EM_RESTART': '1', 15:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:39 INFO - 'PWD': '/builds/slave/test', 15:21:39 INFO - 'SHELL': '/bin/bash', 15:21:39 INFO - 'SHLVL': '1', 15:21:39 INFO - 'TERM': 'linux', 15:21:39 INFO - 'TMOUT': '86400', 15:21:39 INFO - 'USER': 'cltbld', 15:21:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:39 INFO - '_': '/tools/buildbot/bin/python'} 15:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:21:39 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 15:21:39 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 15:21:39 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 15:21:39 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 15:21:39 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 15:21:39 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 15:21:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:21:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:21:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:42 INFO - Downloading docopt-0.6.1.tar.gz 15:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:21:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:21:42 INFO - Running setup.py install for blobuploader 15:21:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:21:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:21:42 INFO - Running setup.py install for requests 15:21:42 INFO - Running setup.py install for docopt 15:21:42 INFO - Successfully installed blobuploader requests docopt 15:21:42 INFO - Cleaning up... 15:21:42 INFO - Return code: 0 15:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:42 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')]} 15:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:42 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')]} 15:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:42 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:42 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 15:21:42 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 15:21:42 INFO - Using env: {'DISPLAY': ':0', 15:21:42 INFO - 'HOME': '/home/cltbld', 15:21:42 INFO - 'LANG': 'en_US.UTF-8', 15:21:42 INFO - 'LANGUAGE': 'en_US:en', 15:21:42 INFO - 'LOGNAME': 'cltbld', 15:21:42 INFO - 'MAIL': '/var/mail/cltbld', 15:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:42 INFO - 'MOZ_NO_REMOTE': '1', 15:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:42 INFO - 'NO_EM_RESTART': '1', 15:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:42 INFO - 'PWD': '/builds/slave/test', 15:21:42 INFO - 'SHELL': '/bin/bash', 15:21:42 INFO - 'SHLVL': '1', 15:21:42 INFO - 'TERM': 'linux', 15:21:42 INFO - 'TMOUT': '86400', 15:21:42 INFO - 'USER': 'cltbld', 15:21:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:42 INFO - '_': '/tools/buildbot/bin/python'} 15:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:42 INFO - Running setup.py (path:/tmp/pip-KM6981-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:43 INFO - Running setup.py (path:/tmp/pip-_dSTA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:43 INFO - Running setup.py (path:/tmp/pip-sG1CeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:43 INFO - Running setup.py (path:/tmp/pip-0X7fw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:43 INFO - Running setup.py (path:/tmp/pip-IibXcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:43 INFO - Running setup.py (path:/tmp/pip-xd92yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:43 INFO - Running setup.py (path:/tmp/pip-FbsHaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:43 INFO - Running setup.py (path:/tmp/pip-urhGAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:43 INFO - Running setup.py (path:/tmp/pip-jSbsKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:43 INFO - Running setup.py (path:/tmp/pip-HEhxGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:43 INFO - Running setup.py (path:/tmp/pip-8PrKbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:43 INFO - Running setup.py (path:/tmp/pip-ADuw9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:43 INFO - Running setup.py (path:/tmp/pip-aAyHUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:43 INFO - Running setup.py (path:/tmp/pip-2nND6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:43 INFO - Running setup.py (path:/tmp/pip-kbow_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:44 INFO - Running setup.py (path:/tmp/pip-mpyMq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:44 INFO - Running setup.py (path:/tmp/pip-EcIIcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:21:44 INFO - Running setup.py install for manifestparser 15:21:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozcrash 15:21:44 INFO - Running setup.py install for mozdebug 15:21:44 INFO - Running setup.py install for mozdevice 15:21:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozfile 15:21:44 INFO - Running setup.py install for mozhttpd 15:21:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozinfo 15:21:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozInstall 15:21:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:21:44 INFO - Running setup.py install for mozleak 15:21:45 INFO - Running setup.py install for mozlog 15:21:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:21:45 INFO - Running setup.py install for moznetwork 15:21:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:21:45 INFO - Running setup.py install for mozprocess 15:21:45 INFO - Running setup.py install for mozprofile 15:21:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:21:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:21:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:21:45 INFO - Running setup.py install for mozrunner 15:21:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:21:45 INFO - Running setup.py install for mozscreenshot 15:21:45 INFO - Running setup.py install for moztest 15:21:45 INFO - Running setup.py install for mozversion 15:21:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:21:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:21:45 INFO - Cleaning up... 15:21:45 INFO - Return code: 0 15:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:45 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')]} 15:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:45 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')]} 15:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:45 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:45 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 15:21:45 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 15:21:45 INFO - Using env: {'DISPLAY': ':0', 15:21:45 INFO - 'HOME': '/home/cltbld', 15:21:45 INFO - 'LANG': 'en_US.UTF-8', 15:21:45 INFO - 'LANGUAGE': 'en_US:en', 15:21:45 INFO - 'LOGNAME': 'cltbld', 15:21:45 INFO - 'MAIL': '/var/mail/cltbld', 15:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:45 INFO - 'MOZ_NO_REMOTE': '1', 15:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:45 INFO - 'NO_EM_RESTART': '1', 15:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:45 INFO - 'PWD': '/builds/slave/test', 15:21:45 INFO - 'SHELL': '/bin/bash', 15:21:45 INFO - 'SHLVL': '1', 15:21:45 INFO - 'TERM': 'linux', 15:21:45 INFO - 'TMOUT': '86400', 15:21:45 INFO - 'USER': 'cltbld', 15:21:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:45 INFO - '_': '/tools/buildbot/bin/python'} 15:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:46 INFO - Running setup.py (path:/tmp/pip-Op4DOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:46 INFO - Running setup.py (path:/tmp/pip-wiKqFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:46 INFO - Running setup.py (path:/tmp/pip-lC1uYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:46 INFO - Running setup.py (path:/tmp/pip-E7WST5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:46 INFO - Running setup.py (path:/tmp/pip-nw6sRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:46 INFO - Running setup.py (path:/tmp/pip-25oRSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:46 INFO - Running setup.py (path:/tmp/pip-RTxRwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:46 INFO - Running setup.py (path:/tmp/pip-P1JAzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:46 INFO - Running setup.py (path:/tmp/pip-RD0nzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:46 INFO - Running setup.py (path:/tmp/pip-6Y4zEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:46 INFO - Running setup.py (path:/tmp/pip-A7mzzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:46 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)) 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:46 INFO - Running setup.py (path:/tmp/pip-x2_ain-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:47 INFO - Running setup.py (path:/tmp/pip-Aq0kid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:47 INFO - Running setup.py (path:/tmp/pip-eJRRpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:47 INFO - Running setup.py (path:/tmp/pip-7sXQpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:47 INFO - Running setup.py (path:/tmp/pip-9s04R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:47 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)) 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:47 INFO - Running setup.py (path:/tmp/pip-UBo9KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:47 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)) 15:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:47 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)) 15:21:47 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)) 15:21:47 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)) 15:21:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:21:47 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 15:21:47 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 15:21:47 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 15:21:47 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 15:21:47 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 15:21:47 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 15:21:49 INFO - Downloading blessings-1.6.tar.gz 15:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:21:49 INFO - Installing collected packages: blessings 15:21:49 INFO - Running setup.py install for blessings 15:21:49 INFO - Successfully installed blessings 15:21:49 INFO - Cleaning up... 15:21:49 INFO - Return code: 0 15:21:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:21:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:49 INFO - Reading from file tmpfile_stdout 15:21:49 INFO - Current package versions: 15:21:49 INFO - argparse == 1.2.1 15:21:49 INFO - blessings == 1.6 15:21:49 INFO - blobuploader == 1.2.4 15:21:49 INFO - docopt == 0.6.1 15:21:49 INFO - manifestparser == 1.1 15:21:49 INFO - mozInstall == 1.12 15:21:49 INFO - mozcrash == 0.17 15:21:49 INFO - mozdebug == 0.1 15:21:49 INFO - mozdevice == 0.48 15:21:49 INFO - mozfile == 1.2 15:21:49 INFO - mozhttpd == 0.7 15:21:49 INFO - mozinfo == 0.9 15:21:49 INFO - mozleak == 0.1 15:21:49 INFO - mozlog == 3.1 15:21:49 INFO - moznetwork == 0.27 15:21:49 INFO - mozprocess == 0.22 15:21:49 INFO - mozprofile == 0.28 15:21:49 INFO - mozrunner == 6.11 15:21:49 INFO - mozscreenshot == 0.1 15:21:49 INFO - mozsystemmonitor == 0.0 15:21:49 INFO - moztest == 0.7 15:21:49 INFO - mozversion == 1.4 15:21:49 INFO - psutil == 3.1.1 15:21:49 INFO - requests == 1.2.3 15:21:49 INFO - wsgiref == 0.1.2 15:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:49 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:49 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 15:21:49 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 15:21:49 INFO - Using env: {'DISPLAY': ':0', 15:21:49 INFO - 'HOME': '/home/cltbld', 15:21:49 INFO - 'LANG': 'en_US.UTF-8', 15:21:49 INFO - 'LANGUAGE': 'en_US:en', 15:21:49 INFO - 'LOGNAME': 'cltbld', 15:21:49 INFO - 'MAIL': '/var/mail/cltbld', 15:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:49 INFO - 'MOZ_NO_REMOTE': '1', 15:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:49 INFO - 'NO_EM_RESTART': '1', 15:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:49 INFO - 'PWD': '/builds/slave/test', 15:21:49 INFO - 'SHELL': '/bin/bash', 15:21:49 INFO - 'SHLVL': '1', 15:21:49 INFO - 'TERM': 'linux', 15:21:49 INFO - 'TMOUT': '86400', 15:21:49 INFO - 'USER': 'cltbld', 15:21:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:49 INFO - '_': '/tools/buildbot/bin/python'} 15:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 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)) 15:21:49 INFO - Cleaning up... 15:21:49 INFO - Return code: 0 15:21:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:49 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:49 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 15:21:49 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 15:21:49 INFO - Using env: {'DISPLAY': ':0', 15:21:49 INFO - 'HOME': '/home/cltbld', 15:21:49 INFO - 'LANG': 'en_US.UTF-8', 15:21:49 INFO - 'LANGUAGE': 'en_US:en', 15:21:49 INFO - 'LOGNAME': 'cltbld', 15:21:49 INFO - 'MAIL': '/var/mail/cltbld', 15:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:49 INFO - 'MOZ_NO_REMOTE': '1', 15:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:49 INFO - 'NO_EM_RESTART': '1', 15:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:49 INFO - 'PWD': '/builds/slave/test', 15:21:49 INFO - 'SHELL': '/bin/bash', 15:21:49 INFO - 'SHLVL': '1', 15:21:49 INFO - 'TERM': 'linux', 15:21:49 INFO - 'TMOUT': '86400', 15:21:49 INFO - 'USER': 'cltbld', 15:21:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:49 INFO - '_': '/tools/buildbot/bin/python'} 15:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:50 INFO - Downloading/unpacking jsonschema 15:21:50 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 15:21:50 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 15:21:50 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 15:21:50 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 15:21:50 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 15:21:50 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 15:21:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:21:52 INFO - Downloading/unpacking functools32 (from jsonschema) 15:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:21:52 INFO - warning: no files found matching '*.txt' 15:21:52 INFO - no previously-included directories found matching 'build' 15:21:52 INFO - no previously-included directories found matching 'dist' 15:21:52 INFO - no previously-included directories found matching '.git*' 15:21:52 INFO - Installing collected packages: jsonschema, functools32 15:21:52 INFO - Running setup.py install for functools32 15:21:52 INFO - warning: no files found matching '*.txt' 15:21:52 INFO - no previously-included directories found matching 'build' 15:21:52 INFO - no previously-included directories found matching 'dist' 15:21:52 INFO - no previously-included directories found matching '.git*' 15:21:52 INFO - Successfully installed jsonschema functools32 15:21:52 INFO - Cleaning up... 15:21:52 INFO - Return code: 0 15:21:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:52 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 0x7fd32f5bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, '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': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', '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 15:21:52 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 15:21:52 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 15:21:52 INFO - Using env: {'DISPLAY': ':0', 15:21:52 INFO - 'HOME': '/home/cltbld', 15:21:52 INFO - 'LANG': 'en_US.UTF-8', 15:21:52 INFO - 'LANGUAGE': 'en_US:en', 15:21:52 INFO - 'LOGNAME': 'cltbld', 15:21:52 INFO - 'MAIL': '/var/mail/cltbld', 15:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:52 INFO - 'MOZ_NO_REMOTE': '1', 15:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:52 INFO - 'NO_EM_RESTART': '1', 15:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:52 INFO - 'PWD': '/builds/slave/test', 15:21:52 INFO - 'SHELL': '/bin/bash', 15:21:52 INFO - 'SHLVL': '1', 15:21:52 INFO - 'TERM': 'linux', 15:21:52 INFO - 'TMOUT': '86400', 15:21:52 INFO - 'USER': 'cltbld', 15:21:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:52 INFO - '_': '/tools/buildbot/bin/python'} 15:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:52 INFO - Downloading/unpacking flake8 15:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:21:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:21:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:21:55 INFO - no previously-included directories found matching 'docs/_build' 15:21:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:21:55 INFO - Running setup.py install for pep8 15:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:21:55 INFO - no previously-included directories found matching 'docs/_build' 15:21:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:21:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:21:55 INFO - Cleaning up... 15:21:55 INFO - Return code: 0 15:21:55 INFO - Running post-action listener: _resource_record_post_action 15:21:55 INFO - Running post-action listener: _start_resource_monitoring 15:21:55 INFO - Starting resource monitoring. 15:21:55 INFO - ##### 15:21:55 INFO - ##### Running install step. 15:21:55 INFO - ##### 15:21:55 INFO - Running pre-action listener: _resource_record_pre_action 15:21:55 INFO - Running main action method: install 15:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:55 INFO - Reading from file tmpfile_stdout 15:21:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:21:55 INFO - Reading from file tmpfile_stdout 15:21:55 INFO - Output received: 15:21:55 INFO - Usage: mozinstall [options] installer 15:21:55 INFO - Options: 15:21:55 INFO - -h, --help show this help message and exit 15:21:55 INFO - -d DEST, --destination=DEST 15:21:55 INFO - Directory to install application into. [default: 15:21:55 INFO - "/builds/slave/test"] 15:21:55 INFO - --app=APP Application being installed. [default: firefox] 15:21:55 INFO - mkdir: /builds/slave/test/build/application 15:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:22:11 INFO - Reading from file tmpfile_stdout 15:22:11 INFO - Output received: 15:22:11 INFO - /builds/slave/test/build/application/firefox/firefox 15:22:11 INFO - Running post-action listener: _resource_record_post_action 15:22:11 INFO - ##### 15:22:11 INFO - ##### Running run-tests step. 15:22:11 INFO - ##### 15:22:11 INFO - Running pre-action listener: _resource_record_pre_action 15:22:11 INFO - Running main action method: run_tests 15:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:22:11 INFO - Python 2.7.3 15:22:11 INFO - Return code: 0 15:22:11 INFO - grabbing minidump binary from tooltool 15:22: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')]} 15:22:11 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 0x23ab410>, '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 0x23ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ac7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:22:11 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 15:22:11 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 15:22:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:22:11 INFO - Return code: 0 15:22:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:22:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:22:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:22:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:22:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:22:12 INFO - Return code: 0 15:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:22:12 INFO - Using env: {'DISPLAY': ':0', 15:22:12 INFO - 'HOME': '/home/cltbld', 15:22:12 INFO - 'LANG': 'en_US.UTF-8', 15:22:12 INFO - 'LANGUAGE': 'en_US:en', 15:22:12 INFO - 'LOGNAME': 'cltbld', 15:22:12 INFO - 'MAIL': '/var/mail/cltbld', 15:22:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:22:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:12 INFO - 'MOZ_NO_REMOTE': '1', 15:22:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:12 INFO - 'NO_EM_RESTART': '1', 15:22:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:12 INFO - 'PWD': '/builds/slave/test', 15:22:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:22:12 INFO - 'SHELL': '/bin/bash', 15:22:12 INFO - 'SHLVL': '1', 15:22:12 INFO - 'TERM': 'linux', 15:22:12 INFO - 'TMOUT': '86400', 15:22:12 INFO - 'USER': 'cltbld', 15:22:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121', 15:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:12 INFO - '_': '/tools/buildbot/bin/python'} 15:22:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:22:12 INFO - mozversion application_buildid: 20160407134248 15:22:12 INFO - mozversion application_changeset: 06678484909cc3712756f82d070548ac144d09c0 15:22:12 INFO - mozversion application_display_name: Nightly 15:22:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:22:12 INFO - mozversion application_name: Firefox 15:22:12 INFO - mozversion application_remotingname: firefox 15:22:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:22:12 INFO - mozversion application_vendor: Mozilla 15:22:12 INFO - mozversion application_version: 48.0a1 15:22:12 INFO - mozversion platform_buildid: 20160407134248 15:22:12 INFO - mozversion platform_changeset: 06678484909cc3712756f82d070548ac144d09c0 15:22:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:22:12 INFO - mozversion platform_version: 48.0a1 15:22:12 INFO - using testdate: 1460067732 15:22:12 INFO - actual date: 1460067732 15:22:12 INFO - starting webserver on 'localhost:60655' 15:22:12 INFO - SUITE-START | Running 2 tests 15:22:12 INFO - TEST-START | dromaeo_css 15:22:12 INFO - operating with platform_type : linux_ 15:22:12 INFO - Initialising browser for dromaeo_css test... 15:22:12 INFO - TEST-INFO | started process 2121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrpHbi/profile http://localhost:60655/getInfo.html) 15:22:16 INFO - PROCESS | 2121 | 15:22:16 INFO - PROCESS | 2121 | (process:2189): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:22:16 INFO - PROCESS | 2121 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:22:17 INFO - PROCESS | 2121 | __metrics Screen width/height:1600/1200 15:22:17 INFO - PROCESS | 2121 | colorDepth:24 15:22:17 INFO - PROCESS | 2121 | Browser inner width/height: 1024/697 15:22:17 INFO - PROCESS | 2121 | __metrics 15:22:18 ERROR - PROCESS | 2121 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 15:22:19 INFO - TEST-INFO | 2121: exit 0 15:22:19 INFO - Browser initialized. 15:22:19 INFO - Running cycle 1/1 for dromaeo_css test... 15:22:19 INFO - TEST-INFO | started process 2240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrpHbi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:21 INFO - PROCESS | 2240 | 15:22:21 INFO - PROCESS | 2240 | (process:2298): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:22:31 INFO - PROCESS | 2240 | RSS: Main: 163966976 15:22:31 INFO - PROCESS | 2240 | 15:23:20 INFO - PROCESS | 2240 | 1460067800788 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] 15:25:32 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:60655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60655/tests/dromaeo/cssquery-ext.html) 15:25:33 INFO - PROCESS | 2240 | RSS: Main: 168878080 15:25:33 INFO - PROCESS | 2240 | 15:28:35 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:60655/tests/dromaeo/cssquery-ext.html (next: http://localhost:60655/tests/dromaeo/cssquery-jquery.html) 15:28:36 INFO - PROCESS | 2240 | RSS: Main: 165257216 15:28:36 INFO - PROCESS | 2240 | 15:31:37 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:60655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60655/tests/dromaeo/cssquery-mootools.html) 15:31:38 INFO - PROCESS | 2240 | RSS: Main: 166424576 15:31:38 INFO - PROCESS | 2240 | 15:34:40 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:60655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60655/tests/dromaeo/cssquery-prototype.html) 15:34:40 INFO - PROCESS | 2240 | RSS: Main: 164012032 15:34:40 INFO - PROCESS | 2240 | 15:37:43 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:60655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60655/tests/dromaeo/cssquery-yui.html) 15:37:44 INFO - PROCESS | 2240 | RSS: Main: 165396480 15:37:44 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:60655/tests/dromaeo/cssquery-yui.html (next: http://localhost:60655/tests/dromaeo/cssquery-dojo.html) 15:40:46 INFO - PROCESS | 2240 | RSS: Main: 167579648 15:40:46 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | __start_tp_report 15:40:46 INFO - PROCESS | 2240 | _x_x_mozilla_page_load 15:40:46 INFO - PROCESS | 2240 | _x_x_mozilla_page_load_details 15:40:46 INFO - PROCESS | 2240 | |i|pagename|runs| 15:40:46 INFO - PROCESS | 2240 | |0;dojo.html;2632.1182403894695;2680.262927694884;2683.8389696618206;2690.6367640368544;2700.270926849752;4639.559241872025;4664.696794708346;4665.626749860012;4675.228587283098;4708.62331013519;4577.2218722817115;4728.385309909707;4761.142994261032;4785.54537318955;4801.4718380978065;4319.956800432003;4324.502682191541;4376.6936314458;4387.210302145612;4418.867433976986;4407.933880991788;4408.86773396797;4439.511653718105;4457.977710111445;4496.033352829141;4248.681348898814;4348.086901750637;4357.041450880801;4418.5581441855875;4439.356293337481;4335.631471324941;4340.52254252032;4351.543087975749;4358.934615980763;4390.187815254157;4325.13497300538;4327.870163895088;4330.372096046056;4378.124375124988;4386.8903277418;4441.622462090726;4615.83844565442;4684.859454216379;4700.341952126705;4723.385959825235;4956.058348913695;5003.124453220708;5014.272930425104;5018.573421259197;5050.191969284933;4980.726060066695;5012.423571289312;5051.545360917535;5053.418856831438;5096.694198348111;4678.1813182692895;4723.551262630044;4725.503822098699;4756.31033500144;4769.66612337133;5069.214271787805;5081.18701007837;5082.288479612857;5104.821331253388;5119.46245644202;4768.165571025057;4856.757162141949;4857.417109946829;4922.237053256751;4951.653384263139;4978.228374601942;5057.848264552069;5058.114829904752;5062.291279220912;5108.795648174031;5038.5969122470115;5041.243813427942;5041.773120209599;5050.444451110375;5086.593072554187;4955.231939049453;5004.724740139254;5028.647994640413;5029.698218106925;5066.392032956069;4326.935095973563;4330.0906809569715;4344.087741574304;4374.321980093091;4376.212281789309;3754.4931434256573;3755.5681096673684;3776.15036616759;3801.6008319126645;3807.4669546263544;4311.6335111515245;4423.62399196072;4431.158079964796;4434.778261086997;4490.910181796346;4992.90014199714;4994.5754610858485;5006.599472042228;5026.673266237683;5050.9494905051215;4376.6498680105515;4380.167768124046;4383.1452866691325;4388.385626012361;4441.533638967861;4513.074819661962;4568.588827005519;4620.930686039645;4682.040181762731;4693.436787585511;4809.879753006133;4826.493218212107;4836.226203807374;4844.95155048452;4861.343718598086;5097.6941383517105;5112;5126.282320475062;5126.923096153486;5163.974180129076;4695.272232803921;4835.492273311252;4855.562999330077;4869.074875773592;4894.339264199288;4982.7508624569355;4984.352034235526;4995.650304478797;5027.723475208899;5053.26727624485;4935.210366341368;5029.29589857413;5045.974770126126;5047.167217409086;5091.59267258611;4798.832040878692;4856.708597484162;4917.459079501181;4972.726500042532;4993.775280112331;4920.532549407801;4922.532359425849;4939.283803848493;4946.678465899705;4967.205247160437;4808.110499557593;4861.1006963711825;4872.025594881109;4872.6832755870755;4909.68087074339;4857.489963553918;4864.73243971585;4903.436104847988;4937.1113199624415;4940.407151141886;4811;4862.027594481188;4880.097182021337;4901.436334821541;4908.680935739166 15:40:46 INFO - PROCESS | 2240 | |1;ext.html;574.5292052345992;597.1937883856793;602.0307305238565;614.1064750787604;624.7500999600156;32969.83515082427;34004;34031.82984085076;34058.48912266318;34278.65721342786;34403.13992150198;34956.650433495655;34964;35044.47433288502;35075;7480.4015678745845;7645.120811106711;7654.617269136549;7658.502197357182;7667;7518.360939320164;7720.884186737204;7741.5355078695175;7746.651400686983;7750;7636.350910172614;7765.262300081483;7776.688932442696;7791.883121753178;7819.296263336299;7617.162112167657;7705.614719264015;7708.267714567107;7717.421193410517;7742.61286935651;7628.237176282383;7735.4585179037485;7747.767566973;7753.147153813076;7772.7279545216215;29303.413931721458;34048;34315;34328.82835585831;34427.139321516916;2858.4140251248446;2941.352902361477;2966.362232120083;3111.9222019449467;3311.9668803311897;26358.341041474116;26874.5968810468;27403.862980684968;27876.721232787615;28149.718502814914;3466.231983867848;3500.9824950875336;3535.964640353615;3577.6422357764013;3596.478510615972;228828;232320;234487;235558;235772.82113589495;58398;58741.41258587359;59005.11492327618;59111;59272;61178.69410652918;61264.69367653133;61294.69352653208;61433.07850382248;61865.38134618596;15009.099454032794;15763.211839408214;15782.68434631301;15801.920990395205;15807.604809879846;11591.76816463666;11758.470868810924;11786;11796.646100616996;11822.172447928562;18842.71735923962;19434.70847937282;19646.21415143407;19648.70526942097;19853.205871765258;7296.70813167478;7450.2549745026145;7470.85058298831;7480.925190748132;7601.201873803282;844.8268105038452;874.908134645853;900.3607438718452;943.4527973775193;1042.5777560088177;28027.439451210863;28239.328887244938;28522.857385712938;28655;28731.56902646462;944.5466176235445;987.7185002274317;1034.1881622925966;1056.155075939261;1118.9160812939062;14927.701445971019;15135;15238.847611523743;15283.847161528465;15410.613044825795;347845;349938;350097;353083;353430;47591.28613070807;48114.518854811;48188.518114819104;48273.517264827606;48299;1168.8305195746739;1175.4651633506735;1191.3090407563593;1242.099477878549;1265.2282107914166;26571.33571660724;27950.440991179657;27987;28438.85780571167;28534.286642834097;43614.29278511362;43842.56157438512;44447.55552444434;44471.33293000543;44733.105337893714;303982;306096;306218;307374;309629;26096;26247;26446.735532644427;36020;36937.63062369342;40238.597614023485;40805.59194408018;41015.1796964065;41083.17833643251;42190.57809421989;33801;34114.31771364509;34179.31641367209;34362.14094647654;34500.48249276212;34617.65382346144;36533.634663654084;36901.26197476089;36945.81527092347;37321.2535749278;36622;36845.07887302839;37916.24167516579;39173.608263917;39500.20999579935;28924.710752893043;31066.844665776527;31516.369672606877;31574.842125789222;31685.940413873024;26088.217353479427;26426.60360094562;26466.338341541614;26512.337191570365;26624.20127396181 15:40:46 INFO - PROCESS | 2240 | |2;jquery.html;367.5607648859612;368.4381318489304;375.90226541099304;382.10587225891413;383.9347310957137;15665.686686266283;16390.34438622455;17529.82470175298;17560.912195439007;17661.823381766193;16239.188040597983;16461.506154815346;17191.742123868153;17211.655766884654;17223.483295501122;5133.537981581657;5300.708461034642;5303.23103150043;5315;5325.334333208349;3758.3047136279874;5219.425863155069;5722.856928576777;6027.246594175728;6054.5459090568165;5964.2842858857;5977.282726072877;5982.820515384546;6000.009998350267;6004.369541198177;5719.571032172604;6139.600925939844;6140.662263575501;6145.324014358417;6157.907631385533;5151.716655583941;5321.707306098163;5365.409804921455;5386.111291636876;5421.241026256327;10428.426436545988;10949.507272172692;20134.194632214694;20298.086586103662;20496.487587810276;1664.2843577261772;1824.5985883105695;1944.9222031118738;2202.966955495669;2222.8774468893107;8670.176333248395;9022;9032;9074.319426043074;9081.318901082379;1695.6354383807418;1767.6376342849685;1784.4825000749768;1816.7002444596626;1818.2454281473172;68987.65506172487;69398.65300673514;69652.3034769656;69752.651236744;69824.95262571116;9341.11259430353;9595.90404095964;9608.75978100539;9739.074787895139;9922.454265015493;13047;13090.607281781562;13185.945124390026;13211.66970825737;13239.338033098307;7116.466265030143;7186.676599553032;7273.89089163663;7385.187629360766;7400.296971787671;6898.896516552256;7004.2645522220455;7040.049593304941;7104.467164962649;7152.392046676091;4012.277789997828;4030;4051.655609273245;4116.4648595682365;4121.732087414309;1582.1693610854163;1642.2363600925628;1689.923953422099;1770.5927636643644;1781.3789451598982;874.2918236228675;912.3567884641312;929.419113054341;929.9349045566745;1021.0351218098825;16213.513594592181;16668.58328541796;16737.832621673628;17059.976401415955;17147.314107435814;842.751388340441;858.5835869603237;867.3018220332693;876.2245412809709;895.5880295064213;9297;9437.386569872937;9524.14282714559;9537.14165725088;9613.471259080818;366597;367051;369901;369997;394502;75032.62483687655;78183.60908195536;78629.60685196538;79294;80294;907.1880666803174;920.8020275640903;933.2906990687127;937.1659223291276;938.3525367496542;14810.961320273324;14861.331240094005;15021.699566008838;15052.247387630356;15167.938244322791;31877.521837172924;32875.835620821745;33379.666203337656;33956.49065264072;34187.829060854536;45128.32307515324;46431;46534.30198547092;46722.53277467182;47267;7283.708651654087;7449.180590134973;7472.663730132048;7658.2724641159;7752.612369381621;11159.776804464027;11481.138914581274;11553.884461155281;11630.53477860876;11940;10039.397636141563;10141.543630536791;10258.743531411475;10441.895581044093;10450.895491044992;10105.898941010495;10188;10317.432541210006;10534.736631584272;10598.25812193139;9940.304178707422;10099.192064634959;10343.293356596378;10477.790444190921;10688.465576721288;7405.370543503647;7436.107667079985;7512.924870751441;7525.924740752742;7582.317591416799;9590.184834289164;9647.855282170913;9678.17735492491;9685.41887486753;9912.405255684682 15:40:46 INFO - PROCESS | 2240 | |3;mootools.html;1414.4554346576572;1452.0706747681481;1579.3287852662622;1734.7091371317485;1741.8345257200563;6822.1131252937175;7352.411807055436;7540.81147971301;7581.241875812416;7632.465727399084;7718.112417072039;7783.299503044725;7793.142754297023;7797.142314345418;7798.805029874256;2163.156369016085;2201.7357917049894;2213.2806837777784;2213.501962058532;2219.3341997400794;2209.0942713487475;2242.8542144760618;2248.2693124734446;2248.8313376496826;2251.9774802252014;2123.4479035450818;2156.2345367394582;2159.416957421495;2173.119886445984;2232.553489302138;2171.272623671072;2180.749213840405;2183.366823621148;2186.2238905188588;2187.3437968609433;2093.11042806808;2095.800898914616;2109.5253567947243;2110.082114280293;2112.767595564487;7991.20087991202;7999.640016199227;8017.35861131114;8018.959905200437;8074.152214017502;4506.571875671839;4668.789904454307;4680.3447517347595;4700.388949436586;4711.293306004127;2689.193242027384;2734.904278350248;2771.986140069307;2934.779891508124;2950.070727720761;862.728240604214;880.9295256379474;900.4012331799346;901.7970956534792;902.7788191892963;10649.041586257197;10776.245662803607;10796.51415686296;10800.459977001197;10801.83797243042;4051.8784436466954;4176.686748493875;4332.9133417332105;4352.673549483801;4419.513853476115;9211.309151813506;9246.26029917605;9247.583858726239;9248.953755231316;9252.95373523128;4680.53194680536;4708.929366059443;4720.834770783006;4721.95278047222;4734.242521196592;3704.7777133372083;4097.303458412077;4259.957400425956;4290.334998075241;4323.848665296699;3732.458793474931;3803.695704343646;3832.9233415331537;3871.6902647788675;3887.7861717605238;1252.9310887901254;1255.9309237991997;1257.7673130470891;1275.253976423784;1276.189619591566;903.4804987132425;925.9629614815467;926.4441335198961;972.6644307713827;1198.634416502975;7355.264473552602;7357.484976051625;7373.741919032808;7402.037735094404;7430.7399241026305;440.649683501617;1090.4166271044953;1136.1819489967374;1148.1618418554501;1150.5742875136086;5684.971575142181;5828.766849326064;5842.912356314659;5862.14998825168;5879.5002424794375;8898.644054237888;9141.994380618127;9424.528773561431;9431.245500359955;9474.431534107976;9352.158305752379;9355.53222338894;9374.812503749887;9413.058694130668;9471;6979.092717946736;7229.783106506813;7253.601051942088;7258.491905566665;7259.89110163348;7427.294407031323;7431.925680743123;7463.850722985619;7529.887051694339;7656.923430765621;8540.74377768668;8541.572921353783;8748.256398206224;8852.468851868909;8872.600732966903;8583;8765.649374024968;8940.46357218569;8991.41555798871;8997.505137217517;6168.907466387918;6563.3764792344655;6732.225794033553;6796.150481189851;6946.131733533309;7513.887291690519;7583.886241706268;7591.848163036819;7593.468457207942;7600.42996775233;6715.1941766988275;6868.244493105654;6875.965620171867;6986.790396288119;7021.297870212938;6696.966515167393;6698.7320507179165;6705.430038446591;6742;6929.7228110875;6827.283135270725;7036.014957905795;7037.718491260497;7113.181984071898;7130.964345178449;6412.198475190601;6468.676566171766;6479.967600161969;6512.479001679949;6536.4117229447675;6664.400203981665;6668.166479190101;6693.364130407604;6713.731450742111;6741.056252124608 15:40:46 INFO - PROCESS | 2240 | |4;prototype.html;314.9071024047907;319.23224644729424;325.2519205826598;327.17225419688197;329.8614581875612;5214.6349755517085;5258.686178081642;5260.658057226277;5267.1045922193225;5332.733363331832;5202.843914682566;5212.556932660728;5218.21726740989;5218.347706536683;5228.320318358617;3924.9018774530578;3954.327764280065;4062.512498500184;4094.979525102385;4113.382992551126;4084.1831633673237;4118.064509680446;4122.340425531916;4124.938125928098;4127.195196936598;4058.168075544521;4065.79671016448;4068.7965601719943;4071.2671719090554;4077.3883917412327;3796.3925771876366;4059.6346328830546;4073.165001174752;4099.672026237894;4118.897027574305;3518.612952575215;3530.3583833517537;3539.451385035298;3539.964600353989;3543.1496440854266;5026.6983980960895;5054.797808087672;5062.569681577071;5072.619553533463;5074.720890351029;4571.748553829571;4594.609458196024;4670.299455081731;4675.205215113405;4675.392199014106;5495.241522712734;5513.862153446155;5523.972380138114;5529.917051244234;5532.806351777709;3866.613338666139;3876.5735769065664;3882.5729169791302;3883.3010058189516;3888.416737489371;5741.942580574183;5818.389069147764;5836.182934389147;5865.472107510302;5883.941160588425;3985.123272879962;3994.4407782910416;3994.6804255659476;3999.3601023836045;4003.579624139482;4017.4375587417785;4038.212548553004;4059.127287633173;4072.597167671029;4073.124278280184;4598.632109431237;4604.401427814362;4604.447466303998;4608.055348653518;4608.3778689876435;5372.435894231049;5558.249636299048;5567.693776842312;5577.27495425592;5580.525655319343;1384.78535826947;1394.6443656867636;1396.734620422137;1396.7695330270392;1400.586826886071;884.3279107878059;927.4481683398367;940.5438362394233;954.7279025477706;960.7309953213112;4813.542713442217;4824.228123500293;4831.95168048322;4887.36464259644;4900.730459824673;5691.9146212806845;5692.829215123553;5693.430656934273;5711.485966263056;5734.340550836624;4647.721136731807;4794.232922732346;4810.95189048105;4819.012102518976;4942.579880710108;3064.7241748242764;3071.3703690743346;3095.90712278632;3125.156207823875;3129;5467.507924286754;5490.145124535219;5495.6153069285565;5504.559635229172;5531.446855314517;5795.217645617788;5826.1552074948895;5931.110333450017;5933.554983376264;5943.138244954457;5444.441112677036;5448.618596698193;5454.400015998158;5465.535429488458;5475.178723191553;5609.102543593006;5732.16883551891;5796.710164491674;5806.506446952057;5817.5676350953145;5677.602567820213;5695.515881150149;5698.544116470755;5724.914126288026;5736.483716465538;5483.177523371526;5501.367342755634;5508.20131080983;5510.91733623988;5515.696636685021;3862.633049860259;3971.2995163289243;3980.2636512245326;4011.217812526646;4014.3376342903093;5774.018416869227;5778.104393818965;5778.219940308005;5786.508146807569;5804.6807425592;5523.226748255167;5545.3622833373065;5547.667139971614;5558.805441809517;5610.354809196831;5477.726113694379;5512.456887606284;5545.390007099135;5546.306711661043;5575.386707462257;5154.742262886765;5433.510984011458;5475.72621368938;5478.233047373291;5501.642393244426;5407.5944304176555;5577.386487486292;5636.013697602985;5637.43625637433;5648.802291919763;5469.56243500511;5476.780928762805;5479.424660410759;5488.560915126701;5501.339839219319 15:40:46 INFO - PROCESS | 2240 | |5;yui.html;647.569366371363;664.0139393001392;700.4921431961832;708.355396589104;730.9488335816493;11951.46218420171;12151.574694885681;12303.200291981015;12359.258444493336;12387.938060309698;12279.938600306987;12289.815652765215;12353.876461235384;12395.62813115608;12404.441800118993;644.5681393466389;793.7420338390017;805.7743831727097;822.48183644304;824.756696774453;809.4050872608628;812.4718932693767;813.2883726739103;816.0411516468156;825.0800357601262;839.7816567692413;841.3437518735366;845.5138295480093;853.3599800149888;862.9395942284043;842.5323945210406;845.3026253340956;845.7124577643631;848.1730312944891;855.6406309350057;629.1537881549309;630.3475902440997;631.7094136697125;633.360306090847;634.3339493531819;12143.817842732366;12245.265284082983;12294;12301.077419193596;12309.753804923852;12926.28905410202;13018.349082545836;13084.542041028613;13108.541201057917;13369.465221391132;9828.705138845846;10027.899721002843;10035.498225088717;10066.446345450997;10231.795364092677;3260.9673903261137;3315.8507867145795;3317.668233176687;3334.333133373335;3357.6474470180524;45576.77211613954;45965;46337.073258534976;46820;46945.765271173426;10092.545835437422;10234.232432567438;10331.48342582868;10435.00867417594;10445.589845370929;18372;18636.16137273826;18650.253989840254;18655.813441865408;18670;6694.698738556776;6741.359570840762;6813.557118787263;6904.516683832084;6945.131858517685;3749.9437508437395;3775.679067279312;3803.353429916921;3827.5981021992848;3851.30676478231;2742.191053639181;2822.6048353230562;2829.5048366535775;2830.235836324181;2834.0789243495947;481.98072077117223;482.49579189746095;493.07056199064306;497.8929530151035;502.5803454115781;608.0969759906535;611.6330201878837;618.7865186510646;637.6206157336377;653.3042309939899;7606.923930760732;7630.160682324939;7927.603619818986;8022.679092836222;8161.63272652732;469.9271612900006;565.4345654345655;586.8151532267323;636.640298231507;642.6947200079925;3651.507046548682;3698.63013698628;3798.6961043116485;3821.3694740367528;3829.5213098362706;47291.29063064057;47429.5257047432;47720.28419573709;48014;48236.27645585319;42116.1576768469;44334.33498497525;44610.55389446064;44804.10391792146;45106.32340514895;31313.843430783156;31445.842770786;33246;37050.814745926094;39990.2001959965;7995.280424761567;8051.436399451982;8292.502449853027;8415.495070295801;8619.6983105591;26096.086636967615;26152.34619134537;26313;26952.730472695806;27574.724252758017;33600.15999600029;34304.656953430145;36241.45637815382;36520.26959460743;36617.81691091527;10121.89878101239;10553.736156596147;10771.19216058783;10921.945390272998;11018.11855051578;11679.474423651127;11956.76086478283;12146.453409596767;12160.513579457076;12548.372581371077;11101.666949991513;11108.833367499332;11153.275037122561;11453.828192576952;11769.058475321783;10688.144948404264;11023.889761102608;11097.556097756;11157.330560166416;11187.776244475228;10725.731856703645;11248.550057997589;11251.606193783178;11429.142814289127;11438.199326047097;9460.858087128561;9922.057404546556;9957.302988791005;9978.700638980843;10045.246606504688;9122.5438728062;9600.279979001463;9908.455034973145;9979.750506237402;10033.648822291185 15:40:46 INFO - PROCESS | 2240 | __end_tp_report 15:40:46 INFO - PROCESS | 2240 | __start_cc_report 15:40:46 INFO - PROCESS | 2240 | _x_x_mozilla_cycle_collect,360 15:40:46 INFO - PROCESS | 2240 | __end_cc_report 15:40:46 INFO - PROCESS | 2240 | __startTimestamp1460068846938__endTimestamp 15:40:46 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | ------- Summary: start ------- 15:40:46 INFO - PROCESS | 2240 | Number of tests: 6 15:40:46 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | [#0] dojo.html Cycles:165 Average:4676.85 Median:4835.49 stddev:471.39 (9.7%) stddev-sans-first:444.71 15:40:46 INFO - PROCESS | 2240 | Values: 2632.1 2680.3 2683.8 2690.6 2700.3 4639.6 4664.7 4665.6 4675.2 4708.6 4577.2 4728.4 4761.1 4785.5 4801.5 4320.0 4324.5 4376.7 4387.2 4418.9 4407.9 4408.9 4439.5 4458.0 4496.0 4248.7 4348.1 4357.0 4418.6 4439.4 4335.6 4340.5 4351.5 4358.9 4390.2 4325.1 4327.9 4330.4 4378.1 4386.9 4441.6 4615.8 4684.9 4700.3 4723.4 4956.1 5003.1 5014.3 5018.6 5050.2 4980.7 5012.4 5051.5 5053.4 5096.7 4678.2 4723.6 4725.5 4756.3 4769.7 5069.2 5081.2 5082.3 5104.8 5119.5 4768.2 4856.8 4857.4 4922.2 4951.7 4978.2 5057.8 5058.1 5062.3 5108.8 5038.6 5041.2 5041.8 5050.4 5086.6 4955.2 5004.7 5028.6 5029.7 5066.4 4326.9 4330.1 4344.1 4374.3 4376.2 3754.5 3755.6 3776.2 3801.6 3807.5 4311.6 4423.6 4431.2 4434.8 4490.9 4992.9 4994.6 5006.6 5026.7 5050.9 4376.6 4380.2 4383.1 4388.4 4441.5 4513.1 4568.6 4620.9 4682.0 4693.4 4809.9 4826.5 4836.2 4845.0 4861.3 5097.7 5112.0 5126.3 5126.9 5164.0 4695.3 4835.5 4855.6 4869.1 4894.3 4982.8 4984.4 4995.7 5027.7 5053.3 4935.2 5029.3 5046.0 5047.2 5091.6 4798.8 4856.7 4917.5 4972.7 4993.8 4920.5 4922.5 4939.3 4946.7 4967.2 4808.1 4861.1 4872.0 4872.7 4909.7 4857.5 4864.7 4903.4 4937.1 4940.4 4811.0 4862.0 4880.1 4901.4 4908.7 15:40:46 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | [#1] ext.html Cycles:180 Average:45696.89 Median:191400.83 stddev:78994.36 (41.3%) stddev-sans-first:79143.31 15:40:46 INFO - PROCESS | 2240 | Values: 574.5 597.2 602.0 614.1 624.8 32969.8 34004.0 34031.8 34058.5 34278.7 34403.1 34956.7 34964.0 35044.5 35075.0 7480.4 7645.1 7654.6 7658.5 7667.0 7518.4 7720.9 7741.5 7746.7 7750.0 7636.4 7765.3 7776.7 7791.9 7819.3 7617.2 7705.6 7708.3 7717.4 7742.6 7628.2 7735.5 7747.8 7753.1 7772.7 29303.4 34048.0 34315.0 34328.8 34427.1 2858.4 2941.4 2966.4 3111.9 3312.0 26358.3 26874.6 27403.9 27876.7 28149.7 3466.2 3501.0 3536.0 3577.6 3596.5 228828.0 232320.0 234487.0 235558.0 235772.8 58398.0 58741.4 59005.1 59111.0 59272.0 61178.7 61264.7 61294.7 61433.1 61865.4 15009.1 15763.2 15782.7 15801.9 15807.6 11591.8 11758.5 11786.0 11796.6 11822.2 18842.7 19434.7 19646.2 19648.7 19853.2 7296.7 7450.3 7470.9 7480.9 7601.2 844.8 874.9 900.4 943.5 1042.6 28027.4 28239.3 28522.9 28655.0 28731.6 944.5 987.7 1034.2 1056.2 1118.9 14927.7 15135.0 15238.8 15283.8 15410.6 347845.0 349938.0 350097.0 353083.0 353430.0 47591.3 48114.5 48188.5 48273.5 48299.0 1168.8 1175.5 1191.3 1242.1 1265.2 26571.3 27950.4 27987.0 28438.9 28534.3 43614.3 43842.6 44447.6 44471.3 44733.1 303982.0 306096.0 306218.0 307374.0 309629.0 26096.0 26247.0 26446.7 36020.0 36937.6 40238.6 40805.6 41015.2 41083.2 42190.6 33801.0 34114.3 34179.3 34362.1 34500.5 34617.7 36533.6 36901.3 36945.8 37321.3 36622.0 36845.1 37916.2 39173.6 39500.2 28924.7 31066.8 31516.4 31574.8 31685.9 26088.2 26426.6 26466.3 26512.3 26624.2 15:40:46 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | [#2] jquery.html Cycles:180 Average:23514.23 Median:26200.27 stddev:61810.44 (235.9%) stddev-sans-first:61959.40 15:40:46 INFO - PROCESS | 2240 | Values: 367.6 368.4 375.9 382.1 383.9 15665.7 16390.3 17529.8 17560.9 17661.8 16239.2 16461.5 17191.7 17211.7 17223.5 5133.5 5300.7 5303.2 5315.0 5325.3 3758.3 5219.4 5722.9 6027.2 6054.5 5964.3 5977.3 5982.8 6000.0 6004.4 5719.6 6139.6 6140.7 6145.3 6157.9 5151.7 5321.7 5365.4 5386.1 5421.2 10428.4 10949.5 20134.2 20298.1 20496.5 1664.3 1824.6 1944.9 2203.0 2222.9 8670.2 9022.0 9032.0 9074.3 9081.3 1695.6 1767.6 1784.5 1816.7 1818.2 68987.7 69398.7 69652.3 69752.7 69825.0 9341.1 9595.9 9608.8 9739.1 9922.5 13047.0 13090.6 13185.9 13211.7 13239.3 7116.5 7186.7 7273.9 7385.2 7400.3 6898.9 7004.3 7040.0 7104.5 7152.4 4012.3 4030.0 4051.7 4116.5 4121.7 1582.2 1642.2 1689.9 1770.6 1781.4 874.3 912.4 929.4 929.9 1021.0 16213.5 16668.6 16737.8 17060.0 17147.3 842.8 858.6 867.3 876.2 895.6 9297.0 9437.4 9524.1 9537.1 9613.5 366597.0 367051.0 369901.0 369997.0 394502.0 75032.6 78183.6 78629.6 79294.0 80294.0 907.2 920.8 933.3 937.2 938.4 14811.0 14861.3 15021.7 15052.2 15167.9 31877.5 32875.8 33379.7 33956.5 34187.8 45128.3 46431.0 46534.3 46722.5 47267.0 7283.7 7449.2 7472.7 7658.3 7752.6 11159.8 11481.1 11553.9 11630.5 11940.0 10039.4 10141.5 10258.7 10441.9 10450.9 10105.9 10188.0 10317.4 10534.7 10598.3 9940.3 10099.2 10343.3 10477.8 10688.5 7405.4 7436.1 7512.9 7525.9 7582.3 9590.2 9647.9 9678.2 9685.4 9912.4 15:40:46 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | [#3] mootools.html Cycles:180 Average:5456.22 Median:6695.17 stddev:2883.84 (43.1%) stddev-sans-first:2875.93 15:40:46 INFO - PROCESS | 2240 | Values: 1414.5 1452.1 1579.3 1734.7 1741.8 6822.1 7352.4 7540.8 7581.2 7632.5 7718.1 7783.3 7793.1 7797.1 7798.8 2163.2 2201.7 2213.3 2213.5 2219.3 2209.1 2242.9 2248.3 2248.8 2252.0 2123.4 2156.2 2159.4 2173.1 2232.6 2171.3 2180.7 2183.4 2186.2 2187.3 2093.1 2095.8 2109.5 2110.1 2112.8 7991.2 7999.6 8017.4 8019.0 8074.2 4506.6 4668.8 4680.3 4700.4 4711.3 2689.2 2734.9 2772.0 2934.8 2950.1 862.7 880.9 900.4 901.8 902.8 10649.0 10776.2 10796.5 10800.5 10801.8 4051.9 4176.7 4332.9 4352.7 4419.5 9211.3 9246.3 9247.6 9249.0 9253.0 4680.5 4708.9 4720.8 4722.0 4734.2 3704.8 4097.3 4260.0 4290.3 4323.8 3732.5 3803.7 3832.9 3871.7 3887.8 1252.9 1255.9 1257.8 1275.3 1276.2 903.5 926.0 926.4 972.7 1198.6 7355.3 7357.5 7373.7 7402.0 7430.7 440.6 1090.4 1136.2 1148.2 1150.6 5685.0 5828.8 5842.9 5862.1 5879.5 8898.6 9142.0 9424.5 9431.2 9474.4 9352.2 9355.5 9374.8 9413.1 9471.0 6979.1 7229.8 7253.6 7258.5 7259.9 7427.3 7431.9 7463.9 7529.9 7656.9 8540.7 8541.6 8748.3 8852.5 8872.6 8583.0 8765.6 8940.5 8991.4 8997.5 6168.9 6563.4 6732.2 6796.2 6946.1 7513.9 7583.9 7591.8 7593.5 7600.4 6715.2 6868.2 6876.0 6986.8 7021.3 6697.0 6698.7 6705.4 6742.0 6929.7 6827.3 7036.0 7037.7 7113.2 7131.0 6412.2 6468.7 6480.0 6512.5 6536.4 6664.4 6668.2 6693.4 6713.7 6741.1 15:40:46 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | [#4] prototype.html Cycles:180 Average:4599.83 Median:5223.33 stddev:1357.49 (26.0%) stddev-sans-first:1322.65 15:40:46 INFO - PROCESS | 2240 | Values: 314.9 319.2 325.3 327.2 329.9 5214.6 5258.7 5260.7 5267.1 5332.7 5202.8 5212.6 5218.2 5218.3 5228.3 3924.9 3954.3 4062.5 4095.0 4113.4 4084.2 4118.1 4122.3 4124.9 4127.2 4058.2 4065.8 4068.8 4071.3 4077.4 3796.4 4059.6 4073.2 4099.7 4118.9 3518.6 3530.4 3539.5 3540.0 3543.1 5026.7 5054.8 5062.6 5072.6 5074.7 4571.7 4594.6 4670.3 4675.2 4675.4 5495.2 5513.9 5524.0 5529.9 5532.8 3866.6 3876.6 3882.6 3883.3 3888.4 5741.9 5818.4 5836.2 5865.5 5883.9 3985.1 3994.4 3994.7 3999.4 4003.6 4017.4 4038.2 4059.1 4072.6 4073.1 4598.6 4604.4 4604.4 4608.1 4608.4 5372.4 5558.2 5567.7 5577.3 5580.5 1384.8 1394.6 1396.7 1396.8 1400.6 884.3 927.4 940.5 954.7 960.7 4813.5 4824.2 4832.0 4887.4 4900.7 5691.9 5692.8 5693.4 5711.5 5734.3 4647.7 4794.2 4811.0 4819.0 4942.6 3064.7 3071.4 3095.9 3125.2 3129.0 5467.5 5490.1 5495.6 5504.6 5531.4 5795.2 5826.2 5931.1 5933.6 5943.1 5444.4 5448.6 5454.4 5465.5 5475.2 5609.1 5732.2 5796.7 5806.5 5817.6 5677.6 5695.5 5698.5 5724.9 5736.5 5483.2 5501.4 5508.2 5510.9 5515.7 3862.6 3971.3 3980.3 4011.2 4014.3 5774.0 5778.1 5778.2 5786.5 5804.7 5523.2 5545.4 5547.7 5558.8 5610.4 5477.7 5512.5 5545.4 5546.3 5575.4 5154.7 5433.5 5475.7 5478.2 5501.6 5407.6 5577.4 5636.0 5637.4 5648.8 5469.6 5476.8 5479.4 5488.6 5501.3 15:40:46 INFO - PROCESS | 2240 | 15:40:46 INFO - PROCESS | 2240 | [#5] yui.html Cycles:180 Average:12298.13 Median:3812.36 stddev:13314.75 (349.3%) stddev-sans-first:13323.35 15:40:46 INFO - PROCESS | 2240 | Values: 647.6 664.0 700.5 708.4 730.9 11951.5 12151.6 12303.2 12359.3 12387.9 12279.9 12289.8 12353.9 12395.6 12404.4 644.6 793.7 805.8 822.5 824.8 809.4 812.5 813.3 816.0 825.1 839.8 841.3 845.5 853.4 862.9 842.5 845.3 845.7 848.2 855.6 629.2 630.3 631.7 633.4 634.3 12143.8 12245.3 12294.0 12301.1 12309.8 12926.3 13018.3 13084.5 13108.5 13369.5 9828.7 10027.9 10035.5 10066.4 10231.8 3261.0 3315.9 3317.7 3334.3 3357.6 45576.8 45965.0 46337.1 46820.0 46945.8 10092.5 10234.2 10331.5 10435.0 10445.6 18372.0 18636.2 18650.3 18655.8 18670.0 6694.7 6741.4 6813.6 6904.5 6945.1 3749.9 3775.7 3803.4 3827.6 3851.3 2742.2 2822.6 2829.5 2830.2 2834.1 482.0 482.5 493.1 497.9 502.6 608.1 611.6 618.8 637.6 653.3 7606.9 7630.2 7927.6 8022.7 8161.6 469.9 565.4 586.8 636.6 642.7 3651.5 3698.6 3798.7 3821.4 3829.5 47291.3 47429.5 47720.3 48014.0 48236.3 42116.2 44334.3 44610.6 44804.1 45106.3 31313.8 31445.8 33246.0 37050.8 39990.2 7995.3 8051.4 8292.5 8415.5 8619.7 26096.1 26152.3 26313.0 26952.7 27574.7 33600.2 34304.7 36241.5 36520.3 36617.8 10121.9 10553.7 10771.2 10921.9 11018.1 11679.5 11956.8 12146.5 12160.5 12548.4 11101.7 11108.8 11153.3 11453.8 11769.1 10688.1 11023.9 11097.6 11157.3 11187.8 10725.7 11248.6 11251.6 11429.1 11438.2 9460.9 9922.1 9957.3 9978.7 10045.2 9122.5 9600.3 9908.5 9979.8 10033.6 15:40:46 INFO - PROCESS | 2240 | -------- Summary: end -------- 15:40:46 INFO - PROCESS | 2240 | 15:40:47 INFO - TEST-INFO | 2240: exit 0 15:40:47 INFO - TEST-OK | dromaeo_css | took 1114842ms 15:40:47 INFO - TEST-START | kraken 15:40:47 INFO - operating with platform_type : linux_ 15:40:47 INFO - Initialising browser for kraken test... 15:40:47 INFO - TEST-INFO | started process 2563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunV1xA/profile http://localhost:60655/getInfo.html) 15:40:51 INFO - PROCESS | 2563 | 15:40:51 INFO - PROCESS | 2563 | (process:2634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:40:51 INFO - PROCESS | 2563 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:40:52 INFO - PROCESS | 2563 | __metrics Screen width/height:1600/1200 15:40:52 INFO - PROCESS | 2563 | colorDepth:24 15:40:52 INFO - PROCESS | 2563 | Browser inner width/height: 1024/697 15:40:52 INFO - PROCESS | 2563 | __metrics 15:40:52 ERROR - PROCESS | 2563 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 15:40:53 INFO - TEST-INFO | 2563: exit 0 15:40:53 INFO - Browser initialized. 15:40:53 INFO - Running cycle 1/1 for kraken test... 15:40:53 INFO - TEST-INFO | started process 2714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunV1xA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:55 INFO - PROCESS | 2714 | 15:40:55 INFO - PROCESS | 2714 | (process:2826): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:41:05 INFO - PROCESS | 2714 | RSS: Main: 164032512 15:41:05 INFO - PROCESS | 2714 | 15:41:08 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60655/tests/kraken/driver.html?testName=audio-beat-detection) 15:41:08 INFO - PROCESS | 2714 | RSS: Main: 168816640 15:41:08 INFO - PROCESS | 2714 | 15:41:11 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60655/tests/kraken/driver.html?testName=audio-dft) 15:41:12 INFO - PROCESS | 2714 | RSS: Main: 172228608 15:41:12 INFO - PROCESS | 2714 | 15:41:15 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60655/tests/kraken/driver.html?testName=audio-fft) 15:41:15 INFO - PROCESS | 2714 | RSS: Main: 164364288 15:41:15 INFO - PROCESS | 2714 | 15:41:18 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60655/tests/kraken/driver.html?testName=audio-oscillator) 15:41:18 INFO - PROCESS | 2714 | RSS: Main: 164864000 15:41:18 INFO - PROCESS | 2714 | 15:41:20 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:41:21 INFO - PROCESS | 2714 | RSS: Main: 165253120 15:41:21 INFO - PROCESS | 2714 | 15:41:24 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60655/tests/kraken/driver.html?testName=imaging-darkroom) 15:41:25 INFO - PROCESS | 2714 | RSS: Main: 165629952 15:41:25 INFO - PROCESS | 2714 | 15:41:28 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60655/tests/kraken/driver.html?testName=imaging-desaturate) 15:41:29 INFO - PROCESS | 2714 | RSS: Main: 163598336 15:41:29 INFO - PROCESS | 2714 | 15:41:32 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60655/tests/kraken/driver.html?testName=json-parse-financial) 15:41:32 INFO - PROCESS | 2714 | RSS: Main: 163799040 15:41:32 INFO - PROCESS | 2714 | 15:41:34 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:41:35 INFO - PROCESS | 2714 | RSS: Main: 164397056 15:41:35 INFO - PROCESS | 2714 | 15:41:37 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60655/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:41:37 INFO - PROCESS | 2714 | RSS: Main: 164442112 15:41:37 INFO - PROCESS | 2714 | 15:41:39 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:41:40 INFO - PROCESS | 2714 | RSS: Main: 164749312 15:41:40 INFO - PROCESS | 2714 | 15:41:43 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:41:44 INFO - PROCESS | 2714 | RSS: Main: 164962304 15:41:44 INFO - PROCESS | 2714 | 15:41:46 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:41:47 INFO - PROCESS | 2714 | RSS: Main: 165208064 15:41:47 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | Cycle 1(1): loaded http://localhost:60655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60655/tests/kraken/driver.html?testName=ai-astar) 15:41:49 INFO - PROCESS | 2714 | RSS: Main: 166129664 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | __start_tp_report 15:41:49 INFO - PROCESS | 2714 | _x_x_mozilla_page_load 15:41:49 INFO - PROCESS | 2714 | _x_x_mozilla_page_load_details 15:41:49 INFO - PROCESS | 2714 | |i|pagename|runs| 15:41:49 INFO - PROCESS | 2714 | |0;ai-astar;116;107;115;114;114;125;114;114;114;115 15:41:49 INFO - PROCESS | 2714 | |1;audio-beat-detection;156;131;161;177;136;156;163;132;179;133 15:41:49 INFO - PROCESS | 2714 | |2;audio-dft;162;163;162;161;163;166;168;163;165;161 15:41:49 INFO - PROCESS | 2714 | |3;audio-fft;77;74;74;77;73;73;73;141;74;73 15:41:49 INFO - PROCESS | 2714 | |4;audio-oscillator;94;94;141;94;94;93;147;95;94;131 15:41:49 INFO - PROCESS | 2714 | |5;imaging-gaussian-blur;117;118;117;117;119;119;118;118;118;117 15:41:49 INFO - PROCESS | 2714 | |6;imaging-darkroom;147;147;148;148;147;148;146;147;147;147 15:41:49 INFO - PROCESS | 2714 | |7;imaging-desaturate;97;97;96;96;95;95;96;95;96;96 15:41:49 INFO - PROCESS | 2714 | |8;json-parse-financial;66;68;65;66;66;67;67;65;65;63 15:41:49 INFO - PROCESS | 2714 | |9;json-stringify-tinderbox;63;65;64;65;65;65;64;64;64;65 15:41:49 INFO - PROCESS | 2714 | |10;stanford-crypto-aes;86;88;87;85;85;85;85;85;88;85 15:41:49 INFO - PROCESS | 2714 | |11;stanford-crypto-ccm;152;142;139;146;143;156;160;147;150;139 15:41:49 INFO - PROCESS | 2714 | |12;stanford-crypto-pbkdf2;175;173;182;173;171;183;172;169;172;179 15:41:49 INFO - PROCESS | 2714 | |13;stanford-crypto-sha256-iterative;73;72;75;72;72;72;73;73;73;71 15:41:49 INFO - PROCESS | 2714 | __end_tp_report 15:41:49 INFO - PROCESS | 2714 | __start_cc_report 15:41:49 INFO - PROCESS | 2714 | _x_x_mozilla_cycle_collect,954 15:41:49 INFO - PROCESS | 2714 | __end_cc_report 15:41:49 INFO - PROCESS | 2714 | __startTimestamp1460068909637__endTimestamp 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | ------- Summary: start ------- 15:41:49 INFO - PROCESS | 2714 | Number of tests: 14 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:4.34 (3.8%) stddev-sans-first:4.58 15:41:49 INFO - PROCESS | 2714 | Values: 116.0 107.0 115.0 114.0 114.0 125.0 114.0 114.0 114.0 115.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:158.50 stddev:18.39 (11.6%) stddev-sans-first:19.46 15:41:49 INFO - PROCESS | 2714 | Values: 156.0 131.0 161.0 177.0 136.0 156.0 163.0 132.0 179.0 133.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.27 (1.4%) stddev-sans-first:2.35 15:41:49 INFO - PROCESS | 2714 | Values: 162.0 163.0 162.0 161.0 163.0 166.0 168.0 163.0 165.0 161.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.00 stddev:21.17 (28.6%) stddev-sans-first:22.41 15:41:49 INFO - PROCESS | 2714 | Values: 77.0 74.0 74.0 77.0 73.0 73.0 73.0 141.0 74.0 73.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:94.00 stddev:22.39 (23.8%) stddev-sans-first:23.19 15:41:49 INFO - PROCESS | 2714 | Values: 94.0 94.0 141.0 94.0 94.0 93.0 147.0 95.0 94.0 131.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 15:41:49 INFO - PROCESS | 2714 | Values: 117.0 118.0 117.0 117.0 119.0 119.0 118.0 118.0 118.0 117.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 15:41:49 INFO - PROCESS | 2714 | Values: 147.0 147.0 148.0 148.0 147.0 148.0 146.0 147.0 147.0 147.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 15:41:49 INFO - PROCESS | 2714 | Values: 97.0 97.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 15:41:49 INFO - PROCESS | 2714 | Values: 66.0 68.0 65.0 66.0 66.0 67.0 67.0 65.0 65.0 63.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 15:41:49 INFO - PROCESS | 2714 | Values: 63.0 65.0 64.0 65.0 65.0 65.0 64.0 64.0 64.0 65.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:1.29 (1.5%) stddev-sans-first:1.36 15:41:49 INFO - PROCESS | 2714 | Values: 86.0 88.0 87.0 85.0 85.0 85.0 85.0 85.0 88.0 85.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:148.50 stddev:7.09 (4.8%) stddev-sans-first:7.32 15:41:49 INFO - PROCESS | 2714 | Values: 152.0 142.0 139.0 146.0 143.0 156.0 160.0 147.0 150.0 139.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.00 stddev:4.79 (2.8%) stddev-sans-first:5.09 15:41:49 INFO - PROCESS | 2714 | Values: 175.0 173.0 182.0 173.0 171.0 183.0 172.0 169.0 172.0 179.0 15:41:49 INFO - PROCESS | 2714 | 15:41:49 INFO - PROCESS | 2714 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:1.07 (1.5%) stddev-sans-first:1.13 15:41:49 INFO - PROCESS | 2714 | Values: 73.0 72.0 75.0 72.0 72.0 72.0 73.0 73.0 73.0 71.0 15:41:49 INFO - PROCESS | 2714 | -------- Summary: end -------- 15:41:49 INFO - PROCESS | 2714 | 15:41:50 INFO - TEST-INFO | 2714: exit 0 15:41:50 INFO - TEST-OK | kraken | took 62985ms 15:41:50 INFO - SUITE-END | took 1177s 15:41:50 INFO - Completed test suite (00:19:37) 15:41:50 INFO - javascript benchmark 15:41:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.1182403894695, 2680.262927694884, 2683.8389696618206, 2690.6367640368544, 2700.270926849752, 4639.559241872025, 4664.696794708346, 4665.626749860012, 4675.228587283098, 4708.62331013519, 4577.2218722817115, 4728.385309909707, 4761.142994261032, 4785.54537318955, 4801.4718380978065, 4319.956800432003, 4324.502682191541, 4376.6936314458, 4387.210302145612, 4418.867433976986, 4407.933880991788, 4408.86773396797, 4439.511653718105, 4457.977710111445, 4496.033352829141, 4248.681348898814, 4348.086901750637, 4357.041450880801, 4418.5581441855875, 4439.356293337481, 4335.631471324941, 4340.52254252032, 4351.543087975749, 4358.934615980763, 4390.187815254157, 4325.13497300538, 4327.870163895088, 4330.372096046056, 4378.124375124988, 4386.8903277418, 4441.622462090726, 4615.83844565442, 4684.859454216379, 4700.341952126705, 4723.385959825235, 4956.058348913695, 5003.124453220708, 5014.272930425104, 5018.573421259197, 5050.191969284933, 4980.726060066695, 5012.423571289312, 5051.545360917535, 5053.418856831438, 5096.694198348111, 4678.1813182692895, 4723.551262630044, 4725.503822098699, 4756.31033500144, 4769.66612337133, 5069.214271787805, 5081.18701007837, 5082.288479612857, 5104.821331253388, 5119.46245644202, 4768.165571025057, 4856.757162141949, 4857.417109946829, 4922.237053256751, 4951.653384263139, 4978.228374601942, 5057.848264552069, 5058.114829904752, 5062.291279220912, 5108.795648174031, 5038.5969122470115, 5041.243813427942, 5041.773120209599, 5050.444451110375, 5086.593072554187, 4955.231939049453, 5004.724740139254, 5028.647994640413, 5029.698218106925, 5066.392032956069, 4326.935095973563, 4330.0906809569715, 4344.087741574304, 4374.321980093091, 4376.212281789309, 3754.4931434256573, 3755.5681096673684, 3776.15036616759, 3801.6008319126645, 3807.4669546263544, 4311.6335111515245, 4423.62399196072, 4431.158079964796, 4434.778261086997, 4490.910181796346, 4992.90014199714, 4994.5754610858485, 5006.599472042228, 5026.673266237683, 5050.9494905051215, 4376.6498680105515, 4380.167768124046, 4383.1452866691325, 4388.385626012361, 4441.533638967861, 4513.074819661962, 4568.588827005519, 4620.930686039645, 4682.040181762731, 4693.436787585511, 4809.879753006133, 4826.493218212107, 4836.226203807374, 4844.95155048452, 4861.343718598086, 5097.6941383517105, 5112.0, 5126.282320475062, 5126.923096153486, 5163.974180129076, 4695.272232803921, 4835.492273311252, 4855.562999330077, 4869.074875773592, 4894.339264199288, 4982.7508624569355, 4984.352034235526, 4995.650304478797, 5027.723475208899, 5053.26727624485, 4935.210366341368, 5029.29589857413, 5045.974770126126, 5047.167217409086, 5091.59267258611, 4798.832040878692, 4856.708597484162, 4917.459079501181, 4972.726500042532, 4993.775280112331, 4920.532549407801, 4922.532359425849, 4939.283803848493, 4946.678465899705, 4967.205247160437, 4808.110499557593, 4861.1006963711825, 4872.025594881109, 4872.6832755870755, 4909.68087074339, 4857.489963553918, 4864.73243971585, 4903.436104847988, 4937.1113199624415, 4940.407151141886, 4811.0, 4862.027594481188, 4880.097182021337, 4901.436334821541, 4908.680935739166], "value": 4647.796260508337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.5292052345992, 597.1937883856793, 602.0307305238565, 614.1064750787604, 624.7500999600156, 32969.83515082427, 34004.0, 34031.82984085076, 34058.48912266318, 34278.65721342786, 34403.13992150198, 34956.650433495655, 34964.0, 35044.47433288502, 35075.0, 7480.4015678745845, 7645.120811106711, 7654.617269136549, 7658.502197357182, 7667.0, 7518.360939320164, 7720.884186737204, 7741.5355078695175, 7746.651400686983, 7750.0, 7636.350910172614, 7765.262300081483, 7776.688932442696, 7791.883121753178, 7819.296263336299, 7617.162112167657, 7705.614719264015, 7708.267714567107, 7717.421193410517, 7742.61286935651, 7628.237176282383, 7735.4585179037485, 7747.767566973, 7753.147153813076, 7772.7279545216215, 29303.413931721458, 34048.0, 34315.0, 34328.82835585831, 34427.139321516916, 2858.4140251248446, 2941.352902361477, 2966.362232120083, 3111.9222019449467, 3311.9668803311897, 26358.341041474116, 26874.5968810468, 27403.862980684968, 27876.721232787615, 28149.718502814914, 3466.231983867848, 3500.9824950875336, 3535.964640353615, 3577.6422357764013, 3596.478510615972, 228828.0, 232320.0, 234487.0, 235558.0, 235772.82113589495, 58398.0, 58741.41258587359, 59005.11492327618, 59111.0, 59272.0, 61178.69410652918, 61264.69367653133, 61294.69352653208, 61433.07850382248, 61865.38134618596, 15009.099454032794, 15763.211839408214, 15782.68434631301, 15801.920990395205, 15807.604809879846, 11591.76816463666, 11758.470868810924, 11786.0, 11796.646100616996, 11822.172447928562, 18842.71735923962, 19434.70847937282, 19646.21415143407, 19648.70526942097, 19853.205871765258, 7296.70813167478, 7450.2549745026145, 7470.85058298831, 7480.925190748132, 7601.201873803282, 844.8268105038452, 874.908134645853, 900.3607438718452, 943.4527973775193, 1042.5777560088177, 28027.439451210863, 28239.328887244938, 28522.857385712938, 28655.0, 28731.56902646462, 944.5466176235445, 987.7185002274317, 1034.1881622925966, 1056.155075939261, 1118.9160812939062, 14927.701445971019, 15135.0, 15238.847611523743, 15283.847161528465, 15410.613044825795, 347845.0, 349938.0, 350097.0, 353083.0, 353430.0, 47591.28613070807, 48114.518854811, 48188.518114819104, 48273.517264827606, 48299.0, 1168.8305195746739, 1175.4651633506735, 1191.3090407563593, 1242.099477878549, 1265.2282107914166, 26571.33571660724, 27950.440991179657, 27987.0, 28438.85780571167, 28534.286642834097, 43614.29278511362, 43842.56157438512, 44447.55552444434, 44471.33293000543, 44733.105337893714, 303982.0, 306096.0, 306218.0, 307374.0, 309629.0, 26096.0, 26247.0, 26446.735532644427, 36020.0, 36937.63062369342, 40238.597614023485, 40805.59194408018, 41015.1796964065, 41083.17833643251, 42190.57809421989, 33801.0, 34114.31771364509, 34179.31641367209, 34362.14094647654, 34500.48249276212, 34617.65382346144, 36533.634663654084, 36901.26197476089, 36945.81527092347, 37321.2535749278, 36622.0, 36845.07887302839, 37916.24167516579, 39173.608263917, 39500.20999579935, 28924.710752893043, 31066.844665776527, 31516.369672606877, 31574.842125789222, 31685.940413873024, 26088.217353479427, 26426.60360094562, 26466.338341541614, 26512.337191570365, 26624.20127396181], "value": 17571.86453514769, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.5607648859612, 368.4381318489304, 375.90226541099304, 382.10587225891413, 383.9347310957137, 15665.686686266283, 16390.34438622455, 17529.82470175298, 17560.912195439007, 17661.823381766193, 16239.188040597983, 16461.506154815346, 17191.742123868153, 17211.655766884654, 17223.483295501122, 5133.537981581657, 5300.708461034642, 5303.23103150043, 5315.0, 5325.334333208349, 3758.3047136279874, 5219.425863155069, 5722.856928576777, 6027.246594175728, 6054.5459090568165, 5964.2842858857, 5977.282726072877, 5982.820515384546, 6000.009998350267, 6004.369541198177, 5719.571032172604, 6139.600925939844, 6140.662263575501, 6145.324014358417, 6157.907631385533, 5151.716655583941, 5321.707306098163, 5365.409804921455, 5386.111291636876, 5421.241026256327, 10428.426436545988, 10949.507272172692, 20134.194632214694, 20298.086586103662, 20496.487587810276, 1664.2843577261772, 1824.5985883105695, 1944.9222031118738, 2202.966955495669, 2222.8774468893107, 8670.176333248395, 9022.0, 9032.0, 9074.319426043074, 9081.318901082379, 1695.6354383807418, 1767.6376342849685, 1784.4825000749768, 1816.7002444596626, 1818.2454281473172, 68987.65506172487, 69398.65300673514, 69652.3034769656, 69752.651236744, 69824.95262571116, 9341.11259430353, 9595.90404095964, 9608.75978100539, 9739.074787895139, 9922.454265015493, 13047.0, 13090.607281781562, 13185.945124390026, 13211.66970825737, 13239.338033098307, 7116.466265030143, 7186.676599553032, 7273.89089163663, 7385.187629360766, 7400.296971787671, 6898.896516552256, 7004.2645522220455, 7040.049593304941, 7104.467164962649, 7152.392046676091, 4012.277789997828, 4030.0, 4051.655609273245, 4116.4648595682365, 4121.732087414309, 1582.1693610854163, 1642.2363600925628, 1689.923953422099, 1770.5927636643644, 1781.3789451598982, 874.2918236228675, 912.3567884641312, 929.419113054341, 929.9349045566745, 1021.0351218098825, 16213.513594592181, 16668.58328541796, 16737.832621673628, 17059.976401415955, 17147.314107435814, 842.751388340441, 858.5835869603237, 867.3018220332693, 876.2245412809709, 895.5880295064213, 9297.0, 9437.386569872937, 9524.14282714559, 9537.14165725088, 9613.471259080818, 366597.0, 367051.0, 369901.0, 369997.0, 394502.0, 75032.62483687655, 78183.60908195536, 78629.60685196538, 79294.0, 80294.0, 907.1880666803174, 920.8020275640903, 933.2906990687127, 937.1659223291276, 938.3525367496542, 14810.961320273324, 14861.331240094005, 15021.699566008838, 15052.247387630356, 15167.938244322791, 31877.521837172924, 32875.835620821745, 33379.666203337656, 33956.49065264072, 34187.829060854536, 45128.32307515324, 46431.0, 46534.30198547092, 46722.53277467182, 47267.0, 7283.708651654087, 7449.180590134973, 7472.663730132048, 7658.2724641159, 7752.612369381621, 11159.776804464027, 11481.138914581274, 11553.884461155281, 11630.53477860876, 11940.0, 10039.397636141563, 10141.543630536791, 10258.743531411475, 10441.895581044093, 10450.895491044992, 10105.898941010495, 10188.0, 10317.432541210006, 10534.736631584272, 10598.25812193139, 9940.304178707422, 10099.192064634959, 10343.293356596378, 10477.790444190921, 10688.465576721288, 7405.370543503647, 7436.107667079985, 7512.924870751441, 7525.924740752742, 7582.317591416799, 9590.184834289164, 9647.855282170913, 9678.17735492491, 9685.41887486753, 9912.405255684682], "value": 8110.381236924502, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.4554346576572, 1452.0706747681481, 1579.3287852662622, 1734.7091371317485, 1741.8345257200563, 6822.1131252937175, 7352.411807055436, 7540.81147971301, 7581.241875812416, 7632.465727399084, 7718.112417072039, 7783.299503044725, 7793.142754297023, 7797.142314345418, 7798.805029874256, 2163.156369016085, 2201.7357917049894, 2213.2806837777784, 2213.501962058532, 2219.3341997400794, 2209.0942713487475, 2242.8542144760618, 2248.2693124734446, 2248.8313376496826, 2251.9774802252014, 2123.4479035450818, 2156.2345367394582, 2159.416957421495, 2173.119886445984, 2232.553489302138, 2171.272623671072, 2180.749213840405, 2183.366823621148, 2186.2238905188588, 2187.3437968609433, 2093.11042806808, 2095.800898914616, 2109.5253567947243, 2110.082114280293, 2112.767595564487, 7991.20087991202, 7999.640016199227, 8017.35861131114, 8018.959905200437, 8074.152214017502, 4506.571875671839, 4668.789904454307, 4680.3447517347595, 4700.388949436586, 4711.293306004127, 2689.193242027384, 2734.904278350248, 2771.986140069307, 2934.779891508124, 2950.070727720761, 862.728240604214, 880.9295256379474, 900.4012331799346, 901.7970956534792, 902.7788191892963, 10649.041586257197, 10776.245662803607, 10796.51415686296, 10800.459977001197, 10801.83797243042, 4051.8784436466954, 4176.686748493875, 4332.9133417332105, 4352.673549483801, 4419.513853476115, 9211.309151813506, 9246.26029917605, 9247.583858726239, 9248.953755231316, 9252.95373523128, 4680.53194680536, 4708.929366059443, 4720.834770783006, 4721.95278047222, 4734.242521196592, 3704.7777133372083, 4097.303458412077, 4259.957400425956, 4290.334998075241, 4323.848665296699, 3732.458793474931, 3803.695704343646, 3832.9233415331537, 3871.6902647788675, 3887.7861717605238, 1252.9310887901254, 1255.9309237991997, 1257.7673130470891, 1275.253976423784, 1276.189619591566, 903.4804987132425, 925.9629614815467, 926.4441335198961, 972.6644307713827, 1198.634416502975, 7355.264473552602, 7357.484976051625, 7373.741919032808, 7402.037735094404, 7430.7399241026305, 440.649683501617, 1090.4166271044953, 1136.1819489967374, 1148.1618418554501, 1150.5742875136086, 5684.971575142181, 5828.766849326064, 5842.912356314659, 5862.14998825168, 5879.5002424794375, 8898.644054237888, 9141.994380618127, 9424.528773561431, 9431.245500359955, 9474.431534107976, 9352.158305752379, 9355.53222338894, 9374.812503749887, 9413.058694130668, 9471.0, 6979.092717946736, 7229.783106506813, 7253.601051942088, 7258.491905566665, 7259.89110163348, 7427.294407031323, 7431.925680743123, 7463.850722985619, 7529.887051694339, 7656.923430765621, 8540.74377768668, 8541.572921353783, 8748.256398206224, 8852.468851868909, 8872.600732966903, 8583.0, 8765.649374024968, 8940.46357218569, 8991.41555798871, 8997.505137217517, 6168.907466387918, 6563.3764792344655, 6732.225794033553, 6796.150481189851, 6946.131733533309, 7513.887291690519, 7583.886241706268, 7591.848163036819, 7593.468457207942, 7600.42996775233, 6715.1941766988275, 6868.244493105654, 6875.965620171867, 6986.790396288119, 7021.297870212938, 6696.966515167393, 6698.7320507179165, 6705.430038446591, 6742.0, 6929.7228110875, 6827.283135270725, 7036.014957905795, 7037.718491260497, 7113.181984071898, 7130.964345178449, 6412.198475190601, 6468.676566171766, 6479.967600161969, 6512.479001679949, 6536.4117229447675, 6664.400203981665, 6668.166479190101, 6693.364130407604, 6713.731450742111, 6741.056252124608], "value": 4427.668881390212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.9071024047907, 319.23224644729424, 325.2519205826598, 327.17225419688197, 329.8614581875612, 5214.6349755517085, 5258.686178081642, 5260.658057226277, 5267.1045922193225, 5332.733363331832, 5202.843914682566, 5212.556932660728, 5218.21726740989, 5218.347706536683, 5228.320318358617, 3924.9018774530578, 3954.327764280065, 4062.512498500184, 4094.979525102385, 4113.382992551126, 4084.1831633673237, 4118.064509680446, 4122.340425531916, 4124.938125928098, 4127.195196936598, 4058.168075544521, 4065.79671016448, 4068.7965601719943, 4071.2671719090554, 4077.3883917412327, 3796.3925771876366, 4059.6346328830546, 4073.165001174752, 4099.672026237894, 4118.897027574305, 3518.612952575215, 3530.3583833517537, 3539.451385035298, 3539.964600353989, 3543.1496440854266, 5026.6983980960895, 5054.797808087672, 5062.569681577071, 5072.619553533463, 5074.720890351029, 4571.748553829571, 4594.609458196024, 4670.299455081731, 4675.205215113405, 4675.392199014106, 5495.241522712734, 5513.862153446155, 5523.972380138114, 5529.917051244234, 5532.806351777709, 3866.613338666139, 3876.5735769065664, 3882.5729169791302, 3883.3010058189516, 3888.416737489371, 5741.942580574183, 5818.389069147764, 5836.182934389147, 5865.472107510302, 5883.941160588425, 3985.123272879962, 3994.4407782910416, 3994.6804255659476, 3999.3601023836045, 4003.579624139482, 4017.4375587417785, 4038.212548553004, 4059.127287633173, 4072.597167671029, 4073.124278280184, 4598.632109431237, 4604.401427814362, 4604.447466303998, 4608.055348653518, 4608.3778689876435, 5372.435894231049, 5558.249636299048, 5567.693776842312, 5577.27495425592, 5580.525655319343, 1384.78535826947, 1394.6443656867636, 1396.734620422137, 1396.7695330270392, 1400.586826886071, 884.3279107878059, 927.4481683398367, 940.5438362394233, 954.7279025477706, 960.7309953213112, 4813.542713442217, 4824.228123500293, 4831.95168048322, 4887.36464259644, 4900.730459824673, 5691.9146212806845, 5692.829215123553, 5693.430656934273, 5711.485966263056, 5734.340550836624, 4647.721136731807, 4794.232922732346, 4810.95189048105, 4819.012102518976, 4942.579880710108, 3064.7241748242764, 3071.3703690743346, 3095.90712278632, 3125.156207823875, 3129.0, 5467.507924286754, 5490.145124535219, 5495.6153069285565, 5504.559635229172, 5531.446855314517, 5795.217645617788, 5826.1552074948895, 5931.110333450017, 5933.554983376264, 5943.138244954457, 5444.441112677036, 5448.618596698193, 5454.400015998158, 5465.535429488458, 5475.178723191553, 5609.102543593006, 5732.16883551891, 5796.710164491674, 5806.506446952057, 5817.5676350953145, 5677.602567820213, 5695.515881150149, 5698.544116470755, 5724.914126288026, 5736.483716465538, 5483.177523371526, 5501.367342755634, 5508.20131080983, 5510.91733623988, 5515.696636685021, 3862.633049860259, 3971.2995163289243, 3980.2636512245326, 4011.217812526646, 4014.3376342903093, 5774.018416869227, 5778.104393818965, 5778.219940308005, 5786.508146807569, 5804.6807425592, 5523.226748255167, 5545.3622833373065, 5547.667139971614, 5558.805441809517, 5610.354809196831, 5477.726113694379, 5512.456887606284, 5545.390007099135, 5546.306711661043, 5575.386707462257, 5154.742262886765, 5433.510984011458, 5475.72621368938, 5478.233047373291, 5501.642393244426, 5407.5944304176555, 5577.386487486292, 5636.013697602985, 5637.43625637433, 5648.802291919763, 5469.56243500511, 5476.780928762805, 5479.424660410759, 5488.560915126701, 5501.339839219319], "value": 4167.314788031684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.569366371363, 664.0139393001392, 700.4921431961832, 708.355396589104, 730.9488335816493, 11951.46218420171, 12151.574694885681, 12303.200291981015, 12359.258444493336, 12387.938060309698, 12279.938600306987, 12289.815652765215, 12353.876461235384, 12395.62813115608, 12404.441800118993, 644.5681393466389, 793.7420338390017, 805.7743831727097, 822.48183644304, 824.756696774453, 809.4050872608628, 812.4718932693767, 813.2883726739103, 816.0411516468156, 825.0800357601262, 839.7816567692413, 841.3437518735366, 845.5138295480093, 853.3599800149888, 862.9395942284043, 842.5323945210406, 845.3026253340956, 845.7124577643631, 848.1730312944891, 855.6406309350057, 629.1537881549309, 630.3475902440997, 631.7094136697125, 633.360306090847, 634.3339493531819, 12143.817842732366, 12245.265284082983, 12294.0, 12301.077419193596, 12309.753804923852, 12926.28905410202, 13018.349082545836, 13084.542041028613, 13108.541201057917, 13369.465221391132, 9828.705138845846, 10027.899721002843, 10035.498225088717, 10066.446345450997, 10231.795364092677, 3260.9673903261137, 3315.8507867145795, 3317.668233176687, 3334.333133373335, 3357.6474470180524, 45576.77211613954, 45965.0, 46337.073258534976, 46820.0, 46945.765271173426, 10092.545835437422, 10234.232432567438, 10331.48342582868, 10435.00867417594, 10445.589845370929, 18372.0, 18636.16137273826, 18650.253989840254, 18655.813441865408, 18670.0, 6694.698738556776, 6741.359570840762, 6813.557118787263, 6904.516683832084, 6945.131858517685, 3749.9437508437395, 3775.679067279312, 3803.353429916921, 3827.5981021992848, 3851.30676478231, 2742.191053639181, 2822.6048353230562, 2829.5048366535775, 2830.235836324181, 2834.0789243495947, 481.98072077117223, 482.49579189746095, 493.07056199064306, 497.8929530151035, 502.5803454115781, 608.0969759906535, 611.6330201878837, 618.7865186510646, 637.6206157336377, 653.3042309939899, 7606.923930760732, 7630.160682324939, 7927.603619818986, 8022.679092836222, 8161.63272652732, 469.9271612900006, 565.4345654345655, 586.8151532267323, 636.640298231507, 642.6947200079925, 3651.507046548682, 3698.63013698628, 3798.6961043116485, 3821.3694740367528, 3829.5213098362706, 47291.29063064057, 47429.5257047432, 47720.28419573709, 48014.0, 48236.27645585319, 42116.1576768469, 44334.33498497525, 44610.55389446064, 44804.10391792146, 45106.32340514895, 31313.843430783156, 31445.842770786, 33246.0, 37050.814745926094, 39990.2001959965, 7995.280424761567, 8051.436399451982, 8292.502449853027, 8415.495070295801, 8619.6983105591, 26096.086636967615, 26152.34619134537, 26313.0, 26952.730472695806, 27574.724252758017, 33600.15999600029, 34304.656953430145, 36241.45637815382, 36520.26959460743, 36617.81691091527, 10121.89878101239, 10553.736156596147, 10771.19216058783, 10921.945390272998, 11018.11855051578, 11679.474423651127, 11956.76086478283, 12146.453409596767, 12160.513579457076, 12548.372581371077, 11101.666949991513, 11108.833367499332, 11153.275037122561, 11453.828192576952, 11769.058475321783, 10688.144948404264, 11023.889761102608, 11097.556097756, 11157.330560166416, 11187.776244475228, 10725.731856703645, 11248.550057997589, 11251.606193783178, 11429.142814289127, 11438.199326047097, 9460.858087128561, 9922.057404546556, 9957.302988791005, 9978.700638980843, 10045.246606504688, 9122.5438728062, 9600.279979001463, 9908.455034973145, 9979.750506237402, 10033.648822291185], "value": 5896.157551382118, "unit": "score"}], "name": "dromaeo_css", "value": 6450.970748660035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 107.0, 115.0, 114.0, 114.0, 125.0, 114.0, 114.0, 114.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 161.0, 177.0, 136.0, 156.0, 163.0, 132.0, 179.0, 133.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 166.0, 168.0, 163.0, 165.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 77.0, 73.0, 73.0, 73.0, 141.0, 74.0, 73.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 141.0, 94.0, 94.0, 93.0, 147.0, 95.0, 94.0, 131.0], "value": 107.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 119.0, 119.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 66.0, 66.0, 67.0, 67.0, 65.0, 65.0, 63.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 87.0, 85.0, 85.0, 85.0, 85.0, 85.0, 88.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 142.0, 139.0, 146.0, 143.0, 156.0, 160.0, 147.0, 150.0, 139.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 182.0, 173.0, 171.0, 183.0, 172.0, 169.0, 172.0, 179.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 75.0, 72.0, 72.0, 72.0, 73.0, 73.0, 73.0, 71.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1591.1000000000004, "alertThreshold": 2.0}]} 15:41:50 INFO - Return code: 0 15:41:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:41:50 ERROR - # TBPL SUCCESS # 15:41:50 INFO - Running post-action listener: _resource_record_post_action 15:41:50 INFO - Running post-run listener: _resource_record_post_run 15:41:52 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526434304; Read time: 12; Write time: 586584 15:41:52 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 211206144; Read time: 0; Write time: 421408 15:41:52 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280829952; Read time: 12; Write time: 157216 15:41:52 INFO - Running post-run listener: _upload_blobber_files 15:41:52 INFO - Blob upload gear active. 15:41:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:41:52 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 15:41:52 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'] 15:41:52 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 15:41:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:53 INFO - (blobuploader) - INFO - Done attempting. 15:41:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:41:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:41:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:54 INFO - (blobuploader) - INFO - Done attempting. 15:41:54 INFO - (blobuploader) - INFO - Iteration through files over. 15:41:54 INFO - Return code: 0 15:41:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:41:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:41:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc1b279f4ecb76744f481a0004dce824fd4484dee2a63f44055b56028d2fdee75a994c08820f0d249d5fe352afc4e0c65f96a6f5c57f9e40ce9d91c99a172bda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e5963d20522d90046c62f03486fda7ca8e8b0c692dd8fe8115658f4dfa7171cb015d66868257c18b1b4436c372c5c5be6e4195c291d84fec0e528b8bf77afe4"} 15:41:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:41:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:41:54 INFO - Contents: 15:41:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc1b279f4ecb76744f481a0004dce824fd4484dee2a63f44055b56028d2fdee75a994c08820f0d249d5fe352afc4e0c65f96a6f5c57f9e40ce9d91c99a172bda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e5963d20522d90046c62f03486fda7ca8e8b0c692dd8fe8115658f4dfa7171cb015d66868257c18b1b4436c372c5c5be6e4195c291d84fec0e528b8bf77afe4"} 15:41:54 INFO - Running post-run listener: copy_logs_to_upload_dir 15:41:54 INFO - Copying logs to upload dir... 15:41:54 INFO - mkdir: /builds/slave/test/build/upload/logs 15:41:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.740802 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-07 15:41:53.764600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 15:41:53.770654) ========= 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=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc1b279f4ecb76744f481a0004dce824fd4484dee2a63f44055b56028d2fdee75a994c08820f0d249d5fe352afc4e0c65f96a6f5c57f9e40ce9d91c99a172bda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e5963d20522d90046c62f03486fda7ca8e8b0c692dd8fe8115658f4dfa7171cb015d66868257c18b1b4436c372c5c5be6e4195c291d84fec0e528b8bf77afe4"} build_url:https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://queue.taskcluster.net/v1/task/KTU5I3oIQaCuqv1AjLetEg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc1b279f4ecb76744f481a0004dce824fd4484dee2a63f44055b56028d2fdee75a994c08820f0d249d5fe352afc4e0c65f96a6f5c57f9e40ce9d91c99a172bda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e5963d20522d90046c62f03486fda7ca8e8b0c692dd8fe8115658f4dfa7171cb015d66868257c18b1b4436c372c5c5be6e4195c291d84fec0e528b8bf77afe4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 15:41:53.795743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:41:53.796066) ========= 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=232498196343f89f466a4a9a000001c8-1460066998.879287-2001520121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 15:41:53.879123) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 15:41:53.879462) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 15:41:53.879773) ========= ========= Total master_lag: 0.30 =========