builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1457017804.95 results: success (0) buildid: 20160302200635 builduid: 6efb071dd86f47a1bdca869686093b38 revision: 07e13e514846833c01f65812d04b9c6a2f4b9f84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:04.945537) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:04.945977) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:04.946264) ========= 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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006189 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:04.969881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:04.970182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:04.983121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:04.983411) ========= 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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.032277) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.032546) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.032886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.033153) ========= 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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 07:10:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-03-03 07:10:05 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.197272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.197583) ========= 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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022444 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.248200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.248564) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 07e13e514846833c01f65812d04b9c6a2f4b9f84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 07e13e514846833c01f65812d04b9c6a2f4b9f84 --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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 07:10:05,407 truncating revision to first 12 chars 2016-03-03 07:10:05,407 Setting DEBUG logging. 2016-03-03 07:10:05,408 attempt 1/10 2016-03-03 07:10:05,408 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/07e13e514846?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 07:10:05,687 unpacking tar archive at: date-07e13e514846/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596080 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.881154) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.881502) ========= echo 07e13e514846833c01f65812d04b9c6a2f4b9f84 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'07e13e514846833c01f65812d04b9c6a2f4b9f84'] 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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07e13e514846833c01f65812d04b9c6a2f4b9f84 program finished with exit code 0 elapsedTime=0.004694 script_repo_revision: '07e13e514846833c01f65812d04b9c6a2f4b9f84' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.957063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.957375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 07:10:05.967027) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-03 07:10:05.967295) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Date-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date-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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:10:06 INFO - MultiFileLogger online at 20160303 07:10:06 in /builds/slave/test 07:10:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-Non-PGO 07:10:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:06 INFO - {'append_to_log': False, 07:10:06 INFO - 'base_work_dir': '/builds/slave/test', 07:10:06 INFO - 'blob_upload_branch': 'Date-Non-PGO', 07:10:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:06 INFO - 'branch': 'Date-Non-PGO', 07:10:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:06 INFO - 'config_files': ('talos/linux_config.py',), 07:10:06 INFO - 'default_actions': ('clobber', 07:10:06 INFO - 'read-buildbot-config', 07:10:06 INFO - 'download-and-extract', 07:10:06 INFO - 'populate-webroot', 07:10:06 INFO - 'create-virtualenv', 07:10:06 INFO - 'install', 07:10:06 INFO - 'run-tests'), 07:10:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:06 INFO - 'download_minidump_stackwalk': True, 07:10:06 INFO - 'download_symbols': 'ondemand', 07:10:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:06 INFO - 'installer_path': 'installer.exe', 07:10:06 INFO - 'log_level': 'info', 07:10:06 INFO - 'log_name': 'talos', 07:10:06 INFO - 'log_to_console': True, 07:10:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:10:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:10:06 INFO - 'opt_config_files': (), 07:10:06 INFO - 'pip_index': False, 07:10:06 INFO - 'sps_profile': False, 07:10:06 INFO - 'sps_profile_interval': 0, 07:10:06 INFO - 'suite': 'dromaeojs', 07:10:06 INFO - 'system_bits': '32', 07:10:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:06 INFO - 'title': 'talos-linux64-ix-069', 07:10:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:06 INFO - 'use_talos_json': True, 07:10:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:06 INFO - 'work_dir': 'build'} 07:10:06 INFO - ##### 07:10:06 INFO - ##### Running clobber step. 07:10:06 INFO - ##### 07:10:06 INFO - Running pre-action listener: _resource_record_pre_action 07:10:06 INFO - Running main action method: clobber 07:10:06 INFO - rmtree: /builds/slave/test/build 07:10:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:06 INFO - Running post-action listener: _resource_record_post_action 07:10:06 INFO - ##### 07:10:06 INFO - ##### Running read-buildbot-config step. 07:10:06 INFO - ##### 07:10:06 INFO - Running pre-action listener: _resource_record_pre_action 07:10:06 INFO - Running main action method: read_buildbot_config 07:10:06 INFO - Using buildbot properties: 07:10:06 INFO - { 07:10:06 INFO - "project": "", 07:10:06 INFO - "product": "firefox", 07:10:06 INFO - "script_repo_revision": "production", 07:10:06 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 07:10:06 INFO - "repository": "", 07:10:06 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 07:10:06 INFO - "buildid": "20160302200635", 07:10:06 INFO - "pgo_build": "False", 07:10:06 INFO - "basedir": "/builds/slave/test", 07:10:06 INFO - "buildnumber": 3, 07:10:06 INFO - "slavename": "talos-linux64-ix-069", 07:10:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:10:06 INFO - "platform": "ubuntu64_hw", 07:10:06 INFO - "scheduler": "tests-date-linux64-talos", 07:10:06 INFO - "branch": "date", 07:10:06 INFO - "repo_path": "projects/date", 07:10:06 INFO - "revision": "07e13e514846833c01f65812d04b9c6a2f4b9f84", 07:10:06 INFO - "stage_platform": "linux64", 07:10:06 INFO - "builduid": "6efb071dd86f47a1bdca869686093b38", 07:10:06 INFO - "slavebuilddir": "test" 07:10:06 INFO - } 07:10:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 07:10:06 INFO - Running post-action listener: _resource_record_post_action 07:10:06 INFO - ##### 07:10:06 INFO - ##### Running download-and-extract step. 07:10:06 INFO - ##### 07:10:06 INFO - Running pre-action listener: _resource_record_pre_action 07:10:06 INFO - Running main action method: download_and_extract 07:10:06 INFO - mkdir: /builds/slave/test/build/tests 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:06 INFO - https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/test_packages.json 07:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/test_packages.json 07:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:10:08 INFO - Downloaded 1412 bytes. 07:10:08 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:10:08 INFO - Using the following test package requirements: 07:10:08 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 07:10:08 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 07:10:08 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 07:10:08 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 07:10:08 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 07:10:08 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 07:10:08 INFO - u'jsshell-linux-x86_64.zip'], 07:10:08 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 07:10:08 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 07:10:08 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 07:10:08 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 07:10:08 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 07:10:08 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 07:10:08 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 07:10:08 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 07:10:08 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 07:10:08 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 07:10:08 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 07:10:08 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 07:10:08 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:10:08 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')]} 07:10:08 INFO - https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 07:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 07:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 07:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:10:12 INFO - Downloaded 23091451 bytes. 07:10:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:10:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:10:13 INFO - Return code: 0 07:10:13 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:10:13 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')]} 07:10:13 INFO - https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 07:10:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 07:10:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 07:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:10:15 INFO - Downloaded 23091451 bytes. 07:10:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:10:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:10:16 INFO - Return code: 0 07:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:16 INFO - https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:10:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 07:10:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 07:10:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 07:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:10:17 INFO - Downloaded 10706668 bytes. 07:10:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:10:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:10:17 INFO - Return code: 0 07:10: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')]} 07:10:17 INFO - https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:10:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 07:10:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 07:10:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 07:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:10:19 INFO - Downloaded 52854063 bytes. 07:10:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 07:10:19 INFO - mkdir: /builds/slave/test/properties 07:10:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:10:19 INFO - Writing to file /builds/slave/test/properties/build_url 07:10:19 INFO - Contents: 07:10:19 INFO - build_url:https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 07:10:20 INFO - Running post-action listener: _resource_record_post_action 07:10:20 INFO - Running post-action listener: set_extra_try_arguments 07:10:20 INFO - ##### 07:10:20 INFO - ##### Running populate-webroot step. 07:10:20 INFO - ##### 07:10:20 INFO - Running pre-action listener: _resource_record_pre_action 07:10:20 INFO - Running main action method: populate_webroot 07:10:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:10:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:10:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:10:20 INFO - '--tppagecycles', 07:10:20 INFO - '7'], 07:10:20 INFO - 'tests': ['tsvgm']}}, 07:10:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:10:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:10:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:10:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:10:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:20 INFO - 'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:20 INFO - 'tests': ['damp', 'tps']}, 07:10:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:20 INFO - 'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['damp', 'tps']}, 07:10:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:10:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:20 INFO - 'other': {'tests': ['a11yr', 07:10:20 INFO - 'ts_paint', 07:10:20 INFO - 'tpaint', 07:10:20 INFO - 'sessionrestore', 07:10:20 INFO - 'sessionrestore_no_auto_restore']}, 07:10:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['a11yr', 07:10:20 INFO - 'ts_paint', 07:10:20 INFO - 'tpaint', 07:10:20 INFO - 'sessionrestore', 07:10:20 INFO - 'sessionrestore_no_auto_restore']}, 07:10:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['a11yr', 07:10:20 INFO - 'ts_paint', 07:10:20 INFO - 'tpaint', 07:10:20 INFO - 'sessionrestore', 07:10:20 INFO - 'sessionrestore_no_auto_restore']}, 07:10:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['a11yr', 07:10:20 INFO - 'ts_paint', 07:10:20 INFO - 'tpaint', 07:10:20 INFO - 'sessionrestore', 07:10:20 INFO - 'sessionrestore_no_auto_restore']}, 07:10:20 INFO - 'other_l64': {'tests': ['a11yr', 07:10:20 INFO - 'ts_paint', 07:10:20 INFO - 'tpaint', 07:10:20 INFO - 'sessionrestore', 07:10:20 INFO - 'sessionrestore_no_auto_restore']}, 07:10:20 INFO - 'other_nol64': {'tests': ['a11yr', 07:10:20 INFO - 'ts_paint', 07:10:20 INFO - 'tpaint', 07:10:20 INFO - 'sessionrestore', 07:10:20 INFO - 'sessionrestore_no_auto_restore']}, 07:10:20 INFO - 'svgr': {'tests': ['tsvgx', 07:10:20 INFO - 'tsvgr_opacity', 07:10:20 INFO - 'tart', 07:10:20 INFO - 'tscrollx', 07:10:20 INFO - 'cart']}, 07:10:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['tsvgx', 07:10:20 INFO - 'tsvgr_opacity', 07:10:20 INFO - 'tart', 07:10:20 INFO - 'tscrollx', 07:10:20 INFO - 'cart']}, 07:10:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:20 INFO - 'tests': ['tp5o']}, 07:10:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:20 INFO - 'talos_options': ['--e10s'], 07:10:20 INFO - 'tests': ['tp5o']}, 07:10:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:20 INFO - 'talos_options': ['--xperf_path', 07:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:20 INFO - 'tests': ['tp5n']}, 07:10:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:20 INFO - 'talos_options': ['--e10s', 07:10:20 INFO - '--xperf_path', 07:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:20 INFO - 'tests': ['tp5n']}}, 07:10:20 INFO - 'talos.zip': {'path': '', 07:10:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:10:20 INFO - Running post-action listener: _resource_record_post_action 07:10:20 INFO - ##### 07:10:20 INFO - ##### Running create-virtualenv step. 07:10:20 INFO - ##### 07:10:20 INFO - Running pre-action listener: _resource_record_pre_action 07:10:20 INFO - Running main action method: create_virtualenv 07:10:20 INFO - Creating virtualenv /builds/slave/test/build/venv 07:10:20 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 07:10:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:10:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:20 INFO - Using real prefix '/usr' 07:10:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:10:20 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:22 INFO - Installing pip.................done. 07:10:22 INFO - Return code: 0 07:10:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:22 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 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10:22 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 07:10:22 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 07:10:22 INFO - Using env: {'DISPLAY': ':0', 07:10:22 INFO - 'HOME': '/home/cltbld', 07:10:22 INFO - 'LANG': 'en_US.UTF-8', 07:10:22 INFO - 'LANGUAGE': 'en_US:en', 07:10:22 INFO - 'LOGNAME': 'cltbld', 07:10:22 INFO - 'MAIL': '/var/mail/cltbld', 07:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:22 INFO - 'MOZ_NO_REMOTE': '1', 07:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:22 INFO - 'NO_EM_RESTART': '1', 07:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:22 INFO - 'PWD': '/builds/slave/test', 07:10:22 INFO - 'SHELL': '/bin/bash', 07:10:22 INFO - 'SHLVL': '1', 07:10:22 INFO - 'TERM': 'linux', 07:10:22 INFO - 'TMOUT': '86400', 07:10:22 INFO - 'USER': 'cltbld', 07:10:22 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:22 INFO - '_': '/tools/buildbot/bin/python'} 07:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:23 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 07:10:23 INFO - Cleaning up... 07:10:23 INFO - Return code: 0 07:10:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:10:23 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')]} 07:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:23 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')]} 07:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:23 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 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10:23 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 07:10:23 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 07:10:23 INFO - Using env: {'DISPLAY': ':0', 07:10:23 INFO - 'HOME': '/home/cltbld', 07:10:23 INFO - 'LANG': 'en_US.UTF-8', 07:10:23 INFO - 'LANGUAGE': 'en_US:en', 07:10:23 INFO - 'LOGNAME': 'cltbld', 07:10:23 INFO - 'MAIL': '/var/mail/cltbld', 07:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:23 INFO - 'MOZ_NO_REMOTE': '1', 07:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:23 INFO - 'NO_EM_RESTART': '1', 07:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:23 INFO - 'PWD': '/builds/slave/test', 07:10:23 INFO - 'SHELL': '/bin/bash', 07:10:23 INFO - 'SHLVL': '1', 07:10:23 INFO - 'TERM': 'linux', 07:10:23 INFO - 'TMOUT': '86400', 07:10:23 INFO - 'USER': 'cltbld', 07:10:23 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:23 INFO - '_': '/tools/buildbot/bin/python'} 07:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:23 INFO - Downloading/unpacking psutil>=0.7.1 07:10:23 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 07:10:23 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 07:10:23 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 07:10:23 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 07:10:23 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 07:10:23 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 07:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:25 INFO - Installing collected packages: psutil 07:10:25 INFO - Running setup.py install for psutil 07:10:25 INFO - building 'psutil._psutil_linux' extension 07:10:25 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 07:10:25 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 07:10:25 INFO - building 'psutil._psutil_posix' extension 07:10:25 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 07:10:25 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 07:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:25 INFO - Successfully installed psutil 07:10:25 INFO - Cleaning up... 07:10:25 INFO - Return code: 0 07:10:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:25 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 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10:25 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 07:10:25 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 07:10:25 INFO - Using env: {'DISPLAY': ':0', 07:10:25 INFO - 'HOME': '/home/cltbld', 07:10:25 INFO - 'LANG': 'en_US.UTF-8', 07:10:25 INFO - 'LANGUAGE': 'en_US:en', 07:10:25 INFO - 'LOGNAME': 'cltbld', 07:10:25 INFO - 'MAIL': '/var/mail/cltbld', 07:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:25 INFO - 'MOZ_NO_REMOTE': '1', 07:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:25 INFO - 'NO_EM_RESTART': '1', 07:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:25 INFO - 'PWD': '/builds/slave/test', 07:10:25 INFO - 'SHELL': '/bin/bash', 07:10:25 INFO - 'SHLVL': '1', 07:10:25 INFO - 'TERM': 'linux', 07:10:25 INFO - 'TMOUT': '86400', 07:10:25 INFO - 'USER': 'cltbld', 07:10:25 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:25 INFO - '_': '/tools/buildbot/bin/python'} 07:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:10:28 INFO - Installing collected packages: mozsystemmonitor 07:10:28 INFO - Running setup.py install for mozsystemmonitor 07:10:29 INFO - Successfully installed mozsystemmonitor 07:10:29 INFO - Cleaning up... 07:10:29 INFO - Return code: 0 07:10:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:10:29 INFO - Using env: {'DISPLAY': ':0', 07:10:29 INFO - 'HOME': '/home/cltbld', 07:10:29 INFO - 'LANG': 'en_US.UTF-8', 07:10:29 INFO - 'LANGUAGE': 'en_US:en', 07:10:29 INFO - 'LOGNAME': 'cltbld', 07:10:29 INFO - 'MAIL': '/var/mail/cltbld', 07:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:29 INFO - 'MOZ_NO_REMOTE': '1', 07:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:29 INFO - 'NO_EM_RESTART': '1', 07:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:29 INFO - 'PWD': '/builds/slave/test', 07:10:29 INFO - 'SHELL': '/bin/bash', 07:10:29 INFO - 'SHLVL': '1', 07:10:29 INFO - 'TERM': 'linux', 07:10:29 INFO - 'TMOUT': '86400', 07:10:29 INFO - 'USER': 'cltbld', 07:10:29 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:29 INFO - '_': '/tools/buildbot/bin/python'} 07:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:29 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:10:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:31 INFO - Downloading docopt-0.6.1.tar.gz 07:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:31 INFO - Running setup.py install for blobuploader 07:10:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:10:31 INFO - Running setup.py install for requests 07:10:32 INFO - Running setup.py install for docopt 07:10:32 INFO - Successfully installed blobuploader requests docopt 07:10:32 INFO - Cleaning up... 07:10:32 INFO - Return code: 0 07:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:32 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 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10:32 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 07:10:32 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 07:10:32 INFO - Using env: {'DISPLAY': ':0', 07:10:32 INFO - 'HOME': '/home/cltbld', 07:10:32 INFO - 'LANG': 'en_US.UTF-8', 07:10:32 INFO - 'LANGUAGE': 'en_US:en', 07:10:32 INFO - 'LOGNAME': 'cltbld', 07:10:32 INFO - 'MAIL': '/var/mail/cltbld', 07:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:32 INFO - 'MOZ_NO_REMOTE': '1', 07:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:32 INFO - 'NO_EM_RESTART': '1', 07:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:32 INFO - 'PWD': '/builds/slave/test', 07:10:32 INFO - 'SHELL': '/bin/bash', 07:10:32 INFO - 'SHLVL': '1', 07:10:32 INFO - 'TERM': 'linux', 07:10:32 INFO - 'TMOUT': '86400', 07:10:32 INFO - 'USER': 'cltbld', 07:10:32 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:32 INFO - '_': '/tools/buildbot/bin/python'} 07:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:32 INFO - Running setup.py (path:/tmp/pip-vdbCvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:32 INFO - Running setup.py (path:/tmp/pip-727pRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:32 INFO - Running setup.py (path:/tmp/pip-mow0A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:32 INFO - Running setup.py (path:/tmp/pip-D1gQmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:33 INFO - Running setup.py (path:/tmp/pip-WZqRlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:33 INFO - Running setup.py (path:/tmp/pip-VrPR1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:33 INFO - Running setup.py (path:/tmp/pip-2BcYEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:33 INFO - Running setup.py (path:/tmp/pip-Nyc4gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:33 INFO - Running setup.py (path:/tmp/pip-soySjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:33 INFO - Running setup.py (path:/tmp/pip-0nzFdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:33 INFO - Running setup.py (path:/tmp/pip-CoWem9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:33 INFO - Running setup.py (path:/tmp/pip-MiZnDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:33 INFO - Running setup.py (path:/tmp/pip-bTkjYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:33 INFO - Running setup.py (path:/tmp/pip-hbMIyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:33 INFO - Running setup.py (path:/tmp/pip-iB2_Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:33 INFO - Running setup.py (path:/tmp/pip-VOVI8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:33 INFO - Running setup.py (path:/tmp/pip-pwrwGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:33 INFO - Running setup.py install for manifestparser 07:10:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozcrash 07:10:34 INFO - Running setup.py install for mozdebug 07:10:34 INFO - Running setup.py install for mozdevice 07:10:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozfile 07:10:34 INFO - Running setup.py install for mozhttpd 07:10:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozinfo 07:10:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozInstall 07:10:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozleak 07:10:34 INFO - Running setup.py install for mozlog 07:10:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for moznetwork 07:10:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:35 INFO - Running setup.py install for mozprocess 07:10:35 INFO - Running setup.py install for mozprofile 07:10:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:35 INFO - Running setup.py install for mozrunner 07:10:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:35 INFO - Running setup.py install for mozscreenshot 07:10:35 INFO - Running setup.py install for moztest 07:10:35 INFO - Running setup.py install for mozversion 07:10:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:35 INFO - Cleaning up... 07:10:35 INFO - Return code: 0 07:10:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:35 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 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10:35 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 07:10:35 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 07:10:35 INFO - Using env: {'DISPLAY': ':0', 07:10:35 INFO - 'HOME': '/home/cltbld', 07:10:35 INFO - 'LANG': 'en_US.UTF-8', 07:10:35 INFO - 'LANGUAGE': 'en_US:en', 07:10:35 INFO - 'LOGNAME': 'cltbld', 07:10:35 INFO - 'MAIL': '/var/mail/cltbld', 07:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:35 INFO - 'MOZ_NO_REMOTE': '1', 07:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:35 INFO - 'NO_EM_RESTART': '1', 07:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:35 INFO - 'PWD': '/builds/slave/test', 07:10:35 INFO - 'SHELL': '/bin/bash', 07:10:35 INFO - 'SHLVL': '1', 07:10:35 INFO - 'TERM': 'linux', 07:10:35 INFO - 'TMOUT': '86400', 07:10:35 INFO - 'USER': 'cltbld', 07:10:35 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:35 INFO - '_': '/tools/buildbot/bin/python'} 07:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:35 INFO - Running setup.py (path:/tmp/pip-IkualH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:36 INFO - Running setup.py (path:/tmp/pip-XoF37g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:36 INFO - Running setup.py (path:/tmp/pip-dxTxWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:36 INFO - Running setup.py (path:/tmp/pip-6AQRoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:36 INFO - Running setup.py (path:/tmp/pip-YyYUaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:36 INFO - Running setup.py (path:/tmp/pip-BSe9BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:36 INFO - Running setup.py (path:/tmp/pip-3xyuwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:36 INFO - Running setup.py (path:/tmp/pip-C9xbob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:36 INFO - Running setup.py (path:/tmp/pip-2CIoqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:36 INFO - Running setup.py (path:/tmp/pip-B8hacb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:36 INFO - Running setup.py (path:/tmp/pip-vzsSds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:36 INFO - Running setup.py (path:/tmp/pip-tqBOds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:36 INFO - Running setup.py (path:/tmp/pip-xhZZe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:36 INFO - Running setup.py (path:/tmp/pip-1jxgyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:36 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)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:36 INFO - Running setup.py (path:/tmp/pip-CJ7Hk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:37 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)) 07:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:37 INFO - Running setup.py (path:/tmp/pip-9PojaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:37 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)) 07:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:37 INFO - Running setup.py (path:/tmp/pip-SafEzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:37 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)) 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:37 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 07:10:37 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 07:10:37 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 07:10:37 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 07:10:37 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 07:10:37 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 07:10:38 INFO - Downloading blessings-1.6.tar.gz 07:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:39 INFO - Installing collected packages: blessings 07:10:39 INFO - Running setup.py install for blessings 07:10:39 INFO - Successfully installed blessings 07:10:39 INFO - Cleaning up... 07:10:39 INFO - Return code: 0 07:10:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:39 INFO - Reading from file tmpfile_stdout 07:10:39 INFO - Current package versions: 07:10:39 INFO - argparse == 1.2.1 07:10:39 INFO - blessings == 1.6 07:10:39 INFO - blobuploader == 1.2.4 07:10:39 INFO - docopt == 0.6.1 07:10:39 INFO - manifestparser == 1.1 07:10:39 INFO - mozInstall == 1.12 07:10:39 INFO - mozcrash == 0.16 07:10:39 INFO - mozdebug == 0.1 07:10:39 INFO - mozdevice == 0.48 07:10:39 INFO - mozfile == 1.2 07:10:39 INFO - mozhttpd == 0.7 07:10:39 INFO - mozinfo == 0.9 07:10:39 INFO - mozleak == 0.1 07:10:39 INFO - mozlog == 3.1 07:10:39 INFO - moznetwork == 0.27 07:10:39 INFO - mozprocess == 0.22 07:10:39 INFO - mozprofile == 0.28 07:10:39 INFO - mozrunner == 6.11 07:10:39 INFO - mozscreenshot == 0.1 07:10:39 INFO - mozsystemmonitor == 0.0 07:10:39 INFO - moztest == 0.7 07:10:39 INFO - mozversion == 1.4 07:10:39 INFO - psutil == 3.1.1 07:10:39 INFO - requests == 1.2.3 07:10:39 INFO - wsgiref == 0.1.2 07:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:39 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 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10:39 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 07:10:39 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 07:10:39 INFO - Using env: {'DISPLAY': ':0', 07:10:39 INFO - 'HOME': '/home/cltbld', 07:10:39 INFO - 'LANG': 'en_US.UTF-8', 07:10:39 INFO - 'LANGUAGE': 'en_US:en', 07:10:39 INFO - 'LOGNAME': 'cltbld', 07:10:39 INFO - 'MAIL': '/var/mail/cltbld', 07:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:39 INFO - 'MOZ_NO_REMOTE': '1', 07:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:39 INFO - 'NO_EM_RESTART': '1', 07:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:39 INFO - 'PWD': '/builds/slave/test', 07:10:39 INFO - 'SHELL': '/bin/bash', 07:10:39 INFO - 'SHLVL': '1', 07:10:39 INFO - 'TERM': 'linux', 07:10:39 INFO - 'TMOUT': '86400', 07:10:39 INFO - 'USER': 'cltbld', 07:10:39 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:39 INFO - '_': '/tools/buildbot/bin/python'} 07:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 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)) 07:10:39 INFO - Cleaning up... 07:10:39 INFO - Return code: 0 07:10:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10: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', 'jsonschema'] in /builds/slave/test/build 07:10: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 jsonschema 07:10:39 INFO - Using env: {'DISPLAY': ':0', 07:10:39 INFO - 'HOME': '/home/cltbld', 07:10:39 INFO - 'LANG': 'en_US.UTF-8', 07:10:39 INFO - 'LANGUAGE': 'en_US:en', 07:10:39 INFO - 'LOGNAME': 'cltbld', 07:10:39 INFO - 'MAIL': '/var/mail/cltbld', 07:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:39 INFO - 'MOZ_NO_REMOTE': '1', 07:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:39 INFO - 'NO_EM_RESTART': '1', 07:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:39 INFO - 'PWD': '/builds/slave/test', 07:10:39 INFO - 'SHELL': '/bin/bash', 07:10:39 INFO - 'SHLVL': '1', 07:10:39 INFO - 'TERM': 'linux', 07:10:39 INFO - 'TMOUT': '86400', 07:10:39 INFO - 'USER': 'cltbld', 07:10:39 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:39 INFO - '_': '/tools/buildbot/bin/python'} 07:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:39 INFO - Downloading/unpacking jsonschema 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:41 INFO - Downloading/unpacking functools32 (from jsonschema) 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:41 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:41 INFO - warning: no files found matching '*.txt' 07:10:41 INFO - no previously-included directories found matching 'build' 07:10:41 INFO - no previously-included directories found matching 'dist' 07:10:41 INFO - no previously-included directories found matching '.git*' 07:10:41 INFO - Installing collected packages: jsonschema, functools32 07:10:42 INFO - Running setup.py install for functools32 07:10:42 INFO - warning: no files found matching '*.txt' 07:10:42 INFO - no previously-included directories found matching 'build' 07:10:42 INFO - no previously-included directories found matching 'dist' 07:10:42 INFO - no previously-included directories found matching '.git*' 07:10:42 INFO - Successfully installed jsonschema functools32 07:10:42 INFO - Cleaning up... 07:10:42 INFO - Return code: 0 07:10:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:42 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 0x7f26a3582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, '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': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', '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 07:10:42 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 07:10:42 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 07:10:42 INFO - Using env: {'DISPLAY': ':0', 07:10:42 INFO - 'HOME': '/home/cltbld', 07:10:42 INFO - 'LANG': 'en_US.UTF-8', 07:10:42 INFO - 'LANGUAGE': 'en_US:en', 07:10:42 INFO - 'LOGNAME': 'cltbld', 07:10:42 INFO - 'MAIL': '/var/mail/cltbld', 07:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:42 INFO - 'MOZ_NO_REMOTE': '1', 07:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:42 INFO - 'NO_EM_RESTART': '1', 07:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:42 INFO - 'PWD': '/builds/slave/test', 07:10:42 INFO - 'SHELL': '/bin/bash', 07:10:42 INFO - 'SHLVL': '1', 07:10:42 INFO - 'TERM': 'linux', 07:10:42 INFO - 'TMOUT': '86400', 07:10:42 INFO - 'USER': 'cltbld', 07:10:42 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:42 INFO - '_': '/tools/buildbot/bin/python'} 07:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:42 INFO - Downloading/unpacking flake8 07:10:42 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 07:10:42 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 07:10:42 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 07:10:42 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 07:10:42 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 07:10:42 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 07:10:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:10:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:10:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 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 07:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:10:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:44 INFO - no previously-included directories found matching 'docs/_build' 07:10:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:10:45 INFO - Running setup.py install for pep8 07:10:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:45 INFO - no previously-included directories found matching 'docs/_build' 07:10:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:10:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:10:45 INFO - Cleaning up... 07:10:45 INFO - Return code: 0 07:10:45 INFO - Running post-action listener: _resource_record_post_action 07:10:45 INFO - Running post-action listener: _start_resource_monitoring 07:10:45 INFO - Starting resource monitoring. 07:10:45 INFO - ##### 07:10:45 INFO - ##### Running install step. 07:10:45 INFO - ##### 07:10:45 INFO - Running pre-action listener: _resource_record_pre_action 07:10:45 INFO - Running main action method: install 07:10:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:45 INFO - Reading from file tmpfile_stdout 07:10:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:45 INFO - Reading from file tmpfile_stdout 07:10:45 INFO - Output received: 07:10:45 INFO - Usage: mozinstall [options] installer 07:10:45 INFO - Options: 07:10:45 INFO - -h, --help show this help message and exit 07:10:45 INFO - -d DEST, --destination=DEST 07:10:45 INFO - Directory to install application into. [default: 07:10:45 INFO - "/builds/slave/test"] 07:10:45 INFO - --app=APP Application being installed. [default: firefox] 07:10:45 INFO - mkdir: /builds/slave/test/build/application 07:10:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:10:58 INFO - Reading from file tmpfile_stdout 07:10:58 INFO - Output received: 07:10:58 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:58 INFO - Running post-action listener: _resource_record_post_action 07:10:58 INFO - ##### 07:10:58 INFO - ##### Running run-tests step. 07:10:58 INFO - ##### 07:10:58 INFO - Running pre-action listener: _resource_record_pre_action 07:10:58 INFO - Running main action method: run_tests 07:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:58 INFO - Python 2.7.3 07:10:58 INFO - Return code: 0 07:10:58 INFO - grabbing minidump binary from tooltool 07:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:58 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 0x2c4a430>, '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 0x2bb5f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb63c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:58 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 07:10:58 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 07:10:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:58 INFO - Return code: 0 07:10:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:10:59 INFO - Return code: 0 07:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:10:59 INFO - Using env: {'DISPLAY': ':0', 07:10:59 INFO - 'HOME': '/home/cltbld', 07:10:59 INFO - 'LANG': 'en_US.UTF-8', 07:10:59 INFO - 'LANGUAGE': 'en_US:en', 07:10:59 INFO - 'LOGNAME': 'cltbld', 07:10:59 INFO - 'MAIL': '/var/mail/cltbld', 07:10:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:59 INFO - 'MOZ_NO_REMOTE': '1', 07:10:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:59 INFO - 'NO_EM_RESTART': '1', 07:10:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:59 INFO - 'PWD': '/builds/slave/test', 07:10:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:59 INFO - 'SHELL': '/bin/bash', 07:10:59 INFO - 'SHLVL': '1', 07:10:59 INFO - 'TERM': 'linux', 07:10:59 INFO - 'TMOUT': '86400', 07:10:59 INFO - 'USER': 'cltbld', 07:10:59 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1457017804.218745-253821512', 07:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:59 INFO - '_': '/tools/buildbot/bin/python'} 07:10:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:10:59 INFO - mozversion application_buildid: 20160302200635 07:10:59 INFO - mozversion application_changeset: 07e13e514846833c01f65812d04b9c6a2f4b9f84 07:10:59 INFO - mozversion application_display_name: Firefox 07:10:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:59 INFO - mozversion application_name: Firefox 07:10:59 INFO - mozversion application_remotingname: firefox 07:10:59 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 07:10:59 INFO - mozversion application_vendor: Mozilla 07:10:59 INFO - mozversion application_version: 46.0 07:10:59 INFO - mozversion platform_buildid: 20160302200635 07:10:59 INFO - mozversion platform_changeset: 07e13e514846833c01f65812d04b9c6a2f4b9f84 07:10:59 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 07:10:59 INFO - mozversion platform_version: 46.0 07:10:59 INFO - using testdate: 1457017859 07:10:59 INFO - actual date: 1457017859 07:10:59 INFO - starting webserver on 'localhost:51914' 07:10:59 INFO - SUITE-START | Running 3 tests 07:10:59 INFO - TEST-START | dromaeo_css 07:10:59 INFO - operating with platform_type : linux_ 07:10:59 INFO - Initialising browser for dromaeo_css test... 07:10:59 INFO - TEST-INFO | started process 10530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpszfhCC/profile http://localhost:51914/getInfo.html) 07:11:03 INFO - PROCESS | 10530 | __metrics Screen width/height:1600/1200 07:11:03 INFO - PROCESS | 10530 | colorDepth:24 07:11:03 INFO - PROCESS | 10530 | Browser inner width/height: 1024/697 07:11:03 INFO - PROCESS | 10530 | __metrics 07:11:04 INFO - PROCESS | 10530 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:05 INFO - TEST-INFO | 10530: exit 0 07:11:05 INFO - Browser initialized. 07:11:05 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:05 INFO - TEST-INFO | started process 10618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpszfhCC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:16 INFO - PROCESS | 10618 | RSS: Main: 136581120 07:11:16 INFO - PROCESS | 10618 | 07:12:07 INFO - PROCESS | 10618 | 1457017927930 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] 07:14:15 INFO - PROCESS | 10618 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51914/tests/dromaeo/cssquery-ext.html) 07:14:16 INFO - PROCESS | 10618 | RSS: Main: 224481280 07:14:16 INFO - PROCESS | 10618 | 07:17:18 INFO - PROCESS | 10618 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-ext.html (next: http://localhost:51914/tests/dromaeo/cssquery-jquery.html) 07:17:19 INFO - PROCESS | 10618 | RSS: Main: 208822272 07:17:19 INFO - PROCESS | 10618 | 07:20:21 INFO - PROCESS | 10618 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51914/tests/dromaeo/cssquery-mootools.html) 07:20:21 INFO - PROCESS | 10618 | RSS: Main: 210317312 07:20:21 INFO - PROCESS | 10618 | 07:23:23 INFO - PROCESS | 10618 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51914/tests/dromaeo/cssquery-prototype.html) 07:23:24 INFO - PROCESS | 10618 | RSS: Main: 197566464 07:23:24 INFO - PROCESS | 10618 | 07:26:26 INFO - PROCESS | 10618 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51914/tests/dromaeo/cssquery-yui.html) 07:26:27 INFO - PROCESS | 10618 | RSS: Main: 200040448 07:26:27 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-yui.html (next: http://localhost:51914/tests/dromaeo/cssquery-dojo.html) 07:29:29 INFO - PROCESS | 10618 | RSS: Main: 240570368 07:29:29 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | __start_tp_report 07:29:29 INFO - PROCESS | 10618 | _x_x_mozilla_page_load 07:29:29 INFO - PROCESS | 10618 | _x_x_mozilla_page_load_details 07:29:29 INFO - PROCESS | 10618 | |i|pagename|runs| 07:29:29 INFO - PROCESS | 10618 | |0;dojo.html;3221.5006673965536;3238.935221295574;3240.189952511872;3261.7227535659467;3268.2319654881085;5144.845654630362;5147.330846989891;5149.613778966574;5153.690778553289;5195.246689230059;5110;5118.232265160228;5148.536631703146;5173.560247378978;5198.168293073109;4632.07358528294;4709.623230141598;4732.361131247289;4757.191277482819;4791.520847915215;4758.524147585231;4790;4795.184818580832;4799.088173247089;4801.639877009221;4761;4778.235482322812;4803.61571074315;4856.7571621418965;4864.246041863516;4824.782884770194;4851.902961940741;4853.563179313879;4874;4878.902421951541;4777.784999675023;4814;4823;4850.151223535867;4852.587530059949;4907.141250281186;4921.188003979375;4940.110780059588;4983.775730092155;4997.150484417622;5474.479924407175;5510.834674959718;5516.310461192351;5520.171974203861;5534.391216966131;5486.396496385394;5557;5570.526505247059;5593.3847276799515;5602.187682785973;5175.896482070375;5220.660657057279;5268.683878967236;5286.577073834084;5311;5646.0683987141665;5647.774089036475;5648.8870222595315;5652.971735141298;5658.519025882846;5314.2825718528275;5393.298871146726;5463.836084917459;5469.890602187934;5486.423925487846;5627.43725627434;5690.4025077367105;5702.144678298288;5717.428257174332;5720.914186287209;5520.751566179451;5554.222408862763;5598.300212473441;5603.15952607104;5612.130119831432;5406.432324605859;5455.563554915597;5489.752961116759;5577.079781836032;5590.301212348457;4327.350897365357;4332.068605249887;4333.956660433419;4357.564243575617;4361.890952726208;3900.9804950975063;3903.1803321302277;3907.199024200032;3919.6864250860435;3926.5484469285825;5054.393472783289;5124.461931497139;5161.380634323905;5210.97394513025;5241.9737901310245;5597.356304025089;5612.803551875665;5635.408282130399;5635.549156067505;5639.041362968305;5278.736063196825;5290.1800220965815;5295.788168473218;5299.019681358961;5333.706646134422;4602.2406302959635;4653.976730116327;4695.178343789823;4725.149473094876;4764.809407623726;5767.336756273083;5794.159846822272;5796.043652797325;5801.216835727208;5804.187413762077;5428.565714742732;5593.13306437511;5609.691466969356;5610.635308704921;5639.097744360883;5649.6327738696855;5723.771049157987;5829.213056237354;5845.561582881386;5885.47030767233;5531.557475401878;5533.197686335539;5534.944650553443;5535.280413546213;5542.334919809648;5548.361938377138;5571.857699659921;5625.09998400254;5632.098864181711;5662.037453632975;5443.183522471661;5501.504864562048;5506.614536982373;5511.889762204813;5542.584306177134;5514.531264842373;5526.613137080366;5532.2254884317035;5535.0590399632965;5536.031194540858;5254.080535906278;5262.02652509287;5327.200919862052;5400.459954004568;5419.647722897999;5506.339239291311;5512.3385193777;5536.944630553643;5538.778448862;5540.030494663499;5387.138057910715;5420.891582168256;5422.078246697992;5434.75543600531;5458.590605704668 07:29:29 INFO - PROCESS | 10618 | |1;ext.html;519.5453977769452;533.5358238332649;556.5213916032214;566.8951244019856;601.8525461261992;29532.11403657891;36986.63013369866;37288.62711372886;37303;37365.813170934176;41395.79302103493;41767.37348939768;41895.790521047355;41952.58047419525;41962.37056444156;8628.007779105405;8833.734987950373;8841.867371989425;8847.115288471166;8849.646014159458;8763;8918.777030574223;8918.910810891904;8923.464592124461;8925.95537022314;8921.732348029536;8999.550022498881;9006.954965225197;9014.36899417041;9018.594163262636;8859.11408859112;8874;8929.241014513775;8944.910550894505;8955.776105597348;8815.77960550985;8943.910560894374;8966.148215919477;8970.147835955573;8976.820463590757;41048.58951410477;41521.37717934234;41540.79229603863;41571.792141039405;41613.79193104015;3635.2366003139373;3683.226522430293;3697.3714468540143;4135.669146468275;4370.453693288339;28511.287217819514;28852.855735721398;29112.41775164506;29118.85440572805;29927.251818704488;4095.877123686294;4144.8756537303925;4190.643795277405;4226.619604235603;4232.555581663912;273002;279042.4191516158;279579;279829;280251.99999999796;55883.72058139765;57035.71482142646;63820.680896596146;64361.67819160968;65461;57319.713401432724;57933.131003034985;58083.4191658078;58109.12836307459;58175;16522.75215871763;16688.83311166897;16701.665966680597;16718.749218761728;16720.331186752635;13004.869951300556;13066.477340906258;13068.869311306766;13073.346332683328;13137.408816603276;21161;21310.36068917935;21395.358139255848;21480.570388592452;21516.569668606855;8135.552544610104;8370.665173393118;8386.235213218719;8432.957835210786;8480.74557763268;1087.8857719939451;1090.7109615951779;1096.0738176241064;1185.5020891225706;1193.6836738264367;30127.397452050835;30633.23416914595;30898.073057808302;31194.376112477625;31441.371172576877;1088.7060493666825;1184.2894263442038;1202.7173614200656;1238.6160290310033;1262.8421447319085;14470.927645361706;16684.74972875408;16941.237644306035;17193.656126877642;17202.225899834288;423075;427110;427348;428225;429300;57388.139177912366;58164.70917645385;58166.70916645474;58173.41826581764;58219.4178058214;1356.4913157565913;1405.5221224783622;1505.6386467248;1520.7186670465999;1594.7129516687107;27395.726042739316;27519.862400687867;27693.58459623067;27896.442071158057;27910.441791163656;43886.12227755491;44605.55394446014;44664;44673;44705.77647111744;258487;258926;261289;263173;263632;33415.16462088467;33814.830925845214;33991.150221244665;34170.14574635555;34171.82914085413;44246.557534424246;44509.33236001527;44687.32969005402;44799.77600111978;45349.54650453585;37076.62923370732;37545.43681844829;38304.23391532098;38447.23105537818;38599.228015438974;35991.64008359883;36133.33532728157;37232;37293.25413491769;37326.25347493089;36665.26669466649;37481.437778433894;37605.62394376021;37716.62283377131;37803;33390.83304583462;33595.32809343848;34595.65404346025;34601;34945;25858.482830343662;26204.73795262099;26326.60510092312;26327.868360658074;26653.60019599669 07:29:29 INFO - PROCESS | 10618 | |2;jquery.html;376.8850500597318;378.68379902781174;380.8609857402049;384.2622165442349;385.3410667758133;14658.267086645652;16556.83443165568;16639.251233694482;17881.910590447045;17905.910470447645;17154.742678859828;17513.73729394057;17652.38216662417;17660.116994150274;17698.646027079452;5337.572994160468;5501.504864562188;5516.641418307797;5542.39033706292;5543.390227075019;4180.644645205161;4382.496012958519;5788.507976821975;6017.097435384705;6022.578419510636;5768.682722450264;5916.674582897939;5969.462748352669;5971.223740913675;5983.521318294526;5875.471207591338;5963.552733544958;6030;6049.909251361233;6051.848703782419;5337.359516858002;5345.866353341159;5364.7317634118135;5368.516833484966;5379.892402151974;20883.164673413197;20927.5814483711;21136.260230892;21147.8942605286;21186.576268474546;2330.2892617751577;2357.092519380034;2447.8898449569633;2462.4213309872166;2499.262717498342;9198.724038278862;9791.216702663769;10213.693589192337;13021.348932553334;13907.513237036655;1905.5807722301072;1907.3515004898263;1970.9901450492655;1983.5338695406567;1999.9600007999904;53095.73452132753;57162.42837571654;57928.71035644837;59160;59690.70154649199;10694.572217111385;10856.131509479223;10972;10974.451277436096;11002.889971100187;13997.090189137674;14117.294135293194;14192.503262385768;14255.358508866919;14284.50004249867;8192.508449493049;8250.669973201006;8276.172382761795;8410.789730256793;8413.158684131538;8131.349492040623;8158.388120890957;8169.591520424074;8202;8217.54803485814;4419.0940857124215;4589.5639914208095;4693.084848454519;4795.400574928134;4814.975925120352;1872.3072463188435;1894.4600788775133;1919.3378284491828;1926.7880533141342;1950.0542237015036;938.648006997376;958.5399008475971;988.614440368257;1089.1395797320188;1110.4836251143256;15167.469138580318;16587.170641467877;16595.585110372336;16751.748723769153;17089.14554272306;1008.4806324742764;1030.8971484134695;1048.916086713061;1055.1084333737979;1060.067140915989;9852.704418867446;10101.747456313504;10112.140468060297;10180.592776288866;10240.948795255976;532254;532774;585975;660922;668855;71788;76855.23144768481;79223;79962;79985;1121.4448847820381;1158.7856246594406;1161.4425075963584;1170.4323403149465;1218.0986070307908;14997.475088371855;15126.848731512544;15165.09009459436;15560;15579.065256084672;34347.14132146716;35850.28299434049;36964.44553331648;36970.44544331783;37419.43870841994;45353.77323113364;46589;47116.528834711215;47871.76064119657;47926.760366197945;3347.0126312737316;3361.159710072482;7402;7528.934375437202;7651.005369302177;10698.946505267735;11348.659540213806;11483.885161148615;11498.022668072972;11889.583864564698;9536.475493847905;9647.469389183661;9778.751151041593;9997.100260976547;10057.044580764816;7667.463277570517;8311.625976831177;10567.841482377617;10622.787544249226;10916.454177290945;7001.63468123711;7409.259074092548;7562.0925488941675;7745.535267883945;7983.960080199562;10349.586016559253;10421.843672345072;10731.980461856112;10840.241183117107;10915.945420272848;7697.114831794415;7710.228977102245;10148.086672199537;10436.58253669875;10509.264351495322 07:29:29 INFO - PROCESS | 10618 | |3;mootools.html;1366.4192718094807;1517.6205948512873;1527.618095476131;1724.5860993361598;1895.365052707344;6925.722971081157;7555.433342499314;7742.651580678869;7746.53520788753;7765.7670269892;7509.9624501877415;7580.39356851452;7598.506097103698;7646.158922518533;7660.272274133962;2288.1648198407543;2307.192482631074;2308.9422764430938;2309.896054677535;2311.6185829338137;2215.4350640586626;2281.0989659084735;2366.7988221001237;2366.810655147584;2368.846025008369;2311.1217737259817;2337.6026075567192;2340.028888011473;2341.1571834139695;2342.6603142544404;2314.1784666443336;2333.6266197408418;2334.9066037358484;2340.368100612825;2344.074090734159;2270.28486026901;2271.1710225767642;2271.3867255840996;2274.8521346112616;2275.7155355580553;7714.190010048977;7779.805504862367;7788.766337009899;7789.415793815429;7794.142644309121;4690.530946905282;4841.2012018016985;4845.248986407112;4847.175980083394;4847.612191024709;3029.4546981543313;3102.922426939322;3190.106770104351;3190.9042728718177;3206.3907857507234;975.5512464266446;981.4258658684678;1048.4233671480656;1058.1746237934424;1954.6481633306141;10465.686029419054;10472.371657700562;10516.47417629123;10588.682339529827;10598.205134614858;4129.483814523184;4171.20747058058;4192.580741925844;4208.347706105558;4213.325867861189;8617.224449799549;8618.525981071101;8624.655013799378;8636;8641.524716140548;4756.9524304756505;4772.522747725269;4782.52174782519;4815.951840481621;4823.445303790038;3851.9037024074623;3934.803259836997;3984.1234928315725;4440.622547083534;4454.955450445519;3274.279658475132;3340.331933613287;3467.3065386922717;3532.4701294805473;3545.9290814183573;1028.8148133336072;1068.433730123036;1072.4798472740715;1077.1113831089383;1082.880883102858;1400.033976556173;1405.220102842932;1405.2552147361914;1421.3745951781184;1427.5075099090798;7531.924680753232;7558.433117516099;7571.621418929031;7574.356179724785;7577.621118944031;1082.9620963266248;1091.4815462655333;1115.1803424482998;1145.9312441253385;1178.7701398227434;5867.207926929896;5903.085021821625;5958.761649534057;6003.339632640406;6004.729787159588;9331.58007889633;9492.715218543455;9713.22294216461;9761.170300524393;9772.853407198898;9265.814683706289;9326.207272381924;9425.245980321557;9429.104235097655;9462.57418416173;7362.7423040193335;7503.7748867534065;7555.924440755632;7564.243575642392;7600.239976002466;7380.594067326134;7403.333699967029;7429.108506979197;7429.219931907072;7429.962850185714;8325.876006739012;8509.361797865062;8617.612207450555;8707.738767836974;8818.735437936872;8739.994900586515;8762.518061506678;8771.342149338952;8886.422382545114;8950.507722075348;6548.607083575001;6635.933640663725;6663.13379260693;6794.42247408956;6820.147481564804;6881.759138430131;7083.574985500886;7308.5614863108385;7538.623068846646;7543.962280188784;6994.160700715946;7024.26245244242;7077.68150433242;7137.464690148156;7277.854442911006;6964.025036494793;6964.4080253179045;6986.510944234058;7069.893951590628;7071;7044.084269044992;7050.894236586558;7115.786526404217;7119.75080872167;7121.465890058163;6515.153030106056;6553.475721942138;6569.57297775643;6578.572392794453;6591.538592298493;6783.118194634666;6819.590824550344;6824.112865327475;6824.761133360308;6838.93161068383 07:29:29 INFO - PROCESS | 10618 | |4;prototype.html;365.87560229521966;366.2181243046096;372.175630977385;374.88378602633185;380.63078813550845;5865.706714664271;5986.64080155191;6026.668533230671;6029.095635654654;6046.969765151168;5784.363719990798;5881.85295367615;5963.463288304062;5979.043353063511;5990.371011043832;4714.5756881880625;4718.669693121483;4721;4722.693024953384;4724.17326967781;4495.977520112395;4501.842435514757;4570.520095389986;4583.060472603109;4714.175019371613;4584.564466375689;4598.333241679954;4602.930956035662;4604.102200070987;4607.239805432099;4608.1474927138415;4617.6536759742985;4622.237330840441;4625.306204069417;4625.375574297461;4074.7147699661036;4080.285949958775;4086.836526538935;4087.9386809197886;4095.3037983542868;5674.829755107354;5742;5752.626079304831;5752.971235143839;5755.740991655385;5430.972845135789;5443.265159203496;5444.128939369682;5446.101393270105;5447.727613619343;6126;6372.745090196387;6373.362663733636;6378.840528986812;6384.3934826191435;4532.388127602764;4581.931271030937;4630.351750754897;4635.420572428447;4640.76796160194;6481.28705842357;6607.339266073354;6612.669366531654;6618.801435956929;6623.07276981223;4765.666403351732;4771.403574553181;4774.68696108566;4776.068666609977;4783.880402989953;4776.09254241693;4843;4852.369192005017;4855.1260773060485;4873.561379475794;5471.06991811393;5479.0411677957;5480.534154596824;5482.17767334895;5485.149801780731;6409.262934762469;6419.293877673452;6421.518386120966;6425.775097871552;6428.357164283534;1711.7860267466567;1714.8971061736336;1722.9396971106203;1728.2136627834304;1731.3940120957564;1128.971775705614;1129.0290350298737;1133.1784456269304;1136.772645470909;1179.0744265751343;5949.286085669661;5990.4908082813445;6005.639661620229;6093.268807743099;6100.450959413674;6535.640539770358;6559.180102487189;6572.309907459744;6572.802815915435;6573.769918052845;6087.57386982907;6091.08633704939;6092.055731361646;6096.237970253718;6103.6948152592195;3426.126337783899;3505.386557352453;3527;3530.2939412117166;3535.169235229719;6760.729570817112;6761.830954226184;6764.864702706017;6773.322667733188;6778.830529236809;6710.859153943841;6723.159605049369;6724.865502690017;6732.158480189976;6744.0895479109695;6636.137302150786;6680.13158289429;6750.3924646782025;6750.8649827004165;6770.661466926634;6382.744690212525;6466.902996454963;6555.344465553597;6573.04690819838;6647.235567909753;6437.806865794034;6438.742450301936;6465.353464653497;6486.318936511599;6579.980103083838;6773.661316934035;6796.116504854337;6809.455243580403;6823.215330237086;6823.93176068233;4576.084783043471;4737.265723812815;4752.310914917249;4849.660523763303;4862.465128835896;6634.535582509178;6637.70130344126;6641.667916604054;6649.102371179829;6655.334466553306;6478.643674597943;6479.708413121515;6481.351864813481;6495.253045899782;6499.935000650122;6334.303226644974;6467.547271690936;6469.547131700736;6481.189851268591;6522.641254731036;6349.238091429058;6375.681215939092;6377.202849643794;6385.616862988236;6388.488920886225;6498.610083395011;6514.218293804774;6528.281888992302;6533.41199292066;6536;6159.6612186330185;6301.464375528131;6360.4275615193;6384.872302554016;6395.872082558416 07:29:29 INFO - PROCESS | 10618 | |5;yui.html;748.6855520681313;799.5562462833125;825.9710910118146;939.3143005605907;943.6508491858013;13064.281464519448;13241.205527668346;13262.801057984127;13267.40296686649;13309;13585.932070339659;13654;13656.112352697068;13671.248081355521;13682.24747638882;718.1525799556521;877.2630989968441;879.7228872905047;880.0759202837028;880.5993273060774;730.7844185965153;879.683314006957;889.7108439757072;895.4492986813095;895.4895709445618;931.6599441203946;940.0834186667978;941.2611100286276;941.2752180820764;942.0720590218664;758.7723682895164;765.9004329437194;919.1268295119663;932.6083045121065;933.4865823796885;688.5042769206163;688.579966220605;688.7554918004137;689.2039694153261;689.7792706333975;14106.506272280421;14110.717785644332;14123.576292711236;14127.505537306248;14142.080764750259;11952.880471195263;12474.18917770342;12543.435545400387;12744.490220391173;12752;11227.887721122848;11293.20947533673;11414.401983722286;11468.714425515704;11651.417429128509;3818.369968955119;3827.617238276178;3834.0798208430056;3853.5183102112237;3855.151866589346;52344.47655523434;53097.46902531003;53237.2014419784;53244.73377633126;53276.73361633206;10392.37645741258;10393.116585090353;10515;10566.735831604117;10692.572297108185;19836.60326793456;19910.104045317996;19931.701024484646;20013.59972800536;20021.599568008558;7679.078510578766;7762.495437796525;7948.721794737272;8016.679332826739;8354.707585234488;4596.931046034312;4799.352087468147;4805.8558243252755;4810.95189048105;4955.1576232039915;3302.1084307237393;3309.2885029718245;3321.4685650295837;3324.8337583120747;3336.115929278743;575.1114528054167;594.9821505354846;602.3614968133792;604.6704546022428;611.7338957553478;603.7494439807518;671.701093013614;672.794797586731;726.8836986082201;759.7948553890419;9493.240540756722;9866.556004979793;9886.505674716236;9957.900420995842;10042.799144017079;648.3613640564041;703.7431337561753;732.8534293141287;740.167311774254;769.2230846844616;4443.400140980926;4504.977475112603;4527.796249168795;4591.380163677927;4591.839285625054;54750;60004.399955999885;60072.69963650241;60402.395976039676;60563.39436605578;54009.72995134999;54438;54775;54869.45130548723;54931.725341373836;45971.080578388246;46062.769686151354;47743;47756.76121619439;48515.51484485181;9139.817203656023;9180.403273787182;9195.310351723514;9202.953985230299;9408.200302974325;35299.470507941885;35360.469592956644;36398.63601363952;36512.45231321586;36555;43780;44333.77833110814;44376.77811610921;48725.512744872096;48995.51004489909;12037.518499260283;12218.14472986918;12401.255924644189;12439.253644781342;12439.564615238423;13106.410211540313;13351.599452016455;13424.798628020782;13501.257430841399;13752.174869507862;11763.529458821551;12152.270863748203;12613.432395542039;12772.48910043625;12876.935615321863;12235.327057011593;12367.505299788269;12718.618441446772;12755.87244127584;13448.596542103753;12479.688007799878;12566.434510446868;12804.871951280367;12851.742965140831;12949.093563450468;9876.259280553844;10233.334833235816;10257.84613230817;10629.25595208328;10892.40091794959;10240.743981400525;10341.121004714383;10349.896501034893;10412.843807343048;10416.71831230317 07:29:29 INFO - PROCESS | 10618 | __end_tp_report 07:29:29 INFO - PROCESS | 10618 | __start_cc_report 07:29:29 INFO - PROCESS | 10618 | _x_x_mozilla_cycle_collect,692 07:29:29 INFO - PROCESS | 10618 | __end_cc_report 07:29:29 INFO - PROCESS | 10618 | __startTimestamp1457018969915__endTimestamp 07:29:29 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | ------- Summary: start ------- 07:29:29 INFO - PROCESS | 10618 | Number of tests: 6 07:29:29 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | [#0] dojo.html Cycles:165 Average:5191.61 Median:5406.43 stddev:553.30 (10.2%) stddev-sans-first:532.98 07:29:29 INFO - PROCESS | 10618 | Values: 3221.5 3238.9 3240.2 3261.7 3268.2 5144.8 5147.3 5149.6 5153.7 5195.2 5110.0 5118.2 5148.5 5173.6 5198.2 4632.1 4709.6 4732.4 4757.2 4791.5 4758.5 4790.0 4795.2 4799.1 4801.6 4761.0 4778.2 4803.6 4856.8 4864.2 4824.8 4851.9 4853.6 4874.0 4878.9 4777.8 4814.0 4823.0 4850.2 4852.6 4907.1 4921.2 4940.1 4983.8 4997.2 5474.5 5510.8 5516.3 5520.2 5534.4 5486.4 5557.0 5570.5 5593.4 5602.2 5175.9 5220.7 5268.7 5286.6 5311.0 5646.1 5647.8 5648.9 5653.0 5658.5 5314.3 5393.3 5463.8 5469.9 5486.4 5627.4 5690.4 5702.1 5717.4 5720.9 5520.8 5554.2 5598.3 5603.2 5612.1 5406.4 5455.6 5489.8 5577.1 5590.3 4327.4 4332.1 4334.0 4357.6 4361.9 3901.0 3903.2 3907.2 3919.7 3926.5 5054.4 5124.5 5161.4 5211.0 5242.0 5597.4 5612.8 5635.4 5635.5 5639.0 5278.7 5290.2 5295.8 5299.0 5333.7 4602.2 4654.0 4695.2 4725.1 4764.8 5767.3 5794.2 5796.0 5801.2 5804.2 5428.6 5593.1 5609.7 5610.6 5639.1 5649.6 5723.8 5829.2 5845.6 5885.5 5531.6 5533.2 5534.9 5535.3 5542.3 5548.4 5571.9 5625.1 5632.1 5662.0 5443.2 5501.5 5506.6 5511.9 5542.6 5514.5 5526.6 5532.2 5535.1 5536.0 5254.1 5262.0 5327.2 5400.5 5419.6 5506.3 5512.3 5536.9 5538.8 5540.0 5387.1 5420.9 5422.1 5434.8 5458.6 07:29:29 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | [#1] ext.html Cycles:180 Average:49420.41 Median:37513.44 stddev:86967.50 (231.8%) stddev-sans-first:87133.96 07:29:29 INFO - PROCESS | 10618 | Values: 519.5 533.5 556.5 566.9 601.9 29532.1 36986.6 37288.6 37303.0 37365.8 41395.8 41767.4 41895.8 41952.6 41962.4 8628.0 8833.7 8841.9 8847.1 8849.6 8763.0 8918.8 8918.9 8923.5 8926.0 8921.7 8999.6 9007.0 9014.4 9018.6 8859.1 8874.0 8929.2 8944.9 8955.8 8815.8 8943.9 8966.1 8970.1 8976.8 41048.6 41521.4 41540.8 41571.8 41613.8 3635.2 3683.2 3697.4 4135.7 4370.5 28511.3 28852.9 29112.4 29118.9 29927.3 4095.9 4144.9 4190.6 4226.6 4232.6 273002.0 279042.4 279579.0 279829.0 280252.0 55883.7 57035.7 63820.7 64361.7 65461.0 57319.7 57933.1 58083.4 58109.1 58175.0 16522.8 16688.8 16701.7 16718.7 16720.3 13004.9 13066.5 13068.9 13073.3 13137.4 21161.0 21310.4 21395.4 21480.6 21516.6 8135.6 8370.7 8386.2 8433.0 8480.7 1087.9 1090.7 1096.1 1185.5 1193.7 30127.4 30633.2 30898.1 31194.4 31441.4 1088.7 1184.3 1202.7 1238.6 1262.8 14470.9 16684.7 16941.2 17193.7 17202.2 423075.0 427110.0 427348.0 428225.0 429300.0 57388.1 58164.7 58166.7 58173.4 58219.4 1356.5 1405.5 1505.6 1520.7 1594.7 27395.7 27519.9 27693.6 27896.4 27910.4 43886.1 44605.6 44664.0 44673.0 44705.8 258487.0 258926.0 261289.0 263173.0 263632.0 33415.2 33814.8 33991.2 34170.1 34171.8 44246.6 44509.3 44687.3 44799.8 45349.5 37076.6 37545.4 38304.2 38447.2 38599.2 35991.6 36133.3 37232.0 37293.3 37326.3 36665.3 37481.4 37605.6 37716.6 37803.0 33390.8 33595.3 34595.7 34601.0 34945.0 25858.5 26204.7 26326.6 26327.9 26653.6 07:29:29 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | [#2] jquery.html Cycles:180 Average:29752.24 Median:36967.45 stddev:97877.39 (264.8%) stddev-sans-first:98127.11 07:29:29 INFO - PROCESS | 10618 | Values: 376.9 378.7 380.9 384.3 385.3 14658.3 16556.8 16639.3 17881.9 17905.9 17154.7 17513.7 17652.4 17660.1 17698.6 5337.6 5501.5 5516.6 5542.4 5543.4 4180.6 4382.5 5788.5 6017.1 6022.6 5768.7 5916.7 5969.5 5971.2 5983.5 5875.5 5963.6 6030.0 6049.9 6051.8 5337.4 5345.9 5364.7 5368.5 5379.9 20883.2 20927.6 21136.3 21147.9 21186.6 2330.3 2357.1 2447.9 2462.4 2499.3 9198.7 9791.2 10213.7 13021.3 13907.5 1905.6 1907.4 1971.0 1983.5 2000.0 53095.7 57162.4 57928.7 59160.0 59690.7 10694.6 10856.1 10972.0 10974.5 11002.9 13997.1 14117.3 14192.5 14255.4 14284.5 8192.5 8250.7 8276.2 8410.8 8413.2 8131.3 8158.4 8169.6 8202.0 8217.5 4419.1 4589.6 4693.1 4795.4 4815.0 1872.3 1894.5 1919.3 1926.8 1950.1 938.6 958.5 988.6 1089.1 1110.5 15167.5 16587.2 16595.6 16751.7 17089.1 1008.5 1030.9 1048.9 1055.1 1060.1 9852.7 10101.7 10112.1 10180.6 10240.9 532254.0 532774.0 585975.0 660922.0 668855.0 71788.0 76855.2 79223.0 79962.0 79985.0 1121.4 1158.8 1161.4 1170.4 1218.1 14997.5 15126.8 15165.1 15560.0 15579.1 34347.1 35850.3 36964.4 36970.4 37419.4 45353.8 46589.0 47116.5 47871.8 47926.8 3347.0 3361.2 7402.0 7528.9 7651.0 10698.9 11348.7 11483.9 11498.0 11889.6 9536.5 9647.5 9778.8 9997.1 10057.0 7667.5 8311.6 10567.8 10622.8 10916.5 7001.6 7409.3 7562.1 7745.5 7984.0 10349.6 10421.8 10732.0 10840.2 10915.9 7697.1 7710.2 10148.1 10436.6 10509.3 07:29:29 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | [#3] mootools.html Cycles:180 Average:5498.67 Median:6561.52 stddev:2813.25 (42.9%) stddev-sans-first:2804.00 07:29:29 INFO - PROCESS | 10618 | Values: 1366.4 1517.6 1527.6 1724.6 1895.4 6925.7 7555.4 7742.7 7746.5 7765.8 7510.0 7580.4 7598.5 7646.2 7660.3 2288.2 2307.2 2308.9 2309.9 2311.6 2215.4 2281.1 2366.8 2366.8 2368.8 2311.1 2337.6 2340.0 2341.2 2342.7 2314.2 2333.6 2334.9 2340.4 2344.1 2270.3 2271.2 2271.4 2274.9 2275.7 7714.2 7779.8 7788.8 7789.4 7794.1 4690.5 4841.2 4845.2 4847.2 4847.6 3029.5 3102.9 3190.1 3190.9 3206.4 975.6 981.4 1048.4 1058.2 1954.6 10465.7 10472.4 10516.5 10588.7 10598.2 4129.5 4171.2 4192.6 4208.3 4213.3 8617.2 8618.5 8624.7 8636.0 8641.5 4757.0 4772.5 4782.5 4816.0 4823.4 3851.9 3934.8 3984.1 4440.6 4455.0 3274.3 3340.3 3467.3 3532.5 3545.9 1028.8 1068.4 1072.5 1077.1 1082.9 1400.0 1405.2 1405.3 1421.4 1427.5 7531.9 7558.4 7571.6 7574.4 7577.6 1083.0 1091.5 1115.2 1145.9 1178.8 5867.2 5903.1 5958.8 6003.3 6004.7 9331.6 9492.7 9713.2 9761.2 9772.9 9265.8 9326.2 9425.2 9429.1 9462.6 7362.7 7503.8 7555.9 7564.2 7600.2 7380.6 7403.3 7429.1 7429.2 7430.0 8325.9 8509.4 8617.6 8707.7 8818.7 8740.0 8762.5 8771.3 8886.4 8950.5 6548.6 6635.9 6663.1 6794.4 6820.1 6881.8 7083.6 7308.6 7538.6 7544.0 6994.2 7024.3 7077.7 7137.5 7277.9 6964.0 6964.4 6986.5 7069.9 7071.0 7044.1 7050.9 7115.8 7119.8 7121.5 6515.2 6553.5 6569.6 6578.6 6591.5 6783.1 6819.6 6824.1 6824.8 6838.9 07:29:29 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | [#4] prototype.html Cycles:180 Average:5381.37 Median:6027.88 stddev:1580.61 (26.2%) stddev-sans-first:1539.56 07:29:29 INFO - PROCESS | 10618 | Values: 365.9 366.2 372.2 374.9 380.6 5865.7 5986.6 6026.7 6029.1 6047.0 5784.4 5881.9 5963.5 5979.0 5990.4 4714.6 4718.7 4721.0 4722.7 4724.2 4496.0 4501.8 4570.5 4583.1 4714.2 4584.6 4598.3 4602.9 4604.1 4607.2 4608.1 4617.7 4622.2 4625.3 4625.4 4074.7 4080.3 4086.8 4087.9 4095.3 5674.8 5742.0 5752.6 5753.0 5755.7 5431.0 5443.3 5444.1 5446.1 5447.7 6126.0 6372.7 6373.4 6378.8 6384.4 4532.4 4581.9 4630.4 4635.4 4640.8 6481.3 6607.3 6612.7 6618.8 6623.1 4765.7 4771.4 4774.7 4776.1 4783.9 4776.1 4843.0 4852.4 4855.1 4873.6 5471.1 5479.0 5480.5 5482.2 5485.1 6409.3 6419.3 6421.5 6425.8 6428.4 1711.8 1714.9 1722.9 1728.2 1731.4 1129.0 1129.0 1133.2 1136.8 1179.1 5949.3 5990.5 6005.6 6093.3 6100.5 6535.6 6559.2 6572.3 6572.8 6573.8 6087.6 6091.1 6092.1 6096.2 6103.7 3426.1 3505.4 3527.0 3530.3 3535.2 6760.7 6761.8 6764.9 6773.3 6778.8 6710.9 6723.2 6724.9 6732.2 6744.1 6636.1 6680.1 6750.4 6750.9 6770.7 6382.7 6466.9 6555.3 6573.0 6647.2 6437.8 6438.7 6465.4 6486.3 6580.0 6773.7 6796.1 6809.5 6823.2 6823.9 4576.1 4737.3 4752.3 4849.7 4862.5 6634.5 6637.7 6641.7 6649.1 6655.3 6478.6 6479.7 6481.4 6495.3 6499.9 6334.3 6467.5 6469.5 6481.2 6522.6 6349.2 6375.7 6377.2 6385.6 6388.5 6498.6 6514.2 6528.3 6533.4 6536.0 6159.7 6301.5 6360.4 6384.9 6395.9 07:29:29 INFO - PROCESS | 10618 | 07:29:29 INFO - PROCESS | 10618 | [#5] yui.html Cycles:180 Average:14620.46 Median:4559.59 stddev:16678.72 (365.8%) stddev-sans-first:16692.98 07:29:29 INFO - PROCESS | 10618 | Values: 748.7 799.6 826.0 939.3 943.7 13064.3 13241.2 13262.8 13267.4 13309.0 13585.9 13654.0 13656.1 13671.2 13682.2 718.2 877.3 879.7 880.1 880.6 730.8 879.7 889.7 895.4 895.5 931.7 940.1 941.3 941.3 942.1 758.8 765.9 919.1 932.6 933.5 688.5 688.6 688.8 689.2 689.8 14106.5 14110.7 14123.6 14127.5 14142.1 11952.9 12474.2 12543.4 12744.5 12752.0 11227.9 11293.2 11414.4 11468.7 11651.4 3818.4 3827.6 3834.1 3853.5 3855.2 52344.5 53097.5 53237.2 53244.7 53276.7 10392.4 10393.1 10515.0 10566.7 10692.6 19836.6 19910.1 19931.7 20013.6 20021.6 7679.1 7762.5 7948.7 8016.7 8354.7 4596.9 4799.4 4805.9 4811.0 4955.2 3302.1 3309.3 3321.5 3324.8 3336.1 575.1 595.0 602.4 604.7 611.7 603.7 671.7 672.8 726.9 759.8 9493.2 9866.6 9886.5 9957.9 10042.8 648.4 703.7 732.9 740.2 769.2 4443.4 4505.0 4527.8 4591.4 4591.8 54750.0 60004.4 60072.7 60402.4 60563.4 54009.7 54438.0 54775.0 54869.5 54931.7 45971.1 46062.8 47743.0 47756.8 48515.5 9139.8 9180.4 9195.3 9203.0 9408.2 35299.5 35360.5 36398.6 36512.5 36555.0 43780.0 44333.8 44376.8 48725.5 48995.5 12037.5 12218.1 12401.3 12439.3 12439.6 13106.4 13351.6 13424.8 13501.3 13752.2 11763.5 12152.3 12613.4 12772.5 12876.9 12235.3 12367.5 12718.6 12755.9 13448.6 12479.7 12566.4 12804.9 12851.7 12949.1 9876.3 10233.3 10257.8 10629.3 10892.4 10240.7 10341.1 10349.9 10412.8 10416.7 07:29:29 INFO - PROCESS | 10618 | -------- Summary: end -------- 07:29:29 INFO - PROCESS | 10618 | 07:29:30 INFO - TEST-INFO | 10618: exit 0 07:29:30 INFO - TEST-OK | dromaeo_css | took 1111127ms 07:29:30 INFO - TEST-START | kraken 07:29:30 INFO - operating with platform_type : linux_ 07:29:30 INFO - Initialising browser for kraken test... 07:29:30 INFO - TEST-INFO | started process 10809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGryikG/profile http://localhost:51914/getInfo.html) 07:29:35 INFO - PROCESS | 10809 | __metrics Screen width/height:1600/1200 07:29:35 INFO - PROCESS | 10809 | colorDepth:24 07:29:35 INFO - PROCESS | 10809 | Browser inner width/height: 1024/697 07:29:35 INFO - PROCESS | 10809 | __metrics 07:29:35 INFO - PROCESS | 10809 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:36 INFO - TEST-INFO | 10809: exit 0 07:29:36 INFO - Browser initialized. 07:29:36 INFO - Running cycle 1/1 for kraken test... 07:29:36 INFO - TEST-INFO | started process 10902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGryikG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:48 INFO - PROCESS | 10902 | RSS: Main: 135503872 07:29:48 INFO - PROCESS | 10902 | 07:29:50 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51914/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:51 INFO - PROCESS | 10902 | RSS: Main: 169373696 07:29:51 INFO - PROCESS | 10902 | 07:29:53 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51914/tests/kraken/driver.html?testName=audio-dft) 07:29:54 INFO - PROCESS | 10902 | RSS: Main: 168108032 07:29:54 INFO - PROCESS | 10902 | 07:29:57 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51914/tests/kraken/driver.html?testName=audio-fft) 07:29:57 INFO - PROCESS | 10902 | RSS: Main: 165089280 07:29:57 INFO - PROCESS | 10902 | 07:29:59 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51914/tests/kraken/driver.html?testName=audio-oscillator) 07:30:00 INFO - PROCESS | 10902 | RSS: Main: 166838272 07:30:00 INFO - PROCESS | 10902 | 07:30:02 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51914/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:03 INFO - PROCESS | 10902 | RSS: Main: 165588992 07:30:03 INFO - PROCESS | 10902 | 07:30:05 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51914/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:06 INFO - PROCESS | 10902 | RSS: Main: 165429248 07:30:06 INFO - PROCESS | 10902 | 07:30:09 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51914/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:10 INFO - PROCESS | 10902 | RSS: Main: 165126144 07:30:10 INFO - PROCESS | 10902 | 07:30:13 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51914/tests/kraken/driver.html?testName=json-parse-financial) 07:30:13 INFO - PROCESS | 10902 | RSS: Main: 164704256 07:30:13 INFO - PROCESS | 10902 | 07:30:15 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51914/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:15 INFO - PROCESS | 10902 | RSS: Main: 169836544 07:30:15 INFO - PROCESS | 10902 | 07:30:17 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:18 INFO - PROCESS | 10902 | RSS: Main: 167247872 07:30:18 INFO - PROCESS | 10902 | 07:30:20 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:20 INFO - PROCESS | 10902 | RSS: Main: 170848256 07:30:20 INFO - PROCESS | 10902 | 07:30:23 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:23 INFO - PROCESS | 10902 | RSS: Main: 177745920 07:30:23 INFO - PROCESS | 10902 | 07:30:26 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:26 INFO - PROCESS | 10902 | RSS: Main: 174567424 07:30:26 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51914/tests/kraken/driver.html?testName=ai-astar) 07:30:28 INFO - PROCESS | 10902 | RSS: Main: 235864064 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | __start_tp_report 07:30:28 INFO - PROCESS | 10902 | _x_x_mozilla_page_load 07:30:28 INFO - PROCESS | 10902 | _x_x_mozilla_page_load_details 07:30:28 INFO - PROCESS | 10902 | |i|pagename|runs| 07:30:28 INFO - PROCESS | 10902 | |0;ai-astar;109;112;106;110;111;111;101;109;109;109 07:30:28 INFO - PROCESS | 10902 | |1;audio-beat-detection;158;134;154;165;124;155;150;127;167;123 07:30:28 INFO - PROCESS | 10902 | |2;audio-dft;161;161;160;161;161;161;162;164;162;159 07:30:28 INFO - PROCESS | 10902 | |3;audio-fft;76;75;76;154;75;75;76;75;138;74 07:30:28 INFO - PROCESS | 10902 | |4;audio-oscillator;97;99;144;95;97;95;142;96;95;139 07:30:28 INFO - PROCESS | 10902 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;110;109;110 07:30:28 INFO - PROCESS | 10902 | |6;imaging-darkroom;146;146;145;147;145;147;145;147;146;146 07:30:28 INFO - PROCESS | 10902 | |7;imaging-desaturate;96;96;95;96;95;97;96;96;96;96 07:30:28 INFO - PROCESS | 10902 | |8;json-parse-financial;52;54;55;55;54;53;55;56;52;53 07:30:28 INFO - PROCESS | 10902 | |9;json-stringify-tinderbox;64;64;65;64;65;65;65;65;65;64 07:30:28 INFO - PROCESS | 10902 | |10;stanford-crypto-aes;78;81;84;86;79;79;80;79;79;87 07:30:28 INFO - PROCESS | 10902 | |11;stanford-crypto-ccm;111;125;111;115;115;114;120;110;109;110 07:30:28 INFO - PROCESS | 10902 | |12;stanford-crypto-pbkdf2;137;134;134;134;134;141;148;128;130;126 07:30:28 INFO - PROCESS | 10902 | |13;stanford-crypto-sha256-iterative;67;67;70;69;64;72;66;68;65;63 07:30:28 INFO - PROCESS | 10902 | __end_tp_report 07:30:28 INFO - PROCESS | 10902 | __start_cc_report 07:30:28 INFO - PROCESS | 10902 | _x_x_mozilla_cycle_collect,917 07:30:28 INFO - PROCESS | 10902 | __end_cc_report 07:30:28 INFO - PROCESS | 10902 | __startTimestamp1457019028542__endTimestamp 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | ------- Summary: start ------- 07:30:28 INFO - PROCESS | 10902 | Number of tests: 14 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.50 stddev:3.16 (2.9%) stddev-sans-first:3.35 07:30:28 INFO - PROCESS | 10902 | Values: 109.0 112.0 106.0 110.0 111.0 111.0 101.0 109.0 109.0 109.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:154.50 stddev:17.08 (11.1%) stddev-sans-first:17.52 07:30:28 INFO - PROCESS | 10902 | Values: 158.0 134.0 154.0 165.0 124.0 155.0 150.0 127.0 167.0 123.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 07:30:28 INFO - PROCESS | 10902 | Values: 161.0 161.0 160.0 161.0 161.0 161.0 162.0 164.0 162.0 159.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#3] audio-fft Cycles:10 Average:89.40 Median:75.00 stddev:30.07 (40.1%) stddev-sans-first:31.51 07:30:28 INFO - PROCESS | 10902 | Values: 76.0 75.0 76.0 154.0 75.0 75.0 76.0 75.0 138.0 74.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:95.50 stddev:21.99 (23.0%) stddev-sans-first:22.82 07:30:28 INFO - PROCESS | 10902 | Values: 97.0 99.0 144.0 95.0 97.0 95.0 142.0 96.0 95.0 139.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:30:28 INFO - PROCESS | 10902 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 07:30:28 INFO - PROCESS | 10902 | Values: 146.0 146.0 145.0 147.0 145.0 147.0 145.0 147.0 146.0 146.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:30:28 INFO - PROCESS | 10902 | Values: 96.0 96.0 95.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.50 stddev:1.37 (2.5%) stddev-sans-first:1.27 07:30:28 INFO - PROCESS | 10902 | Values: 52.0 54.0 55.0 55.0 54.0 53.0 55.0 56.0 52.0 53.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:30:28 INFO - PROCESS | 10902 | Values: 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:3.26 (4.0%) stddev-sans-first:3.24 07:30:28 INFO - PROCESS | 10902 | Values: 78.0 81.0 84.0 86.0 79.0 79.0 80.0 79.0 79.0 87.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#11] stanford-crypto-ccm Cycles:10 Average:114.00 Median:114.50 stddev:5.10 (4.5%) stddev-sans-first:5.29 07:30:28 INFO - PROCESS | 10902 | Values: 111.0 125.0 111.0 115.0 115.0 114.0 120.0 110.0 109.0 110.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.60 Median:134.00 stddev:6.38 (4.8%) stddev-sans-first:6.71 07:30:28 INFO - PROCESS | 10902 | Values: 137.0 134.0 134.0 134.0 134.0 141.0 148.0 128.0 130.0 126.0 07:30:28 INFO - PROCESS | 10902 | 07:30:28 INFO - PROCESS | 10902 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:2.77 (4.1%) stddev-sans-first:2.93 07:30:28 INFO - PROCESS | 10902 | Values: 67.0 67.0 70.0 69.0 64.0 72.0 66.0 68.0 65.0 63.0 07:30:28 INFO - PROCESS | 10902 | -------- Summary: end -------- 07:30:28 INFO - PROCESS | 10902 | 07:30:29 INFO - TEST-INFO | 10902: exit 0 07:30:29 INFO - TEST-OK | kraken | took 58798ms 07:30:29 INFO - TEST-START | v8_7 07:30:29 INFO - operating with platform_type : linux_ 07:30:29 INFO - Initialising browser for v8_7 test... 07:30:29 INFO - TEST-INFO | started process 11160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDU_lAj/profile http://localhost:51914/getInfo.html) 07:30:33 INFO - PROCESS | 11160 | __metrics Screen width/height:1600/1200 07:30:33 INFO - PROCESS | 11160 | colorDepth:24 07:30:33 INFO - PROCESS | 11160 | Browser inner width/height: 1024/697 07:30:33 INFO - PROCESS | 11160 | __metrics 07:30:33 INFO - PROCESS | 11160 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:30:35 INFO - TEST-INFO | 11160: exit 0 07:30:35 INFO - Browser initialized. 07:30:35 INFO - Running cycle 1/1 for v8_7 test... 07:30:35 INFO - TEST-INFO | started process 11247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDU_lAj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:46 INFO - PROCESS | 11247 | RSS: Main: 135839744 07:30:46 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | Cycle 1(1): loaded http://localhost:51914/tests/v8_7/run.html (next: http://localhost:51914/tests/v8_7/run.html) 07:31:09 INFO - PROCESS | 11247 | RSS: Main: 421900288 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | __start_tp_report 07:31:09 INFO - PROCESS | 11247 | _x_x_mozilla_page_load 07:31:09 INFO - PROCESS | 11247 | _x_x_mozilla_page_load_details 07:31:09 INFO - PROCESS | 11247 | |i|pagename|runs| 07:31:09 INFO - PROCESS | 11247 | |0;Richards;165.97510373443984 07:31:09 INFO - PROCESS | 11247 | |1;DeltaBlue;168.12373907195695 07:31:09 INFO - PROCESS | 11247 | |2;Encrypt;278.9400278940028 07:31:09 INFO - PROCESS | 11247 | |3;Decrypt;5235.602094240838 07:31:09 INFO - PROCESS | 11247 | |4;RayTrace;962.4639076034649 07:31:09 INFO - PROCESS | 11247 | |5;Earley;541.1255411255411 07:31:09 INFO - PROCESS | 11247 | |6;Boyer;10659.574468085106 07:31:09 INFO - PROCESS | 11247 | |7;RegExp;40320 07:31:09 INFO - PROCESS | 11247 | |8;Splay;537.9236148466917 07:31:09 INFO - PROCESS | 11247 | |9;NavierStokes;4826.923076923077 07:31:09 INFO - PROCESS | 11247 | __end_tp_report 07:31:09 INFO - PROCESS | 11247 | __startTimestamp1457019069520__endTimestamp 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | ------- Summary: start ------- 07:31:09 INFO - PROCESS | 11247 | Number of tests: 10 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 166.0 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#1] DeltaBlue Cycles:1 Average:168.12 Median:168.12 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 168.1 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 278.9 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 5235.6 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#4] RayTrace Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 962.5 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#5] Earley Cycles:1 Average:541.13 Median:541.13 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 541.1 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#6] Boyer Cycles:1 Average:10659.57 Median:10659.57 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 10659.6 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#7] RegExp Cycles:1 Average:40320.00 Median:40320.00 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 40320.0 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#8] Splay Cycles:1 Average:537.92 Median:537.92 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 537.9 07:31:09 INFO - PROCESS | 11247 | 07:31:09 INFO - PROCESS | 11247 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:31:09 INFO - PROCESS | 11247 | Values: 4826.9 07:31:09 INFO - PROCESS | 11247 | -------- Summary: end -------- 07:31:09 INFO - PROCESS | 11247 | 07:31:10 INFO - TEST-INFO | 11247: exit 0 07:31:10 INFO - TEST-OK | v8_7 | took 40986ms 07:31:10 INFO - SUITE-END | took 1210s 07:31:10 INFO - Completed test suite (00:20:11) 07:31:10 INFO - Working with test: dromaeo_css 07:31:10 INFO - Generating results file: dromaeo_css 07:31:10 INFO - Working with test: kraken 07:31:10 INFO - Generating results file: kraken 07:31:10 INFO - javascript benchmark 07:31:10 INFO - Working with test: v8_7 07:31:10 INFO - Generating results file: v8_7 07:31:10 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,35]] 07:31:10 INFO - process_Request line: dromaeo_css 7106.35 graph.html#tests=[[72,181,35]] 07:31:10 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:10 INFO - process_Request line: kraken 1481.40 graph.html#tests=[[232,181,35]] 07:31:10 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:10 INFO - process_Request line: v8_7 22009.35 graph.html#tests=[[230,181,35]] 07:31:10 INFO - RETURN: dromaeo_css: 7106.35 07:31:10 INFO - RETURN: kraken: 1481.40 07:31:10 INFO - RETURN: v8_7: 22009.35 07:31:10 INFO - javascript benchmark 07:31:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3221.5006673965536, 3238.935221295574, 3240.189952511872, 3261.7227535659467, 3268.2319654881085, 5144.845654630362, 5147.330846989891, 5149.613778966574, 5153.690778553289, 5195.246689230059, 5110.0, 5118.232265160228, 5148.536631703146, 5173.560247378978, 5198.168293073109, 4632.07358528294, 4709.623230141598, 4732.361131247289, 4757.191277482819, 4791.520847915215, 4758.524147585231, 4790.0, 4795.184818580832, 4799.088173247089, 4801.639877009221, 4761.0, 4778.235482322812, 4803.61571074315, 4856.7571621418965, 4864.246041863516, 4824.782884770194, 4851.902961940741, 4853.563179313879, 4874.0, 4878.902421951541, 4777.784999675023, 4814.0, 4823.0, 4850.151223535867, 4852.587530059949, 4907.141250281186, 4921.188003979375, 4940.110780059588, 4983.775730092155, 4997.150484417622, 5474.479924407175, 5510.834674959718, 5516.310461192351, 5520.171974203861, 5534.391216966131, 5486.396496385394, 5557.0, 5570.526505247059, 5593.3847276799515, 5602.187682785973, 5175.896482070375, 5220.660657057279, 5268.683878967236, 5286.577073834084, 5311.0, 5646.0683987141665, 5647.774089036475, 5648.8870222595315, 5652.971735141298, 5658.519025882846, 5314.2825718528275, 5393.298871146726, 5463.836084917459, 5469.890602187934, 5486.423925487846, 5627.43725627434, 5690.4025077367105, 5702.144678298288, 5717.428257174332, 5720.914186287209, 5520.751566179451, 5554.222408862763, 5598.300212473441, 5603.15952607104, 5612.130119831432, 5406.432324605859, 5455.563554915597, 5489.752961116759, 5577.079781836032, 5590.301212348457, 4327.350897365357, 4332.068605249887, 4333.956660433419, 4357.564243575617, 4361.890952726208, 3900.9804950975063, 3903.1803321302277, 3907.199024200032, 3919.6864250860435, 3926.5484469285825, 5054.393472783289, 5124.461931497139, 5161.380634323905, 5210.97394513025, 5241.9737901310245, 5597.356304025089, 5612.803551875665, 5635.408282130399, 5635.549156067505, 5639.041362968305, 5278.736063196825, 5290.1800220965815, 5295.788168473218, 5299.019681358961, 5333.706646134422, 4602.2406302959635, 4653.976730116327, 4695.178343789823, 4725.149473094876, 4764.809407623726, 5767.336756273083, 5794.159846822272, 5796.043652797325, 5801.216835727208, 5804.187413762077, 5428.565714742732, 5593.13306437511, 5609.691466969356, 5610.635308704921, 5639.097744360883, 5649.6327738696855, 5723.771049157987, 5829.213056237354, 5845.561582881386, 5885.47030767233, 5531.557475401878, 5533.197686335539, 5534.944650553443, 5535.280413546213, 5542.334919809648, 5548.361938377138, 5571.857699659921, 5625.09998400254, 5632.098864181711, 5662.037453632975, 5443.183522471661, 5501.504864562048, 5506.614536982373, 5511.889762204813, 5542.584306177134, 5514.531264842373, 5526.613137080366, 5532.2254884317035, 5535.0590399632965, 5536.031194540858, 5254.080535906278, 5262.02652509287, 5327.200919862052, 5400.459954004568, 5419.647722897999, 5506.339239291311, 5512.3385193777, 5536.944630553643, 5538.778448862, 5540.030494663499, 5387.138057910715, 5420.891582168256, 5422.078246697992, 5434.75543600531, 5458.590605704668], "unit": "score", "name": "dojo.html", "value": 5157.724365753082}, {"lowerIsBetter": false, "replicates": [519.5453977769452, 533.5358238332649, 556.5213916032214, 566.8951244019856, 601.8525461261992, 29532.11403657891, 36986.63013369866, 37288.62711372886, 37303.0, 37365.813170934176, 41395.79302103493, 41767.37348939768, 41895.790521047355, 41952.58047419525, 41962.37056444156, 8628.007779105405, 8833.734987950373, 8841.867371989425, 8847.115288471166, 8849.646014159458, 8763.0, 8918.777030574223, 8918.910810891904, 8923.464592124461, 8925.95537022314, 8921.732348029536, 8999.550022498881, 9006.954965225197, 9014.36899417041, 9018.594163262636, 8859.11408859112, 8874.0, 8929.241014513775, 8944.910550894505, 8955.776105597348, 8815.77960550985, 8943.910560894374, 8966.148215919477, 8970.147835955573, 8976.820463590757, 41048.58951410477, 41521.37717934234, 41540.79229603863, 41571.792141039405, 41613.79193104015, 3635.2366003139373, 3683.226522430293, 3697.3714468540143, 4135.669146468275, 4370.453693288339, 28511.287217819514, 28852.855735721398, 29112.41775164506, 29118.85440572805, 29927.251818704488, 4095.877123686294, 4144.8756537303925, 4190.643795277405, 4226.619604235603, 4232.555581663912, 273002.0, 279042.4191516158, 279579.0, 279829.0, 280251.99999999796, 55883.72058139765, 57035.71482142646, 63820.680896596146, 64361.67819160968, 65461.0, 57319.713401432724, 57933.131003034985, 58083.4191658078, 58109.12836307459, 58175.0, 16522.75215871763, 16688.83311166897, 16701.665966680597, 16718.749218761728, 16720.331186752635, 13004.869951300556, 13066.477340906258, 13068.869311306766, 13073.346332683328, 13137.408816603276, 21161.0, 21310.36068917935, 21395.358139255848, 21480.570388592452, 21516.569668606855, 8135.552544610104, 8370.665173393118, 8386.235213218719, 8432.957835210786, 8480.74557763268, 1087.8857719939451, 1090.7109615951779, 1096.0738176241064, 1185.5020891225706, 1193.6836738264367, 30127.397452050835, 30633.23416914595, 30898.073057808302, 31194.376112477625, 31441.371172576877, 1088.7060493666825, 1184.2894263442038, 1202.7173614200656, 1238.6160290310033, 1262.8421447319085, 14470.927645361706, 16684.74972875408, 16941.237644306035, 17193.656126877642, 17202.225899834288, 423075.0, 427110.0, 427348.0, 428225.0, 429300.0, 57388.139177912366, 58164.70917645385, 58166.70916645474, 58173.41826581764, 58219.4178058214, 1356.4913157565913, 1405.5221224783622, 1505.6386467248, 1520.7186670465999, 1594.7129516687107, 27395.726042739316, 27519.862400687867, 27693.58459623067, 27896.442071158057, 27910.441791163656, 43886.12227755491, 44605.55394446014, 44664.0, 44673.0, 44705.77647111744, 258487.0, 258926.0, 261289.0, 263173.0, 263632.0, 33415.16462088467, 33814.830925845214, 33991.150221244665, 34170.14574635555, 34171.82914085413, 44246.557534424246, 44509.33236001527, 44687.32969005402, 44799.77600111978, 45349.54650453585, 37076.62923370732, 37545.43681844829, 38304.23391532098, 38447.23105537818, 38599.228015438974, 35991.64008359883, 36133.33532728157, 37232.0, 37293.25413491769, 37326.25347493089, 36665.26669466649, 37481.437778433894, 37605.62394376021, 37716.62283377131, 37803.0, 33390.83304583462, 33595.32809343848, 34595.65404346025, 34601.0, 34945.0, 25858.482830343662, 26204.73795262099, 26326.60510092312, 26327.868360658074, 26653.60019599669], "unit": "score", "name": "ext.html", "value": 19337.494141487725}, {"lowerIsBetter": false, "replicates": [376.8850500597318, 378.68379902781174, 380.8609857402049, 384.2622165442349, 385.3410667758133, 14658.267086645652, 16556.83443165568, 16639.251233694482, 17881.910590447045, 17905.910470447645, 17154.742678859828, 17513.73729394057, 17652.38216662417, 17660.116994150274, 17698.646027079452, 5337.572994160468, 5501.504864562188, 5516.641418307797, 5542.39033706292, 5543.390227075019, 4180.644645205161, 4382.496012958519, 5788.507976821975, 6017.097435384705, 6022.578419510636, 5768.682722450264, 5916.674582897939, 5969.462748352669, 5971.223740913675, 5983.521318294526, 5875.471207591338, 5963.552733544958, 6030.0, 6049.909251361233, 6051.848703782419, 5337.359516858002, 5345.866353341159, 5364.7317634118135, 5368.516833484966, 5379.892402151974, 20883.164673413197, 20927.5814483711, 21136.260230892, 21147.8942605286, 21186.576268474546, 2330.2892617751577, 2357.092519380034, 2447.8898449569633, 2462.4213309872166, 2499.262717498342, 9198.724038278862, 9791.216702663769, 10213.693589192337, 13021.348932553334, 13907.513237036655, 1905.5807722301072, 1907.3515004898263, 1970.9901450492655, 1983.5338695406567, 1999.9600007999904, 53095.73452132753, 57162.42837571654, 57928.71035644837, 59160.0, 59690.70154649199, 10694.572217111385, 10856.131509479223, 10972.0, 10974.451277436096, 11002.889971100187, 13997.090189137674, 14117.294135293194, 14192.503262385768, 14255.358508866919, 14284.50004249867, 8192.508449493049, 8250.669973201006, 8276.172382761795, 8410.789730256793, 8413.158684131538, 8131.349492040623, 8158.388120890957, 8169.591520424074, 8202.0, 8217.54803485814, 4419.0940857124215, 4589.5639914208095, 4693.084848454519, 4795.400574928134, 4814.975925120352, 1872.3072463188435, 1894.4600788775133, 1919.3378284491828, 1926.7880533141342, 1950.0542237015036, 938.648006997376, 958.5399008475971, 988.614440368257, 1089.1395797320188, 1110.4836251143256, 15167.469138580318, 16587.170641467877, 16595.585110372336, 16751.748723769153, 17089.14554272306, 1008.4806324742764, 1030.8971484134695, 1048.916086713061, 1055.1084333737979, 1060.067140915989, 9852.704418867446, 10101.747456313504, 10112.140468060297, 10180.592776288866, 10240.948795255976, 532254.0, 532774.0, 585975.0, 660922.0, 668855.0, 71788.0, 76855.23144768481, 79223.0, 79962.0, 79985.0, 1121.4448847820381, 1158.7856246594406, 1161.4425075963584, 1170.4323403149465, 1218.0986070307908, 14997.475088371855, 15126.848731512544, 15165.09009459436, 15560.0, 15579.065256084672, 34347.14132146716, 35850.28299434049, 36964.44553331648, 36970.44544331783, 37419.43870841994, 45353.77323113364, 46589.0, 47116.528834711215, 47871.76064119657, 47926.760366197945, 3347.0126312737316, 3361.159710072482, 7402.0, 7528.934375437202, 7651.005369302177, 10698.946505267735, 11348.659540213806, 11483.885161148615, 11498.022668072972, 11889.583864564698, 9536.475493847905, 9647.469389183661, 9778.751151041593, 9997.100260976547, 10057.044580764816, 7667.463277570517, 8311.625976831177, 10567.841482377617, 10622.787544249226, 10916.454177290945, 7001.63468123711, 7409.259074092548, 7562.0925488941675, 7745.535267883945, 7983.960080199562, 10349.586016559253, 10421.843672345072, 10731.980461856112, 10840.241183117107, 10915.945420272848, 7697.114831794415, 7710.228977102245, 10148.086672199537, 10436.58253669875, 10509.264351495322], "unit": "score", "name": "jquery.html", "value": 8596.060226584576}, {"lowerIsBetter": false, "replicates": [1366.4192718094807, 1517.6205948512873, 1527.618095476131, 1724.5860993361598, 1895.365052707344, 6925.722971081157, 7555.433342499314, 7742.651580678869, 7746.53520788753, 7765.7670269892, 7509.9624501877415, 7580.39356851452, 7598.506097103698, 7646.158922518533, 7660.272274133962, 2288.1648198407543, 2307.192482631074, 2308.9422764430938, 2309.896054677535, 2311.6185829338137, 2215.4350640586626, 2281.0989659084735, 2366.7988221001237, 2366.810655147584, 2368.846025008369, 2311.1217737259817, 2337.6026075567192, 2340.028888011473, 2341.1571834139695, 2342.6603142544404, 2314.1784666443336, 2333.6266197408418, 2334.9066037358484, 2340.368100612825, 2344.074090734159, 2270.28486026901, 2271.1710225767642, 2271.3867255840996, 2274.8521346112616, 2275.7155355580553, 7714.190010048977, 7779.805504862367, 7788.766337009899, 7789.415793815429, 7794.142644309121, 4690.530946905282, 4841.2012018016985, 4845.248986407112, 4847.175980083394, 4847.612191024709, 3029.4546981543313, 3102.922426939322, 3190.106770104351, 3190.9042728718177, 3206.3907857507234, 975.5512464266446, 981.4258658684678, 1048.4233671480656, 1058.1746237934424, 1954.6481633306141, 10465.686029419054, 10472.371657700562, 10516.47417629123, 10588.682339529827, 10598.205134614858, 4129.483814523184, 4171.20747058058, 4192.580741925844, 4208.347706105558, 4213.325867861189, 8617.224449799549, 8618.525981071101, 8624.655013799378, 8636.0, 8641.524716140548, 4756.9524304756505, 4772.522747725269, 4782.52174782519, 4815.951840481621, 4823.445303790038, 3851.9037024074623, 3934.803259836997, 3984.1234928315725, 4440.622547083534, 4454.955450445519, 3274.279658475132, 3340.331933613287, 3467.3065386922717, 3532.4701294805473, 3545.9290814183573, 1028.8148133336072, 1068.433730123036, 1072.4798472740715, 1077.1113831089383, 1082.880883102858, 1400.033976556173, 1405.220102842932, 1405.2552147361914, 1421.3745951781184, 1427.5075099090798, 7531.924680753232, 7558.433117516099, 7571.621418929031, 7574.356179724785, 7577.621118944031, 1082.9620963266248, 1091.4815462655333, 1115.1803424482998, 1145.9312441253385, 1178.7701398227434, 5867.207926929896, 5903.085021821625, 5958.761649534057, 6003.339632640406, 6004.729787159588, 9331.58007889633, 9492.715218543455, 9713.22294216461, 9761.170300524393, 9772.853407198898, 9265.814683706289, 9326.207272381924, 9425.245980321557, 9429.104235097655, 9462.57418416173, 7362.7423040193335, 7503.7748867534065, 7555.924440755632, 7564.243575642392, 7600.239976002466, 7380.594067326134, 7403.333699967029, 7429.108506979197, 7429.219931907072, 7429.962850185714, 8325.876006739012, 8509.361797865062, 8617.612207450555, 8707.738767836974, 8818.735437936872, 8739.994900586515, 8762.518061506678, 8771.342149338952, 8886.422382545114, 8950.507722075348, 6548.607083575001, 6635.933640663725, 6663.13379260693, 6794.42247408956, 6820.147481564804, 6881.759138430131, 7083.574985500886, 7308.5614863108385, 7538.623068846646, 7543.962280188784, 6994.160700715946, 7024.26245244242, 7077.68150433242, 7137.464690148156, 7277.854442911006, 6964.025036494793, 6964.4080253179045, 6986.510944234058, 7069.893951590628, 7071.0, 7044.084269044992, 7050.894236586558, 7115.786526404217, 7119.75080872167, 7121.465890058163, 6515.153030106056, 6553.475721942138, 6569.57297775643, 6578.572392794453, 6591.538592298493, 6783.118194634666, 6819.590824550344, 6824.112865327475, 6824.761133360308, 6838.93161068383], "unit": "score", "name": "mootools.html", "value": 4552.549885100528}, {"lowerIsBetter": false, "replicates": [365.87560229521966, 366.2181243046096, 372.175630977385, 374.88378602633185, 380.63078813550845, 5865.706714664271, 5986.64080155191, 6026.668533230671, 6029.095635654654, 6046.969765151168, 5784.363719990798, 5881.85295367615, 5963.463288304062, 5979.043353063511, 5990.371011043832, 4714.5756881880625, 4718.669693121483, 4721.0, 4722.693024953384, 4724.17326967781, 4495.977520112395, 4501.842435514757, 4570.520095389986, 4583.060472603109, 4714.175019371613, 4584.564466375689, 4598.333241679954, 4602.930956035662, 4604.102200070987, 4607.239805432099, 4608.1474927138415, 4617.6536759742985, 4622.237330840441, 4625.306204069417, 4625.375574297461, 4074.7147699661036, 4080.285949958775, 4086.836526538935, 4087.9386809197886, 4095.3037983542868, 5674.829755107354, 5742.0, 5752.626079304831, 5752.971235143839, 5755.740991655385, 5430.972845135789, 5443.265159203496, 5444.128939369682, 5446.101393270105, 5447.727613619343, 6126.0, 6372.745090196387, 6373.362663733636, 6378.840528986812, 6384.3934826191435, 4532.388127602764, 4581.931271030937, 4630.351750754897, 4635.420572428447, 4640.76796160194, 6481.28705842357, 6607.339266073354, 6612.669366531654, 6618.801435956929, 6623.07276981223, 4765.666403351732, 4771.403574553181, 4774.68696108566, 4776.068666609977, 4783.880402989953, 4776.09254241693, 4843.0, 4852.369192005017, 4855.1260773060485, 4873.561379475794, 5471.06991811393, 5479.0411677957, 5480.534154596824, 5482.17767334895, 5485.149801780731, 6409.262934762469, 6419.293877673452, 6421.518386120966, 6425.775097871552, 6428.357164283534, 1711.7860267466567, 1714.8971061736336, 1722.9396971106203, 1728.2136627834304, 1731.3940120957564, 1128.971775705614, 1129.0290350298737, 1133.1784456269304, 1136.772645470909, 1179.0744265751343, 5949.286085669661, 5990.4908082813445, 6005.639661620229, 6093.268807743099, 6100.450959413674, 6535.640539770358, 6559.180102487189, 6572.309907459744, 6572.802815915435, 6573.769918052845, 6087.57386982907, 6091.08633704939, 6092.055731361646, 6096.237970253718, 6103.6948152592195, 3426.126337783899, 3505.386557352453, 3527.0, 3530.2939412117166, 3535.169235229719, 6760.729570817112, 6761.830954226184, 6764.864702706017, 6773.322667733188, 6778.830529236809, 6710.859153943841, 6723.159605049369, 6724.865502690017, 6732.158480189976, 6744.0895479109695, 6636.137302150786, 6680.13158289429, 6750.3924646782025, 6750.8649827004165, 6770.661466926634, 6382.744690212525, 6466.902996454963, 6555.344465553597, 6573.04690819838, 6647.235567909753, 6437.806865794034, 6438.742450301936, 6465.353464653497, 6486.318936511599, 6579.980103083838, 6773.661316934035, 6796.116504854337, 6809.455243580403, 6823.215330237086, 6823.93176068233, 4576.084783043471, 4737.265723812815, 4752.310914917249, 4849.660523763303, 4862.465128835896, 6634.535582509178, 6637.70130344126, 6641.667916604054, 6649.102371179829, 6655.334466553306, 6478.643674597943, 6479.708413121515, 6481.351864813481, 6495.253045899782, 6499.935000650122, 6334.303226644974, 6467.547271690936, 6469.547131700736, 6481.189851268591, 6522.641254731036, 6349.238091429058, 6375.681215939092, 6377.202849643794, 6385.616862988236, 6388.488920886225, 6498.610083395011, 6514.218293804774, 6528.281888992302, 6533.41199292066, 6536.0, 6159.6612186330185, 6301.464375528131, 6360.4275615193, 6384.872302554016, 6395.872082558416], "unit": "score", "name": "prototype.html", "value": 4881.46945133276}, {"lowerIsBetter": false, "replicates": [748.6855520681313, 799.5562462833125, 825.9710910118146, 939.3143005605907, 943.6508491858013, 13064.281464519448, 13241.205527668346, 13262.801057984127, 13267.40296686649, 13309.0, 13585.932070339659, 13654.0, 13656.112352697068, 13671.248081355521, 13682.24747638882, 718.1525799556521, 877.2630989968441, 879.7228872905047, 880.0759202837028, 880.5993273060774, 730.7844185965153, 879.683314006957, 889.7108439757072, 895.4492986813095, 895.4895709445618, 931.6599441203946, 940.0834186667978, 941.2611100286276, 941.2752180820764, 942.0720590218664, 758.7723682895164, 765.9004329437194, 919.1268295119663, 932.6083045121065, 933.4865823796885, 688.5042769206163, 688.579966220605, 688.7554918004137, 689.2039694153261, 689.7792706333975, 14106.506272280421, 14110.717785644332, 14123.576292711236, 14127.505537306248, 14142.080764750259, 11952.880471195263, 12474.18917770342, 12543.435545400387, 12744.490220391173, 12752.0, 11227.887721122848, 11293.20947533673, 11414.401983722286, 11468.714425515704, 11651.417429128509, 3818.369968955119, 3827.617238276178, 3834.0798208430056, 3853.5183102112237, 3855.151866589346, 52344.47655523434, 53097.46902531003, 53237.2014419784, 53244.73377633126, 53276.73361633206, 10392.37645741258, 10393.116585090353, 10515.0, 10566.735831604117, 10692.572297108185, 19836.60326793456, 19910.104045317996, 19931.701024484646, 20013.59972800536, 20021.599568008558, 7679.078510578766, 7762.495437796525, 7948.721794737272, 8016.679332826739, 8354.707585234488, 4596.931046034312, 4799.352087468147, 4805.8558243252755, 4810.95189048105, 4955.1576232039915, 3302.1084307237393, 3309.2885029718245, 3321.4685650295837, 3324.8337583120747, 3336.115929278743, 575.1114528054167, 594.9821505354846, 602.3614968133792, 604.6704546022428, 611.7338957553478, 603.7494439807518, 671.701093013614, 672.794797586731, 726.8836986082201, 759.7948553890419, 9493.240540756722, 9866.556004979793, 9886.505674716236, 9957.900420995842, 10042.799144017079, 648.3613640564041, 703.7431337561753, 732.8534293141287, 740.167311774254, 769.2230846844616, 4443.400140980926, 4504.977475112603, 4527.796249168795, 4591.380163677927, 4591.839285625054, 54750.0, 60004.399955999885, 60072.69963650241, 60402.395976039676, 60563.39436605578, 54009.72995134999, 54438.0, 54775.0, 54869.45130548723, 54931.725341373836, 45971.080578388246, 46062.769686151354, 47743.0, 47756.76121619439, 48515.51484485181, 9139.817203656023, 9180.403273787182, 9195.310351723514, 9202.953985230299, 9408.200302974325, 35299.470507941885, 35360.469592956644, 36398.63601363952, 36512.45231321586, 36555.0, 43780.0, 44333.77833110814, 44376.77811610921, 48725.512744872096, 48995.51004489909, 12037.518499260283, 12218.14472986918, 12401.255924644189, 12439.253644781342, 12439.564615238423, 13106.410211540313, 13351.599452016455, 13424.798628020782, 13501.257430841399, 13752.174869507862, 11763.529458821551, 12152.270863748203, 12613.432395542039, 12772.48910043625, 12876.935615321863, 12235.327057011593, 12367.505299788269, 12718.618441446772, 12755.87244127584, 13448.596542103753, 12479.688007799878, 12566.434510446868, 12804.871951280367, 12851.742965140831, 12949.093563450468, 9876.259280553844, 10233.334833235816, 10257.84613230817, 10629.25595208328, 10892.40091794959, 10240.743981400525, 10341.121004714383, 10349.896501034893, 10412.843807343048, 10416.71831230317], "unit": "score", "name": "yui.html", "value": 6758.912901774976}], "name": "dromaeo_css", "value": 7106.348537167555}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 110.0, 111.0, 111.0, 101.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 154.0, 165.0, 124.0, 155.0, 150.0, 127.0, 167.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 164.0, 162.0, 159.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 76.0, 154.0, 75.0, 75.0, 76.0, 75.0, 138.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.4}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 144.0, 95.0, 97.0, 95.0, 142.0, 96.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 147.0, 145.0, 147.0, 145.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [52.0, 54.0, 55.0, 55.0, 54.0, 53.0, 55.0, 56.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 53.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [78.0, 81.0, 84.0, 86.0, 79.0, 79.0, 80.0, 79.0, 79.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [111.0, 125.0, 111.0, 115.0, 115.0, 114.0, 120.0, 110.0, 109.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.0}, {"lowerIsBetter": true, "replicates": [137.0, 134.0, 134.0, 134.0, 134.0, 141.0, 148.0, 128.0, 130.0, 126.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 70.0, 69.0, 64.0, 72.0, 66.0, 68.0, 65.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1481.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [168.12373907195695], "unit": "score", "name": "DeltaBlue", "value": 393.26986400000015}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [962.4639076034649], "unit": "score", "name": "RayTrace", "value": 768.8485710000002}, {"lowerIsBetter": false, "replicates": [541.1255411255411], "unit": "score", "name": "Earley", "value": 1231.623624}, {"lowerIsBetter": false, "replicates": [10659.574468085106], "unit": "score", "name": "Boyer", "value": 62.522477045908175}, {"lowerIsBetter": false, "replicates": [40320.0], "unit": "score", "name": "RegExp", "value": 22.593874007936517}, {"lowerIsBetter": false, "replicates": [537.9236148466917], "unit": "score", "name": "Splay", "value": 151.49176899999995}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22009.35436692649}]} 07:31:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,35]]", "result": "22009.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,35]]", "result": "1481.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,35]]", "result": "7106.35"}}} 07:31:10 INFO - Return code: 0 07:31:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:31:10 INFO - # TBPL SUCCESS # 07:31:10 INFO - Running post-action listener: _resource_record_post_action 07:31:10 INFO - Running post-run listener: _resource_record_post_run 07:31:12 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 270336; Write bytes: 460357632; Read time: 184; Write time: 453384 07:31:12 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 229531648; Read time: 0; Write time: 293368 07:31:12 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 270336; Write bytes: 225366016; Read time: 184; Write time: 159844 07:31:12 INFO - Running post-run listener: _upload_blobber_files 07:31:12 INFO - Blob upload gear active. 07:31:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:31:12 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 07:31:12 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', 'Date-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:31:12 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 Date-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:31:12 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:31:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:13 INFO - (blobuploader) - INFO - Done attempting. 07:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:31:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:14 INFO - (blobuploader) - INFO - Done attempting. 07:31:14 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:14 INFO - Return code: 0 07:31:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/2719c1719bdb8c2ab0d0ad7e63c3014b8e73553f9ac3db6192f2263a2e9d973f36f874e380df2d08a2c1415fc7812fd28e9cc3338124fbe3468ff18bb0d31064", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/7f52608a34c698f733c7fcf1941d3e7a3cff03ef1f9b6ae2fa2e304b9d95aeb7a10040e8728ce328a65d03d68f87ed7d6b7eecb3ec7d5425098cd9faca861e1b"} 07:31:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:14 INFO - Contents: 07:31:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/2719c1719bdb8c2ab0d0ad7e63c3014b8e73553f9ac3db6192f2263a2e9d973f36f874e380df2d08a2c1415fc7812fd28e9cc3338124fbe3468ff18bb0d31064", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/7f52608a34c698f733c7fcf1941d3e7a3cff03ef1f9b6ae2fa2e304b9d95aeb7a10040e8728ce328a65d03d68f87ed7d6b7eecb3ec7d5425098cd9faca861e1b"} 07:31:14 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:14 INFO - Copying logs to upload dir... 07:31:14 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.091425 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-03 07:31:14.055249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 07:31:14.059138) ========= 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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/2719c1719bdb8c2ab0d0ad7e63c3014b8e73553f9ac3db6192f2263a2e9d973f36f874e380df2d08a2c1415fc7812fd28e9cc3338124fbe3468ff18bb0d31064", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/7f52608a34c698f733c7fcf1941d3e7a3cff03ef1f9b6ae2fa2e304b9d95aeb7a10040e8728ce328a65d03d68f87ed7d6b7eecb3ec7d5425098cd9faca861e1b"} build_url:https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/ShaUYRl5Rb26WvWycayaaA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/2719c1719bdb8c2ab0d0ad7e63c3014b8e73553f9ac3db6192f2263a2e9d973f36f874e380df2d08a2c1415fc7812fd28e9cc3338124fbe3468ff18bb0d31064", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/7f52608a34c698f733c7fcf1941d3e7a3cff03ef1f9b6ae2fa2e304b9d95aeb7a10040e8728ce328a65d03d68f87ed7d6b7eecb3ec7d5425098cd9faca861e1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 07:31:14.083975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:31:14.084307) ========= 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=1861a34ebfea852630dec091000001fa-1457017804.218745-253821512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:31:14.169544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 07:31:14.170193) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 07:31:14.170776) ========= ========= Total master_lag: 0.30 =========