builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1457056098.25 results: success (0) buildid: 20160303150953 builduid: 5bf8fcf2384f4a238fbe034a4f14bd0b revision: bde8e6623e5dabe145c84076d15bf2eb08cb8ec4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.250993) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.251580) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.251933) ========= 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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003115 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.265580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.265907) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.284322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.284618) ========= 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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002172 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.336496) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.336833) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.337213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.337529) ========= 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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 17:48:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.2M=0s 2016-03-03 17:48:18 (99.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.485795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.486109) ========= 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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009463 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.533223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:18.533860) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev bde8e6623e5dabe145c84076d15bf2eb08cb8ec4 --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 bde8e6623e5dabe145c84076d15bf2eb08cb8ec4 --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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 17:48:18,879 truncating revision to first 12 chars 2016-03-03 17:48:18,879 Setting DEBUG logging. 2016-03-03 17:48:18,879 attempt 1/10 2016-03-03 17:48:18,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/bde8e6623e5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 17:48:19,361 unpacking tar archive at: date-bde8e6623e5d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:19.300637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:19.301037) ========= echo bde8e6623e5dabe145c84076d15bf2eb08cb8ec4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bde8e6623e5dabe145c84076d15bf2eb08cb8ec4'] 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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bde8e6623e5dabe145c84076d15bf2eb08cb8ec4 program finished with exit code 0 elapsedTime=0.002414 script_repo_revision: 'bde8e6623e5dabe145c84076d15bf2eb08cb8ec4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:19.349648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:19.349981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 17:48:19.356069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-03 17:48:19.356377) ========= /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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:48:19 INFO - MultiFileLogger online at 20160303 17:48:19 in /builds/slave/test 17:48:19 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 17:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:48:19 INFO - {'append_to_log': False, 17:48:19 INFO - 'base_work_dir': '/builds/slave/test', 17:48:19 INFO - 'blob_upload_branch': 'Date-Non-PGO', 17:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:48:19 INFO - 'branch': 'Date-Non-PGO', 17:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:48:19 INFO - 'config_files': ('talos/linux_config.py',), 17:48:19 INFO - 'default_actions': ('clobber', 17:48:19 INFO - 'read-buildbot-config', 17:48:19 INFO - 'download-and-extract', 17:48:19 INFO - 'populate-webroot', 17:48:19 INFO - 'create-virtualenv', 17:48:19 INFO - 'install', 17:48:19 INFO - 'run-tests'), 17:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:48:19 INFO - 'download_minidump_stackwalk': True, 17:48:19 INFO - 'download_symbols': 'ondemand', 17:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 17:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 17:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:48:19 INFO - 'installer_path': 'installer.exe', 17:48:19 INFO - 'log_level': 'info', 17:48:19 INFO - 'log_name': 'talos', 17:48:19 INFO - 'log_to_console': True, 17:48:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:48:19 INFO - 'opt_config_files': (), 17:48:19 INFO - 'pip_index': False, 17:48:19 INFO - 'sps_profile': False, 17:48:19 INFO - 'sps_profile_interval': 0, 17:48:19 INFO - 'suite': 'dromaeojs', 17:48:19 INFO - 'system_bits': '32', 17:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:48:19 INFO - 'title': 'talos-linux64-ix-032', 17:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:48:19 INFO - 'use_talos_json': True, 17:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:48:19 INFO - 'work_dir': 'build'} 17:48:19 INFO - ##### 17:48:19 INFO - ##### Running clobber step. 17:48:19 INFO - ##### 17:48:19 INFO - Running pre-action listener: _resource_record_pre_action 17:48:19 INFO - Running main action method: clobber 17:48:19 INFO - rmtree: /builds/slave/test/build 17:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:48:20 INFO - Running post-action listener: _resource_record_post_action 17:48:20 INFO - ##### 17:48:20 INFO - ##### Running read-buildbot-config step. 17:48:20 INFO - ##### 17:48:20 INFO - Running pre-action listener: _resource_record_pre_action 17:48:20 INFO - Running main action method: read_buildbot_config 17:48:20 INFO - Using buildbot properties: 17:48:20 INFO - { 17:48:20 INFO - "project": "", 17:48:20 INFO - "product": "firefox", 17:48:20 INFO - "script_repo_revision": "production", 17:48:20 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 17:48:20 INFO - "repository": "", 17:48:20 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 17:48:20 INFO - "buildid": "20160303150953", 17:48:20 INFO - "pgo_build": "False", 17:48:20 INFO - "basedir": "/builds/slave/test", 17:48:20 INFO - "buildnumber": 5, 17:48:20 INFO - "slavename": "talos-linux64-ix-032", 17:48:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:48:20 INFO - "platform": "ubuntu64_hw", 17:48:20 INFO - "scheduler": "tests-date-linux64-talos", 17:48:20 INFO - "branch": "date", 17:48:20 INFO - "repo_path": "projects/date", 17:48:20 INFO - "revision": "bde8e6623e5dabe145c84076d15bf2eb08cb8ec4", 17:48:20 INFO - "stage_platform": "linux64", 17:48:20 INFO - "builduid": "5bf8fcf2384f4a238fbe034a4f14bd0b", 17:48:20 INFO - "slavebuilddir": "test" 17:48:20 INFO - } 17:48:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 17:48:20 INFO - Running post-action listener: _resource_record_post_action 17:48:20 INFO - ##### 17:48:20 INFO - ##### Running download-and-extract step. 17:48:20 INFO - ##### 17:48:20 INFO - Running pre-action listener: _resource_record_pre_action 17:48:20 INFO - Running main action method: download_and_extract 17:48:20 INFO - mkdir: /builds/slave/test/build/tests 17:48:20 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')]} 17:48:20 INFO - https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/test_packages.json 17:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/test_packages.json 17:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:48:21 INFO - Downloaded 1412 bytes. 17:48:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:48:21 INFO - Using the following test package requirements: 17:48:21 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 17:48:21 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:48:21 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:48:21 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:48:21 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 17:48:21 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:48:21 INFO - u'jsshell-linux-x86_64.zip'], 17:48:21 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:48:21 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:48:21 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 17:48:21 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:48:21 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 17:48:21 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:48:21 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 17:48:21 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:48:21 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:48:21 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 17:48:21 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:48:21 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:48:21 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:48:21 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')]} 17:48:21 INFO - https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:48:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 17:48:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 17:48:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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 17:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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 17:48:23 INFO - Downloaded 23091872 bytes. 17:48:23 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'] 17:48:23 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 17:48:24 INFO - Return code: 0 17:48:24 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 17:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:24 INFO - https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 17:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 17:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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 17:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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 17:48:29 INFO - Downloaded 23091872 bytes. 17:48:29 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'] 17:48:29 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 17:48:30 INFO - Return code: 0 17:48:30 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')]} 17:48:30 INFO - https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 17:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 17:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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 17:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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 17:48:31 INFO - Downloaded 10706668 bytes. 17:48:31 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'] 17:48:31 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 17:48:31 INFO - Return code: 0 17:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:31 INFO - https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:48:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 17:48:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 17:48:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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 17:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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 17:48:33 INFO - Downloaded 52852505 bytes. 17:48:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 17:48:33 INFO - mkdir: /builds/slave/test/properties 17:48:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:48:33 INFO - Writing to file /builds/slave/test/properties/build_url 17:48:33 INFO - Contents: 17:48:33 INFO - build_url:https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 17:48:34 INFO - Running post-action listener: _resource_record_post_action 17:48:34 INFO - Running post-action listener: set_extra_try_arguments 17:48:34 INFO - ##### 17:48:34 INFO - ##### Running populate-webroot step. 17:48:34 INFO - ##### 17:48:34 INFO - Running pre-action listener: _resource_record_pre_action 17:48:34 INFO - Running main action method: populate_webroot 17:48:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:48:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:48:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:48:34 INFO - '--tppagecycles', 17:48:34 INFO - '7'], 17:48:34 INFO - 'tests': ['tsvgm']}}, 17:48:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:48:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:48:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:48:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:48:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:48:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:34 INFO - 'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:48:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:34 INFO - 'tests': ['damp', 'tps']}, 17:48:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:34 INFO - 'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['damp', 'tps']}, 17:48:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:48:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:48:34 INFO - 'other': {'tests': ['a11yr', 17:48:34 INFO - 'ts_paint', 17:48:34 INFO - 'tpaint', 17:48:34 INFO - 'sessionrestore', 17:48:34 INFO - 'sessionrestore_no_auto_restore']}, 17:48:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['a11yr', 17:48:34 INFO - 'ts_paint', 17:48:34 INFO - 'tpaint', 17:48:34 INFO - 'sessionrestore', 17:48:34 INFO - 'sessionrestore_no_auto_restore']}, 17:48:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['a11yr', 17:48:34 INFO - 'ts_paint', 17:48:34 INFO - 'tpaint', 17:48:34 INFO - 'sessionrestore', 17:48:34 INFO - 'sessionrestore_no_auto_restore']}, 17:48:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['a11yr', 17:48:34 INFO - 'ts_paint', 17:48:34 INFO - 'tpaint', 17:48:34 INFO - 'sessionrestore', 17:48:34 INFO - 'sessionrestore_no_auto_restore']}, 17:48:34 INFO - 'other_l64': {'tests': ['a11yr', 17:48:34 INFO - 'ts_paint', 17:48:34 INFO - 'tpaint', 17:48:34 INFO - 'sessionrestore', 17:48:34 INFO - 'sessionrestore_no_auto_restore']}, 17:48:34 INFO - 'other_nol64': {'tests': ['a11yr', 17:48:34 INFO - 'ts_paint', 17:48:34 INFO - 'tpaint', 17:48:34 INFO - 'sessionrestore', 17:48:34 INFO - 'sessionrestore_no_auto_restore']}, 17:48:34 INFO - 'svgr': {'tests': ['tsvgx', 17:48:34 INFO - 'tsvgr_opacity', 17:48:34 INFO - 'tart', 17:48:34 INFO - 'tscrollx', 17:48:34 INFO - 'cart']}, 17:48:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['tsvgx', 17:48:34 INFO - 'tsvgr_opacity', 17:48:34 INFO - 'tart', 17:48:34 INFO - 'tscrollx', 17:48:34 INFO - 'cart']}, 17:48:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:34 INFO - 'tests': ['tp5o']}, 17:48:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:34 INFO - 'talos_options': ['--e10s'], 17:48:34 INFO - 'tests': ['tp5o']}, 17:48:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:34 INFO - 'talos_options': ['--xperf_path', 17:48:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:48:34 INFO - 'tests': ['tp5n']}, 17:48:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:34 INFO - 'talos_options': ['--e10s', 17:48:34 INFO - '--xperf_path', 17:48:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:48:34 INFO - 'tests': ['tp5n']}}, 17:48:34 INFO - 'talos.zip': {'path': '', 17:48:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:48:34 INFO - Running post-action listener: _resource_record_post_action 17:48:34 INFO - ##### 17:48:34 INFO - ##### Running create-virtualenv step. 17:48:34 INFO - ##### 17:48:34 INFO - Running pre-action listener: _resource_record_pre_action 17:48:34 INFO - Running main action method: create_virtualenv 17:48:34 INFO - Creating virtualenv /builds/slave/test/build/venv 17:48:34 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 17:48:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:48:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:48:34 INFO - Using real prefix '/usr' 17:48:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:48:34 INFO - Installing distribute.............................................................................................................................................................................................done. 17:48:36 INFO - Installing pip.................done. 17:48:36 INFO - Return code: 0 17:48:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:48:36 INFO - Using env: {'DISPLAY': ':0', 17:48:36 INFO - 'HOME': '/home/cltbld', 17:48:36 INFO - 'LANG': 'en_US.UTF-8', 17:48:36 INFO - 'LANGUAGE': 'en_US:en', 17:48:36 INFO - 'LOGNAME': 'cltbld', 17:48:36 INFO - 'MAIL': '/var/mail/cltbld', 17:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:36 INFO - 'MOZ_NO_REMOTE': '1', 17:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:36 INFO - 'NO_EM_RESTART': '1', 17:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:36 INFO - 'PWD': '/builds/slave/test', 17:48:36 INFO - 'SHELL': '/bin/bash', 17:48:36 INFO - 'SHLVL': '1', 17:48:36 INFO - 'TERM': 'linux', 17:48:36 INFO - 'TMOUT': '86400', 17:48:36 INFO - 'USER': 'cltbld', 17:48:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:36 INFO - '_': '/tools/buildbot/bin/python'} 17:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:37 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 17:48:37 INFO - Cleaning up... 17:48:37 INFO - Return code: 0 17:48:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:48:37 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')]} 17:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:37 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')]} 17:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:37 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 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48:37 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 17:48:37 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 17:48:37 INFO - Using env: {'DISPLAY': ':0', 17:48:37 INFO - 'HOME': '/home/cltbld', 17:48:37 INFO - 'LANG': 'en_US.UTF-8', 17:48:37 INFO - 'LANGUAGE': 'en_US:en', 17:48:37 INFO - 'LOGNAME': 'cltbld', 17:48:37 INFO - 'MAIL': '/var/mail/cltbld', 17:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:37 INFO - 'MOZ_NO_REMOTE': '1', 17:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:37 INFO - 'NO_EM_RESTART': '1', 17:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:37 INFO - 'PWD': '/builds/slave/test', 17:48:37 INFO - 'SHELL': '/bin/bash', 17:48:37 INFO - 'SHLVL': '1', 17:48:37 INFO - 'TERM': 'linux', 17:48:37 INFO - 'TMOUT': '86400', 17:48:37 INFO - 'USER': 'cltbld', 17:48:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:37 INFO - '_': '/tools/buildbot/bin/python'} 17:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:37 INFO - Downloading/unpacking psutil>=0.7.1 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:48:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:48:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:48:39 INFO - Installing collected packages: psutil 17:48:39 INFO - Running setup.py install for psutil 17:48:39 INFO - building 'psutil._psutil_linux' extension 17:48:39 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 17:48:39 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 17:48:39 INFO - building 'psutil._psutil_posix' extension 17:48:39 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 17:48:39 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 17:48:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:48:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:48:39 INFO - Successfully installed psutil 17:48:39 INFO - Cleaning up... 17:48:39 INFO - Return code: 0 17:48:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:48: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')]} 17:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48: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')]} 17:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48: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', '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 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:48: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 mozsystemmonitor==0.0.0 17:48:39 INFO - Using env: {'DISPLAY': ':0', 17:48:39 INFO - 'HOME': '/home/cltbld', 17:48:39 INFO - 'LANG': 'en_US.UTF-8', 17:48:39 INFO - 'LANGUAGE': 'en_US:en', 17:48:39 INFO - 'LOGNAME': 'cltbld', 17:48:39 INFO - 'MAIL': '/var/mail/cltbld', 17:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:39 INFO - 'MOZ_NO_REMOTE': '1', 17:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:39 INFO - 'NO_EM_RESTART': '1', 17:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:39 INFO - 'PWD': '/builds/slave/test', 17:48:39 INFO - 'SHELL': '/bin/bash', 17:48:39 INFO - 'SHLVL': '1', 17:48:39 INFO - 'TERM': 'linux', 17:48:39 INFO - 'TMOUT': '86400', 17:48:39 INFO - 'USER': 'cltbld', 17:48:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:39 INFO - '_': '/tools/buildbot/bin/python'} 17:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:48:41 INFO - Installing collected packages: mozsystemmonitor 17:48:41 INFO - Running setup.py install for mozsystemmonitor 17:48:41 INFO - Successfully installed mozsystemmonitor 17:48:41 INFO - Cleaning up... 17:48:41 INFO - Return code: 0 17:48:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:48:41 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')]} 17:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:41 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')]} 17:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:41 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 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48:41 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 17:48:41 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 17:48:41 INFO - Using env: {'DISPLAY': ':0', 17:48:41 INFO - 'HOME': '/home/cltbld', 17:48:41 INFO - 'LANG': 'en_US.UTF-8', 17:48:41 INFO - 'LANGUAGE': 'en_US:en', 17:48:41 INFO - 'LOGNAME': 'cltbld', 17:48:41 INFO - 'MAIL': '/var/mail/cltbld', 17:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:41 INFO - 'MOZ_NO_REMOTE': '1', 17:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:41 INFO - 'NO_EM_RESTART': '1', 17:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:41 INFO - 'PWD': '/builds/slave/test', 17:48:41 INFO - 'SHELL': '/bin/bash', 17:48:41 INFO - 'SHLVL': '1', 17:48:41 INFO - 'TERM': 'linux', 17:48:41 INFO - 'TMOUT': '86400', 17:48:41 INFO - 'USER': 'cltbld', 17:48:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:41 INFO - '_': '/tools/buildbot/bin/python'} 17:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:41 INFO - Downloading/unpacking blobuploader==1.2.4 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:48:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:48:43 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 17:48:43 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 17:48:43 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 17:48:43 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 17:48:43 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 17:48:43 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 17:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:48:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48:44 INFO - Downloading docopt-0.6.1.tar.gz 17:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:48:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:48:44 INFO - Running setup.py install for blobuploader 17:48:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:48:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:48:44 INFO - Running setup.py install for requests 17:48:44 INFO - Running setup.py install for docopt 17:48:44 INFO - Successfully installed blobuploader requests docopt 17:48:44 INFO - Cleaning up... 17:48:44 INFO - Return code: 0 17:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:44 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 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48:44 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 17:48:44 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 17:48:44 INFO - Using env: {'DISPLAY': ':0', 17:48:44 INFO - 'HOME': '/home/cltbld', 17:48:44 INFO - 'LANG': 'en_US.UTF-8', 17:48:44 INFO - 'LANGUAGE': 'en_US:en', 17:48:44 INFO - 'LOGNAME': 'cltbld', 17:48:44 INFO - 'MAIL': '/var/mail/cltbld', 17:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:44 INFO - 'MOZ_NO_REMOTE': '1', 17:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:44 INFO - 'NO_EM_RESTART': '1', 17:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:44 INFO - 'PWD': '/builds/slave/test', 17:48:44 INFO - 'SHELL': '/bin/bash', 17:48:44 INFO - 'SHLVL': '1', 17:48:44 INFO - 'TERM': 'linux', 17:48:44 INFO - 'TMOUT': '86400', 17:48:44 INFO - 'USER': 'cltbld', 17:48:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:44 INFO - '_': '/tools/buildbot/bin/python'} 17:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:48:45 INFO - Running setup.py (path:/tmp/pip-M8MXM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:48:45 INFO - Running setup.py (path:/tmp/pip-qMPv5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:48:45 INFO - Running setup.py (path:/tmp/pip-RhgKcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:48:45 INFO - Running setup.py (path:/tmp/pip-HhEexQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:48:45 INFO - Running setup.py (path:/tmp/pip-Sl3s9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:48:45 INFO - Running setup.py (path:/tmp/pip-LZ0kQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:48:45 INFO - Running setup.py (path:/tmp/pip-gZucZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:48:45 INFO - Running setup.py (path:/tmp/pip-evy_Z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:48:45 INFO - Running setup.py (path:/tmp/pip-lwjfOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:48:45 INFO - Running setup.py (path:/tmp/pip-L1yKIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:48:45 INFO - Running setup.py (path:/tmp/pip-CgyYj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:48:45 INFO - Running setup.py (path:/tmp/pip-t5LUmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:48:45 INFO - Running setup.py (path:/tmp/pip-BPc67a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:48:45 INFO - Running setup.py (path:/tmp/pip-8kLHwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:45 INFO - Running setup.py (path:/tmp/pip-4Ej5n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:48:46 INFO - Running setup.py (path:/tmp/pip-2hKHa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:48:46 INFO - Running setup.py (path:/tmp/pip-OMxdZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:48:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:48:46 INFO - Running setup.py install for manifestparser 17:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Running setup.py install for mozcrash 17:48:46 INFO - Running setup.py install for mozdebug 17:48:46 INFO - Running setup.py install for mozdevice 17:48:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Running setup.py install for mozfile 17:48:46 INFO - Running setup.py install for mozhttpd 17:48:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Running setup.py install for mozinfo 17:48:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Running setup.py install for mozInstall 17:48:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Running setup.py install for mozleak 17:48:46 INFO - Running setup.py install for mozlog 17:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:48:47 INFO - Running setup.py install for moznetwork 17:48:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:48:47 INFO - Running setup.py install for mozprocess 17:48:47 INFO - Running setup.py install for mozprofile 17:48:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:48:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:48:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:48:47 INFO - Running setup.py install for mozrunner 17:48:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:48:47 INFO - Running setup.py install for mozscreenshot 17:48:47 INFO - Running setup.py install for moztest 17:48:47 INFO - Running setup.py install for mozversion 17:48:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:48:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:48:47 INFO - Cleaning up... 17:48:47 INFO - Return code: 0 17:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48:47 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')]} 17:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:47 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')]} 17:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:47 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 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48:47 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 17:48:47 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 17:48:47 INFO - Using env: {'DISPLAY': ':0', 17:48:47 INFO - 'HOME': '/home/cltbld', 17:48:47 INFO - 'LANG': 'en_US.UTF-8', 17:48:47 INFO - 'LANGUAGE': 'en_US:en', 17:48:47 INFO - 'LOGNAME': 'cltbld', 17:48:47 INFO - 'MAIL': '/var/mail/cltbld', 17:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:47 INFO - 'MOZ_NO_REMOTE': '1', 17:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:47 INFO - 'NO_EM_RESTART': '1', 17:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:47 INFO - 'PWD': '/builds/slave/test', 17:48:47 INFO - 'SHELL': '/bin/bash', 17:48:47 INFO - 'SHLVL': '1', 17:48:47 INFO - 'TERM': 'linux', 17:48:47 INFO - 'TMOUT': '86400', 17:48:47 INFO - 'USER': 'cltbld', 17:48:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:47 INFO - '_': '/tools/buildbot/bin/python'} 17:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:48:47 INFO - Running setup.py (path:/tmp/pip-CdAcQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:48:48 INFO - Running setup.py (path:/tmp/pip-l3Jy1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:48:48 INFO - Running setup.py (path:/tmp/pip-S4BrsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:48:48 INFO - Running setup.py (path:/tmp/pip-ZiZ4v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:48:48 INFO - Running setup.py (path:/tmp/pip-8M4xG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:48:48 INFO - Running setup.py (path:/tmp/pip-7bHyfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:48:48 INFO - Running setup.py (path:/tmp/pip-fdKdjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:48:48 INFO - Running setup.py (path:/tmp/pip-UAkLyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:48:48 INFO - Running setup.py (path:/tmp/pip-4E2q2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:48:48 INFO - Running setup.py (path:/tmp/pip-LY3GuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:48:48 INFO - Running setup.py (path:/tmp/pip-M7m7ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:48:48 INFO - Running setup.py (path:/tmp/pip-ujsDtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:48:48 INFO - Running setup.py (path:/tmp/pip-9Rmhqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:48:48 INFO - Running setup.py (path:/tmp/pip-0f8deK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:48 INFO - Running setup.py (path:/tmp/pip-PeLqM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:48:48 INFO - Running setup.py (path:/tmp/pip-4bBx3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:48:48 INFO - Running setup.py (path:/tmp/pip-Jl4Ui7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:48:48 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)) 17:48:48 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)) 17:48:48 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)) 17:48:48 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)) 17:48:48 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)) 17:48:48 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)) 17:48:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:48:48 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 17:48:48 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 17:48:48 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 17:48:48 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 17:48:48 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 17:48:48 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 17:48:50 INFO - Downloading blessings-1.6.tar.gz 17:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:48:50 INFO - Installing collected packages: blessings 17:48:50 INFO - Running setup.py install for blessings 17:48:50 INFO - Successfully installed blessings 17:48:50 INFO - Cleaning up... 17:48:50 INFO - Return code: 0 17:48:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:48:51 INFO - Reading from file tmpfile_stdout 17:48:51 INFO - Current package versions: 17:48:51 INFO - argparse == 1.2.1 17:48:51 INFO - blessings == 1.6 17:48:51 INFO - blobuploader == 1.2.4 17:48:51 INFO - docopt == 0.6.1 17:48:51 INFO - manifestparser == 1.1 17:48:51 INFO - mozInstall == 1.12 17:48:51 INFO - mozcrash == 0.16 17:48:51 INFO - mozdebug == 0.1 17:48:51 INFO - mozdevice == 0.48 17:48:51 INFO - mozfile == 1.2 17:48:51 INFO - mozhttpd == 0.7 17:48:51 INFO - mozinfo == 0.9 17:48:51 INFO - mozleak == 0.1 17:48:51 INFO - mozlog == 3.1 17:48:51 INFO - moznetwork == 0.27 17:48:51 INFO - mozprocess == 0.22 17:48:51 INFO - mozprofile == 0.28 17:48:51 INFO - mozrunner == 6.11 17:48:51 INFO - mozscreenshot == 0.1 17:48:51 INFO - mozsystemmonitor == 0.0 17:48:51 INFO - moztest == 0.7 17:48:51 INFO - mozversion == 1.4 17:48:51 INFO - psutil == 3.1.1 17:48:51 INFO - requests == 1.2.3 17:48:51 INFO - wsgiref == 0.1.2 17:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:51 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 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48:51 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 17:48:51 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 17:48:51 INFO - Using env: {'DISPLAY': ':0', 17:48:51 INFO - 'HOME': '/home/cltbld', 17:48:51 INFO - 'LANG': 'en_US.UTF-8', 17:48:51 INFO - 'LANGUAGE': 'en_US:en', 17:48:51 INFO - 'LOGNAME': 'cltbld', 17:48:51 INFO - 'MAIL': '/var/mail/cltbld', 17:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:51 INFO - 'MOZ_NO_REMOTE': '1', 17:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:51 INFO - 'NO_EM_RESTART': '1', 17:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:51 INFO - 'PWD': '/builds/slave/test', 17:48:51 INFO - 'SHELL': '/bin/bash', 17:48:51 INFO - 'SHLVL': '1', 17:48:51 INFO - 'TERM': 'linux', 17:48:51 INFO - 'TMOUT': '86400', 17:48:51 INFO - 'USER': 'cltbld', 17:48:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:51 INFO - '_': '/tools/buildbot/bin/python'} 17:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 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)) 17:48:51 INFO - Cleaning up... 17:48:51 INFO - Return code: 0 17:48:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:51 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 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48:51 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 17:48:51 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 17:48:51 INFO - Using env: {'DISPLAY': ':0', 17:48:51 INFO - 'HOME': '/home/cltbld', 17:48:51 INFO - 'LANG': 'en_US.UTF-8', 17:48:51 INFO - 'LANGUAGE': 'en_US:en', 17:48:51 INFO - 'LOGNAME': 'cltbld', 17:48:51 INFO - 'MAIL': '/var/mail/cltbld', 17:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:51 INFO - 'MOZ_NO_REMOTE': '1', 17:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:51 INFO - 'NO_EM_RESTART': '1', 17:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:51 INFO - 'PWD': '/builds/slave/test', 17:48:51 INFO - 'SHELL': '/bin/bash', 17:48:51 INFO - 'SHLVL': '1', 17:48:51 INFO - 'TERM': 'linux', 17:48:51 INFO - 'TMOUT': '86400', 17:48:51 INFO - 'USER': 'cltbld', 17:48:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:51 INFO - '_': '/tools/buildbot/bin/python'} 17:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:51 INFO - Downloading/unpacking jsonschema 17:48:51 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 17:48:51 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 17:48:51 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 17:48:51 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 17:48:51 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 17:48:51 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 17:48:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:48:53 INFO - Downloading/unpacking functools32 (from jsonschema) 17:48:53 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 17:48:53 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 17:48:53 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 17:48:53 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 17:48:53 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 17:48:53 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 17:48:53 INFO - Downloading functools32-3.2.3-2.tar.gz 17:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:48:53 INFO - warning: no files found matching '*.txt' 17:48:53 INFO - no previously-included directories found matching 'build' 17:48:53 INFO - no previously-included directories found matching 'dist' 17:48:53 INFO - no previously-included directories found matching '.git*' 17:48:53 INFO - Installing collected packages: jsonschema, functools32 17:48:53 INFO - Running setup.py install for functools32 17:48:53 INFO - warning: no files found matching '*.txt' 17:48:53 INFO - no previously-included directories found matching 'build' 17:48:53 INFO - no previously-included directories found matching 'dist' 17:48:53 INFO - no previously-included directories found matching '.git*' 17:48:53 INFO - Successfully installed jsonschema functools32 17:48:53 INFO - Cleaning up... 17:48:53 INFO - Return code: 0 17:48:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:53 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 0x7f0aaa682f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbfe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, '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': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', '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 17:48:53 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 17:48:53 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 17:48:53 INFO - Using env: {'DISPLAY': ':0', 17:48:53 INFO - 'HOME': '/home/cltbld', 17:48:53 INFO - 'LANG': 'en_US.UTF-8', 17:48:53 INFO - 'LANGUAGE': 'en_US:en', 17:48:53 INFO - 'LOGNAME': 'cltbld', 17:48:53 INFO - 'MAIL': '/var/mail/cltbld', 17:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:53 INFO - 'MOZ_NO_REMOTE': '1', 17:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:53 INFO - 'NO_EM_RESTART': '1', 17:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:53 INFO - 'PWD': '/builds/slave/test', 17:48:53 INFO - 'SHELL': '/bin/bash', 17:48:53 INFO - 'SHLVL': '1', 17:48:53 INFO - 'TERM': 'linux', 17:48:53 INFO - 'TMOUT': '86400', 17:48:53 INFO - 'USER': 'cltbld', 17:48:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:53 INFO - '_': '/tools/buildbot/bin/python'} 17:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:54 INFO - Downloading/unpacking flake8 17:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:48:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:48:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:48:56 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 17:48:56 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 17:48:56 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 17:48:56 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 17:48:56 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 17:48:56 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 17:48:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:48:56 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 17:48:56 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 17:48:56 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 17:48:56 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 17:48:56 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 17:48:56 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 17:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:48:56 INFO - no previously-included directories found matching 'docs/_build' 17:48:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:48:56 INFO - Running setup.py install for pep8 17:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:48:56 INFO - no previously-included directories found matching 'docs/_build' 17:48:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:48:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:48:56 INFO - Cleaning up... 17:48:56 INFO - Return code: 0 17:48:56 INFO - Running post-action listener: _resource_record_post_action 17:48:56 INFO - Running post-action listener: _start_resource_monitoring 17:48:56 INFO - Starting resource monitoring. 17:48:56 INFO - ##### 17:48:56 INFO - ##### Running install step. 17:48:56 INFO - ##### 17:48:56 INFO - Running pre-action listener: _resource_record_pre_action 17:48:56 INFO - Running main action method: install 17:48:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:48:56 INFO - Reading from file tmpfile_stdout 17:48:56 INFO - Detecting whether we're running mozinstall >=1.0... 17:48:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:48:57 INFO - Reading from file tmpfile_stdout 17:48:57 INFO - Output received: 17:48:57 INFO - Usage: mozinstall [options] installer 17:48:57 INFO - Options: 17:48:57 INFO - -h, --help show this help message and exit 17:48:57 INFO - -d DEST, --destination=DEST 17:48:57 INFO - Directory to install application into. [default: 17:48:57 INFO - "/builds/slave/test"] 17:48:57 INFO - --app=APP Application being installed. [default: firefox] 17:48:57 INFO - mkdir: /builds/slave/test/build/application 17:48:57 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'] 17:48:57 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 17:49:09 INFO - Reading from file tmpfile_stdout 17:49:09 INFO - Output received: 17:49:09 INFO - /builds/slave/test/build/application/firefox/firefox 17:49:09 INFO - Running post-action listener: _resource_record_post_action 17:49:09 INFO - ##### 17:49:09 INFO - ##### Running run-tests step. 17:49:09 INFO - ##### 17:49:09 INFO - Running pre-action listener: _resource_record_pre_action 17:49:09 INFO - Running main action method: run_tests 17:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:49:09 INFO - Python 2.7.3 17:49:09 INFO - Return code: 0 17:49:09 INFO - grabbing minidump binary from tooltool 17:49:09 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')]} 17:49:09 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 0x2052430>, '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 0x1fbdf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe3c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:49:09 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 17:49:09 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 17:49:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:49:09 INFO - Return code: 0 17:49:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:49:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:49:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:49:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:49:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:49:10 INFO - Return code: 0 17:49:10 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/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 17:49:10 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/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 17:49:10 INFO - Using env: {'DISPLAY': ':0', 17:49:10 INFO - 'HOME': '/home/cltbld', 17:49:10 INFO - 'LANG': 'en_US.UTF-8', 17:49:10 INFO - 'LANGUAGE': 'en_US:en', 17:49:10 INFO - 'LOGNAME': 'cltbld', 17:49:10 INFO - 'MAIL': '/var/mail/cltbld', 17:49:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:49:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:10 INFO - 'MOZ_NO_REMOTE': '1', 17:49:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:10 INFO - 'NO_EM_RESTART': '1', 17:49:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:10 INFO - 'PWD': '/builds/slave/test', 17:49:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:49:10 INFO - 'SHELL': '/bin/bash', 17:49:10 INFO - 'SHLVL': '1', 17:49:10 INFO - 'TERM': 'linux', 17:49:10 INFO - 'TMOUT': '86400', 17:49:10 INFO - 'USER': 'cltbld', 17:49:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457055079.250885-532101098', 17:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:10 INFO - '_': '/tools/buildbot/bin/python'} 17:49:10 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/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 17:49:10 INFO - mozversion application_buildid: 20160303150953 17:49:10 INFO - mozversion application_changeset: bde8e6623e5dabe145c84076d15bf2eb08cb8ec4 17:49:10 INFO - mozversion application_display_name: Firefox 17:49:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:49:10 INFO - mozversion application_name: Firefox 17:49:10 INFO - mozversion application_remotingname: firefox 17:49:10 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 17:49:10 INFO - mozversion application_vendor: Mozilla 17:49:10 INFO - mozversion application_version: 46.0 17:49:10 INFO - mozversion platform_buildid: 20160303150953 17:49:10 INFO - mozversion platform_changeset: bde8e6623e5dabe145c84076d15bf2eb08cb8ec4 17:49:10 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 17:49:10 INFO - mozversion platform_version: 46.0 17:49:10 INFO - using testdate: 1457056150 17:49:10 INFO - actual date: 1457056150 17:49:10 INFO - starting webserver on 'localhost:49000' 17:49:10 INFO - SUITE-START | Running 3 tests 17:49:10 INFO - TEST-START | dromaeo_css 17:49:10 INFO - operating with platform_type : linux_ 17:49:10 INFO - Initialising browser for dromaeo_css test... 17:49:10 INFO - TEST-INFO | started process 16938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_18Geq/profile http://localhost:49000/getInfo.html) 17:49:14 INFO - PROCESS | 16938 | __metrics Screen width/height:1600/1200 17:49:14 INFO - PROCESS | 16938 | colorDepth:24 17:49:14 INFO - PROCESS | 16938 | Browser inner width/height: 1024/697 17:49:14 INFO - PROCESS | 16938 | __metrics 17:49:14 INFO - PROCESS | 16938 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:49:15 INFO - TEST-INFO | 16938: exit 0 17:49:15 INFO - Browser initialized. 17:49:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:49:15 INFO - TEST-INFO | started process 17025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_18Geq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:49:27 INFO - PROCESS | 17025 | RSS: Main: 134639616 17:49:27 INFO - PROCESS | 17025 | 17:50:18 INFO - PROCESS | 17025 | 1457056218893 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] 17:52:25 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49000/tests/dromaeo/cssquery-ext.html) 17:52:26 INFO - PROCESS | 17025 | RSS: Main: 241684480 17:52:26 INFO - PROCESS | 17025 | 17:55:28 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-ext.html (next: http://localhost:49000/tests/dromaeo/cssquery-jquery.html) 17:55:29 INFO - PROCESS | 17025 | RSS: Main: 213929984 17:55:29 INFO - PROCESS | 17025 | 17:58:31 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49000/tests/dromaeo/cssquery-mootools.html) 17:58:31 INFO - PROCESS | 17025 | RSS: Main: 224337920 17:58:31 INFO - PROCESS | 17025 | 18:01:33 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49000/tests/dromaeo/cssquery-prototype.html) 18:01:33 INFO - PROCESS | 17025 | RSS: Main: 200065024 18:01:33 INFO - PROCESS | 17025 | 18:04:36 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49000/tests/dromaeo/cssquery-yui.html) 18:04:36 INFO - PROCESS | 17025 | RSS: Main: 203087872 18:04:36 INFO - PROCESS | 17025 | 18:07:38 INFO - PROCESS | 17025 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-yui.html (next: http://localhost:49000/tests/dromaeo/cssquery-dojo.html) 18:07:39 INFO - PROCESS | 17025 | RSS: Main: 241885184 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - PROCESS | 17025 | __start_tp_report 18:07:39 INFO - PROCESS | 17025 | _x_x_mozilla_page_load 18:07:39 INFO - PROCESS | 17025 | _x_x_mozilla_page_load_details 18:07:39 INFO - PROCESS | 17025 | |i|pagename|runs| 18:07:39 INFO - PROCESS | 17025 | |0;dojo.html;3241.0924941016515;3260.0871755908356;3283.1792051987004;3292.407366673999;3313.7514686398517;5269.841904742864;5276.894462110756;5277.472252774725;5282.022825777229;5330.3603567571845;5313.415524292324;5319.893602127955;5329.200619907016;5358.624896257264;5363.302770639821;4806.447258565275;4876.829310974116;4896.363472748538;4928.507149285061;4970.87572810679;4866.562009419152;4971.726555039471;4974.726390048546;4976.4525902150735;4978.576820970222;4894;4895.804167833282;4964.280179373988;4972.577330926875;4980.0288943656005;4881.755912204411;4887.877803054935;4914.508549145093;4915.975420122876;4993.226049962262;4789;4829.058333624945;4844;4861.564532608988;4874.8537543873745;5081.136206844845;5087.669301495428;5119;5133.30700355451;5205.895882082337;5645.463680950304;5694.4590263924865;5695.743691533891;5698.974184646762;5709.800156994527;5694.544436445074;5717.028105222081;5724.4561766632105;5737.368889422202;5741.712914354265;5230.372355317349;5265.447128051576;5269.736513174326;5351.17056856184;5455.481729235717;5755.309362876482;5758.107493338539;5812.215350927655;5821.359650438449;5831.9708401458565;5597.048501754712;5605.439456054362;5641.069223578063;5643.717814109278;5647.632903861236;5706.543476521952;5776.277965254343;5819.79630712923;5849.976254155506;5892.94107058924;5651.547876169897;5724.599278050497;5732.77068917247;5736.885262294731;5758.596898217168;5479.397266300703;5708.828735137952;5713.771449142071;5736.913946290809;5741.88516229673;4249.68127390447;4299.398084268205;4311.48262208537;4315.3742707307265;4330.653547716175;3938.6455219030427;3946.565877753445;3968.8809335719975;3974.6422821945584;3984.7011474139554;5268.367795864444;5343.385510666323;5349.866253343697;5362.463753624685;5366.6243362964215;5719.771209151588;5738.942610573924;5740.712964351766;5748.913766293509;5751.942480575224;5185.844424667266;5234.842954711365;5254.973725131426;5274.868128296824;5339.813106541253;4894.216925291937;4922.630802689741;4943.01139772047;4943.332650092191;4970.925436118461;5711.057675483498;5801.883962320814;5803.593748437569;5815.854603634943;5871.706414679249;5717.485426311652;5744.540436764965;5759.481646651821;5818.73815678304;5844.47399734026;5846.35690074083;5883.852903677443;5891.440313170242;5892.6759028253855;5915.526757859447;5562.860928476821;5643.492085712305;5692.886142277214;5706.144078388275;5722.141678748221;5657.264555607745;5710.8001219957105;5722.942770572241;5756.65460072397;5760.135979603093;5455.727213639223;5541.972290138524;5546.473085056913;5572.944270557243;5573.247611572386;5417.593680474059;5556.444355564573;5557.499825015768;5564.721763911869;5580.218769372373;5473.17902314656;5474.890502190014;5480.479354461319;5497.5601951842955;5541.750621222135;5580.637258578179;5601.439856014366;5614.29821272341;5620.578456615852;5631.746571404378;5376.462353764592;5381.75782089799;5412.83761487156;5430.484104010113;5484.204790305464 18:07:39 INFO - PROCESS | 17025 | |1;ext.html;495.3263561556285;518.3106468397032;520.4847201270743;544.9945500544994;591.4381337729159;29624.703752962465;36566.634333656686;37080.25839483209;37083.258334833285;37335;39350.40974385387;39885.20229595406;39930.40104398429;40027.39958900611;40264.79867600665;8642.43824151428;8854.513001784931;8889.73330800077;8906.86639700405;8913.465192088463;8562.357823163256;8831;8834.64661413546;8873;8887.644494220223;8749.650013999433;8837.867431988525;8869.423487473294;8874.733757987238;8878.778030549223;8770.342224333168;8842.646294148226;8847.07105753893;8849.247813935823;8871.891013623297;8650.956745216297;8791.692290769857;8801.119888011148;8832.425892317044;8832.514211718353;42583.57416425858;43114.56885431137;43149;43298.78350608258;43301.78349108266;3610.8194590270646;3618.3125206210734;3648.0515066082744;3684.2631473705096;4062.837486500536;28036;28349.14952551406;28440.71559284422;28520.857395713098;29194.70805291941;3897.4543563901075;3948.9802550987347;4028.295048366524;4153.1486045360625;4216.978915105436;232382;232623;233066;233704;311065;45916.311255331195;64233;65390.67304663541;65718.37126514982;65916.34083659197;56782;57525.42474575285;57543.410546525505;57572;57732.71133644305;15901.840981590267;16049.438269660506;16074;16127.354905803872;16175.433859815086;12072.396380181131;12171.573994910135;12194.878051219373;12259.448324825404;12626.55807046749;20521.89739051325;20809.791902081088;20833.791662083488;20863.37409877706;20909.163633454795;8298.21166989135;8504;8533.189347012023;8536.231739143383;8570.571471426403;937.5218638494417;978.7699890525721;1121.971950701239;1133.790248803974;1143.7540928700369;27714.168574942785;28027.579586306223;28513.572296415572;28533.714662853105;29015.709842901302;1177.9646610601696;1183.4319526627266;1220.6765207220094;1225.8038713805747;1245.4768997021272;14060.578182654537;14991.400343986337;16090.678186436206;16377.754333685005;16563.254653540618;324722;326138;326169;326367;327439;50645.24032139447;51271.230931536054;51280.48719512757;51334.48665513372;51652.74173629108;1310.8754668306497;1348.480834878579;1445.4001589340517;1452.7457694903349;1454.4255019267541;26720.465590687687;28269.57595636108;28896.855515723128;30666.233344166576;30897.691023089483;52811.73594132005;53311.200331994274;53705.73147134239;53709.46290537201;53756.46243537514;311703;313511;320440;320930;321634;43203;44032;44345.55654443414;44507.33239001353;44873;47195;47772.522274778195;48604.27093593528;48744.2688359682;48763.756181218865;39132.80433597814;39787.40318895277;39845.60154398419;40024.1995160101;40649.59350406458;40792.79603601963;40795.38806917958;40874.59125408708;41080.38379424371;41369.79315103526;38520.80739596284;39044;39145;40538;40589;30332.241693956945;31720.682793171774;34049;35050.29899401947;35158.12104697403;25991.74008259893;26281.73718262793;26589.335266617716;26600.8669956649;26670.333241668337 18:07:39 INFO - PROCESS | 17025 | |2;jquery.html;374.118949873049;379.61279494915186;380.68022860796924;384.12994567305077;386.62304253352966;14577.125372477632;15892.761608575865;17110.486685399428;18025.918444893297;18041.368552100663;17216.82783172168;17872;17891.19489622967;17971.460856174337;18242.27030918765;5516.420775818541;5673.149027645865;5691.886162276752;5707.286589176353;5722.027255366597;4296.334068219431;4473;5636.2954630671165;6039.939600604003;6328.841778955517;5951.6726580038085;6150.292716337612;6230.501559875199;6279.623222606659;6307.842303942392;6135.846603834895;6151.077338399254;6164.568480206387;6197.25632924052;6200.78297259596;5101.7194054327;5322.121849894801;5334.91997620036;5336.092864213093;5337.70642614656;18744.343947961755;18932.337368192046;19365.4190374289;19410;20321.593568128555;2224.8887555622314;2265.0600000999566;2267.6711876777777;2301.608726516496;2451.982427292671;9770.218382529381;13425.462981480729;13730.51943181984;14400.71198576033;14669.186397411635;1922.6731455652432;1954.7556555430572;1989.8607097503182;2008.8794672319707;2094.2356040045274;66432;67513;68047.65976170138;68641.313586864;69379.95930061053;15495.690086198212;15979.680406391806;16010.439634612965;16020.679586408207;16037.075550933963;25233;25234.621480677804;25276.747232527807;25551.488970220864;25603;7492.812679683051;7754.7673569793;7790.688372465038;7811.45319827618;7826.060872695313;7400.222976587488;7418.740344087931;7483.925160748432;7504.662290196954;7507.849843003219;4508.909821803545;4638.768061596974;4712.59942904857;4747.501512341223;4751.6695325308965;1845.1973391574709;1915.1286164794985;1938.5638231397822;1978.4460351101714;1989.1844343818964;918.481058202127;969.3360048366891;999.6501224571342;1048.0410424461684;1048.2557384257263;13622.591322260349;15683.843161568238;16140.435084771976;16281.837181628032;16644.916775416044;984.2667212926416;989.3569180033036;1033.2199189611795;1044.9216308776872;1093.9935259561223;9139.680111196076;9276.814463710689;9284.210842078364;9338.159565639126;9501.952490237505;592589;615495;615984;630589;632391;74291;74458;74702;76025;77210.61394693103;1209.087139209891;1216.975660486803;1218.7806194885006;1247.2080229054616;1250.7435975624976;14532.491362802251;14925.328360224034;14979.475718349806;14987;15144.697106057596;32589.674103258665;32611.34777304488;32954;33836.154096147795;34268.82865585656;41009;41292.38061429141;41744.3738343919;42172.367414488195;42399.3640095405;7485.588292643957;7532;7675;7743.612819359122;7760.262775036363;10490.632827850988;10611;11145.665630031112;11202.21584489078;11801;9691.176250018827;9711.951440242754;9938.30431869791;10194;10275.588976440858;7634.312911837961;9888.851667224853;9957.20342372594;10014.198864091;10109.39343639384;9975.301728878909;10354.430506322225;10415;10528.210384221062;10787.352758834495;7113.822154445973;7463.626818658937;7908.683652653829;7947.205279472238;7962.442629016145;9072.455652660861;9314.161725444743;9355.4386736796;9358.625654973725;9386.202172815114 18:07:39 INFO - PROCESS | 17025 | |3;mootools.html;1536.3624096000158;1553.883458740594;1705.0962989615507;1848.51938495991;1885.5663197464573;8372.911521502203;8584.48493090415;8613.87079193811;8629.784255393619;8642.178992995656;8369.288610468118;8458.111898250687;8479.236868681817;8515.701950431721;8517.574121293941;2451.3258853815255;2455.6684847545575;2474.9628755568683;2481.838680485763;2488.701355837293;2433.756624337561;2493.2021753039035;2501.8373805702663;2511.836730612504;2516.5721827289312;2112.5669237806214;2178.3900507857747;2385.8329916905823;2466.149178533412;2466.9515455931246;2380.0598763488497;2393.916212932539;2395.173665085543;2398.712154541449;2406.5427568761966;2322.465832858452;2374.014783864694;2389.462370966536;2392.7009123859516;2399.8920048597856;7349.412047036224;7579.1662917079075;7975.003124609424;8138.674453021872;8175.468594541336;4888.217885138396;4988.850334489971;4993.700377977333;5020.472850350697;5024.221245706921;3273.9672603273902;3278.1476816027766;3288.325893191914;3297.835108244602;3330.850111744953;1045.989540104597;1994.5611965367596;2070.6272870883236;2100.884451355175;2104.642210824148;11760.647180584596;11817.822732659017;11830.112741544333;11831.349275789828;11841;4354.648489815464;4364.367166760802;4441.867323832402;4498.235299999008;4515.571020753023;9556.426614403159;9557.713268601814;9597.760055998657;9602.95198524003;9608.231341492663;5007.674501157413;5045.9747701261995;5064.974675126675;5070.960453107178;5097.311862898536;4438.400815889813;4663.883402914887;4695.600873925755;4711.67018308722;4720.575148236675;3774.245150969817;3780.4896338993885;3781.621837816251;3827.0623697194364;3827.3302172119766;1150.0741902768184;1154.3247200387866;1163.4648061891626;1165.5862168930078;1177.2995067934564;1053.9789204215872;1135.6990397544657;1202.9578964736193;1364.3382959264748;1399.9370028348544;7990.20097990208;8010.479318844256;8073.152319006537;8309.542975136304;8349.081601023883;546.9589780766379;557.4648337595872;560.1038338658115;560.5543592843699;569.2883895131087;5902.2032025676845;5968.731407086691;6349.809505714836;6352.2694890087305;6391.3289104643345;10162.339447935861;10520.316179448311;10603.787924241473;10647;10684.94657526723;10144.239182061376;10276.332038417479;10479.738006549896;10485.05634492884;10490.632827850988;7939.483933544301;8135.3898457615915;8148.429609927367;8151.551664658501;8178.223068808454;8062.1874516036205;8192.139825318494;8245.340372770284;8250.958745206235;8259.545724985184;9211.124943130391;9226.769330766785;9283.814323713623;9438.150566449052;9499.572519236513;9393.201577865684;9586.376885502421;9832.9016709832;9836.163926066365;9840.3603765755;7212.603306818175;7213;7413.851722965403;7469.77590672259;7480.962595186989;8045.436819422584;8065.475744076616;8077.83844323122;8090.797730056795;8120.837583248183;7186.425085993213;7429.962850185714;7467.178610352966;7512.436567257369;7606.543607383574;7170.892436613351;7297.562146271241;7358.558486490828;7437.293457121565;7457.366123879531;7688.615569221628;7708.576028318496;7720.8455830884195;7722.884156737541;7781.144074151725;6917;6921.1002569665625;6946.0622815919205;6948.965255173692;7012.298770122947;7290.453216008927;7295.2340004298785;7354.595497247703;7356.264373562601;7381.741639042608 18:07:39 INFO - PROCESS | 17025 | |4;prototype.html;352.40971372950304;354.52316634127106;355.73675480144703;358.0654491776465;359.0646366216007;5872.148538461921;6030.969845150774;6079.8176054718315;6081.361457047007;6131.7240724167405;5834.737436815343;5956.8212953611355;5984.3417224105315;5993.610415323001;6010.699465026753;4690.132325519773;4690.648201384893;4706.364640773486;4713.363695901053;4715.622750179978;4527.298268768346;4571.017231295271;4657.650676199281;4668.626509879218;4676.251799712047;4613.1696294666945;4617.769111544426;4634.629229661636;4646.930296045562;4650.4186976627925;4580.129775342674;4621;4664.486906440289;4677.929831052537;4696.765161741933;4121.072758629314;4126.360414135814;4144.668426525871;4152.065785198336;4164.68764842635;5599.720013999325;5668.43315668434;5688.061469857468;5695.117256825199;5703.0589952657765;5316.12283973144;5373.75818088183;5402.8919421611745;5407.675539467645;5435.537979271767;6056.757729690807;6377.904331435032;6389.520785941027;6400.679966001681;6406.519511036644;4546.454425468932;4574.565416285448;4576.954230457719;4583.656225783079;4609.354690343354;6618.437432818217;6623.569467984566;6625.768098116591;6629.403353698142;6637.93362066378;4684.508126646653;4716.551927566876;4722.173619616553;4724.834630787906;4733.739644319527;4694.36626055485;4765.666403351802;4778.378810754649;4781.976090119597;4782.545658162469;5402.081646120169;5409.404965453797;5438.021156191844;5453.781848726086;5462.126059830408;6397.200349956255;6414.935850641527;6427;6439.259485159173;6451.161349024596;1690.4928521443517;1723.8448539631493;1728.9885417031178;1729.3342063305465;1730.195459111519;1098.7637657903429;1126.7577470843808;1127.4588197665166;1134.3307448605362;1187.1274613159321;5904.819036192693;5925.288965324103;5928.051511758098;6018.969905150446;6019.759209631566;6535.57518761279;6537.378948999837;6549.934500654933;6550;6583.736650534021;5980.611260268069;5982.790602328898;6011.849703757353;6017.608855424471;6041.214642096499;3447.413939630269;3529.36471435139;3530.717542596586;3540.964590354115;3551.2897420516;6690.832729181712;6706.463482921452;6720.395164435225;6730.629815360202;6757.526973111835;6771.255161932184;6779.559328643622;6781.796546103526;6786.185657721105;6791.660416979132;6663.333666633298;6752.83117922046;6756.763513277012;6773.254941956381;6858.862822743617;6423.775167869289;6519.608823470607;6545.280019197789;6632.303608121078;6634.635095069624;6543.640099794557;6567.671616419065;6572.244191917991;6574.3754343337305;6579.276279609335;6813.931860681329;6828.0440738297675;6834;6841.794746157623;6913.75801846933;4528.343390208467;4550.567696068868;4568.543145685538;4742.264948932921;4743.525647435229;6611.801645950629;6650.434713049445;6657.500687448364;6665.600063996176;6672.733090676513;6445.355464453517;6449.161608990801;6463.709133088928;6469.347567497303;6498.317676643885;6281.089242059968;6452.483801295791;6457.838554036187;6469.644169570719;6475.935240647534;6346.873062538631;6366.4588509977175;6371.681415929278;6379.266384365857;6429.54993150475;6494.512911531559;6496.9025464617125;6499.155109835691;6532.41208291256;6561.80314590563;6156.661383623765;6327.335629758809;6340.461060809883;6362.745490180341;6373.840653983502 18:07:39 INFO - PROCESS | 17025 | |5;yui.html;865.4158443050939;885.720997885666;895.2435192262536;898.142274128208;912.5026860361103;11406.372649504274;11624.825627615583;11755.941220293897;11781.352025638587;11866.347350895698;12544.43550040248;12604.180728252657;12637.747245055116;12657.746845063093;12714.046446516502;745.5414919824324;756.4440136499668;874.715717391847;875.8554838451648;884.3234925282164;862.0517430826104;869.4739682492065;872.6814712629877;873.3144481581959;874.9300055995537;920.6317473010815;923.1184219070772;925.5834874306555;926.2589928057561;926.4487629860222;758.7761610324967;776.0725932510652;899.4108858697531;906.8775715278418;911.0070023674227;673.4477728262826;675.7432175773224;676.627854679929;676.6785776756002;677.6679427080744;13186.934065329708;13206.669833254246;13208.933955330258;13254.602361929157;13289.534866279633;13034.217946923214;13922.860771392257;14093.929530352385;14135.858641413557;14180.50368237117;10734.624288149877;10809.297395669257;10940.890591094067;11107.111431085494;11521.135914806424;3845.2309538092495;3909.902252443683;3941.1723538057045;3946.605339466059;3993.201359728066;48042;48304.5169548307;48772.51227487751;49270.26094608584;50022.24966625503;11264.831027534594;11520.94239528797;11562.132840037031;11716.824247636292;11946.940265298792;17313.480595582154;17363.65272694539;17386.47840564785;17429.564260893327;17497.650046998988;7809.1409944907155;7834.647440865175;7891.6054197289905;8022.358211343078;8321.83356332882;4438.511763705989;4510.075434535912;4516.932246016312;4612.30815377696;4735.337052812609;3290.6051273847293;3337.6829201225846;3340.565726455594;3344.816035118043;3352.1284466039006;621.4220774679501;633.1673848888696;643.5366536094004;649.0945131541473;655.6983787457823;567.9517241034558;590.754836742747;627.2947542104552;687.6664817563478;695.1429624244352;9013.729588112366;9090.500022498825;9447.76380590477;9593.568289426992;9664.613415463302;603.4840211619003;641.0640464921267;654.9443297319685;695.1553862057624;715.5670819154441;4261;4269.103488267437;4275.5296917339065;4362.30203167498;4737.881552961204;55118.72440637771;58599.41400586025;59003;59269.70365148147;59413.702931485066;51316.74341628268;51613.22580161301;51774.48225517772;52240.47759522356;52275.21587176195;46457.535424646;47142;47233.5276647236;47811.28283075757;47920.760396197795;9118.817623647357;9279.6288148476;9428.387154834914;9578.281628878001;9703.5148242589;37073.629263707015;37179.62820371761;38088.238235235694;38185;38294.234115316984;45887;46554;46704.532954670016;46774.53225467702;53046.73476632592;11681.766364672489;11981.580644677395;12086.153969222421;12173.20874143178;12208.206466579644;12834.486620535074;13074.215547067206;13598.456061757419;13651.249181295125;14014.78977815354;12268.263904165779;12445.502179912703;12540.561080362144;12684.048696347627;13021.869781302066;12549.184303020274;12715.93642031784;12747.553835615709;13004.804927926278;13045;12071.155019148575;12197.75604487923;12256;12431.62705118848;12537.686557836127;9908.306418550632;9995.900040999497;10226.59093636276;10402.115820155372;10523.105536029523;10372.954547726544;10788.784224315314;10859.185561083108;11031.558737650405;11056.557737690724 18:07:39 INFO - PROCESS | 17025 | __end_tp_report 18:07:39 INFO - PROCESS | 17025 | __start_cc_report 18:07:39 INFO - PROCESS | 17025 | _x_x_mozilla_cycle_collect,788 18:07:39 INFO - PROCESS | 17025 | __end_cc_report 18:07:39 INFO - PROCESS | 17025 | __startTimestamp1457057259104__endTimestamp 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - PROCESS | 17025 | ------- Summary: start ------- 18:07:39 INFO - PROCESS | 17025 | Number of tests: 6 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - PROCESS | 17025 | [#0] dojo.html Cycles:165 Average:5300.36 Median:5474.89 stddev:571.65 (10.4%) stddev-sans-first:550.11 18:07:39 INFO - PROCESS | 17025 | Values: 3241.1 3260.1 3283.2 3292.4 3313.8 5269.8 5276.9 5277.5 5282.0 5330.4 5313.4 5319.9 5329.2 5358.6 5363.3 4806.4 4876.8 4896.4 4928.5 4970.9 4866.6 4971.7 4974.7 4976.5 4978.6 4894.0 4895.8 4964.3 4972.6 4980.0 4881.8 4887.9 4914.5 4916.0 4993.2 4789.0 4829.1 4844.0 4861.6 4874.9 5081.1 5087.7 5119.0 5133.3 5205.9 5645.5 5694.5 5695.7 5699.0 5709.8 5694.5 5717.0 5724.5 5737.4 5741.7 5230.4 5265.4 5269.7 5351.2 5455.5 5755.3 5758.1 5812.2 5821.4 5832.0 5597.0 5605.4 5641.1 5643.7 5647.6 5706.5 5776.3 5819.8 5850.0 5892.9 5651.5 5724.6 5732.8 5736.9 5758.6 5479.4 5708.8 5713.8 5736.9 5741.9 4249.7 4299.4 4311.5 4315.4 4330.7 3938.6 3946.6 3968.9 3974.6 3984.7 5268.4 5343.4 5349.9 5362.5 5366.6 5719.8 5738.9 5740.7 5748.9 5751.9 5185.8 5234.8 5255.0 5274.9 5339.8 4894.2 4922.6 4943.0 4943.3 4970.9 5711.1 5801.9 5803.6 5815.9 5871.7 5717.5 5744.5 5759.5 5818.7 5844.5 5846.4 5883.9 5891.4 5892.7 5915.5 5562.9 5643.5 5692.9 5706.1 5722.1 5657.3 5710.8 5722.9 5756.7 5760.1 5455.7 5542.0 5546.5 5572.9 5573.2 5417.6 5556.4 5557.5 5564.7 5580.2 5473.2 5474.9 5480.5 5497.6 5541.8 5580.6 5601.4 5614.3 5620.6 5631.7 5376.5 5381.8 5412.8 5430.5 5484.2 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - PROCESS | 17025 | [#1] ext.html Cycles:180 Average:47840.57 Median:39865.40 stddev:78387.68 (196.6%) stddev-sans-first:78526.97 18:07:39 INFO - PROCESS | 17025 | Values: 495.3 518.3 520.5 545.0 591.4 29624.7 36566.6 37080.3 37083.3 37335.0 39350.4 39885.2 39930.4 40027.4 40264.8 8642.4 8854.5 8889.7 8906.9 8913.5 8562.4 8831.0 8834.6 8873.0 8887.6 8749.7 8837.9 8869.4 8874.7 8878.8 8770.3 8842.6 8847.1 8849.2 8871.9 8651.0 8791.7 8801.1 8832.4 8832.5 42583.6 43114.6 43149.0 43298.8 43301.8 3610.8 3618.3 3648.1 3684.3 4062.8 28036.0 28349.1 28440.7 28520.9 29194.7 3897.5 3949.0 4028.3 4153.1 4217.0 232382.0 232623.0 233066.0 233704.0 311065.0 45916.3 64233.0 65390.7 65718.4 65916.3 56782.0 57525.4 57543.4 57572.0 57732.7 15901.8 16049.4 16074.0 16127.4 16175.4 12072.4 12171.6 12194.9 12259.4 12626.6 20521.9 20809.8 20833.8 20863.4 20909.2 8298.2 8504.0 8533.2 8536.2 8570.6 937.5 978.8 1122.0 1133.8 1143.8 27714.2 28027.6 28513.6 28533.7 29015.7 1178.0 1183.4 1220.7 1225.8 1245.5 14060.6 14991.4 16090.7 16377.8 16563.3 324722.0 326138.0 326169.0 326367.0 327439.0 50645.2 51271.2 51280.5 51334.5 51652.7 1310.9 1348.5 1445.4 1452.7 1454.4 26720.5 28269.6 28896.9 30666.2 30897.7 52811.7 53311.2 53705.7 53709.5 53756.5 311703.0 313511.0 320440.0 320930.0 321634.0 43203.0 44032.0 44345.6 44507.3 44873.0 47195.0 47772.5 48604.3 48744.3 48763.8 39132.8 39787.4 39845.6 40024.2 40649.6 40792.8 40795.4 40874.6 41080.4 41369.8 38520.8 39044.0 39145.0 40538.0 40589.0 30332.2 31720.7 34049.0 35050.3 35158.1 25991.7 26281.7 26589.3 26600.9 26670.3 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - PROCESS | 17025 | [#2] jquery.html Cycles:180 Average:30777.40 Median:42285.87 stddev:100834.25 (238.5%) stddev-sans-first:101091.27 18:07:39 INFO - PROCESS | 17025 | Values: 374.1 379.6 380.7 384.1 386.6 14577.1 15892.8 17110.5 18025.9 18041.4 17216.8 17872.0 17891.2 17971.5 18242.3 5516.4 5673.1 5691.9 5707.3 5722.0 4296.3 4473.0 5636.3 6039.9 6328.8 5951.7 6150.3 6230.5 6279.6 6307.8 6135.8 6151.1 6164.6 6197.3 6200.8 5101.7 5322.1 5334.9 5336.1 5337.7 18744.3 18932.3 19365.4 19410.0 20321.6 2224.9 2265.1 2267.7 2301.6 2452.0 9770.2 13425.5 13730.5 14400.7 14669.2 1922.7 1954.8 1989.9 2008.9 2094.2 66432.0 67513.0 68047.7 68641.3 69380.0 15495.7 15979.7 16010.4 16020.7 16037.1 25233.0 25234.6 25276.7 25551.5 25603.0 7492.8 7754.8 7790.7 7811.5 7826.1 7400.2 7418.7 7483.9 7504.7 7507.8 4508.9 4638.8 4712.6 4747.5 4751.7 1845.2 1915.1 1938.6 1978.4 1989.2 918.5 969.3 999.7 1048.0 1048.3 13622.6 15683.8 16140.4 16281.8 16644.9 984.3 989.4 1033.2 1044.9 1094.0 9139.7 9276.8 9284.2 9338.2 9502.0 592589.0 615495.0 615984.0 630589.0 632391.0 74291.0 74458.0 74702.0 76025.0 77210.6 1209.1 1217.0 1218.8 1247.2 1250.7 14532.5 14925.3 14979.5 14987.0 15144.7 32589.7 32611.3 32954.0 33836.2 34268.8 41009.0 41292.4 41744.4 42172.4 42399.4 7485.6 7532.0 7675.0 7743.6 7760.3 10490.6 10611.0 11145.7 11202.2 11801.0 9691.2 9712.0 9938.3 10194.0 10275.6 7634.3 9888.9 9957.2 10014.2 10109.4 9975.3 10354.4 10415.0 10528.2 10787.4 7113.8 7463.6 7908.7 7947.2 7962.4 9072.5 9314.2 9355.4 9358.6 9386.2 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - PROCESS | 17025 | [#3] mootools.html Cycles:180 Average:5941.20 Median:552.21 stddev:3132.95 (567.3%) stddev-sans-first:3124.24 18:07:39 INFO - PROCESS | 17025 | Values: 1536.4 1553.9 1705.1 1848.5 1885.6 8372.9 8584.5 8613.9 8629.8 8642.2 8369.3 8458.1 8479.2 8515.7 8517.6 2451.3 2455.7 2475.0 2481.8 2488.7 2433.8 2493.2 2501.8 2511.8 2516.6 2112.6 2178.4 2385.8 2466.1 2467.0 2380.1 2393.9 2395.2 2398.7 2406.5 2322.5 2374.0 2389.5 2392.7 2399.9 7349.4 7579.2 7975.0 8138.7 8175.5 4888.2 4988.9 4993.7 5020.5 5024.2 3274.0 3278.1 3288.3 3297.8 3330.9 1046.0 1994.6 2070.6 2100.9 2104.6 11760.6 11817.8 11830.1 11831.3 11841.0 4354.6 4364.4 4441.9 4498.2 4515.6 9556.4 9557.7 9597.8 9603.0 9608.2 5007.7 5046.0 5065.0 5071.0 5097.3 4438.4 4663.9 4695.6 4711.7 4720.6 3774.2 3780.5 3781.6 3827.1 3827.3 1150.1 1154.3 1163.5 1165.6 1177.3 1054.0 1135.7 1203.0 1364.3 1399.9 7990.2 8010.5 8073.2 8309.5 8349.1 547.0 557.5 560.1 560.6 569.3 5902.2 5968.7 6349.8 6352.3 6391.3 10162.3 10520.3 10603.8 10647.0 10684.9 10144.2 10276.3 10479.7 10485.1 10490.6 7939.5 8135.4 8148.4 8151.6 8178.2 8062.2 8192.1 8245.3 8251.0 8259.5 9211.1 9226.8 9283.8 9438.2 9499.6 9393.2 9586.4 9832.9 9836.2 9840.4 7212.6 7213.0 7413.9 7469.8 7481.0 8045.4 8065.5 8077.8 8090.8 8120.8 7186.4 7430.0 7467.2 7512.4 7606.5 7170.9 7297.6 7358.6 7437.3 7457.4 7688.6 7708.6 7720.8 7722.9 7781.1 6917.0 6921.1 6946.1 6949.0 7012.3 7290.5 7295.2 7354.6 7356.3 7381.7 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - PROCESS | 17025 | [#4] prototype.html Cycles:180 Average:5375.65 Median:6011.27 stddev:1585.95 (26.4%) stddev-sans-first:1544.94 18:07:39 INFO - PROCESS | 17025 | Values: 352.4 354.5 355.7 358.1 359.1 5872.1 6031.0 6079.8 6081.4 6131.7 5834.7 5956.8 5984.3 5993.6 6010.7 4690.1 4690.6 4706.4 4713.4 4715.6 4527.3 4571.0 4657.7 4668.6 4676.3 4613.2 4617.8 4634.6 4646.9 4650.4 4580.1 4621.0 4664.5 4677.9 4696.8 4121.1 4126.4 4144.7 4152.1 4164.7 5599.7 5668.4 5688.1 5695.1 5703.1 5316.1 5373.8 5402.9 5407.7 5435.5 6056.8 6377.9 6389.5 6400.7 6406.5 4546.5 4574.6 4577.0 4583.7 4609.4 6618.4 6623.6 6625.8 6629.4 6637.9 4684.5 4716.6 4722.2 4724.8 4733.7 4694.4 4765.7 4778.4 4782.0 4782.5 5402.1 5409.4 5438.0 5453.8 5462.1 6397.2 6414.9 6427.0 6439.3 6451.2 1690.5 1723.8 1729.0 1729.3 1730.2 1098.8 1126.8 1127.5 1134.3 1187.1 5904.8 5925.3 5928.1 6019.0 6019.8 6535.6 6537.4 6549.9 6550.0 6583.7 5980.6 5982.8 6011.8 6017.6 6041.2 3447.4 3529.4 3530.7 3541.0 3551.3 6690.8 6706.5 6720.4 6730.6 6757.5 6771.3 6779.6 6781.8 6786.2 6791.7 6663.3 6752.8 6756.8 6773.3 6858.9 6423.8 6519.6 6545.3 6632.3 6634.6 6543.6 6567.7 6572.2 6574.4 6579.3 6813.9 6828.0 6834.0 6841.8 6913.8 4528.3 4550.6 4568.5 4742.3 4743.5 6611.8 6650.4 6657.5 6665.6 6672.7 6445.4 6449.2 6463.7 6469.3 6498.3 6281.1 6452.5 6457.8 6469.6 6475.9 6346.9 6366.5 6371.7 6379.3 6429.5 6494.5 6496.9 6499.2 6532.4 6561.8 6156.7 6327.3 6340.5 6362.7 6373.8 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - PROCESS | 17025 | [#5] yui.html Cycles:180 Average:14373.89 Median:25249.65 stddev:16334.23 (64.7%) stddev-sans-first:16348.55 18:07:39 INFO - PROCESS | 17025 | Values: 865.4 885.7 895.2 898.1 912.5 11406.4 11624.8 11755.9 11781.4 11866.3 12544.4 12604.2 12637.7 12657.7 12714.0 745.5 756.4 874.7 875.9 884.3 862.1 869.5 872.7 873.3 874.9 920.6 923.1 925.6 926.3 926.4 758.8 776.1 899.4 906.9 911.0 673.4 675.7 676.6 676.7 677.7 13186.9 13206.7 13208.9 13254.6 13289.5 13034.2 13922.9 14093.9 14135.9 14180.5 10734.6 10809.3 10940.9 11107.1 11521.1 3845.2 3909.9 3941.2 3946.6 3993.2 48042.0 48304.5 48772.5 49270.3 50022.2 11264.8 11520.9 11562.1 11716.8 11946.9 17313.5 17363.7 17386.5 17429.6 17497.7 7809.1 7834.6 7891.6 8022.4 8321.8 4438.5 4510.1 4516.9 4612.3 4735.3 3290.6 3337.7 3340.6 3344.8 3352.1 621.4 633.2 643.5 649.1 655.7 568.0 590.8 627.3 687.7 695.1 9013.7 9090.5 9447.8 9593.6 9664.6 603.5 641.1 654.9 695.2 715.6 4261.0 4269.1 4275.5 4362.3 4737.9 55118.7 58599.4 59003.0 59269.7 59413.7 51316.7 51613.2 51774.5 52240.5 52275.2 46457.5 47142.0 47233.5 47811.3 47920.8 9118.8 9279.6 9428.4 9578.3 9703.5 37073.6 37179.6 38088.2 38185.0 38294.2 45887.0 46554.0 46704.5 46774.5 53046.7 11681.8 11981.6 12086.2 12173.2 12208.2 12834.5 13074.2 13598.5 13651.2 14014.8 12268.3 12445.5 12540.6 12684.0 13021.9 12549.2 12715.9 12747.6 13004.8 13045.0 12071.2 12197.8 12256.0 12431.6 12537.7 9908.3 9995.9 10226.6 10402.1 10523.1 10373.0 10788.8 10859.2 11031.6 11056.6 18:07:39 INFO - PROCESS | 17025 | -------- Summary: end -------- 18:07:39 INFO - PROCESS | 17025 | 18:07:39 INFO - TEST-INFO | 17025: exit 0 18:07:39 INFO - TEST-OK | dromaeo_css | took 1108759ms 18:07:39 INFO - TEST-START | kraken 18:07:39 INFO - operating with platform_type : linux_ 18:07:39 INFO - Initialising browser for kraken test... 18:07:39 INFO - TEST-INFO | started process 17220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOz32oc/profile http://localhost:49000/getInfo.html) 18:07:43 INFO - PROCESS | 17220 | __metrics Screen width/height:1600/1200 18:07:43 INFO - PROCESS | 17220 | colorDepth:24 18:07:43 INFO - PROCESS | 17220 | Browser inner width/height: 1024/697 18:07:43 INFO - PROCESS | 17220 | __metrics 18:07:43 INFO - PROCESS | 17220 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:07:44 INFO - TEST-INFO | 17220: exit 0 18:07:44 INFO - Browser initialized. 18:07:44 INFO - Running cycle 1/1 for kraken test... 18:07:44 INFO - TEST-INFO | started process 17306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOz32oc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:07:56 INFO - PROCESS | 17306 | RSS: Main: 134905856 18:07:56 INFO - PROCESS | 17306 | 18:07:58 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49000/tests/kraken/driver.html?testName=audio-beat-detection) 18:07:59 INFO - PROCESS | 17306 | RSS: Main: 168505344 18:07:59 INFO - PROCESS | 17306 | 18:08:01 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49000/tests/kraken/driver.html?testName=audio-dft) 18:08:02 INFO - PROCESS | 17306 | RSS: Main: 166047744 18:08:02 INFO - PROCESS | 17306 | 18:08:05 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49000/tests/kraken/driver.html?testName=audio-fft) 18:08:05 INFO - PROCESS | 17306 | RSS: Main: 164306944 18:08:05 INFO - PROCESS | 17306 | 18:08:07 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49000/tests/kraken/driver.html?testName=audio-oscillator) 18:08:08 INFO - PROCESS | 17306 | RSS: Main: 164487168 18:08:08 INFO - PROCESS | 17306 | 18:08:10 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49000/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:08:10 INFO - PROCESS | 17306 | RSS: Main: 163942400 18:08:10 INFO - PROCESS | 17306 | 18:08:13 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49000/tests/kraken/driver.html?testName=imaging-darkroom) 18:08:14 INFO - PROCESS | 17306 | RSS: Main: 163168256 18:08:14 INFO - PROCESS | 17306 | 18:08:17 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49000/tests/kraken/driver.html?testName=imaging-desaturate) 18:08:18 INFO - PROCESS | 17306 | RSS: Main: 164077568 18:08:18 INFO - PROCESS | 17306 | 18:08:21 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49000/tests/kraken/driver.html?testName=json-parse-financial) 18:08:21 INFO - PROCESS | 17306 | RSS: Main: 163229696 18:08:21 INFO - PROCESS | 17306 | 18:08:23 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49000/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:08:23 INFO - PROCESS | 17306 | RSS: Main: 166371328 18:08:23 INFO - PROCESS | 17306 | 18:08:25 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:08:25 INFO - PROCESS | 17306 | RSS: Main: 163856384 18:08:25 INFO - PROCESS | 17306 | 18:08:27 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:08:28 INFO - PROCESS | 17306 | RSS: Main: 167043072 18:08:28 INFO - PROCESS | 17306 | 18:08:30 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:08:31 INFO - PROCESS | 17306 | RSS: Main: 173715456 18:08:31 INFO - PROCESS | 17306 | 18:08:33 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:08:34 INFO - PROCESS | 17306 | RSS: Main: 172683264 18:08:34 INFO - PROCESS | 17306 | 18:08:35 INFO - PROCESS | 17306 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49000/tests/kraken/driver.html?testName=ai-astar) 18:08:36 INFO - PROCESS | 17306 | RSS: Main: 232873984 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | __start_tp_report 18:08:36 INFO - PROCESS | 17306 | _x_x_mozilla_page_load 18:08:36 INFO - PROCESS | 17306 | _x_x_mozilla_page_load_details 18:08:36 INFO - PROCESS | 17306 | |i|pagename|runs| 18:08:36 INFO - PROCESS | 17306 | |0;ai-astar;111;114;106;110;113;115;100;111;110;110 18:08:36 INFO - PROCESS | 17306 | |1;audio-beat-detection;163;132;158;169;137;152;156;136;177;144 18:08:36 INFO - PROCESS | 17306 | |2;audio-dft;162;164;170;164;162;162;161;165;163;163 18:08:36 INFO - PROCESS | 17306 | |3;audio-fft;74;76;77;162;76;75;76;75;163;76 18:08:36 INFO - PROCESS | 17306 | |4;audio-oscillator;96;97;135;96;96;98;142;96;96;135 18:08:36 INFO - PROCESS | 17306 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;110;109;110 18:08:36 INFO - PROCESS | 17306 | |6;imaging-darkroom;147;148;149;147;147;148;147;148;147;147 18:08:36 INFO - PROCESS | 17306 | |7;imaging-desaturate;97;96;97;97;96;96;97;96;97;96 18:08:36 INFO - PROCESS | 17306 | |8;json-parse-financial;54;54;53;55;55;55;56;55;56;52 18:08:36 INFO - PROCESS | 17306 | |9;json-stringify-tinderbox;64;64;64;64;66;66;65;66;65;65 18:08:36 INFO - PROCESS | 17306 | |10;stanford-crypto-aes;79;80;80;80;80;80;81;80;81;82 18:08:36 INFO - PROCESS | 17306 | |11;stanford-crypto-ccm;121;114;124;118;116;119;124;118;124;115 18:08:36 INFO - PROCESS | 17306 | |12;stanford-crypto-pbkdf2;129;131;144;142;132;151;129;134;139;142 18:08:36 INFO - PROCESS | 17306 | |13;stanford-crypto-sha256-iterative;66;67;67;66;67;67;65;68;65;65 18:08:36 INFO - PROCESS | 17306 | __end_tp_report 18:08:36 INFO - PROCESS | 17306 | __start_cc_report 18:08:36 INFO - PROCESS | 17306 | _x_x_mozilla_cycle_collect,839 18:08:36 INFO - PROCESS | 17306 | __end_cc_report 18:08:36 INFO - PROCESS | 17306 | __startTimestamp1457057316187__endTimestamp 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | ------- Summary: start ------- 18:08:36 INFO - PROCESS | 17306 | Number of tests: 14 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:4.32 (3.9%) stddev-sans-first:4.57 18:08:36 INFO - PROCESS | 17306 | Values: 111.0 114.0 106.0 110.0 113.0 115.0 100.0 111.0 110.0 110.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:157.00 stddev:15.02 (9.6%) stddev-sans-first:15.43 18:08:36 INFO - PROCESS | 17306 | Values: 163.0 132.0 158.0 169.0 137.0 152.0 156.0 136.0 177.0 144.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.55 (1.6%) stddev-sans-first:2.64 18:08:36 INFO - PROCESS | 17306 | Values: 162.0 164.0 170.0 164.0 162.0 162.0 161.0 165.0 163.0 163.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:36.64 (48.2%) stddev-sans-first:38.21 18:08:36 INFO - PROCESS | 17306 | Values: 74.0 76.0 77.0 162.0 76.0 75.0 76.0 75.0 163.0 76.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:96.00 stddev:19.86 (20.7%) stddev-sans-first:20.53 18:08:36 INFO - PROCESS | 17306 | Values: 96.0 97.0 135.0 96.0 96.0 98.0 142.0 96.0 96.0 135.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:08:36 INFO - PROCESS | 17306 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 110.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 18:08:36 INFO - PROCESS | 17306 | Values: 147.0 148.0 149.0 147.0 147.0 148.0 147.0 148.0 147.0 147.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:08:36 INFO - PROCESS | 17306 | Values: 97.0 96.0 97.0 97.0 96.0 96.0 97.0 96.0 97.0 96.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.27 (2.3%) stddev-sans-first:1.33 18:08:36 INFO - PROCESS | 17306 | Values: 54.0 54.0 53.0 55.0 55.0 55.0 56.0 55.0 56.0 52.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 18:08:36 INFO - PROCESS | 17306 | Values: 64.0 64.0 64.0 64.0 66.0 66.0 65.0 66.0 65.0 65.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 18:08:36 INFO - PROCESS | 17306 | Values: 79.0 80.0 80.0 80.0 80.0 80.0 81.0 80.0 81.0 82.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:120.00 stddev:3.80 (3.2%) stddev-sans-first:3.98 18:08:36 INFO - PROCESS | 17306 | Values: 121.0 114.0 124.0 118.0 116.0 119.0 124.0 118.0 124.0 115.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.30 Median:140.50 stddev:7.42 (5.3%) stddev-sans-first:7.24 18:08:36 INFO - PROCESS | 17306 | Values: 129.0 131.0 144.0 142.0 132.0 151.0 129.0 134.0 139.0 142.0 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - PROCESS | 17306 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 18:08:36 INFO - PROCESS | 17306 | Values: 66.0 67.0 67.0 66.0 67.0 67.0 65.0 68.0 65.0 65.0 18:08:36 INFO - PROCESS | 17306 | -------- Summary: end -------- 18:08:36 INFO - PROCESS | 17306 | 18:08:36 INFO - TEST-INFO | 17306: exit 0 18:08:36 INFO - TEST-OK | kraken | took 57167ms 18:08:36 INFO - TEST-START | v8_7 18:08:36 INFO - operating with platform_type : linux_ 18:08:36 INFO - Initialising browser for v8_7 test... 18:08:36 INFO - TEST-INFO | started process 17561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZvTCTr/profile http://localhost:49000/getInfo.html) 18:08:40 INFO - PROCESS | 17561 | __metrics Screen width/height:1600/1200 18:08:40 INFO - PROCESS | 17561 | colorDepth:24 18:08:40 INFO - PROCESS | 17561 | Browser inner width/height: 1024/697 18:08:40 INFO - PROCESS | 17561 | __metrics 18:08:40 INFO - PROCESS | 17561 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:08:41 INFO - TEST-INFO | 17561: exit 0 18:08:41 INFO - Browser initialized. 18:08:41 INFO - Running cycle 1/1 for v8_7 test... 18:08:41 INFO - TEST-INFO | started process 17651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZvTCTr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:08:53 INFO - PROCESS | 17651 | RSS: Main: 135417856 18:08:53 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | Cycle 1(1): loaded http://localhost:49000/tests/v8_7/run.html (next: http://localhost:49000/tests/v8_7/run.html) 18:09:15 INFO - PROCESS | 17651 | RSS: Main: 422203392 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | __start_tp_report 18:09:15 INFO - PROCESS | 17651 | _x_x_mozilla_page_load 18:09:15 INFO - PROCESS | 17651 | _x_x_mozilla_page_load_details 18:09:15 INFO - PROCESS | 17651 | |i|pagename|runs| 18:09:15 INFO - PROCESS | 17651 | |0;Richards;168.0672268907563 18:09:15 INFO - PROCESS | 17651 | |1;DeltaBlue;171.17425539198905 18:09:15 INFO - PROCESS | 17651 | |2;Encrypt;283.60748723766307 18:09:15 INFO - PROCESS | 17651 | |3;Decrypt;5335.106382978724 18:09:15 INFO - PROCESS | 17651 | |4;RayTrace;949.667616334283 18:09:15 INFO - PROCESS | 17651 | |5;Earley;564.652738565782 18:09:15 INFO - PROCESS | 17651 | |6;Boyer;10870.967741935483 18:09:15 INFO - PROCESS | 17651 | |7;RegExp;42250 18:09:15 INFO - PROCESS | 17651 | |8;Splay;565.9309564233164 18:09:15 INFO - PROCESS | 17651 | |9;NavierStokes;4926.108374384236 18:09:15 INFO - PROCESS | 17651 | __end_tp_report 18:09:15 INFO - PROCESS | 17651 | __startTimestamp1457057355739__endTimestamp 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | ------- Summary: start ------- 18:09:15 INFO - PROCESS | 17651 | Number of tests: 10 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#0] Richards Cycles:1 Average:168.07 Median:168.07 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 168.1 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#1] DeltaBlue Cycles:1 Average:171.17 Median:171.17 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 171.2 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#2] Encrypt Cycles:1 Average:283.61 Median:283.61 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 283.6 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#3] Decrypt Cycles:1 Average:5335.11 Median:5335.11 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 5335.1 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#4] RayTrace Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 949.7 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#5] Earley Cycles:1 Average:564.65 Median:564.65 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 564.7 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#6] Boyer Cycles:1 Average:10870.97 Median:10870.97 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 10871.0 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#7] RegExp Cycles:1 Average:42250.00 Median:42250.00 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 42250.0 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#8] Splay Cycles:1 Average:565.93 Median:565.93 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 565.9 18:09:15 INFO - PROCESS | 17651 | 18:09:15 INFO - PROCESS | 17651 | [#9] NavierStokes Cycles:1 Average:4926.11 Median:4926.11 stddev:0.00 (0.0%) 18:09:15 INFO - PROCESS | 17651 | Values: 4926.1 18:09:15 INFO - PROCESS | 17651 | -------- Summary: end -------- 18:09:15 INFO - PROCESS | 17651 | 18:09:16 INFO - TEST-INFO | 17651: exit 0 18:09:16 INFO - TEST-OK | v8_7 | took 39587ms 18:09:16 INFO - SUITE-END | took 1205s 18:09:16 INFO - Completed test suite (00:20:05) 18:09:16 INFO - Working with test: dromaeo_css 18:09:16 INFO - Generating results file: dromaeo_css 18:09:16 INFO - Working with test: kraken 18:09:16 INFO - Generating results file: kraken 18:09:16 INFO - javascript benchmark 18:09:16 INFO - Working with test: v8_7 18:09:16 INFO - Generating results file: v8_7 18:09:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:09:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,35]] 18:09:16 INFO - process_Request line: dromaeo_css 7209.19 graph.html#tests=[[72,181,35]] 18:09:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:09:16 INFO - process_Request line: kraken 1504.10 graph.html#tests=[[232,181,35]] 18:09:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:09:16 INFO - process_Request line: v8_7 21508.07 graph.html#tests=[[230,181,35]] 18:09:16 INFO - RETURN: dromaeo_css: 7209.19 18:09:16 INFO - RETURN: kraken: 1504.10 18:09:16 INFO - RETURN: v8_7: 21508.07 18:09:16 INFO - javascript benchmark 18:09:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3241.0924941016515, 3260.0871755908356, 3283.1792051987004, 3292.407366673999, 3313.7514686398517, 5269.841904742864, 5276.894462110756, 5277.472252774725, 5282.022825777229, 5330.3603567571845, 5313.415524292324, 5319.893602127955, 5329.200619907016, 5358.624896257264, 5363.302770639821, 4806.447258565275, 4876.829310974116, 4896.363472748538, 4928.507149285061, 4970.87572810679, 4866.562009419152, 4971.726555039471, 4974.726390048546, 4976.4525902150735, 4978.576820970222, 4894.0, 4895.804167833282, 4964.280179373988, 4972.577330926875, 4980.0288943656005, 4881.755912204411, 4887.877803054935, 4914.508549145093, 4915.975420122876, 4993.226049962262, 4789.0, 4829.058333624945, 4844.0, 4861.564532608988, 4874.8537543873745, 5081.136206844845, 5087.669301495428, 5119.0, 5133.30700355451, 5205.895882082337, 5645.463680950304, 5694.4590263924865, 5695.743691533891, 5698.974184646762, 5709.800156994527, 5694.544436445074, 5717.028105222081, 5724.4561766632105, 5737.368889422202, 5741.712914354265, 5230.372355317349, 5265.447128051576, 5269.736513174326, 5351.17056856184, 5455.481729235717, 5755.309362876482, 5758.107493338539, 5812.215350927655, 5821.359650438449, 5831.9708401458565, 5597.048501754712, 5605.439456054362, 5641.069223578063, 5643.717814109278, 5647.632903861236, 5706.543476521952, 5776.277965254343, 5819.79630712923, 5849.976254155506, 5892.94107058924, 5651.547876169897, 5724.599278050497, 5732.77068917247, 5736.885262294731, 5758.596898217168, 5479.397266300703, 5708.828735137952, 5713.771449142071, 5736.913946290809, 5741.88516229673, 4249.68127390447, 4299.398084268205, 4311.48262208537, 4315.3742707307265, 4330.653547716175, 3938.6455219030427, 3946.565877753445, 3968.8809335719975, 3974.6422821945584, 3984.7011474139554, 5268.367795864444, 5343.385510666323, 5349.866253343697, 5362.463753624685, 5366.6243362964215, 5719.771209151588, 5738.942610573924, 5740.712964351766, 5748.913766293509, 5751.942480575224, 5185.844424667266, 5234.842954711365, 5254.973725131426, 5274.868128296824, 5339.813106541253, 4894.216925291937, 4922.630802689741, 4943.01139772047, 4943.332650092191, 4970.925436118461, 5711.057675483498, 5801.883962320814, 5803.593748437569, 5815.854603634943, 5871.706414679249, 5717.485426311652, 5744.540436764965, 5759.481646651821, 5818.73815678304, 5844.47399734026, 5846.35690074083, 5883.852903677443, 5891.440313170242, 5892.6759028253855, 5915.526757859447, 5562.860928476821, 5643.492085712305, 5692.886142277214, 5706.144078388275, 5722.141678748221, 5657.264555607745, 5710.8001219957105, 5722.942770572241, 5756.65460072397, 5760.135979603093, 5455.727213639223, 5541.972290138524, 5546.473085056913, 5572.944270557243, 5573.247611572386, 5417.593680474059, 5556.444355564573, 5557.499825015768, 5564.721763911869, 5580.218769372373, 5473.17902314656, 5474.890502190014, 5480.479354461319, 5497.5601951842955, 5541.750621222135, 5580.637258578179, 5601.439856014366, 5614.29821272341, 5620.578456615852, 5631.746571404378, 5376.462353764592, 5381.75782089799, 5412.83761487156, 5430.484104010113, 5484.204790305464], "unit": "score", "name": "dojo.html", "value": 5264.6154720523455}, {"lowerIsBetter": false, "replicates": [495.3263561556285, 518.3106468397032, 520.4847201270743, 544.9945500544994, 591.4381337729159, 29624.703752962465, 36566.634333656686, 37080.25839483209, 37083.258334833285, 37335.0, 39350.40974385387, 39885.20229595406, 39930.40104398429, 40027.39958900611, 40264.79867600665, 8642.43824151428, 8854.513001784931, 8889.73330800077, 8906.86639700405, 8913.465192088463, 8562.357823163256, 8831.0, 8834.64661413546, 8873.0, 8887.644494220223, 8749.650013999433, 8837.867431988525, 8869.423487473294, 8874.733757987238, 8878.778030549223, 8770.342224333168, 8842.646294148226, 8847.07105753893, 8849.247813935823, 8871.891013623297, 8650.956745216297, 8791.692290769857, 8801.119888011148, 8832.425892317044, 8832.514211718353, 42583.57416425858, 43114.56885431137, 43149.0, 43298.78350608258, 43301.78349108266, 3610.8194590270646, 3618.3125206210734, 3648.0515066082744, 3684.2631473705096, 4062.837486500536, 28036.0, 28349.14952551406, 28440.71559284422, 28520.857395713098, 29194.70805291941, 3897.4543563901075, 3948.9802550987347, 4028.295048366524, 4153.1486045360625, 4216.978915105436, 232382.0, 232623.0, 233066.0, 233704.0, 311065.0, 45916.311255331195, 64233.0, 65390.67304663541, 65718.37126514982, 65916.34083659197, 56782.0, 57525.42474575285, 57543.410546525505, 57572.0, 57732.71133644305, 15901.840981590267, 16049.438269660506, 16074.0, 16127.354905803872, 16175.433859815086, 12072.396380181131, 12171.573994910135, 12194.878051219373, 12259.448324825404, 12626.55807046749, 20521.89739051325, 20809.791902081088, 20833.791662083488, 20863.37409877706, 20909.163633454795, 8298.21166989135, 8504.0, 8533.189347012023, 8536.231739143383, 8570.571471426403, 937.5218638494417, 978.7699890525721, 1121.971950701239, 1133.790248803974, 1143.7540928700369, 27714.168574942785, 28027.579586306223, 28513.572296415572, 28533.714662853105, 29015.709842901302, 1177.9646610601696, 1183.4319526627266, 1220.6765207220094, 1225.8038713805747, 1245.4768997021272, 14060.578182654537, 14991.400343986337, 16090.678186436206, 16377.754333685005, 16563.254653540618, 324722.0, 326138.0, 326169.0, 326367.0, 327439.0, 50645.24032139447, 51271.230931536054, 51280.48719512757, 51334.48665513372, 51652.74173629108, 1310.8754668306497, 1348.480834878579, 1445.4001589340517, 1452.7457694903349, 1454.4255019267541, 26720.465590687687, 28269.57595636108, 28896.855515723128, 30666.233344166576, 30897.691023089483, 52811.73594132005, 53311.200331994274, 53705.73147134239, 53709.46290537201, 53756.46243537514, 311703.0, 313511.0, 320440.0, 320930.0, 321634.0, 43203.0, 44032.0, 44345.55654443414, 44507.33239001353, 44873.0, 47195.0, 47772.522274778195, 48604.27093593528, 48744.2688359682, 48763.756181218865, 39132.80433597814, 39787.40318895277, 39845.60154398419, 40024.1995160101, 40649.59350406458, 40792.79603601963, 40795.38806917958, 40874.59125408708, 41080.38379424371, 41369.79315103526, 38520.80739596284, 39044.0, 39145.0, 40538.0, 40589.0, 30332.241693956945, 31720.682793171774, 34049.0, 35050.29899401947, 35158.12104697403, 25991.74008259893, 26281.73718262793, 26589.335266617716, 26600.8669956649, 26670.333241668337], "unit": "score", "name": "ext.html", "value": 19279.253978563665}, {"lowerIsBetter": false, "replicates": [374.118949873049, 379.61279494915186, 380.68022860796924, 384.12994567305077, 386.62304253352966, 14577.125372477632, 15892.761608575865, 17110.486685399428, 18025.918444893297, 18041.368552100663, 17216.82783172168, 17872.0, 17891.19489622967, 17971.460856174337, 18242.27030918765, 5516.420775818541, 5673.149027645865, 5691.886162276752, 5707.286589176353, 5722.027255366597, 4296.334068219431, 4473.0, 5636.2954630671165, 6039.939600604003, 6328.841778955517, 5951.6726580038085, 6150.292716337612, 6230.501559875199, 6279.623222606659, 6307.842303942392, 6135.846603834895, 6151.077338399254, 6164.568480206387, 6197.25632924052, 6200.78297259596, 5101.7194054327, 5322.121849894801, 5334.91997620036, 5336.092864213093, 5337.70642614656, 18744.343947961755, 18932.337368192046, 19365.4190374289, 19410.0, 20321.593568128555, 2224.8887555622314, 2265.0600000999566, 2267.6711876777777, 2301.608726516496, 2451.982427292671, 9770.218382529381, 13425.462981480729, 13730.51943181984, 14400.71198576033, 14669.186397411635, 1922.6731455652432, 1954.7556555430572, 1989.8607097503182, 2008.8794672319707, 2094.2356040045274, 66432.0, 67513.0, 68047.65976170138, 68641.313586864, 69379.95930061053, 15495.690086198212, 15979.680406391806, 16010.439634612965, 16020.679586408207, 16037.075550933963, 25233.0, 25234.621480677804, 25276.747232527807, 25551.488970220864, 25603.0, 7492.812679683051, 7754.7673569793, 7790.688372465038, 7811.45319827618, 7826.060872695313, 7400.222976587488, 7418.740344087931, 7483.925160748432, 7504.662290196954, 7507.849843003219, 4508.909821803545, 4638.768061596974, 4712.59942904857, 4747.501512341223, 4751.6695325308965, 1845.1973391574709, 1915.1286164794985, 1938.5638231397822, 1978.4460351101714, 1989.1844343818964, 918.481058202127, 969.3360048366891, 999.6501224571342, 1048.0410424461684, 1048.2557384257263, 13622.591322260349, 15683.843161568238, 16140.435084771976, 16281.837181628032, 16644.916775416044, 984.2667212926416, 989.3569180033036, 1033.2199189611795, 1044.9216308776872, 1093.9935259561223, 9139.680111196076, 9276.814463710689, 9284.210842078364, 9338.159565639126, 9501.952490237505, 592589.0, 615495.0, 615984.0, 630589.0, 632391.0, 74291.0, 74458.0, 74702.0, 76025.0, 77210.61394693103, 1209.087139209891, 1216.975660486803, 1218.7806194885006, 1247.2080229054616, 1250.7435975624976, 14532.491362802251, 14925.328360224034, 14979.475718349806, 14987.0, 15144.697106057596, 32589.674103258665, 32611.34777304488, 32954.0, 33836.154096147795, 34268.82865585656, 41009.0, 41292.38061429141, 41744.3738343919, 42172.367414488195, 42399.3640095405, 7485.588292643957, 7532.0, 7675.0, 7743.612819359122, 7760.262775036363, 10490.632827850988, 10611.0, 11145.665630031112, 11202.21584489078, 11801.0, 9691.176250018827, 9711.951440242754, 9938.30431869791, 10194.0, 10275.588976440858, 7634.312911837961, 9888.851667224853, 9957.20342372594, 10014.198864091, 10109.39343639384, 9975.301728878909, 10354.430506322225, 10415.0, 10528.210384221062, 10787.352758834495, 7113.822154445973, 7463.626818658937, 7908.683652653829, 7947.205279472238, 7962.442629016145, 9072.455652660861, 9314.161725444743, 9355.4386736796, 9358.625654973725, 9386.202172815114], "unit": "score", "name": "jquery.html", "value": 8851.32298810318}, {"lowerIsBetter": false, "replicates": [1536.3624096000158, 1553.883458740594, 1705.0962989615507, 1848.51938495991, 1885.5663197464573, 8372.911521502203, 8584.48493090415, 8613.87079193811, 8629.784255393619, 8642.178992995656, 8369.288610468118, 8458.111898250687, 8479.236868681817, 8515.701950431721, 8517.574121293941, 2451.3258853815255, 2455.6684847545575, 2474.9628755568683, 2481.838680485763, 2488.701355837293, 2433.756624337561, 2493.2021753039035, 2501.8373805702663, 2511.836730612504, 2516.5721827289312, 2112.5669237806214, 2178.3900507857747, 2385.8329916905823, 2466.149178533412, 2466.9515455931246, 2380.0598763488497, 2393.916212932539, 2395.173665085543, 2398.712154541449, 2406.5427568761966, 2322.465832858452, 2374.014783864694, 2389.462370966536, 2392.7009123859516, 2399.8920048597856, 7349.412047036224, 7579.1662917079075, 7975.003124609424, 8138.674453021872, 8175.468594541336, 4888.217885138396, 4988.850334489971, 4993.700377977333, 5020.472850350697, 5024.221245706921, 3273.9672603273902, 3278.1476816027766, 3288.325893191914, 3297.835108244602, 3330.850111744953, 1045.989540104597, 1994.5611965367596, 2070.6272870883236, 2100.884451355175, 2104.642210824148, 11760.647180584596, 11817.822732659017, 11830.112741544333, 11831.349275789828, 11841.0, 4354.648489815464, 4364.367166760802, 4441.867323832402, 4498.235299999008, 4515.571020753023, 9556.426614403159, 9557.713268601814, 9597.760055998657, 9602.95198524003, 9608.231341492663, 5007.674501157413, 5045.9747701261995, 5064.974675126675, 5070.960453107178, 5097.311862898536, 4438.400815889813, 4663.883402914887, 4695.600873925755, 4711.67018308722, 4720.575148236675, 3774.245150969817, 3780.4896338993885, 3781.621837816251, 3827.0623697194364, 3827.3302172119766, 1150.0741902768184, 1154.3247200387866, 1163.4648061891626, 1165.5862168930078, 1177.2995067934564, 1053.9789204215872, 1135.6990397544657, 1202.9578964736193, 1364.3382959264748, 1399.9370028348544, 7990.20097990208, 8010.479318844256, 8073.152319006537, 8309.542975136304, 8349.081601023883, 546.9589780766379, 557.4648337595872, 560.1038338658115, 560.5543592843699, 569.2883895131087, 5902.2032025676845, 5968.731407086691, 6349.809505714836, 6352.2694890087305, 6391.3289104643345, 10162.339447935861, 10520.316179448311, 10603.787924241473, 10647.0, 10684.94657526723, 10144.239182061376, 10276.332038417479, 10479.738006549896, 10485.05634492884, 10490.632827850988, 7939.483933544301, 8135.3898457615915, 8148.429609927367, 8151.551664658501, 8178.223068808454, 8062.1874516036205, 8192.139825318494, 8245.340372770284, 8250.958745206235, 8259.545724985184, 9211.124943130391, 9226.769330766785, 9283.814323713623, 9438.150566449052, 9499.572519236513, 9393.201577865684, 9586.376885502421, 9832.9016709832, 9836.163926066365, 9840.3603765755, 7212.603306818175, 7213.0, 7413.851722965403, 7469.77590672259, 7480.962595186989, 8045.436819422584, 8065.475744076616, 8077.83844323122, 8090.797730056795, 8120.837583248183, 7186.425085993213, 7429.962850185714, 7467.178610352966, 7512.436567257369, 7606.543607383574, 7170.892436613351, 7297.562146271241, 7358.558486490828, 7437.293457121565, 7457.366123879531, 7688.615569221628, 7708.576028318496, 7720.8455830884195, 7722.884156737541, 7781.144074151725, 6917.0, 6921.1002569665625, 6946.0622815919205, 6948.965255173692, 7012.298770122947, 7290.453216008927, 7295.2340004298785, 7354.595497247703, 7356.264373562601, 7381.741639042608], "unit": "score", "name": "mootools.html", "value": 4812.768600548086}, {"lowerIsBetter": false, "replicates": [352.40971372950304, 354.52316634127106, 355.73675480144703, 358.0654491776465, 359.0646366216007, 5872.148538461921, 6030.969845150774, 6079.8176054718315, 6081.361457047007, 6131.7240724167405, 5834.737436815343, 5956.8212953611355, 5984.3417224105315, 5993.610415323001, 6010.699465026753, 4690.132325519773, 4690.648201384893, 4706.364640773486, 4713.363695901053, 4715.622750179978, 4527.298268768346, 4571.017231295271, 4657.650676199281, 4668.626509879218, 4676.251799712047, 4613.1696294666945, 4617.769111544426, 4634.629229661636, 4646.930296045562, 4650.4186976627925, 4580.129775342674, 4621.0, 4664.486906440289, 4677.929831052537, 4696.765161741933, 4121.072758629314, 4126.360414135814, 4144.668426525871, 4152.065785198336, 4164.68764842635, 5599.720013999325, 5668.43315668434, 5688.061469857468, 5695.117256825199, 5703.0589952657765, 5316.12283973144, 5373.75818088183, 5402.8919421611745, 5407.675539467645, 5435.537979271767, 6056.757729690807, 6377.904331435032, 6389.520785941027, 6400.679966001681, 6406.519511036644, 4546.454425468932, 4574.565416285448, 4576.954230457719, 4583.656225783079, 4609.354690343354, 6618.437432818217, 6623.569467984566, 6625.768098116591, 6629.403353698142, 6637.93362066378, 4684.508126646653, 4716.551927566876, 4722.173619616553, 4724.834630787906, 4733.739644319527, 4694.36626055485, 4765.666403351802, 4778.378810754649, 4781.976090119597, 4782.545658162469, 5402.081646120169, 5409.404965453797, 5438.021156191844, 5453.781848726086, 5462.126059830408, 6397.200349956255, 6414.935850641527, 6427.0, 6439.259485159173, 6451.161349024596, 1690.4928521443517, 1723.8448539631493, 1728.9885417031178, 1729.3342063305465, 1730.195459111519, 1098.7637657903429, 1126.7577470843808, 1127.4588197665166, 1134.3307448605362, 1187.1274613159321, 5904.819036192693, 5925.288965324103, 5928.051511758098, 6018.969905150446, 6019.759209631566, 6535.57518761279, 6537.378948999837, 6549.934500654933, 6550.0, 6583.736650534021, 5980.611260268069, 5982.790602328898, 6011.849703757353, 6017.608855424471, 6041.214642096499, 3447.413939630269, 3529.36471435139, 3530.717542596586, 3540.964590354115, 3551.2897420516, 6690.832729181712, 6706.463482921452, 6720.395164435225, 6730.629815360202, 6757.526973111835, 6771.255161932184, 6779.559328643622, 6781.796546103526, 6786.185657721105, 6791.660416979132, 6663.333666633298, 6752.83117922046, 6756.763513277012, 6773.254941956381, 6858.862822743617, 6423.775167869289, 6519.608823470607, 6545.280019197789, 6632.303608121078, 6634.635095069624, 6543.640099794557, 6567.671616419065, 6572.244191917991, 6574.3754343337305, 6579.276279609335, 6813.931860681329, 6828.0440738297675, 6834.0, 6841.794746157623, 6913.75801846933, 4528.343390208467, 4550.567696068868, 4568.543145685538, 4742.264948932921, 4743.525647435229, 6611.801645950629, 6650.434713049445, 6657.500687448364, 6665.600063996176, 6672.733090676513, 6445.355464453517, 6449.161608990801, 6463.709133088928, 6469.347567497303, 6498.317676643885, 6281.089242059968, 6452.483801295791, 6457.838554036187, 6469.644169570719, 6475.935240647534, 6346.873062538631, 6366.4588509977175, 6371.681415929278, 6379.266384365857, 6429.54993150475, 6494.512911531559, 6496.9025464617125, 6499.155109835691, 6532.41208291256, 6561.80314590563, 6156.661383623765, 6327.335629758809, 6340.461060809883, 6362.745490180341, 6373.840653983502], "unit": "score", "name": "prototype.html", "value": 4869.487469459867}, {"lowerIsBetter": false, "replicates": [865.4158443050939, 885.720997885666, 895.2435192262536, 898.142274128208, 912.5026860361103, 11406.372649504274, 11624.825627615583, 11755.941220293897, 11781.352025638587, 11866.347350895698, 12544.43550040248, 12604.180728252657, 12637.747245055116, 12657.746845063093, 12714.046446516502, 745.5414919824324, 756.4440136499668, 874.715717391847, 875.8554838451648, 884.3234925282164, 862.0517430826104, 869.4739682492065, 872.6814712629877, 873.3144481581959, 874.9300055995537, 920.6317473010815, 923.1184219070772, 925.5834874306555, 926.2589928057561, 926.4487629860222, 758.7761610324967, 776.0725932510652, 899.4108858697531, 906.8775715278418, 911.0070023674227, 673.4477728262826, 675.7432175773224, 676.627854679929, 676.6785776756002, 677.6679427080744, 13186.934065329708, 13206.669833254246, 13208.933955330258, 13254.602361929157, 13289.534866279633, 13034.217946923214, 13922.860771392257, 14093.929530352385, 14135.858641413557, 14180.50368237117, 10734.624288149877, 10809.297395669257, 10940.890591094067, 11107.111431085494, 11521.135914806424, 3845.2309538092495, 3909.902252443683, 3941.1723538057045, 3946.605339466059, 3993.201359728066, 48042.0, 48304.5169548307, 48772.51227487751, 49270.26094608584, 50022.24966625503, 11264.831027534594, 11520.94239528797, 11562.132840037031, 11716.824247636292, 11946.940265298792, 17313.480595582154, 17363.65272694539, 17386.47840564785, 17429.564260893327, 17497.650046998988, 7809.1409944907155, 7834.647440865175, 7891.6054197289905, 8022.358211343078, 8321.83356332882, 4438.511763705989, 4510.075434535912, 4516.932246016312, 4612.30815377696, 4735.337052812609, 3290.6051273847293, 3337.6829201225846, 3340.565726455594, 3344.816035118043, 3352.1284466039006, 621.4220774679501, 633.1673848888696, 643.5366536094004, 649.0945131541473, 655.6983787457823, 567.9517241034558, 590.754836742747, 627.2947542104552, 687.6664817563478, 695.1429624244352, 9013.729588112366, 9090.500022498825, 9447.76380590477, 9593.568289426992, 9664.613415463302, 603.4840211619003, 641.0640464921267, 654.9443297319685, 695.1553862057624, 715.5670819154441, 4261.0, 4269.103488267437, 4275.5296917339065, 4362.30203167498, 4737.881552961204, 55118.72440637771, 58599.41400586025, 59003.0, 59269.70365148147, 59413.702931485066, 51316.74341628268, 51613.22580161301, 51774.48225517772, 52240.47759522356, 52275.21587176195, 46457.535424646, 47142.0, 47233.5276647236, 47811.28283075757, 47920.760396197795, 9118.817623647357, 9279.6288148476, 9428.387154834914, 9578.281628878001, 9703.5148242589, 37073.629263707015, 37179.62820371761, 38088.238235235694, 38185.0, 38294.234115316984, 45887.0, 46554.0, 46704.532954670016, 46774.53225467702, 53046.73476632592, 11681.766364672489, 11981.580644677395, 12086.153969222421, 12173.20874143178, 12208.206466579644, 12834.486620535074, 13074.215547067206, 13598.456061757419, 13651.249181295125, 14014.78977815354, 12268.263904165779, 12445.502179912703, 12540.561080362144, 12684.048696347627, 13021.869781302066, 12549.184303020274, 12715.93642031784, 12747.553835615709, 13004.804927926278, 13045.0, 12071.155019148575, 12197.75604487923, 12256.0, 12431.62705118848, 12537.686557836127, 9908.306418550632, 9995.900040999497, 10226.59093636276, 10402.115820155372, 10523.105536029523, 10372.954547726544, 10788.784224315314, 10859.185561083108, 11031.558737650405, 11056.557737690724], "unit": "score", "name": "yui.html", "value": 6667.090815702696}], "name": "dromaeo_css", "value": 7209.184559387238}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 106.0, 110.0, 113.0, 115.0, 100.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [163.0, 132.0, 158.0, 169.0, 137.0, 152.0, 156.0, 136.0, 177.0, 144.0], "unit": "score", "name": "audio-beat-detection", "value": 152.4}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 170.0, 164.0, 162.0, 162.0, 161.0, 165.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 77.0, 162.0, 76.0, 75.0, 76.0, 75.0, 163.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 135.0, 96.0, 96.0, 98.0, 142.0, 96.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 149.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 53.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 80.0, 80.0, 80.0, 80.0, 81.0, 80.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [121.0, 114.0, 124.0, 118.0, 116.0, 119.0, 124.0, 118.0, 124.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [129.0, 131.0, 144.0, 142.0, 132.0, 151.0, 129.0, 134.0, 139.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 65.0, 68.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1504.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.0672268907563], "unit": "score", "name": "Richards", "value": 210.04689999999997}, {"lowerIsBetter": false, "replicates": [171.17425539198905], "unit": "score", "name": "DeltaBlue", "value": 386.2613559999999}, {"lowerIsBetter": false, "replicates": [283.60748723766307], "unit": "score", "name": "Encrypt", "value": 938.5542060000004}, {"lowerIsBetter": false, "replicates": [5335.106382978724], "unit": "score", "name": "Decrypt", "value": 49.892350947158555}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "RayTrace", "value": 779.2084170000002}, {"lowerIsBetter": false, "replicates": [564.652738565782], "unit": "score", "name": "Earley", "value": 1180.3059730000004}, {"lowerIsBetter": false, "replicates": [10870.967741935483], "unit": "score", "name": "Boyer", "value": 61.30668545994071}, {"lowerIsBetter": false, "replicates": [42250.0], "unit": "score", "name": "RegExp", "value": 21.561775147929005}, {"lowerIsBetter": false, "replicates": [565.9309564233164], "unit": "score", "name": "Splay", "value": 143.99459700000003}, {"lowerIsBetter": false, "replicates": [4926.108374384236], "unit": "score", "name": "NavierStokes", "value": 301.25200000000024}], "name": "v8_7", "value": 21508.06831608553}]} 18:09:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,35]]", "result": "21508.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,35]]", "result": "1504.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,35]]", "result": "7209.19"}}} 18:09:17 INFO - Return code: 0 18:09:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:09:17 INFO - # TBPL SUCCESS # 18:09:17 INFO - Running post-action listener: _resource_record_post_action 18:09:17 INFO - Running post-run listener: _resource_record_post_run 18:09:18 INFO - Total resource usage - Wall time: 1220s; CPU: 25.0%; Read bytes: 0; Write bytes: 479924224; Read time: 0; Write time: 625200 18:09:18 INFO - install - Wall time: 13s; CPU: 28.0%; Read bytes: 0; Write bytes: 221597696; Read time: 0; Write time: 406304 18:09:18 INFO - run-tests - Wall time: 1207s; CPU: 25.0%; Read bytes: 0; Write bytes: 228286464; Read time: 0; Write time: 195884 18:09:18 INFO - Running post-run listener: _upload_blobber_files 18:09:18 INFO - Blob upload gear active. 18:09:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:09:18 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 18:09:18 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'] 18:09:18 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 18:09:18 INFO - (blobuploader) - INFO - Open directory for files ... 18:09:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:09:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:09:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:19 INFO - (blobuploader) - INFO - Done attempting. 18:09:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:09:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:09:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:20 INFO - (blobuploader) - INFO - Done attempting. 18:09:20 INFO - (blobuploader) - INFO - Iteration through files over. 18:09:20 INFO - Return code: 0 18:09:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:09:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:09:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/3945b073b9f708068673ff759781d06037f5a516a5e30a5bc6ac6aa8603882b0292b8f8a2ee452715bf495361aa11a8d7859334f6ff9b62b9f79e7c07101d93e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/31b0cd590e32efb04b58bbe50fa34516c2c296c62d6b63c0690ff4a482d041517d2baab4bd2f93e8eee917aa2add062e35d1b199cf2054ebf998d1d52d8692d3"} 18:09:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:09:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:09:20 INFO - Contents: 18:09:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/3945b073b9f708068673ff759781d06037f5a516a5e30a5bc6ac6aa8603882b0292b8f8a2ee452715bf495361aa11a8d7859334f6ff9b62b9f79e7c07101d93e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/31b0cd590e32efb04b58bbe50fa34516c2c296c62d6b63c0690ff4a482d041517d2baab4bd2f93e8eee917aa2add062e35d1b199cf2054ebf998d1d52d8692d3"} 18:09:20 INFO - Running post-run listener: copy_logs_to_upload_dir 18:09:20 INFO - Copying logs to upload dir... 18:09:20 INFO - mkdir: /builds/slave/test/build/upload/logs 18:09:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.611769 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-03 18:09:19.982843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 18:09:19.986138) ========= 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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 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/3945b073b9f708068673ff759781d06037f5a516a5e30a5bc6ac6aa8603882b0292b8f8a2ee452715bf495361aa11a8d7859334f6ff9b62b9f79e7c07101d93e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/31b0cd590e32efb04b58bbe50fa34516c2c296c62d6b63c0690ff4a482d041517d2baab4bd2f93e8eee917aa2add062e35d1b199cf2054ebf998d1d52d8692d3"} build_url:https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005347 build_url: 'https://queue.taskcluster.net/v1/task/EO9P1BkeQxGBIqZRFBxyhg/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/3945b073b9f708068673ff759781d06037f5a516a5e30a5bc6ac6aa8603882b0292b8f8a2ee452715bf495361aa11a8d7859334f6ff9b62b9f79e7c07101d93e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/31b0cd590e32efb04b58bbe50fa34516c2c296c62d6b63c0690ff4a482d041517d2baab4bd2f93e8eee917aa2add062e35d1b199cf2054ebf998d1d52d8692d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 18:09:20.000518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 18:09:20.000877) ========= 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=745a4373a2a16df560f216e000000264-1457055079.250885-532101098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002190 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 18:09:20.083513) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 18:09:20.083888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 18:09:20.084241) ========= ========= Total master_lag: 0.27 =========