builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1456988058.47 results: success (0) buildid: 20160302200635 builduid: 6efb071dd86f47a1bdca869686093b38 revision: 07e13e514846833c01f65812d04b9c6a2f4b9f84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.470734) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.471164) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.471489) ========= 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=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005269 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.494234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.494537) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.509117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.509723) ========= 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=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004700 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.563643) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.563946) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.564313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.564680) ========= 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=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 22:54: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 267K=0.04s 2016-03-02 22:54:18 (267 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151307 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.736736) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.737053) ========= 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=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.786322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:18.786685) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 07e13e514846833c01f65812d04b9c6a2f4b9f84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 07e13e514846833c01f65812d04b9c6a2f4b9f84 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 22:54:18,858 truncating revision to first 12 chars 2016-03-02 22:54:18,858 Setting DEBUG logging. 2016-03-02 22:54:18,858 attempt 1/10 2016-03-02 22:54:18,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/07e13e514846?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 22:54:19,105 unpacking tar archive at: date-07e13e514846/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:19.355852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:19.356222) ========= echo 07e13e514846833c01f65812d04b9c6a2f4b9f84 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'07e13e514846833c01f65812d04b9c6a2f4b9f84'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07e13e514846833c01f65812d04b9c6a2f4b9f84 program finished with exit code 0 elapsedTime=0.004693 script_repo_revision: '07e13e514846833c01f65812d04b9c6a2f4b9f84' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:19.414908) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:19.415689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 22:54:19.436454) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-02 22:54:19.436780) ========= /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=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:54:19 INFO - MultiFileLogger online at 20160302 22:54:19 in /builds/slave/test 22:54: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 22:54:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:54:19 INFO - {'append_to_log': False, 22:54:19 INFO - 'base_work_dir': '/builds/slave/test', 22:54:19 INFO - 'blob_upload_branch': 'Date-Non-PGO', 22:54:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:54:19 INFO - 'branch': 'Date-Non-PGO', 22:54:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:54:19 INFO - 'config_files': ('talos/linux_config.py',), 22:54:19 INFO - 'default_actions': ('clobber', 22:54:19 INFO - 'read-buildbot-config', 22:54:19 INFO - 'download-and-extract', 22:54:19 INFO - 'populate-webroot', 22:54:19 INFO - 'create-virtualenv', 22:54:19 INFO - 'install', 22:54:19 INFO - 'run-tests'), 22:54:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:54:19 INFO - 'download_minidump_stackwalk': True, 22:54:19 INFO - 'download_symbols': 'ondemand', 22:54:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:54:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:54:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:54:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:54:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:54:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:54:19 INFO - 'installer_path': 'installer.exe', 22:54:19 INFO - 'log_level': 'info', 22:54:19 INFO - 'log_name': 'talos', 22:54:19 INFO - 'log_to_console': True, 22:54:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:54:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:54:19 INFO - 'opt_config_files': (), 22:54:19 INFO - 'pip_index': False, 22:54:19 INFO - 'sps_profile': False, 22:54:19 INFO - 'sps_profile_interval': 0, 22:54:19 INFO - 'suite': 'dromaeojs', 22:54:19 INFO - 'system_bits': '32', 22:54:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:54:19 INFO - 'title': 'talos-linux64-ix-003', 22:54:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:54:19 INFO - 'use_talos_json': True, 22:54:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:54:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:54:19 INFO - 'work_dir': 'build'} 22:54:19 INFO - ##### 22:54:19 INFO - ##### Running clobber step. 22:54:19 INFO - ##### 22:54:19 INFO - Running pre-action listener: _resource_record_pre_action 22:54:19 INFO - Running main action method: clobber 22:54:19 INFO - rmtree: /builds/slave/test/build 22:54:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:54:20 INFO - Running post-action listener: _resource_record_post_action 22:54:20 INFO - ##### 22:54:20 INFO - ##### Running read-buildbot-config step. 22:54:20 INFO - ##### 22:54:20 INFO - Running pre-action listener: _resource_record_pre_action 22:54:20 INFO - Running main action method: read_buildbot_config 22:54:20 INFO - Using buildbot properties: 22:54:20 INFO - { 22:54:20 INFO - "project": "", 22:54:20 INFO - "product": "firefox", 22:54:20 INFO - "script_repo_revision": "production", 22:54:20 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 22:54:20 INFO - "repository": "", 22:54:20 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 22:54:20 INFO - "buildid": "20160302200635", 22:54:20 INFO - "pgo_build": "False", 22:54:20 INFO - "basedir": "/builds/slave/test", 22:54:20 INFO - "buildnumber": 2, 22:54:20 INFO - "slavename": "talos-linux64-ix-003", 22:54:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:54:20 INFO - "platform": "ubuntu64_hw", 22:54:20 INFO - "scheduler": "tests-date-linux64-talos", 22:54:20 INFO - "branch": "date", 22:54:20 INFO - "repo_path": "projects/date", 22:54:20 INFO - "revision": "07e13e514846833c01f65812d04b9c6a2f4b9f84", 22:54:20 INFO - "stage_platform": "linux64", 22:54:20 INFO - "builduid": "6efb071dd86f47a1bdca869686093b38", 22:54:20 INFO - "slavebuilddir": "test" 22:54:20 INFO - } 22:54:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 22:54:20 INFO - Running post-action listener: _resource_record_post_action 22:54:20 INFO - ##### 22:54:20 INFO - ##### Running download-and-extract step. 22:54:20 INFO - ##### 22:54:20 INFO - Running pre-action listener: _resource_record_pre_action 22:54:20 INFO - Running main action method: download_and_extract 22:54:20 INFO - mkdir: /builds/slave/test/build/tests 22:54: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')]} 22:54:20 INFO - https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/test_packages.json 22:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/test_packages.json 22:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:54:22 INFO - Downloaded 1412 bytes. 22:54:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:54:22 INFO - Using the following test package requirements: 22:54:22 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 22:54:22 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 22:54:22 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:54:22 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 22:54:22 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 22:54:22 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 22:54:22 INFO - u'jsshell-linux-x86_64.zip'], 22:54:22 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 22:54:22 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:54:22 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 22:54:22 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 22:54:22 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 22:54:22 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 22:54:22 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 22:54:22 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 22:54:22 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:54:22 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 22:54:22 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 22:54:22 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:54:22 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:22 INFO - https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 22:54:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 22:54:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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 22:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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 22:54:23 INFO - Downloaded 23091861 bytes. 22:54: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'] 22:54: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 22:54:24 INFO - Return code: 0 22:54: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 22:54: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')]} 22:54:24 INFO - https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 22:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 22:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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 22:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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 22:54:26 INFO - Downloaded 23091861 bytes. 22:54:26 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'] 22:54:26 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 22:54:27 INFO - Return code: 0 22:54:27 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')]} 22:54:27 INFO - https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 22:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 22:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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 22:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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 22:54:28 INFO - Downloaded 10706668 bytes. 22:54:28 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'] 22:54:28 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 22:54:28 INFO - Return code: 0 22:54:28 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')]} 22:54:28 INFO - https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 22:54:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 22:54:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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 22:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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 22:54:29 INFO - Downloaded 52851001 bytes. 22:54:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 22:54:29 INFO - mkdir: /builds/slave/test/properties 22:54:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:54:29 INFO - Writing to file /builds/slave/test/properties/build_url 22:54:29 INFO - Contents: 22:54:29 INFO - build_url:https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 22:54:30 INFO - Running post-action listener: _resource_record_post_action 22:54:30 INFO - Running post-action listener: set_extra_try_arguments 22:54:30 INFO - ##### 22:54:30 INFO - ##### Running populate-webroot step. 22:54:30 INFO - ##### 22:54:30 INFO - Running pre-action listener: _resource_record_pre_action 22:54:30 INFO - Running main action method: populate_webroot 22:54:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:30 INFO - '--tppagecycles', 22:54:30 INFO - '7'], 22:54:30 INFO - 'tests': ['tsvgm']}}, 22:54:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:54:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:54:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:54:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:30 INFO - 'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:30 INFO - 'tests': ['damp', 'tps']}, 22:54:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:30 INFO - 'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['damp', 'tps']}, 22:54:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:54:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:54:30 INFO - 'other': {'tests': ['a11yr', 22:54:30 INFO - 'ts_paint', 22:54:30 INFO - 'tpaint', 22:54:30 INFO - 'sessionrestore', 22:54:30 INFO - 'sessionrestore_no_auto_restore']}, 22:54:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['a11yr', 22:54:30 INFO - 'ts_paint', 22:54:30 INFO - 'tpaint', 22:54:30 INFO - 'sessionrestore', 22:54:30 INFO - 'sessionrestore_no_auto_restore']}, 22:54:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['a11yr', 22:54:30 INFO - 'ts_paint', 22:54:30 INFO - 'tpaint', 22:54:30 INFO - 'sessionrestore', 22:54:30 INFO - 'sessionrestore_no_auto_restore']}, 22:54:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['a11yr', 22:54:30 INFO - 'ts_paint', 22:54:30 INFO - 'tpaint', 22:54:30 INFO - 'sessionrestore', 22:54:30 INFO - 'sessionrestore_no_auto_restore']}, 22:54:30 INFO - 'other_l64': {'tests': ['a11yr', 22:54:30 INFO - 'ts_paint', 22:54:30 INFO - 'tpaint', 22:54:30 INFO - 'sessionrestore', 22:54:30 INFO - 'sessionrestore_no_auto_restore']}, 22:54:30 INFO - 'other_nol64': {'tests': ['a11yr', 22:54:30 INFO - 'ts_paint', 22:54:30 INFO - 'tpaint', 22:54:30 INFO - 'sessionrestore', 22:54:30 INFO - 'sessionrestore_no_auto_restore']}, 22:54:30 INFO - 'svgr': {'tests': ['tsvgx', 22:54:30 INFO - 'tsvgr_opacity', 22:54:30 INFO - 'tart', 22:54:30 INFO - 'tscrollx', 22:54:30 INFO - 'cart']}, 22:54:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['tsvgx', 22:54:30 INFO - 'tsvgr_opacity', 22:54:30 INFO - 'tart', 22:54:30 INFO - 'tscrollx', 22:54:30 INFO - 'cart']}, 22:54:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:30 INFO - 'tests': ['tp5o']}, 22:54:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:30 INFO - 'talos_options': ['--e10s'], 22:54:30 INFO - 'tests': ['tp5o']}, 22:54:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:30 INFO - 'talos_options': ['--xperf_path', 22:54:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:30 INFO - 'tests': ['tp5n']}, 22:54:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:30 INFO - 'talos_options': ['--e10s', 22:54:30 INFO - '--xperf_path', 22:54:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:30 INFO - 'tests': ['tp5n']}}, 22:54:30 INFO - 'talos.zip': {'path': '', 22:54:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:30 INFO - Running post-action listener: _resource_record_post_action 22:54:30 INFO - ##### 22:54:30 INFO - ##### Running create-virtualenv step. 22:54:30 INFO - ##### 22:54:30 INFO - Running pre-action listener: _resource_record_pre_action 22:54:30 INFO - Running main action method: create_virtualenv 22:54:30 INFO - Creating virtualenv /builds/slave/test/build/venv 22:54:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:54:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:54:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:30 INFO - Using real prefix '/usr' 22:54:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:54:31 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:33 INFO - Installing pip.................done. 22:54:33 INFO - Return code: 0 22:54:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:33 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 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54:33 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 22:54:33 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 22:54:33 INFO - Using env: {'DISPLAY': ':0', 22:54:33 INFO - 'HOME': '/home/cltbld', 22:54:33 INFO - 'LANG': 'en_US.UTF-8', 22:54:33 INFO - 'LANGUAGE': 'en_US:en', 22:54:33 INFO - 'LOGNAME': 'cltbld', 22:54:33 INFO - 'MAIL': '/var/mail/cltbld', 22:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:33 INFO - 'MOZ_NO_REMOTE': '1', 22:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:33 INFO - 'NO_EM_RESTART': '1', 22:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:33 INFO - 'PWD': '/builds/slave/test', 22:54:33 INFO - 'SHELL': '/bin/bash', 22:54:33 INFO - 'SHLVL': '1', 22:54:33 INFO - 'TERM': 'linux', 22:54:33 INFO - 'TMOUT': '86400', 22:54:33 INFO - 'USER': 'cltbld', 22:54:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:33 INFO - '_': '/tools/buildbot/bin/python'} 22:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:33 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 22:54:33 INFO - Cleaning up... 22:54:33 INFO - Return code: 0 22:54:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:33 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 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54:33 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 22:54:33 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 22:54:33 INFO - Using env: {'DISPLAY': ':0', 22:54:33 INFO - 'HOME': '/home/cltbld', 22:54:33 INFO - 'LANG': 'en_US.UTF-8', 22:54:33 INFO - 'LANGUAGE': 'en_US:en', 22:54:33 INFO - 'LOGNAME': 'cltbld', 22:54:33 INFO - 'MAIL': '/var/mail/cltbld', 22:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:33 INFO - 'MOZ_NO_REMOTE': '1', 22:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:33 INFO - 'NO_EM_RESTART': '1', 22:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:33 INFO - 'PWD': '/builds/slave/test', 22:54:33 INFO - 'SHELL': '/bin/bash', 22:54:33 INFO - 'SHLVL': '1', 22:54:33 INFO - 'TERM': 'linux', 22:54:33 INFO - 'TMOUT': '86400', 22:54:33 INFO - 'USER': 'cltbld', 22:54:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:33 INFO - '_': '/tools/buildbot/bin/python'} 22:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:33 INFO - Downloading/unpacking psutil>=0.7.1 22:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:54:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:35 INFO - Installing collected packages: psutil 22:54:35 INFO - Running setup.py install for psutil 22:54:35 INFO - building 'psutil._psutil_linux' extension 22:54:35 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 22:54:35 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 22:54:35 INFO - building 'psutil._psutil_posix' extension 22:54:35 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 22:54:35 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 22:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:36 INFO - Successfully installed psutil 22:54:36 INFO - Cleaning up... 22:54:36 INFO - Return code: 0 22:54:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:54:36 INFO - Using env: {'DISPLAY': ':0', 22:54:36 INFO - 'HOME': '/home/cltbld', 22:54:36 INFO - 'LANG': 'en_US.UTF-8', 22:54:36 INFO - 'LANGUAGE': 'en_US:en', 22:54:36 INFO - 'LOGNAME': 'cltbld', 22:54:36 INFO - 'MAIL': '/var/mail/cltbld', 22:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:36 INFO - 'MOZ_NO_REMOTE': '1', 22:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:36 INFO - 'NO_EM_RESTART': '1', 22:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:36 INFO - 'PWD': '/builds/slave/test', 22:54:36 INFO - 'SHELL': '/bin/bash', 22:54:36 INFO - 'SHLVL': '1', 22:54:36 INFO - 'TERM': 'linux', 22:54:36 INFO - 'TMOUT': '86400', 22:54:36 INFO - 'USER': 'cltbld', 22:54:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:36 INFO - '_': '/tools/buildbot/bin/python'} 22:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:54:38 INFO - Installing collected packages: mozsystemmonitor 22:54:38 INFO - Running setup.py install for mozsystemmonitor 22:54:38 INFO - Successfully installed mozsystemmonitor 22:54:38 INFO - Cleaning up... 22:54:38 INFO - Return code: 0 22:54:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:54:38 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')]} 22:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:38 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')]} 22:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:38 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 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54:38 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 22:54:38 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 22:54:38 INFO - Using env: {'DISPLAY': ':0', 22:54:38 INFO - 'HOME': '/home/cltbld', 22:54:38 INFO - 'LANG': 'en_US.UTF-8', 22:54:38 INFO - 'LANGUAGE': 'en_US:en', 22:54:38 INFO - 'LOGNAME': 'cltbld', 22:54:38 INFO - 'MAIL': '/var/mail/cltbld', 22:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:38 INFO - 'MOZ_NO_REMOTE': '1', 22:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:38 INFO - 'NO_EM_RESTART': '1', 22:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:38 INFO - 'PWD': '/builds/slave/test', 22:54:38 INFO - 'SHELL': '/bin/bash', 22:54:38 INFO - 'SHLVL': '1', 22:54:38 INFO - 'TERM': 'linux', 22:54:38 INFO - 'TMOUT': '86400', 22:54:38 INFO - 'USER': 'cltbld', 22:54:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:38 INFO - '_': '/tools/buildbot/bin/python'} 22:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:38 INFO - Downloading/unpacking blobuploader==1.2.4 22:54:38 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 22:54:38 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 22:54:38 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 22:54:38 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 22:54:38 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 22:54:38 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 22:54:40 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:40 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 22:54:40 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 22:54:40 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 22:54:40 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 22:54:40 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 22:54:40 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 22:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:54:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:40 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 22:54:40 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 22:54:40 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 22:54:40 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 22:54:40 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 22:54:40 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 22:54:41 INFO - Downloading docopt-0.6.1.tar.gz 22:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:41 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:41 INFO - Running setup.py install for blobuploader 22:54:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:54:41 INFO - Running setup.py install for requests 22:54:41 INFO - Running setup.py install for docopt 22:54:41 INFO - Successfully installed blobuploader requests docopt 22:54:41 INFO - Cleaning up... 22:54:41 INFO - Return code: 0 22:54:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:41 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 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54:41 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 22:54:41 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 22:54:41 INFO - Using env: {'DISPLAY': ':0', 22:54:41 INFO - 'HOME': '/home/cltbld', 22:54:41 INFO - 'LANG': 'en_US.UTF-8', 22:54:41 INFO - 'LANGUAGE': 'en_US:en', 22:54:41 INFO - 'LOGNAME': 'cltbld', 22:54:41 INFO - 'MAIL': '/var/mail/cltbld', 22:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:41 INFO - 'MOZ_NO_REMOTE': '1', 22:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:41 INFO - 'NO_EM_RESTART': '1', 22:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:41 INFO - 'PWD': '/builds/slave/test', 22:54:41 INFO - 'SHELL': '/bin/bash', 22:54:41 INFO - 'SHLVL': '1', 22:54:41 INFO - 'TERM': 'linux', 22:54:41 INFO - 'TMOUT': '86400', 22:54:41 INFO - 'USER': 'cltbld', 22:54:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:41 INFO - '_': '/tools/buildbot/bin/python'} 22:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:41 INFO - Running setup.py (path:/tmp/pip-hFRkLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:42 INFO - Running setup.py (path:/tmp/pip-c5_Ohg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:42 INFO - Running setup.py (path:/tmp/pip-pYWXzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:42 INFO - Running setup.py (path:/tmp/pip-Ag20nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:42 INFO - Running setup.py (path:/tmp/pip-uDE0k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:42 INFO - Running setup.py (path:/tmp/pip-bIfU41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:42 INFO - Running setup.py (path:/tmp/pip-CKwBAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:42 INFO - Running setup.py (path:/tmp/pip-PGDFIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:42 INFO - Running setup.py (path:/tmp/pip-ZMPKlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:42 INFO - Running setup.py (path:/tmp/pip-JuIGlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:42 INFO - Running setup.py (path:/tmp/pip-aeOTaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:42 INFO - Running setup.py (path:/tmp/pip-LDsEOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:42 INFO - Running setup.py (path:/tmp/pip-OCJ9I1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:42 INFO - Running setup.py (path:/tmp/pip-mlA8At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:42 INFO - Running setup.py (path:/tmp/pip-cdTsTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:43 INFO - Running setup.py (path:/tmp/pip-rFkWtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:43 INFO - Running setup.py (path:/tmp/pip-JClsqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:43 INFO - Running setup.py install for manifestparser 22:54:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Running setup.py install for mozcrash 22:54:43 INFO - Running setup.py install for mozdebug 22:54:43 INFO - Running setup.py install for mozdevice 22:54:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Running setup.py install for mozfile 22:54:43 INFO - Running setup.py install for mozhttpd 22:54:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Running setup.py install for mozinfo 22:54:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Running setup.py install for mozInstall 22:54:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:54:43 INFO - Running setup.py install for mozleak 22:54:44 INFO - Running setup.py install for mozlog 22:54:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:54:44 INFO - Running setup.py install for moznetwork 22:54:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:54:44 INFO - Running setup.py install for mozprocess 22:54:44 INFO - Running setup.py install for mozprofile 22:54:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:54:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:54:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:54:44 INFO - Running setup.py install for mozrunner 22:54:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:54:44 INFO - Running setup.py install for mozscreenshot 22:54:44 INFO - Running setup.py install for moztest 22:54:44 INFO - Running setup.py install for mozversion 22:54:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:54:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:44 INFO - Cleaning up... 22:54:44 INFO - Return code: 0 22:54:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:44 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 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54:44 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 22:54:44 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 22:54:44 INFO - Using env: {'DISPLAY': ':0', 22:54:44 INFO - 'HOME': '/home/cltbld', 22:54:44 INFO - 'LANG': 'en_US.UTF-8', 22:54:44 INFO - 'LANGUAGE': 'en_US:en', 22:54:44 INFO - 'LOGNAME': 'cltbld', 22:54:44 INFO - 'MAIL': '/var/mail/cltbld', 22:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:44 INFO - 'MOZ_NO_REMOTE': '1', 22:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:44 INFO - 'NO_EM_RESTART': '1', 22:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:44 INFO - 'PWD': '/builds/slave/test', 22:54:44 INFO - 'SHELL': '/bin/bash', 22:54:44 INFO - 'SHLVL': '1', 22:54:44 INFO - 'TERM': 'linux', 22:54:44 INFO - 'TMOUT': '86400', 22:54:44 INFO - 'USER': 'cltbld', 22:54:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:44 INFO - '_': '/tools/buildbot/bin/python'} 22:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:45 INFO - Running setup.py (path:/tmp/pip-rziSvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:45 INFO - Running setup.py (path:/tmp/pip-jEvWDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:45 INFO - Running setup.py (path:/tmp/pip-YCDUAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:45 INFO - Running setup.py (path:/tmp/pip-BuQwwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:45 INFO - Running setup.py (path:/tmp/pip-nf_xK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:45 INFO - Running setup.py (path:/tmp/pip-goWPZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:45 INFO - Running setup.py (path:/tmp/pip-iYESdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:45 INFO - Running setup.py (path:/tmp/pip-uhrZAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:45 INFO - Running setup.py (path:/tmp/pip-_0iGCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:45 INFO - Running setup.py (path:/tmp/pip-YEcw8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:45 INFO - Running setup.py (path:/tmp/pip-H5odJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:45 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)) 22:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:45 INFO - Running setup.py (path:/tmp/pip-iPIc8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:46 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)) 22:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:46 INFO - Running setup.py (path:/tmp/pip-LkA9DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:46 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)) 22:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:46 INFO - Running setup.py (path:/tmp/pip-tJF9bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:46 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)) 22:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:46 INFO - Running setup.py (path:/tmp/pip-92tF4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:46 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)) 22:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:46 INFO - Running setup.py (path:/tmp/pip-9r8l1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:46 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)) 22:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:46 INFO - Running setup.py (path:/tmp/pip-TIXkbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:46 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)) 22:54:46 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)) 22:54:46 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)) 22:54:46 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)) 22:54:46 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)) 22:54:46 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)) 22:54:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:46 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 22:54:46 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 22:54:46 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 22:54:46 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 22:54:46 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 22:54:46 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 22:54:48 INFO - Downloading blessings-1.6.tar.gz 22:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:48 INFO - Installing collected packages: blessings 22:54:48 INFO - Running setup.py install for blessings 22:54:48 INFO - Successfully installed blessings 22:54:48 INFO - Cleaning up... 22:54:48 INFO - Return code: 0 22:54:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:48 INFO - Reading from file tmpfile_stdout 22:54:48 INFO - Current package versions: 22:54:48 INFO - argparse == 1.2.1 22:54:48 INFO - blessings == 1.6 22:54:48 INFO - blobuploader == 1.2.4 22:54:48 INFO - docopt == 0.6.1 22:54:48 INFO - manifestparser == 1.1 22:54:48 INFO - mozInstall == 1.12 22:54:48 INFO - mozcrash == 0.16 22:54:48 INFO - mozdebug == 0.1 22:54:48 INFO - mozdevice == 0.48 22:54:48 INFO - mozfile == 1.2 22:54:48 INFO - mozhttpd == 0.7 22:54:48 INFO - mozinfo == 0.9 22:54:48 INFO - mozleak == 0.1 22:54:48 INFO - mozlog == 3.1 22:54:48 INFO - moznetwork == 0.27 22:54:48 INFO - mozprocess == 0.22 22:54:48 INFO - mozprofile == 0.28 22:54:48 INFO - mozrunner == 6.11 22:54:48 INFO - mozscreenshot == 0.1 22:54:48 INFO - mozsystemmonitor == 0.0 22:54:48 INFO - moztest == 0.7 22:54:48 INFO - mozversion == 1.4 22:54:48 INFO - psutil == 3.1.1 22:54:48 INFO - requests == 1.2.3 22:54:48 INFO - wsgiref == 0.1.2 22:54:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:48 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 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54:48 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 22:54:48 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 22:54:48 INFO - Using env: {'DISPLAY': ':0', 22:54:48 INFO - 'HOME': '/home/cltbld', 22:54:48 INFO - 'LANG': 'en_US.UTF-8', 22:54:48 INFO - 'LANGUAGE': 'en_US:en', 22:54:48 INFO - 'LOGNAME': 'cltbld', 22:54:48 INFO - 'MAIL': '/var/mail/cltbld', 22:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:48 INFO - 'MOZ_NO_REMOTE': '1', 22:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:48 INFO - 'NO_EM_RESTART': '1', 22:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:48 INFO - 'PWD': '/builds/slave/test', 22:54:48 INFO - 'SHELL': '/bin/bash', 22:54:48 INFO - 'SHLVL': '1', 22:54:48 INFO - 'TERM': 'linux', 22:54:48 INFO - 'TMOUT': '86400', 22:54:48 INFO - 'USER': 'cltbld', 22:54:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:48 INFO - '_': '/tools/buildbot/bin/python'} 22:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 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)) 22:54:48 INFO - Cleaning up... 22:54:48 INFO - Return code: 0 22:54:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:48 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 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54:48 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 22:54:48 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 22:54:48 INFO - Using env: {'DISPLAY': ':0', 22:54:48 INFO - 'HOME': '/home/cltbld', 22:54:48 INFO - 'LANG': 'en_US.UTF-8', 22:54:48 INFO - 'LANGUAGE': 'en_US:en', 22:54:48 INFO - 'LOGNAME': 'cltbld', 22:54:48 INFO - 'MAIL': '/var/mail/cltbld', 22:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:48 INFO - 'MOZ_NO_REMOTE': '1', 22:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:48 INFO - 'NO_EM_RESTART': '1', 22:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:48 INFO - 'PWD': '/builds/slave/test', 22:54:48 INFO - 'SHELL': '/bin/bash', 22:54:48 INFO - 'SHLVL': '1', 22:54:48 INFO - 'TERM': 'linux', 22:54:48 INFO - 'TMOUT': '86400', 22:54:48 INFO - 'USER': 'cltbld', 22:54:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:48 INFO - '_': '/tools/buildbot/bin/python'} 22:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:49 INFO - Downloading/unpacking jsonschema 22:54:49 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 22:54:49 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 22:54:49 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 22:54:49 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 22:54:49 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 22:54:49 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 22:54:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:50 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:51 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:51 INFO - warning: no files found matching '*.txt' 22:54:51 INFO - no previously-included directories found matching 'build' 22:54:51 INFO - no previously-included directories found matching 'dist' 22:54:51 INFO - no previously-included directories found matching '.git*' 22:54:51 INFO - Installing collected packages: jsonschema, functools32 22:54:51 INFO - Running setup.py install for functools32 22:54:51 INFO - warning: no files found matching '*.txt' 22:54:51 INFO - no previously-included directories found matching 'build' 22:54:51 INFO - no previously-included directories found matching 'dist' 22:54:51 INFO - no previously-included directories found matching '.git*' 22:54:51 INFO - Successfully installed jsonschema functools32 22:54:51 INFO - Cleaning up... 22:54:51 INFO - Return code: 0 22:54:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0bae0eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, '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': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', '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 22:54: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', 'flake8'] in /builds/slave/test/build 22:54: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 flake8 22:54:51 INFO - Using env: {'DISPLAY': ':0', 22:54:51 INFO - 'HOME': '/home/cltbld', 22:54:51 INFO - 'LANG': 'en_US.UTF-8', 22:54:51 INFO - 'LANGUAGE': 'en_US:en', 22:54:51 INFO - 'LOGNAME': 'cltbld', 22:54:51 INFO - 'MAIL': '/var/mail/cltbld', 22:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:51 INFO - 'MOZ_NO_REMOTE': '1', 22:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:51 INFO - 'NO_EM_RESTART': '1', 22:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:51 INFO - 'PWD': '/builds/slave/test', 22:54:51 INFO - 'SHELL': '/bin/bash', 22:54:51 INFO - 'SHLVL': '1', 22:54:51 INFO - 'TERM': 'linux', 22:54:51 INFO - 'TMOUT': '86400', 22:54:51 INFO - 'USER': 'cltbld', 22:54:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:51 INFO - '_': '/tools/buildbot/bin/python'} 22:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:51 INFO - Downloading/unpacking flake8 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:54 INFO - no previously-included directories found matching 'docs/_build' 22:54:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:54 INFO - Running setup.py install for pep8 22:54:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:54 INFO - no previously-included directories found matching 'docs/_build' 22:54:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:54:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:54 INFO - Cleaning up... 22:54:54 INFO - Return code: 0 22:54:54 INFO - Running post-action listener: _resource_record_post_action 22:54:54 INFO - Running post-action listener: _start_resource_monitoring 22:54:54 INFO - Starting resource monitoring. 22:54:54 INFO - ##### 22:54:54 INFO - ##### Running install step. 22:54:54 INFO - ##### 22:54:54 INFO - Running pre-action listener: _resource_record_pre_action 22:54:54 INFO - Running main action method: install 22:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:54 INFO - Reading from file tmpfile_stdout 22:54:54 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:54:54 INFO - Reading from file tmpfile_stdout 22:54:54 INFO - Output received: 22:54:54 INFO - Usage: mozinstall [options] installer 22:54:54 INFO - Options: 22:54:54 INFO - -h, --help show this help message and exit 22:54:54 INFO - -d DEST, --destination=DEST 22:54:54 INFO - Directory to install application into. [default: 22:54:54 INFO - "/builds/slave/test"] 22:54:54 INFO - --app=APP Application being installed. [default: firefox] 22:54:54 INFO - mkdir: /builds/slave/test/build/application 22:54:54 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'] 22:54:54 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 22:55:07 INFO - Reading from file tmpfile_stdout 22:55:07 INFO - Output received: 22:55:07 INFO - /builds/slave/test/build/application/firefox/firefox 22:55:07 INFO - Running post-action listener: _resource_record_post_action 22:55:07 INFO - ##### 22:55:07 INFO - ##### Running run-tests step. 22:55:07 INFO - ##### 22:55:07 INFO - Running pre-action listener: _resource_record_pre_action 22:55:07 INFO - Running main action method: run_tests 22:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:55:07 INFO - Python 2.7.3 22:55:07 INFO - Return code: 0 22:55:07 INFO - grabbing minidump binary from tooltool 22:55:07 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')]} 22:55:07 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 0x2c66430>, '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 0x2bd1f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd23c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:55:07 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 22:55:07 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 22:55:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:55:07 INFO - Return code: 0 22:55:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:55:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:55:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:55:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:55:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:55:08 INFO - Return code: 0 22:55:08 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/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 22:55:08 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/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 22:55:08 INFO - Using env: {'DISPLAY': ':0', 22:55:08 INFO - 'HOME': '/home/cltbld', 22:55:08 INFO - 'LANG': 'en_US.UTF-8', 22:55:08 INFO - 'LANGUAGE': 'en_US:en', 22:55:08 INFO - 'LOGNAME': 'cltbld', 22:55:08 INFO - 'MAIL': '/var/mail/cltbld', 22:55:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:55:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:08 INFO - 'MOZ_NO_REMOTE': '1', 22:55:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:08 INFO - 'NO_EM_RESTART': '1', 22:55:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:08 INFO - 'PWD': '/builds/slave/test', 22:55:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:55:08 INFO - 'SHELL': '/bin/bash', 22:55:08 INFO - 'SHLVL': '1', 22:55:08 INFO - 'TERM': 'linux', 22:55:08 INFO - 'TMOUT': '86400', 22:55:08 INFO - 'USER': 'cltbld', 22:55:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456987808.339529-1541909988', 22:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:08 INFO - '_': '/tools/buildbot/bin/python'} 22:55:08 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/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 22:55:09 INFO - mozversion application_buildid: 20160302200635 22:55:09 INFO - mozversion application_changeset: 07e13e514846833c01f65812d04b9c6a2f4b9f84 22:55:09 INFO - mozversion application_display_name: Firefox 22:55:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:55:09 INFO - mozversion application_name: Firefox 22:55:09 INFO - mozversion application_remotingname: firefox 22:55:09 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 22:55:09 INFO - mozversion application_vendor: Mozilla 22:55:09 INFO - mozversion application_version: 46.0 22:55:09 INFO - mozversion platform_buildid: 20160302200635 22:55:09 INFO - mozversion platform_changeset: 07e13e514846833c01f65812d04b9c6a2f4b9f84 22:55:09 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 22:55:09 INFO - mozversion platform_version: 46.0 22:55:09 INFO - using testdate: 1456988109 22:55:09 INFO - actual date: 1456988109 22:55:09 INFO - starting webserver on 'localhost:37854' 22:55:09 INFO - SUITE-START | Running 3 tests 22:55:09 INFO - TEST-START | dromaeo_css 22:55:09 INFO - operating with platform_type : linux_ 22:55:09 INFO - Initialising browser for dromaeo_css test... 22:55:09 INFO - TEST-INFO | started process 8428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsOevJR/profile http://localhost:37854/getInfo.html) 22:55:13 INFO - PROCESS | 8428 | __metrics Screen width/height:1600/1200 22:55:13 INFO - PROCESS | 8428 | colorDepth:24 22:55:13 INFO - PROCESS | 8428 | Browser inner width/height: 1024/697 22:55:13 INFO - PROCESS | 8428 | __metrics 22:55:13 INFO - PROCESS | 8428 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:55:14 INFO - TEST-INFO | 8428: exit 0 22:55:14 INFO - Browser initialized. 22:55:14 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:14 INFO - TEST-INFO | started process 8516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsOevJR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:26 INFO - PROCESS | 8516 | RSS: Main: 135966720 22:55:26 INFO - PROCESS | 8516 | 22:56:17 INFO - PROCESS | 8516 | 1456988177300 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] 22:58:25 INFO - PROCESS | 8516 | Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37854/tests/dromaeo/cssquery-ext.html) 22:58:26 INFO - PROCESS | 8516 | RSS: Main: 256368640 22:58:26 INFO - PROCESS | 8516 | 23:01:28 INFO - PROCESS | 8516 | Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-ext.html (next: http://localhost:37854/tests/dromaeo/cssquery-jquery.html) 23:01:29 INFO - PROCESS | 8516 | RSS: Main: 220581888 23:01:29 INFO - PROCESS | 8516 | 23:04:30 INFO - PROCESS | 8516 | Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37854/tests/dromaeo/cssquery-mootools.html) 23:04:31 INFO - PROCESS | 8516 | RSS: Main: 219742208 23:04:31 INFO - PROCESS | 8516 | 23:07:33 INFO - PROCESS | 8516 | Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37854/tests/dromaeo/cssquery-prototype.html) 23:07:33 INFO - PROCESS | 8516 | RSS: Main: 203210752 23:07:33 INFO - PROCESS | 8516 | 23:10:36 INFO - PROCESS | 8516 | Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37854/tests/dromaeo/cssquery-yui.html) 23:10:36 INFO - PROCESS | 8516 | RSS: Main: 207548416 23:10:36 INFO - PROCESS | 8516 | 23:13:38 INFO - PROCESS | 8516 | Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-yui.html (next: http://localhost:37854/tests/dromaeo/cssquery-dojo.html) 23:13:39 INFO - PROCESS | 8516 | RSS: Main: 252502016 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - PROCESS | 8516 | __start_tp_report 23:13:39 INFO - PROCESS | 8516 | _x_x_mozilla_page_load 23:13:39 INFO - PROCESS | 8516 | _x_x_mozilla_page_load_details 23:13:39 INFO - PROCESS | 8516 | |i|pagename|runs| 23:13:39 INFO - PROCESS | 8516 | |0;dojo.html;3209.727173190279;3244.8215348155873;3283.950740738889;3285.4414749492585;3315.668433156684;5230.790768369266;5239.738013099344;5252.422233554306;5253.264542963988;5291.973540132303;5247.107991641421;5253.947460525394;5266.5786737061035;5279.841604751854;5289.338832645919;4714.858554243378;4774.212254977933;4808.735519546423;4843;4847.224444088946;4791.736454495001;4816.97591512042;4831.154547954112;4831.37192165018;4833.734144622044;4771.069641419925;4775.880602984918;4827.493113223114;4869.659123861331;4875.68308059975;4795.256735206049;4836.975815120937;4846.684965477232;4853.660243782937;4869.805207791684;4807.326974223612;4811.13399588074;4812.037592481518;4824.975875120637;4837.226043833005;4958.281049247875;4985.651004429691;5110.9744451277875;5116.462771409023;5118.948810511884;5625.943740562583;5663.405342439026;5686.431356864322;5692.117721753135;5698.116791897221;5705.4579814917515;5713.428657134295;5729.083346664555;5736.770529178828;5742.2247996520355;5200.427952925175;5221.242919776649;5266;5304.496072873071;5332.946670533283;5698.31620205578;5722.942770572325;5725.997950358754;5727.911696777683;5728.656280623176;5369.570434365241;5534.225208470817;5534.667919924817;5534.778608855681;5540.501354878081;5516.972415137979;5574.358948720868;5601.467860553241;5626.859328516738;5644.407337229532;5539.501444869981;5543.196236545678;5574.526165275915;5574.86062848432;5575.526080283222;5480.205370221295;5520.861978450571;5539.030669632798;5541.556675465953;5568.7215639217875;4271.871843844628;4297.247981603269;4307.353896915488;4311.827526898889;4313.396124542566;3872.2255548890334;3880.3403421418425;3886.028492876781;3898.317794385971;3915.7454765440725;5168.870778230575;5225.843224703265;5237.502437268454;5257.290265814143;5262.342207224097;5560.582956278296;5638.069718496484;5646.774129034792;5668.716564171775;5695.202671625976;5322.866928326823;5360.249565060894;5362.3565172178805;5365.839024829262;5374.140137577969;4805.783739731721;4885.560299573055;4895.290182923527;4926.679765815211;4930.2851086592245;5760.942390576124;5798.391168927286;5801.3038435388025;5810.564207684356;5813.389594092644;5584.413636568183;5631;5634.943650563442;5640.661560306231;5640.661560306395;5702.45826646468;5789.53683705311;5794.507466865363;5806.5064469518875;5810.941890581209;5525.834224973257;5601.383847776823;5604.355499117491;5604.747786349705;5642.153676948491;5599.076152434803;5630.408807075362;5639.069553523786;5642.971785141048;5652.63257888236;5441.809536666197;5479.53423958968;5514.255575497417;5518.475744804237;5519.31008623922;5454.290942177491;5483.287172667528;5507.7246137693755;5516.531094856821;5524.944750552443;5388.784448622011;5406.540444062299;5413.756380962945;5417.729113544386;5423.050966080999;5404.459554044564;5504.146857237135;5520.033994051106;5546.916796247979;5547.8890422192135;5350.571954243574;5376.677399356051;5429.402765695691;5433.8369848904595;5460.2355670207 23:13:39 INFO - PROCESS | 8516 | |1;ext.html;552.8175702018334;559.0886854427285;572.3132241310428;578.6210032428755;585.0785013603572;31371.68628313719;32067.67932320676;32068.839655801687;32131.839340803293;37429.25141497168;42712.572874271245;43372.783136084276;43408.3488747669;43411.78294108533;43451.34822977658;8837.248833849115;9046.457212567268;9053.637854485813;9057.45655260683;9063.093690630918;8635.740927772176;8754.824903501925;8758.781030474225;8758.912410875906;8760.12398760122;8737.388382813206;9007;9053.592588333508;9058.23005044572;9066.637334506611;8910.198082172603;8947.597358118901;8948.194662480408;8956.731298061004;8976.506292153928;8824.691135810215;8964.641414343418;8971.775705607346;8986.595603197871;8988.011318754932;42655.786721066506;43001;43169.35245971313;43172.568274317484;43196.3520547192;3341.298327351259;3469.7224222062173;3571.196480791827;4037.9192416151805;4163.625273725349;32483.675163248303;32831.343373132404;32875.6712432875;33055.338893222244;33182.66817331844;4387.583179597933;4419.248727716296;4437.689361744679;4472;4480.395146655193;300391;303277.4836125827;303334.4499832504;303544;303594;58917.11624325639;59772;65154.34845651578;65955;66537.33462665312;59397.40602594005;59414.70292648509;59634;59730.40269597335;59806.70096649576;15781.921090394704;15874.841251587568;15894.60263493422;15971.121588312755;16022.679546409006;11779.587714430125;11783.587574435025;11849.229800062969;11910.940445297718;11946.940265298617;21705.240316588843;22217.111315547198;22257.777422225896;22257.888710556344;22278.777212227993;7597.278258565428;7746.376992342353;7815.570143642154;7859.84280314402;7946;1027.8766548014137;1035.7928414317166;1058.640062378795;1067.3169171730099;1099.301943266032;30204.395912081636;30219;30924.690753092633;31118.844405777825;31389.686103139135;1178.709313301933;1209.455744914792;1215.3497878634887;1250.0749445410331;1314.454501381935;13613;16070.919645401698;16202;16459.423920162735;16788.992660440414;380255;381825;382368;383257;384884;58508;58646;58706;58789.118163227584;58860.411395885494;1375.099309951983;1467.6551010512521;1472.639203395175;1483.4585376337775;1484.3543058769253;27913.302167445163;28108;28381.716182837907;28522.42955140844;28787.28031799222;43328.78335608302;43464.34803478014;43484.56515434805;43635.34546981861;43648;196152;197373;197567;197729;197767;32279.193020174684;34760.13099672528;34965.825170873984;35199.47200792041;35547.64452355443;41082.589174107874;41780.16439671129;41947.1610567793;42503.149937001705;42601.36097958595;35987.820060899525;36130.27739445249;36169.45745813762;36847.44728829123;40224.396634049925;38758.61241387663;38876.6112338873;39375;39602.207955840146;43968.78015609901;37240.25519489649;37880;37915.24169516649;38015.239695206496;38086;34595.30809383849;34659.82670086633;35156.12109697176;35355.82322088373;35518.28963420665;26868.73131268662;26894.865525672245;27166.72833271721;27332.316692082855;27432.17703468899 23:13:39 INFO - PROCESS | 8516 | |2;jquery.html;385.6779589043147;387.9224155168967;391.32105796443176;392.04928049480014;396.4924896132951;14345.928270358634;15094.849051509482;16639.251233694482;19221.23115075397;19263.229470821152;17992.4602261932;18148.455546333633;18188.545286367815;18274.725879111826;18506.907465462653;6097.176881121059;6344.270408902989;6344.682765861711;6373.553851230416;6376.968115159418;4525.0949810037955;4646.651501137411;4682.742449165295;6126.019836826109;6658.533902626818;6683.699233534503;6900.27547107554;6905.896411553831;6906.240313565504;6921.273266307041;6551.705173267167;6761.526693131483;6763.188417389895;6768.932310676904;6808.931910680904;6463.773767918147;6482.773102941422;6506.089147519351;6508.54440189187;6509.023646453023;20976.790232097635;21424.678629820566;22049.559008819895;22108.22621208266;22252;2465.642481840141;2496.488219914913;2672.3853513691765;2702.3244188952763;2704.634874291965;13444.5294414696;14097.295135243197;14126.788098178535;14291.356888940023;14326.283685815772;2049.4364049886253;2077.314486219544;2086.1759604955955;2121.9787802121937;2126.734158230221;65707;66593.3340666592;67512.32487675159;68327.65836170837;68328.65835670789;15397;15499.380024799108;15559.14424706652;15607.531774046796;15654.45209417665;23513.294601161993;23578.764212358;23706.525869482513;23851.688157151522;23854.642180367307;7459.179490256068;7751.883721744179;8011.1588283230585;8038.196180382032;9223.631054757869;7602.391808655294;7606.201348858401;7609.467337286337;7626.580538070349;7720.3051725344985;4374.343848422762;4510.075434535912;4704.129735998851;4807.206810876236;4827.637927155477;1805.997671292419;1876.5214870208283;1880.1445342369188;1886.9245230190913;1916.5400303926958;996.9451680157516;1033.4574348466965;1061.273027975839;1083.7290677330668;1125.8254970479588;15638.687226255412;16521.173941302888;17004.149792510325;17201.7419738704;17551.561210969827;989.6288891665625;1034.6895931220754;1057.1965306367217;1073.2540884085486;1079.4117206122683;9750.707478775648;9923.503824808875;9989.150922171551;10037.849432258521;10108.039736225046;601325;622725;625725;676355;682006;49843.50156498388;62558;75538;79140.6042969793;81780;1223.932683702405;1229.8093795461718;1230.4954968462887;1257.8427696537933;1277.6167149855007;15648;15659.843401565839;15736.213189340717;15926;16056.759148612546;32289.51565726563;32518.51222231621;34042;34326;35661.28677426489;40633;41002;41774.37338439865;42245.577544224165;42359.7882010588;7176.7488137914925;7398.926010739824;7476.775696729107;7558.319751222416;7614.885776713243;8393.622286996977;10086.243531735003;10712.410817405118;10752.150929821119;10882.238243322892;7523.909033190266;7685.23147685227;7723.382129429519;10205.540750666387;10495.265331426726;7503.9249607503225;7580.583067931317;7628.313451789366;7884.408669349937;7891.84216315682;6308.400701933309;7550.137632717149;7950.443468957117;7958.0848202455145;8053.516788992679;9516.619335226791;10007.199424046205;10143.28996970205;10252.128569071414;10634.574617015232;7290.161631412456;7345.963270183614;7689.3464055555905;7755.806104847424;7778.961105194438 23:13:39 INFO - PROCESS | 8516 | |3;mootools.html;1523.3373482535096;1546.1032601091367;1734.7744793176885;1791.9731204031934;1862.720591911214;7815.49199302045;7981.92018079819;7986.321162701162;7987.800304992371;7995.92004079959;7887.723929662463;7923.405744569166;7924.92075079249;7924.92075079249;7929.088154862193;2301.1255722825304;2307.9653805192934;2327.3367090379247;2331.35887630902;2331.8834058297102;2338.169949667869;2338.4153961509624;2340.3330050935488;2344.6248600223967;2346.085026839534;2067.9586408271825;2116.4285642876416;2188.540406514626;2270.421042634126;2356.7643235676464;2294.1855641247366;2314.132200424841;2335.159342636666;2335.5912715274844;2342.2856028911174;2288.4736510602656;2359.9882000589887;2360.78752912237;2362.61016932206;2364.0307473935604;7071.540349877293;7222.313880181375;7690.961545192238;7851.725189618336;7888.605569721491;4820.566149046567;4922.80308787648;4924.384451943507;4925.965547235085;4940.357753492023;3137.8274194919272;3139.3407384449292;3186.952195717066;3196.4406228909847;3256.674332566748;1056.8520407143005;1057.7672911959357;1073.202386003441;1088.1294964028746;1122.691259903525;10972;11026;11037.282576632493;11050.33697978116;11064.889351106467;4403.713758605681;4478.753668548261;4503.459584849839;4504.189245935763;4511.639068874482;9434.19809316202;9491.572879220452;9492.477913714813;9496.335256532115;9522.95238523803;4943.110240156806;4976.278439626234;4981.750912454363;4981.90036199274;4986.775595098229;4377.781110944504;4506.662000349987;4562.931556026662;4574.153781550423;4591.95408045922;3786.3752480840353;3845.73079884411;3861.5559210690567;3866.4007078902814;3890.0469385000856;1220.737541428597;1269.1877198592908;1270.6569226308845;1282.6152154353656;1287.8003909394058;1375.1542801177404;1386.577093986344;1406.1000959386001;1412.0257022654541;1435.791810187517;7406.07424071991;7593.088829340514;7594.658240379085;7622.390208783395;7634.427417943676;1087.521490544158;1119.9664010079712;1149.3333866357493;1165.953361865516;1172.9648110556698;5785.768569257182;6273.780417685359;6296.244450665949;6325.715342809584;6330.873382532323;8731.476111433334;9202.723918282461;9203.217726493189;9233.307501937381;9240.722778316662;8950.68672596469;8964.506952117696;9042.140996605312;9091.772705682411;9221;7586.203448637813;7636.961815191;7710.306072453394;7729.188435214334;7748.845023099507;7416.7404140854815;7478.663460144197;7568.5458872467825;7589.6205189739185;7591.772246832604;8555.31557475388;8769.736907892773;8858.73423797287;8904.643814247358;8962.14859588338;8848.07095254989;9079.954600226956;9085.954570227106;9087.863682044643;9252.629894804133;7043.506954513135;7138.964305178441;7139.32176443237;7144.214136445091;7154.034205382207;7065.540739851893;7193.3166349196745;7201.6399180041835;7231.385332246818;7287.161976372573;6659.53383263167;6710.362515561014;6814.386705196556;6904.551204171713;7057;6783.728650853911;6811.931880681328;6845.110135682329;6896.655167241718;7023.051887995055;7122.038524799086;7162.319579639926;7175.892361614684;7187.353138217585;7196.352328290479;6453.806385808433;6546.509011824228;6555.836104097436;6571.704273307808;6614.305497922649;6604.108445360007;6661.533692641662;6671;6714.52998290115;6721.327867213239 23:13:39 INFO - PROCESS | 8516 | |4;prototype.html;356.15768707007925;364.48607463476486;365.05086774386615;365.63436563436557;366.4686205002745;5883.117532370136;5963.224780778498;6049.153118563394;6053.334133245339;6056.3943605639415;5739.885202295962;5874.9118763218585;5876.676782776945;5941.16823644689;5981.312149102854;4628.629709623239;4654.999175177336;4659.161350956826;4661.114388266235;4666.580007799297;4510.075434535912;4510.661700372485;4601.3558101865765;4610.2854057621125;4659.301104834268;4556.521565235652;4571.1543364477675;4577.313402989545;4595.862124136264;4599.379083823691;4611.838585649503;4619.0530941156985;4620.699654522462;4625.907481850378;4628.074385122955;4093.5906409359122;4095.7337773044655;4099.569545197741;4107.383892416132;4108.4453598764085;5597.6641401515635;5650.858728531778;5666.348369937468;5677.120046392774;5693.829185124453;5359.919601205946;5360.65155764874;5366.570674346043;5367.651102678314;5368.114261146906;6078.1186727924205;6270.87458250837;6315.336889626569;6315.494760419156;6315.8736825263695;4464.486584042844;4495.03356778291;4546;4546.8635940921495;4552.430946131733;6564.835879103013;6594.802155935329;6605.372489613527;6609.074729537869;6615.17310336208;4696.2486002239475;4700.600448961876;4702.036082603058;4704.317873908332;4710.152172608895;4461.776911154429;4591.494935557086;4592.6555508337005;4759.048190361872;4767.61859051275;5264;5265.21021846726;5269.604779641542;5270.341207349082;5274.630775845654;6270.7805226816845;6305.400986906328;6316.9368306317265;6344.714487848058;6422.325655806167;1616.2807550640086;1628.6172749403881;1631.1028934086205;1633.8447847454472;1634.795650543682;1051.1433181956681;1068.7381591509975;1073.120041565924;1129.8361737548173;1142.7885841119419;5996.940030599725;6007.36922623127;6172.938270617236;6193.256809182837;6195.783147589813;6596.505262105361;6603.570767900071;6606.570572912745;6608.900866487006;6612.471002319803;5904.645721256738;6160.414760597736;6180.66006369645;6187.876242475125;6192.504599632109;3490.65093490654;3547.609762926076;3554.59122200945;3568.072301201706;3574.821258937043;6748.223954245324;6794.184697836291;6794.422474089758;6797.762078327235;6807.387335139762;6677.933220667828;6805;6820;6868.896966545506;6872;6780.389764921082;6787.6266805325195;6787.93212067873;6796.150481189752;6800.6939687714175;6577.967110164419;6612.801615951529;6623.072769812326;6624.337566243337;6630.30381809903;6314.084457753508;6481;6492.058651495412;6525.086487891604;6539.836504087436;6738.898916516354;6773.830654233683;6776.6950487227205;6778.491613129134;6788.253292137762;4593.379893714306;4645.953540464552;4650.744209068398;4651.465081515534;4655.23188673865;6522.869542609026;6608.140941677551;6617.735290588323;6620.5034622402545;6622.37087476689;6452.516061295515;6458.612483250832;6458.935410645833;6470.385313395408;6470.579412338183;6426;6440.2915679276175;6449.709763060768;6454.096426500388;6455.193100862392;5879.176915231786;6320.62076275425;6327.177466929454;6335.176427064452;6340.175777148941;5740.39725828782;6402.359764023747;6408.198975128109;6433.067205255305;6452.451541619015;6314.368563143649;6317.684115794284;6317.9052314214405;6326.6520341381665;6328.208973878265 23:13:39 INFO - PROCESS | 8516 | |5;yui.html;869.2871845087024;872.2978002707822;878.1745159550022;878.7451639024683;937.6905621145021;14626.122432654034;14716.852831471682;14784.408623655068;14787.186704731235;14820.481283155079;13391.464341426332;14113.92943035286;14121.57635270941;14123.081999670014;14129.152250864956;738.0258059361645;748.1620584944842;846.6782622603417;853.3301358433631;859.9785005374853;745.7389913530275;858.9570521473933;873.0745409865531;876.0494863073541;876.1063715010686;887.4586502233665;897.1297841094129;898.2454738020061;898.2723993565234;898.3531857062904;755.9168491465934;766.0730516075555;889.977750556238;891.1266958380791;900.2213085680904;669.8727241824038;670.5038271678972;670.7216505150357;670.9966450167767;672.3411057163958;14368.78446823288;14399;14405.78391324131;14444.494442694455;14458.204798736066;13040.543580974716;13507.189568625914;13619;13624.455021799116;13641.931790341085;10884.564617415293;10884.836727449094;10959.83560246597;11145.108391328755;11172.60895868649;3816.141368192162;3834.827432765532;3845.692344612424;3848.7883166425836;3852.4413959975927;48934.75532622314;49486;49963.75018124923;50002.499975000515;50189.49810501885;10330.690079297634;10376;10423.635172769069;10508.63219787319;10735.892641073646;19554.51113722168;19642.90178549098;19671.114799834042;19672;19723.704144437845;7753.8449231015065;7824.921750782533;7885.935398721214;7912.960435197787;7956.602169891482;4262.893427664333;4303.1178608385835;4381.824727010884;4497.392851965008;4501.729896206238;3102.51910953798;3141.4973604223674;3155;3158.7788854779947;3162.588863447737;573.3750212268648;590.2798585725408;591.1457943271931;595.7944509144338;599.7301214453513;708.4226355520337;727.7925791149497;732.7728404194717;746.1978373248779;750.53091817614;8934.553272336358;8999.82000359989;9053.864192037125;9219.354645174773;9580.904190958141;648.8442773734364;689.7896141676837;716.7276434954683;760.4600733479292;779.1585088104833;4360.825566977285;4491.550844915548;4598.195315819718;4611.354410382549;4633.513481084505;61586.38413615896;61864.69067654723;61927.38072619306;61979.690101549204;61980;55890.72054639701;59657.70171149203;60436.395636043955;60567.69716151391;61063.69468152631;46723.29915051277;48437.27344089842;48519.5148048515;48905.510944890804;50302.49697502978;9399.953000234955;9405.200557952377;9422.01068887757;9616.326857119935;9735.853962190715;37050.814745926094;37843.432348514245;38251.23497529978;38409.807950960065;38753.418698718975;44250.778746106065;45566;48241.517584823705;48569.51430485791;49252.507474924794;12217.93891030539;12450.688732781753;12524.123311368481;12675.049371297375;12763.489460421479;12356.814647780471;12874;12932.676683082998;12959.092863499465;13610.183388996691;11959.342236177094;12043.81934270969;12114.575989840665;12232.32722200252;12469.251844889335;11629.476673549541;11886.16796824214;12074.275543467069;12106.818397724217;12504.187227830162;11166.385848778395;11359.716007099558;11457.828132577852;11506.367149806842;11543.076553875502;9928.205743540644;10191.592336306465;10505.212109091695;10640.680779576625;10742.785144297226;10043.799124017625;10468.68593942183;10520.842187367349;10543.841842372523;10560.683179504627 23:13:39 INFO - PROCESS | 8516 | __end_tp_report 23:13:39 INFO - PROCESS | 8516 | __start_cc_report 23:13:39 INFO - PROCESS | 8516 | _x_x_mozilla_cycle_collect,946 23:13:39 INFO - PROCESS | 8516 | __end_cc_report 23:13:39 INFO - PROCESS | 8516 | __startTimestamp1456989219245__endTimestamp 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - PROCESS | 8516 | ------- Summary: start ------- 23:13:39 INFO - PROCESS | 8516 | Number of tests: 6 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - PROCESS | 8516 | [#0] dojo.html Cycles:165 Average:5229.65 Median:5417.73 stddev:556.87 (10.3%) stddev-sans-first:535.56 23:13:39 INFO - PROCESS | 8516 | Values: 3209.7 3244.8 3284.0 3285.4 3315.7 5230.8 5239.7 5252.4 5253.3 5292.0 5247.1 5253.9 5266.6 5279.8 5289.3 4714.9 4774.2 4808.7 4843.0 4847.2 4791.7 4817.0 4831.2 4831.4 4833.7 4771.1 4775.9 4827.5 4869.7 4875.7 4795.3 4837.0 4846.7 4853.7 4869.8 4807.3 4811.1 4812.0 4825.0 4837.2 4958.3 4985.7 5111.0 5116.5 5118.9 5625.9 5663.4 5686.4 5692.1 5698.1 5705.5 5713.4 5729.1 5736.8 5742.2 5200.4 5221.2 5266.0 5304.5 5332.9 5698.3 5722.9 5726.0 5727.9 5728.7 5369.6 5534.2 5534.7 5534.8 5540.5 5517.0 5574.4 5601.5 5626.9 5644.4 5539.5 5543.2 5574.5 5574.9 5575.5 5480.2 5520.9 5539.0 5541.6 5568.7 4271.9 4297.2 4307.4 4311.8 4313.4 3872.2 3880.3 3886.0 3898.3 3915.7 5168.9 5225.8 5237.5 5257.3 5262.3 5560.6 5638.1 5646.8 5668.7 5695.2 5322.9 5360.2 5362.4 5365.8 5374.1 4805.8 4885.6 4895.3 4926.7 4930.3 5760.9 5798.4 5801.3 5810.6 5813.4 5584.4 5631.0 5634.9 5640.7 5640.7 5702.5 5789.5 5794.5 5806.5 5810.9 5525.8 5601.4 5604.4 5604.7 5642.2 5599.1 5630.4 5639.1 5643.0 5652.6 5441.8 5479.5 5514.3 5518.5 5519.3 5454.3 5483.3 5507.7 5516.5 5524.9 5388.8 5406.5 5413.8 5417.7 5423.1 5404.5 5504.1 5520.0 5546.9 5547.9 5350.6 5376.7 5429.4 5433.8 5460.2 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - PROCESS | 8516 | [#1] ext.html Cycles:180 Average:47317.64 Median:209135.12 stddev:79785.86 (38.2%) stddev-sans-first:79932.42 23:13:39 INFO - PROCESS | 8516 | Values: 552.8 559.1 572.3 578.6 585.1 31371.7 32067.7 32068.8 32131.8 37429.3 42712.6 43372.8 43408.3 43411.8 43451.3 8837.2 9046.5 9053.6 9057.5 9063.1 8635.7 8754.8 8758.8 8758.9 8760.1 8737.4 9007.0 9053.6 9058.2 9066.6 8910.2 8947.6 8948.2 8956.7 8976.5 8824.7 8964.6 8971.8 8986.6 8988.0 42655.8 43001.0 43169.4 43172.6 43196.4 3341.3 3469.7 3571.2 4037.9 4163.6 32483.7 32831.3 32875.7 33055.3 33182.7 4387.6 4419.2 4437.7 4472.0 4480.4 300391.0 303277.5 303334.4 303544.0 303594.0 58917.1 59772.0 65154.3 65955.0 66537.3 59397.4 59414.7 59634.0 59730.4 59806.7 15781.9 15874.8 15894.6 15971.1 16022.7 11779.6 11783.6 11849.2 11910.9 11946.9 21705.2 22217.1 22257.8 22257.9 22278.8 7597.3 7746.4 7815.6 7859.8 7946.0 1027.9 1035.8 1058.6 1067.3 1099.3 30204.4 30219.0 30924.7 31118.8 31389.7 1178.7 1209.5 1215.3 1250.1 1314.5 13613.0 16070.9 16202.0 16459.4 16789.0 380255.0 381825.0 382368.0 383257.0 384884.0 58508.0 58646.0 58706.0 58789.1 58860.4 1375.1 1467.7 1472.6 1483.5 1484.4 27913.3 28108.0 28381.7 28522.4 28787.3 43328.8 43464.3 43484.6 43635.3 43648.0 196152.0 197373.0 197567.0 197729.0 197767.0 32279.2 34760.1 34965.8 35199.5 35547.6 41082.6 41780.2 41947.2 42503.1 42601.4 35987.8 36130.3 36169.5 36847.4 40224.4 38758.6 38876.6 39375.0 39602.2 43968.8 37240.3 37880.0 37915.2 38015.2 38086.0 34595.3 34659.8 35156.1 35355.8 35518.3 26868.7 26894.9 27166.7 27332.3 27432.2 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - PROCESS | 8516 | [#2] jquery.html Cycles:180 Average:31347.46 Median:40817.50 stddev:104820.67 (256.8%) stddev-sans-first:105088.93 23:13:39 INFO - PROCESS | 8516 | Values: 385.7 387.9 391.3 392.0 396.5 14345.9 15094.8 16639.3 19221.2 19263.2 17992.5 18148.5 18188.5 18274.7 18506.9 6097.2 6344.3 6344.7 6373.6 6377.0 4525.1 4646.7 4682.7 6126.0 6658.5 6683.7 6900.3 6905.9 6906.2 6921.3 6551.7 6761.5 6763.2 6768.9 6808.9 6463.8 6482.8 6506.1 6508.5 6509.0 20976.8 21424.7 22049.6 22108.2 22252.0 2465.6 2496.5 2672.4 2702.3 2704.6 13444.5 14097.3 14126.8 14291.4 14326.3 2049.4 2077.3 2086.2 2122.0 2126.7 65707.0 66593.3 67512.3 68327.7 68328.7 15397.0 15499.4 15559.1 15607.5 15654.5 23513.3 23578.8 23706.5 23851.7 23854.6 7459.2 7751.9 8011.2 8038.2 9223.6 7602.4 7606.2 7609.5 7626.6 7720.3 4374.3 4510.1 4704.1 4807.2 4827.6 1806.0 1876.5 1880.1 1886.9 1916.5 996.9 1033.5 1061.3 1083.7 1125.8 15638.7 16521.2 17004.1 17201.7 17551.6 989.6 1034.7 1057.2 1073.3 1079.4 9750.7 9923.5 9989.2 10037.8 10108.0 601325.0 622725.0 625725.0 676355.0 682006.0 49843.5 62558.0 75538.0 79140.6 81780.0 1223.9 1229.8 1230.5 1257.8 1277.6 15648.0 15659.8 15736.2 15926.0 16056.8 32289.5 32518.5 34042.0 34326.0 35661.3 40633.0 41002.0 41774.4 42245.6 42359.8 7176.7 7398.9 7476.8 7558.3 7614.9 8393.6 10086.2 10712.4 10752.2 10882.2 7523.9 7685.2 7723.4 10205.5 10495.3 7503.9 7580.6 7628.3 7884.4 7891.8 6308.4 7550.1 7950.4 7958.1 8053.5 9516.6 10007.2 10143.3 10252.1 10634.6 7290.2 7346.0 7689.3 7755.8 7779.0 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - PROCESS | 8516 | [#3] mootools.html Cycles:180 Average:5594.96 Median:6500.16 stddev:2844.11 (43.8%) stddev-sans-first:2835.62 23:13:39 INFO - PROCESS | 8516 | Values: 1523.3 1546.1 1734.8 1792.0 1862.7 7815.5 7981.9 7986.3 7987.8 7995.9 7887.7 7923.4 7924.9 7924.9 7929.1 2301.1 2308.0 2327.3 2331.4 2331.9 2338.2 2338.4 2340.3 2344.6 2346.1 2068.0 2116.4 2188.5 2270.4 2356.8 2294.2 2314.1 2335.2 2335.6 2342.3 2288.5 2360.0 2360.8 2362.6 2364.0 7071.5 7222.3 7691.0 7851.7 7888.6 4820.6 4922.8 4924.4 4926.0 4940.4 3137.8 3139.3 3187.0 3196.4 3256.7 1056.9 1057.8 1073.2 1088.1 1122.7 10972.0 11026.0 11037.3 11050.3 11064.9 4403.7 4478.8 4503.5 4504.2 4511.6 9434.2 9491.6 9492.5 9496.3 9523.0 4943.1 4976.3 4981.8 4981.9 4986.8 4377.8 4506.7 4562.9 4574.2 4592.0 3786.4 3845.7 3861.6 3866.4 3890.0 1220.7 1269.2 1270.7 1282.6 1287.8 1375.2 1386.6 1406.1 1412.0 1435.8 7406.1 7593.1 7594.7 7622.4 7634.4 1087.5 1120.0 1149.3 1166.0 1173.0 5785.8 6273.8 6296.2 6325.7 6330.9 8731.5 9202.7 9203.2 9233.3 9240.7 8950.7 8964.5 9042.1 9091.8 9221.0 7586.2 7637.0 7710.3 7729.2 7748.8 7416.7 7478.7 7568.5 7589.6 7591.8 8555.3 8769.7 8858.7 8904.6 8962.1 8848.1 9080.0 9086.0 9087.9 9252.6 7043.5 7139.0 7139.3 7144.2 7154.0 7065.5 7193.3 7201.6 7231.4 7287.2 6659.5 6710.4 6814.4 6904.6 7057.0 6783.7 6811.9 6845.1 6896.7 7023.1 7122.0 7162.3 7175.9 7187.4 7196.4 6453.8 6546.5 6555.8 6571.7 6614.3 6604.1 6661.5 6671.0 6714.5 6721.3 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - PROCESS | 8516 | [#4] prototype.html Cycles:180 Average:5346.38 Median:6002.15 stddev:1592.82 (26.5%) stddev-sans-first:1552.62 23:13:39 INFO - PROCESS | 8516 | Values: 356.2 364.5 365.1 365.6 366.5 5883.1 5963.2 6049.2 6053.3 6056.4 5739.9 5874.9 5876.7 5941.2 5981.3 4628.6 4655.0 4659.2 4661.1 4666.6 4510.1 4510.7 4601.4 4610.3 4659.3 4556.5 4571.2 4577.3 4595.9 4599.4 4611.8 4619.1 4620.7 4625.9 4628.1 4093.6 4095.7 4099.6 4107.4 4108.4 5597.7 5650.9 5666.3 5677.1 5693.8 5359.9 5360.7 5366.6 5367.7 5368.1 6078.1 6270.9 6315.3 6315.5 6315.9 4464.5 4495.0 4546.0 4546.9 4552.4 6564.8 6594.8 6605.4 6609.1 6615.2 4696.2 4700.6 4702.0 4704.3 4710.2 4461.8 4591.5 4592.7 4759.0 4767.6 5264.0 5265.2 5269.6 5270.3 5274.6 6270.8 6305.4 6316.9 6344.7 6422.3 1616.3 1628.6 1631.1 1633.8 1634.8 1051.1 1068.7 1073.1 1129.8 1142.8 5996.9 6007.4 6172.9 6193.3 6195.8 6596.5 6603.6 6606.6 6608.9 6612.5 5904.6 6160.4 6180.7 6187.9 6192.5 3490.7 3547.6 3554.6 3568.1 3574.8 6748.2 6794.2 6794.4 6797.8 6807.4 6677.9 6805.0 6820.0 6868.9 6872.0 6780.4 6787.6 6787.9 6796.2 6800.7 6578.0 6612.8 6623.1 6624.3 6630.3 6314.1 6481.0 6492.1 6525.1 6539.8 6738.9 6773.8 6776.7 6778.5 6788.3 4593.4 4646.0 4650.7 4651.5 4655.2 6522.9 6608.1 6617.7 6620.5 6622.4 6452.5 6458.6 6458.9 6470.4 6470.6 6426.0 6440.3 6449.7 6454.1 6455.2 5879.2 6320.6 6327.2 6335.2 6340.2 5740.4 6402.4 6408.2 6433.1 6452.5 6314.4 6317.7 6317.9 6326.7 6328.2 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - PROCESS | 8516 | [#5] yui.html Cycles:180 Average:14834.47 Median:4499.56 stddev:17251.32 (383.4%) stddev-sans-first:17267.84 23:13:39 INFO - PROCESS | 8516 | Values: 869.3 872.3 878.2 878.7 937.7 14626.1 14716.9 14784.4 14787.2 14820.5 13391.5 14113.9 14121.6 14123.1 14129.2 738.0 748.2 846.7 853.3 860.0 745.7 859.0 873.1 876.0 876.1 887.5 897.1 898.2 898.3 898.4 755.9 766.1 890.0 891.1 900.2 669.9 670.5 670.7 671.0 672.3 14368.8 14399.0 14405.8 14444.5 14458.2 13040.5 13507.2 13619.0 13624.5 13641.9 10884.6 10884.8 10959.8 11145.1 11172.6 3816.1 3834.8 3845.7 3848.8 3852.4 48934.8 49486.0 49963.8 50002.5 50189.5 10330.7 10376.0 10423.6 10508.6 10735.9 19554.5 19642.9 19671.1 19672.0 19723.7 7753.8 7824.9 7885.9 7913.0 7956.6 4262.9 4303.1 4381.8 4497.4 4501.7 3102.5 3141.5 3155.0 3158.8 3162.6 573.4 590.3 591.1 595.8 599.7 708.4 727.8 732.8 746.2 750.5 8934.6 8999.8 9053.9 9219.4 9580.9 648.8 689.8 716.7 760.5 779.2 4360.8 4491.6 4598.2 4611.4 4633.5 61586.4 61864.7 61927.4 61979.7 61980.0 55890.7 59657.7 60436.4 60567.7 61063.7 46723.3 48437.3 48519.5 48905.5 50302.5 9400.0 9405.2 9422.0 9616.3 9735.9 37050.8 37843.4 38251.2 38409.8 38753.4 44250.8 45566.0 48241.5 48569.5 49252.5 12217.9 12450.7 12524.1 12675.0 12763.5 12356.8 12874.0 12932.7 12959.1 13610.2 11959.3 12043.8 12114.6 12232.3 12469.3 11629.5 11886.2 12074.3 12106.8 12504.2 11166.4 11359.7 11457.8 11506.4 11543.1 9928.2 10191.6 10505.2 10640.7 10742.8 10043.8 10468.7 10520.8 10543.8 10560.7 23:13:39 INFO - PROCESS | 8516 | -------- Summary: end -------- 23:13:39 INFO - PROCESS | 8516 | 23:13:39 INFO - TEST-INFO | 8516: exit 0 23:13:39 INFO - TEST-OK | dromaeo_css | took 1110747ms 23:13:39 INFO - TEST-START | kraken 23:13:39 INFO - operating with platform_type : linux_ 23:13:39 INFO - Initialising browser for kraken test... 23:13:39 INFO - TEST-INFO | started process 8710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF8Edof/profile http://localhost:37854/getInfo.html) 23:13:44 INFO - PROCESS | 8710 | __metrics Screen width/height:1600/1200 23:13:44 INFO - PROCESS | 8710 | colorDepth:24 23:13:44 INFO - PROCESS | 8710 | Browser inner width/height: 1024/697 23:13:44 INFO - PROCESS | 8710 | __metrics 23:13:44 INFO - PROCESS | 8710 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:13:45 INFO - TEST-INFO | 8710: exit 0 23:13:45 INFO - Browser initialized. 23:13:45 INFO - Running cycle 1/1 for kraken test... 23:13:45 INFO - TEST-INFO | started process 8797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF8Edof/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:57 INFO - PROCESS | 8797 | RSS: Main: 136126464 23:13:57 INFO - PROCESS | 8797 | 23:13:59 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37854/tests/kraken/driver.html?testName=audio-beat-detection) 23:14:00 INFO - PROCESS | 8797 | RSS: Main: 168820736 23:14:00 INFO - PROCESS | 8797 | 23:14:02 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37854/tests/kraken/driver.html?testName=audio-dft) 23:14:03 INFO - PROCESS | 8797 | RSS: Main: 167464960 23:14:03 INFO - PROCESS | 8797 | 23:14:06 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37854/tests/kraken/driver.html?testName=audio-fft) 23:14:06 INFO - PROCESS | 8797 | RSS: Main: 164261888 23:14:06 INFO - PROCESS | 8797 | 23:14:08 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37854/tests/kraken/driver.html?testName=audio-oscillator) 23:14:09 INFO - PROCESS | 8797 | RSS: Main: 164720640 23:14:09 INFO - PROCESS | 8797 | 23:14:11 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37854/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:12 INFO - PROCESS | 8797 | RSS: Main: 162250752 23:14:12 INFO - PROCESS | 8797 | 23:14:14 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37854/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:15 INFO - PROCESS | 8797 | RSS: Main: 163475456 23:14:15 INFO - PROCESS | 8797 | 23:14:18 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37854/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:19 INFO - PROCESS | 8797 | RSS: Main: 164384768 23:14:19 INFO - PROCESS | 8797 | 23:14:22 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37854/tests/kraken/driver.html?testName=json-parse-financial) 23:14:22 INFO - PROCESS | 8797 | RSS: Main: 164667392 23:14:22 INFO - PROCESS | 8797 | 23:14:24 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37854/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:24 INFO - PROCESS | 8797 | RSS: Main: 167198720 23:14:24 INFO - PROCESS | 8797 | 23:14:26 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:27 INFO - PROCESS | 8797 | RSS: Main: 165322752 23:14:27 INFO - PROCESS | 8797 | 23:14:29 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:29 INFO - PROCESS | 8797 | RSS: Main: 170893312 23:14:29 INFO - PROCESS | 8797 | 23:14:31 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:32 INFO - PROCESS | 8797 | RSS: Main: 173494272 23:14:32 INFO - PROCESS | 8797 | 23:14:34 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:35 INFO - PROCESS | 8797 | RSS: Main: 171622400 23:14:35 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37854/tests/kraken/driver.html?testName=ai-astar) 23:14:37 INFO - PROCESS | 8797 | RSS: Main: 231677952 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | __start_tp_report 23:14:37 INFO - PROCESS | 8797 | _x_x_mozilla_page_load 23:14:37 INFO - PROCESS | 8797 | _x_x_mozilla_page_load_details 23:14:37 INFO - PROCESS | 8797 | |i|pagename|runs| 23:14:37 INFO - PROCESS | 8797 | |0;ai-astar;110;109;104;110;110;110;100;108;109;108 23:14:37 INFO - PROCESS | 8797 | |1;audio-beat-detection;160;123;154;170;127;158;163;125;165;134 23:14:37 INFO - PROCESS | 8797 | |2;audio-dft;160;160;160;160;162;162;160;164;162;160 23:14:37 INFO - PROCESS | 8797 | |3;audio-fft;76;73;74;141;74;74;72;74;161;73 23:14:37 INFO - PROCESS | 8797 | |4;audio-oscillator;95;95;146;95;94;95;147;96;95;142 23:14:37 INFO - PROCESS | 8797 | |5;imaging-gaussian-blur;109;108;109;109;109;110;109;110;109;109 23:14:37 INFO - PROCESS | 8797 | |6;imaging-darkroom;146;146;146;145;146;146;145;145;145;145 23:14:37 INFO - PROCESS | 8797 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;95;96 23:14:37 INFO - PROCESS | 8797 | |8;json-parse-financial;53;54;54;54;53;53;55;55;53;53 23:14:37 INFO - PROCESS | 8797 | |9;json-stringify-tinderbox;64;64;64;63;65;65;65;65;65;64 23:14:37 INFO - PROCESS | 8797 | |10;stanford-crypto-aes;78;79;78;78;85;79;78;79;79;77 23:14:37 INFO - PROCESS | 8797 | |11;stanford-crypto-ccm;112;110;112;110;110;121;113;117;111;108 23:14:37 INFO - PROCESS | 8797 | |12;stanford-crypto-pbkdf2;142;134;140;137;138;133;134;133;133;135 23:14:37 INFO - PROCESS | 8797 | |13;stanford-crypto-sha256-iterative;64;65;63;63;63;64;64;63;63;65 23:14:37 INFO - PROCESS | 8797 | __end_tp_report 23:14:37 INFO - PROCESS | 8797 | __start_cc_report 23:14:37 INFO - PROCESS | 8797 | _x_x_mozilla_cycle_collect,899 23:14:37 INFO - PROCESS | 8797 | __end_cc_report 23:14:37 INFO - PROCESS | 8797 | __startTimestamp1456989277402__endTimestamp 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | ------- Summary: start ------- 23:14:37 INFO - PROCESS | 8797 | Number of tests: 14 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.50 stddev:3.29 (3.0%) stddev-sans-first:3.40 23:14:37 INFO - PROCESS | 8797 | Values: 110.0 109.0 104.0 110.0 110.0 110.0 100.0 108.0 109.0 108.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:159.00 stddev:18.47 (11.6%) stddev-sans-first:19.06 23:14:37 INFO - PROCESS | 8797 | Values: 160.0 123.0 154.0 170.0 127.0 158.0 163.0 125.0 165.0 134.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 23:14:37 INFO - PROCESS | 8797 | Values: 160.0 160.0 160.0 160.0 162.0 162.0 160.0 164.0 162.0 160.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#3] audio-fft Cycles:10 Average:89.20 Median:74.00 stddev:32.93 (44.5%) stddev-sans-first:34.58 23:14:37 INFO - PROCESS | 8797 | Values: 76.0 73.0 74.0 141.0 74.0 74.0 72.0 74.0 161.0 73.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.00 stddev:24.19 (25.5%) stddev-sans-first:25.04 23:14:37 INFO - PROCESS | 8797 | Values: 95.0 95.0 146.0 95.0 94.0 95.0 147.0 96.0 95.0 142.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:14:37 INFO - PROCESS | 8797 | Values: 109.0 108.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 23:14:37 INFO - PROCESS | 8797 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:14:37 INFO - PROCESS | 8797 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 23:14:37 INFO - PROCESS | 8797 | Values: 53.0 54.0 54.0 54.0 53.0 53.0 55.0 55.0 53.0 53.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 23:14:37 INFO - PROCESS | 8797 | Values: 64.0 64.0 64.0 63.0 65.0 65.0 65.0 65.0 65.0 64.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.21 (2.8%) stddev-sans-first:2.32 23:14:37 INFO - PROCESS | 8797 | Values: 78.0 79.0 78.0 78.0 85.0 79.0 78.0 79.0 79.0 77.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#11] stanford-crypto-ccm Cycles:10 Average:112.40 Median:112.00 stddev:3.86 (3.5%) stddev-sans-first:4.10 23:14:37 INFO - PROCESS | 8797 | Values: 112.0 110.0 112.0 110.0 110.0 121.0 113.0 117.0 111.0 108.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:136.00 stddev:3.21 (2.4%) stddev-sans-first:2.54 23:14:37 INFO - PROCESS | 8797 | Values: 142.0 134.0 140.0 137.0 138.0 133.0 134.0 133.0 133.0 135.0 23:14:37 INFO - PROCESS | 8797 | 23:14:37 INFO - PROCESS | 8797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 23:14:37 INFO - PROCESS | 8797 | Values: 64.0 65.0 63.0 63.0 63.0 64.0 64.0 63.0 63.0 65.0 23:14:37 INFO - PROCESS | 8797 | -------- Summary: end -------- 23:14:37 INFO - PROCESS | 8797 | 23:14:38 INFO - TEST-INFO | 8797: exit 0 23:14:38 INFO - TEST-OK | kraken | took 58317ms 23:14:38 INFO - TEST-START | v8_7 23:14:38 INFO - operating with platform_type : linux_ 23:14:38 INFO - Initialising browser for v8_7 test... 23:14:38 INFO - TEST-INFO | started process 9046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWoK5NL/profile http://localhost:37854/getInfo.html) 23:14:42 INFO - PROCESS | 9046 | __metrics Screen width/height:1600/1200 23:14:42 INFO - PROCESS | 9046 | colorDepth:24 23:14:42 INFO - PROCESS | 9046 | Browser inner width/height: 1024/697 23:14:42 INFO - PROCESS | 9046 | __metrics 23:14:42 INFO - PROCESS | 9046 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:14:43 INFO - TEST-INFO | 9046: exit 0 23:14:43 INFO - Browser initialized. 23:14:43 INFO - Running cycle 1/1 for v8_7 test... 23:14:43 INFO - TEST-INFO | started process 9137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWoK5NL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:55 INFO - PROCESS | 9137 | RSS: Main: 135950336 23:14:55 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | Cycle 1(1): loaded http://localhost:37854/tests/v8_7/run.html (next: http://localhost:37854/tests/v8_7/run.html) 23:15:17 INFO - PROCESS | 9137 | RSS: Main: 422973440 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | __start_tp_report 23:15:17 INFO - PROCESS | 9137 | _x_x_mozilla_page_load 23:15:17 INFO - PROCESS | 9137 | _x_x_mozilla_page_load_details 23:15:17 INFO - PROCESS | 9137 | |i|pagename|runs| 23:15:17 INFO - PROCESS | 9137 | |0;Richards;166.25103906899417 23:15:17 INFO - PROCESS | 9137 | |1;DeltaBlue;169.98130205677376 23:15:17 INFO - PROCESS | 9137 | |2;Encrypt;277.54648903691367 23:15:17 INFO - PROCESS | 9137 | |3;Decrypt;5191.709844559586 23:15:17 INFO - PROCESS | 9137 | |4;RayTrace;991.0802775024777 23:15:17 INFO - PROCESS | 9137 | |5;Earley;566.2514156285391 23:15:17 INFO - PROCESS | 9137 | |6;Boyer;10610.526315789473 23:15:17 INFO - PROCESS | 9137 | |7;RegExp;39921.56862745098 23:15:17 INFO - PROCESS | 9137 | |8;Splay;518.1347150259068 23:15:17 INFO - PROCESS | 9137 | |9;NavierStokes;4812.5 23:15:17 INFO - PROCESS | 9137 | __end_tp_report 23:15:17 INFO - PROCESS | 9137 | __startTimestamp1456989317944__endTimestamp 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | ------- Summary: start ------- 23:15:17 INFO - PROCESS | 9137 | Number of tests: 10 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 166.3 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#1] DeltaBlue Cycles:1 Average:169.98 Median:169.98 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 170.0 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#2] Encrypt Cycles:1 Average:277.55 Median:277.55 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 277.5 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 5191.7 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#4] RayTrace Cycles:1 Average:991.08 Median:991.08 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 991.1 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#5] Earley Cycles:1 Average:566.25 Median:566.25 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 566.3 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#6] Boyer Cycles:1 Average:10610.53 Median:10610.53 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 10610.5 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#7] RegExp Cycles:1 Average:39921.57 Median:39921.57 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 39921.6 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#8] Splay Cycles:1 Average:518.13 Median:518.13 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 518.1 23:15:17 INFO - PROCESS | 9137 | 23:15:17 INFO - PROCESS | 9137 | [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 23:15:17 INFO - PROCESS | 9137 | Values: 4812.5 23:15:17 INFO - PROCESS | 9137 | -------- Summary: end -------- 23:15:17 INFO - PROCESS | 9137 | 23:15:18 INFO - TEST-INFO | 9137: exit 0 23:15:18 INFO - TEST-OK | v8_7 | took 40547ms 23:15:18 INFO - SUITE-END | took 1209s 23:15:19 INFO - Completed test suite (00:20:09) 23:15:19 INFO - Working with test: dromaeo_css 23:15:19 INFO - Generating results file: dromaeo_css 23:15:19 INFO - Working with test: kraken 23:15:19 INFO - Generating results file: kraken 23:15:19 INFO - javascript benchmark 23:15:19 INFO - Working with test: v8_7 23:15:19 INFO - Generating results file: v8_7 23:15:19 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,35]] 23:15:19 INFO - process_Request line: dromaeo_css 7162.36 graph.html#tests=[[72,181,35]] 23:15:19 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:19 INFO - process_Request line: kraken 1475.40 graph.html#tests=[[232,181,35]] 23:15:19 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:19 INFO - process_Request line: v8_7 21965.87 graph.html#tests=[[230,181,35]] 23:15:19 INFO - RETURN: dromaeo_css: 7162.36 23:15:19 INFO - RETURN: kraken: 1475.40 23:15:19 INFO - RETURN: v8_7: 21965.87 23:15:19 INFO - javascript benchmark 23:15:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3209.727173190279, 3244.8215348155873, 3283.950740738889, 3285.4414749492585, 3315.668433156684, 5230.790768369266, 5239.738013099344, 5252.422233554306, 5253.264542963988, 5291.973540132303, 5247.107991641421, 5253.947460525394, 5266.5786737061035, 5279.841604751854, 5289.338832645919, 4714.858554243378, 4774.212254977933, 4808.735519546423, 4843.0, 4847.224444088946, 4791.736454495001, 4816.97591512042, 4831.154547954112, 4831.37192165018, 4833.734144622044, 4771.069641419925, 4775.880602984918, 4827.493113223114, 4869.659123861331, 4875.68308059975, 4795.256735206049, 4836.975815120937, 4846.684965477232, 4853.660243782937, 4869.805207791684, 4807.326974223612, 4811.13399588074, 4812.037592481518, 4824.975875120637, 4837.226043833005, 4958.281049247875, 4985.651004429691, 5110.9744451277875, 5116.462771409023, 5118.948810511884, 5625.943740562583, 5663.405342439026, 5686.431356864322, 5692.117721753135, 5698.116791897221, 5705.4579814917515, 5713.428657134295, 5729.083346664555, 5736.770529178828, 5742.2247996520355, 5200.427952925175, 5221.242919776649, 5266.0, 5304.496072873071, 5332.946670533283, 5698.31620205578, 5722.942770572325, 5725.997950358754, 5727.911696777683, 5728.656280623176, 5369.570434365241, 5534.225208470817, 5534.667919924817, 5534.778608855681, 5540.501354878081, 5516.972415137979, 5574.358948720868, 5601.467860553241, 5626.859328516738, 5644.407337229532, 5539.501444869981, 5543.196236545678, 5574.526165275915, 5574.86062848432, 5575.526080283222, 5480.205370221295, 5520.861978450571, 5539.030669632798, 5541.556675465953, 5568.7215639217875, 4271.871843844628, 4297.247981603269, 4307.353896915488, 4311.827526898889, 4313.396124542566, 3872.2255548890334, 3880.3403421418425, 3886.028492876781, 3898.317794385971, 3915.7454765440725, 5168.870778230575, 5225.843224703265, 5237.502437268454, 5257.290265814143, 5262.342207224097, 5560.582956278296, 5638.069718496484, 5646.774129034792, 5668.716564171775, 5695.202671625976, 5322.866928326823, 5360.249565060894, 5362.3565172178805, 5365.839024829262, 5374.140137577969, 4805.783739731721, 4885.560299573055, 4895.290182923527, 4926.679765815211, 4930.2851086592245, 5760.942390576124, 5798.391168927286, 5801.3038435388025, 5810.564207684356, 5813.389594092644, 5584.413636568183, 5631.0, 5634.943650563442, 5640.661560306231, 5640.661560306395, 5702.45826646468, 5789.53683705311, 5794.507466865363, 5806.5064469518875, 5810.941890581209, 5525.834224973257, 5601.383847776823, 5604.355499117491, 5604.747786349705, 5642.153676948491, 5599.076152434803, 5630.408807075362, 5639.069553523786, 5642.971785141048, 5652.63257888236, 5441.809536666197, 5479.53423958968, 5514.255575497417, 5518.475744804237, 5519.31008623922, 5454.290942177491, 5483.287172667528, 5507.7246137693755, 5516.531094856821, 5524.944750552443, 5388.784448622011, 5406.540444062299, 5413.756380962945, 5417.729113544386, 5423.050966080999, 5404.459554044564, 5504.146857237135, 5520.033994051106, 5546.916796247979, 5547.8890422192135, 5350.571954243574, 5376.677399356051, 5429.402765695691, 5433.8369848904595, 5460.2355670207], "unit": "score", "name": "dojo.html", "value": 5195.294941253462}, {"lowerIsBetter": false, "replicates": [552.8175702018334, 559.0886854427285, 572.3132241310428, 578.6210032428755, 585.0785013603572, 31371.68628313719, 32067.67932320676, 32068.839655801687, 32131.839340803293, 37429.25141497168, 42712.572874271245, 43372.783136084276, 43408.3488747669, 43411.78294108533, 43451.34822977658, 8837.248833849115, 9046.457212567268, 9053.637854485813, 9057.45655260683, 9063.093690630918, 8635.740927772176, 8754.824903501925, 8758.781030474225, 8758.912410875906, 8760.12398760122, 8737.388382813206, 9007.0, 9053.592588333508, 9058.23005044572, 9066.637334506611, 8910.198082172603, 8947.597358118901, 8948.194662480408, 8956.731298061004, 8976.506292153928, 8824.691135810215, 8964.641414343418, 8971.775705607346, 8986.595603197871, 8988.011318754932, 42655.786721066506, 43001.0, 43169.35245971313, 43172.568274317484, 43196.3520547192, 3341.298327351259, 3469.7224222062173, 3571.196480791827, 4037.9192416151805, 4163.625273725349, 32483.675163248303, 32831.343373132404, 32875.6712432875, 33055.338893222244, 33182.66817331844, 4387.583179597933, 4419.248727716296, 4437.689361744679, 4472.0, 4480.395146655193, 300391.0, 303277.4836125827, 303334.4499832504, 303544.0, 303594.0, 58917.11624325639, 59772.0, 65154.34845651578, 65955.0, 66537.33462665312, 59397.40602594005, 59414.70292648509, 59634.0, 59730.40269597335, 59806.70096649576, 15781.921090394704, 15874.841251587568, 15894.60263493422, 15971.121588312755, 16022.679546409006, 11779.587714430125, 11783.587574435025, 11849.229800062969, 11910.940445297718, 11946.940265298617, 21705.240316588843, 22217.111315547198, 22257.777422225896, 22257.888710556344, 22278.777212227993, 7597.278258565428, 7746.376992342353, 7815.570143642154, 7859.84280314402, 7946.0, 1027.8766548014137, 1035.7928414317166, 1058.640062378795, 1067.3169171730099, 1099.301943266032, 30204.395912081636, 30219.0, 30924.690753092633, 31118.844405777825, 31389.686103139135, 1178.709313301933, 1209.455744914792, 1215.3497878634887, 1250.0749445410331, 1314.454501381935, 13613.0, 16070.919645401698, 16202.0, 16459.423920162735, 16788.992660440414, 380255.0, 381825.0, 382368.0, 383257.0, 384884.0, 58508.0, 58646.0, 58706.0, 58789.118163227584, 58860.411395885494, 1375.099309951983, 1467.6551010512521, 1472.639203395175, 1483.4585376337775, 1484.3543058769253, 27913.302167445163, 28108.0, 28381.716182837907, 28522.42955140844, 28787.28031799222, 43328.78335608302, 43464.34803478014, 43484.56515434805, 43635.34546981861, 43648.0, 196152.0, 197373.0, 197567.0, 197729.0, 197767.0, 32279.193020174684, 34760.13099672528, 34965.825170873984, 35199.47200792041, 35547.64452355443, 41082.589174107874, 41780.16439671129, 41947.1610567793, 42503.149937001705, 42601.36097958595, 35987.820060899525, 36130.27739445249, 36169.45745813762, 36847.44728829123, 40224.396634049925, 38758.61241387663, 38876.6112338873, 39375.0, 39602.207955840146, 43968.78015609901, 37240.25519489649, 37880.0, 37915.24169516649, 38015.239695206496, 38086.0, 34595.30809383849, 34659.82670086633, 35156.12109697176, 35355.82322088373, 35518.28963420665, 26868.73131268662, 26894.865525672245, 27166.72833271721, 27332.316692082855, 27432.17703468899], "unit": "score", "name": "ext.html", "value": 19198.532629672216}, {"lowerIsBetter": false, "replicates": [385.6779589043147, 387.9224155168967, 391.32105796443176, 392.04928049480014, 396.4924896132951, 14345.928270358634, 15094.849051509482, 16639.251233694482, 19221.23115075397, 19263.229470821152, 17992.4602261932, 18148.455546333633, 18188.545286367815, 18274.725879111826, 18506.907465462653, 6097.176881121059, 6344.270408902989, 6344.682765861711, 6373.553851230416, 6376.968115159418, 4525.0949810037955, 4646.651501137411, 4682.742449165295, 6126.019836826109, 6658.533902626818, 6683.699233534503, 6900.27547107554, 6905.896411553831, 6906.240313565504, 6921.273266307041, 6551.705173267167, 6761.526693131483, 6763.188417389895, 6768.932310676904, 6808.931910680904, 6463.773767918147, 6482.773102941422, 6506.089147519351, 6508.54440189187, 6509.023646453023, 20976.790232097635, 21424.678629820566, 22049.559008819895, 22108.22621208266, 22252.0, 2465.642481840141, 2496.488219914913, 2672.3853513691765, 2702.3244188952763, 2704.634874291965, 13444.5294414696, 14097.295135243197, 14126.788098178535, 14291.356888940023, 14326.283685815772, 2049.4364049886253, 2077.314486219544, 2086.1759604955955, 2121.9787802121937, 2126.734158230221, 65707.0, 66593.3340666592, 67512.32487675159, 68327.65836170837, 68328.65835670789, 15397.0, 15499.380024799108, 15559.14424706652, 15607.531774046796, 15654.45209417665, 23513.294601161993, 23578.764212358, 23706.525869482513, 23851.688157151522, 23854.642180367307, 7459.179490256068, 7751.883721744179, 8011.1588283230585, 8038.196180382032, 9223.631054757869, 7602.391808655294, 7606.201348858401, 7609.467337286337, 7626.580538070349, 7720.3051725344985, 4374.343848422762, 4510.075434535912, 4704.129735998851, 4807.206810876236, 4827.637927155477, 1805.997671292419, 1876.5214870208283, 1880.1445342369188, 1886.9245230190913, 1916.5400303926958, 996.9451680157516, 1033.4574348466965, 1061.273027975839, 1083.7290677330668, 1125.8254970479588, 15638.687226255412, 16521.173941302888, 17004.149792510325, 17201.7419738704, 17551.561210969827, 989.6288891665625, 1034.6895931220754, 1057.1965306367217, 1073.2540884085486, 1079.4117206122683, 9750.707478775648, 9923.503824808875, 9989.150922171551, 10037.849432258521, 10108.039736225046, 601325.0, 622725.0, 625725.0, 676355.0, 682006.0, 49843.50156498388, 62558.0, 75538.0, 79140.6042969793, 81780.0, 1223.932683702405, 1229.8093795461718, 1230.4954968462887, 1257.8427696537933, 1277.6167149855007, 15648.0, 15659.843401565839, 15736.213189340717, 15926.0, 16056.759148612546, 32289.51565726563, 32518.51222231621, 34042.0, 34326.0, 35661.28677426489, 40633.0, 41002.0, 41774.37338439865, 42245.577544224165, 42359.7882010588, 7176.7488137914925, 7398.926010739824, 7476.775696729107, 7558.319751222416, 7614.885776713243, 8393.622286996977, 10086.243531735003, 10712.410817405118, 10752.150929821119, 10882.238243322892, 7523.909033190266, 7685.23147685227, 7723.382129429519, 10205.540750666387, 10495.265331426726, 7503.9249607503225, 7580.583067931317, 7628.313451789366, 7884.408669349937, 7891.84216315682, 6308.400701933309, 7550.137632717149, 7950.443468957117, 7958.0848202455145, 8053.516788992679, 9516.619335226791, 10007.199424046205, 10143.28996970205, 10252.128569071414, 10634.574617015232, 7290.161631412456, 7345.963270183614, 7689.3464055555905, 7755.806104847424, 7778.961105194438], "unit": "score", "name": "jquery.html", "value": 8948.845437617287}, {"lowerIsBetter": false, "replicates": [1523.3373482535096, 1546.1032601091367, 1734.7744793176885, 1791.9731204031934, 1862.720591911214, 7815.49199302045, 7981.92018079819, 7986.321162701162, 7987.800304992371, 7995.92004079959, 7887.723929662463, 7923.405744569166, 7924.92075079249, 7924.92075079249, 7929.088154862193, 2301.1255722825304, 2307.9653805192934, 2327.3367090379247, 2331.35887630902, 2331.8834058297102, 2338.169949667869, 2338.4153961509624, 2340.3330050935488, 2344.6248600223967, 2346.085026839534, 2067.9586408271825, 2116.4285642876416, 2188.540406514626, 2270.421042634126, 2356.7643235676464, 2294.1855641247366, 2314.132200424841, 2335.159342636666, 2335.5912715274844, 2342.2856028911174, 2288.4736510602656, 2359.9882000589887, 2360.78752912237, 2362.61016932206, 2364.0307473935604, 7071.540349877293, 7222.313880181375, 7690.961545192238, 7851.725189618336, 7888.605569721491, 4820.566149046567, 4922.80308787648, 4924.384451943507, 4925.965547235085, 4940.357753492023, 3137.8274194919272, 3139.3407384449292, 3186.952195717066, 3196.4406228909847, 3256.674332566748, 1056.8520407143005, 1057.7672911959357, 1073.202386003441, 1088.1294964028746, 1122.691259903525, 10972.0, 11026.0, 11037.282576632493, 11050.33697978116, 11064.889351106467, 4403.713758605681, 4478.753668548261, 4503.459584849839, 4504.189245935763, 4511.639068874482, 9434.19809316202, 9491.572879220452, 9492.477913714813, 9496.335256532115, 9522.95238523803, 4943.110240156806, 4976.278439626234, 4981.750912454363, 4981.90036199274, 4986.775595098229, 4377.781110944504, 4506.662000349987, 4562.931556026662, 4574.153781550423, 4591.95408045922, 3786.3752480840353, 3845.73079884411, 3861.5559210690567, 3866.4007078902814, 3890.0469385000856, 1220.737541428597, 1269.1877198592908, 1270.6569226308845, 1282.6152154353656, 1287.8003909394058, 1375.1542801177404, 1386.577093986344, 1406.1000959386001, 1412.0257022654541, 1435.791810187517, 7406.07424071991, 7593.088829340514, 7594.658240379085, 7622.390208783395, 7634.427417943676, 1087.521490544158, 1119.9664010079712, 1149.3333866357493, 1165.953361865516, 1172.9648110556698, 5785.768569257182, 6273.780417685359, 6296.244450665949, 6325.715342809584, 6330.873382532323, 8731.476111433334, 9202.723918282461, 9203.217726493189, 9233.307501937381, 9240.722778316662, 8950.68672596469, 8964.506952117696, 9042.140996605312, 9091.772705682411, 9221.0, 7586.203448637813, 7636.961815191, 7710.306072453394, 7729.188435214334, 7748.845023099507, 7416.7404140854815, 7478.663460144197, 7568.5458872467825, 7589.6205189739185, 7591.772246832604, 8555.31557475388, 8769.736907892773, 8858.73423797287, 8904.643814247358, 8962.14859588338, 8848.07095254989, 9079.954600226956, 9085.954570227106, 9087.863682044643, 9252.629894804133, 7043.506954513135, 7138.964305178441, 7139.32176443237, 7144.214136445091, 7154.034205382207, 7065.540739851893, 7193.3166349196745, 7201.6399180041835, 7231.385332246818, 7287.161976372573, 6659.53383263167, 6710.362515561014, 6814.386705196556, 6904.551204171713, 7057.0, 6783.728650853911, 6811.931880681328, 6845.110135682329, 6896.655167241718, 7023.051887995055, 7122.038524799086, 7162.319579639926, 7175.892361614684, 7187.353138217585, 7196.352328290479, 6453.806385808433, 6546.509011824228, 6555.836104097436, 6571.704273307808, 6614.305497922649, 6604.108445360007, 6661.533692641662, 6671.0, 6714.52998290115, 6721.327867213239], "unit": "score", "name": "mootools.html", "value": 4639.499939201304}, {"lowerIsBetter": false, "replicates": [356.15768707007925, 364.48607463476486, 365.05086774386615, 365.63436563436557, 366.4686205002745, 5883.117532370136, 5963.224780778498, 6049.153118563394, 6053.334133245339, 6056.3943605639415, 5739.885202295962, 5874.9118763218585, 5876.676782776945, 5941.16823644689, 5981.312149102854, 4628.629709623239, 4654.999175177336, 4659.161350956826, 4661.114388266235, 4666.580007799297, 4510.075434535912, 4510.661700372485, 4601.3558101865765, 4610.2854057621125, 4659.301104834268, 4556.521565235652, 4571.1543364477675, 4577.313402989545, 4595.862124136264, 4599.379083823691, 4611.838585649503, 4619.0530941156985, 4620.699654522462, 4625.907481850378, 4628.074385122955, 4093.5906409359122, 4095.7337773044655, 4099.569545197741, 4107.383892416132, 4108.4453598764085, 5597.6641401515635, 5650.858728531778, 5666.348369937468, 5677.120046392774, 5693.829185124453, 5359.919601205946, 5360.65155764874, 5366.570674346043, 5367.651102678314, 5368.114261146906, 6078.1186727924205, 6270.87458250837, 6315.336889626569, 6315.494760419156, 6315.8736825263695, 4464.486584042844, 4495.03356778291, 4546.0, 4546.8635940921495, 4552.430946131733, 6564.835879103013, 6594.802155935329, 6605.372489613527, 6609.074729537869, 6615.17310336208, 4696.2486002239475, 4700.600448961876, 4702.036082603058, 4704.317873908332, 4710.152172608895, 4461.776911154429, 4591.494935557086, 4592.6555508337005, 4759.048190361872, 4767.61859051275, 5264.0, 5265.21021846726, 5269.604779641542, 5270.341207349082, 5274.630775845654, 6270.7805226816845, 6305.400986906328, 6316.9368306317265, 6344.714487848058, 6422.325655806167, 1616.2807550640086, 1628.6172749403881, 1631.1028934086205, 1633.8447847454472, 1634.795650543682, 1051.1433181956681, 1068.7381591509975, 1073.120041565924, 1129.8361737548173, 1142.7885841119419, 5996.940030599725, 6007.36922623127, 6172.938270617236, 6193.256809182837, 6195.783147589813, 6596.505262105361, 6603.570767900071, 6606.570572912745, 6608.900866487006, 6612.471002319803, 5904.645721256738, 6160.414760597736, 6180.66006369645, 6187.876242475125, 6192.504599632109, 3490.65093490654, 3547.609762926076, 3554.59122200945, 3568.072301201706, 3574.821258937043, 6748.223954245324, 6794.184697836291, 6794.422474089758, 6797.762078327235, 6807.387335139762, 6677.933220667828, 6805.0, 6820.0, 6868.896966545506, 6872.0, 6780.389764921082, 6787.6266805325195, 6787.93212067873, 6796.150481189752, 6800.6939687714175, 6577.967110164419, 6612.801615951529, 6623.072769812326, 6624.337566243337, 6630.30381809903, 6314.084457753508, 6481.0, 6492.058651495412, 6525.086487891604, 6539.836504087436, 6738.898916516354, 6773.830654233683, 6776.6950487227205, 6778.491613129134, 6788.253292137762, 4593.379893714306, 4645.953540464552, 4650.744209068398, 4651.465081515534, 4655.23188673865, 6522.869542609026, 6608.140941677551, 6617.735290588323, 6620.5034622402545, 6622.37087476689, 6452.516061295515, 6458.612483250832, 6458.935410645833, 6470.385313395408, 6470.579412338183, 6426.0, 6440.2915679276175, 6449.709763060768, 6454.096426500388, 6455.193100862392, 5879.176915231786, 6320.62076275425, 6327.177466929454, 6335.176427064452, 6340.175777148941, 5740.39725828782, 6402.359764023747, 6408.198975128109, 6433.067205255305, 6452.451541619015, 6314.368563143649, 6317.684115794284, 6317.9052314214405, 6326.6520341381665, 6328.208973878265], "unit": "score", "name": "prototype.html", "value": 4836.777086864066}, {"lowerIsBetter": false, "replicates": [869.2871845087024, 872.2978002707822, 878.1745159550022, 878.7451639024683, 937.6905621145021, 14626.122432654034, 14716.852831471682, 14784.408623655068, 14787.186704731235, 14820.481283155079, 13391.464341426332, 14113.92943035286, 14121.57635270941, 14123.081999670014, 14129.152250864956, 738.0258059361645, 748.1620584944842, 846.6782622603417, 853.3301358433631, 859.9785005374853, 745.7389913530275, 858.9570521473933, 873.0745409865531, 876.0494863073541, 876.1063715010686, 887.4586502233665, 897.1297841094129, 898.2454738020061, 898.2723993565234, 898.3531857062904, 755.9168491465934, 766.0730516075555, 889.977750556238, 891.1266958380791, 900.2213085680904, 669.8727241824038, 670.5038271678972, 670.7216505150357, 670.9966450167767, 672.3411057163958, 14368.78446823288, 14399.0, 14405.78391324131, 14444.494442694455, 14458.204798736066, 13040.543580974716, 13507.189568625914, 13619.0, 13624.455021799116, 13641.931790341085, 10884.564617415293, 10884.836727449094, 10959.83560246597, 11145.108391328755, 11172.60895868649, 3816.141368192162, 3834.827432765532, 3845.692344612424, 3848.7883166425836, 3852.4413959975927, 48934.75532622314, 49486.0, 49963.75018124923, 50002.499975000515, 50189.49810501885, 10330.690079297634, 10376.0, 10423.635172769069, 10508.63219787319, 10735.892641073646, 19554.51113722168, 19642.90178549098, 19671.114799834042, 19672.0, 19723.704144437845, 7753.8449231015065, 7824.921750782533, 7885.935398721214, 7912.960435197787, 7956.602169891482, 4262.893427664333, 4303.1178608385835, 4381.824727010884, 4497.392851965008, 4501.729896206238, 3102.51910953798, 3141.4973604223674, 3155.0, 3158.7788854779947, 3162.588863447737, 573.3750212268648, 590.2798585725408, 591.1457943271931, 595.7944509144338, 599.7301214453513, 708.4226355520337, 727.7925791149497, 732.7728404194717, 746.1978373248779, 750.53091817614, 8934.553272336358, 8999.82000359989, 9053.864192037125, 9219.354645174773, 9580.904190958141, 648.8442773734364, 689.7896141676837, 716.7276434954683, 760.4600733479292, 779.1585088104833, 4360.825566977285, 4491.550844915548, 4598.195315819718, 4611.354410382549, 4633.513481084505, 61586.38413615896, 61864.69067654723, 61927.38072619306, 61979.690101549204, 61980.0, 55890.72054639701, 59657.70171149203, 60436.395636043955, 60567.69716151391, 61063.69468152631, 46723.29915051277, 48437.27344089842, 48519.5148048515, 48905.510944890804, 50302.49697502978, 9399.953000234955, 9405.200557952377, 9422.01068887757, 9616.326857119935, 9735.853962190715, 37050.814745926094, 37843.432348514245, 38251.23497529978, 38409.807950960065, 38753.418698718975, 44250.778746106065, 45566.0, 48241.517584823705, 48569.51430485791, 49252.507474924794, 12217.93891030539, 12450.688732781753, 12524.123311368481, 12675.049371297375, 12763.489460421479, 12356.814647780471, 12874.0, 12932.676683082998, 12959.092863499465, 13610.183388996691, 11959.342236177094, 12043.81934270969, 12114.575989840665, 12232.32722200252, 12469.251844889335, 11629.476673549541, 11886.16796824214, 12074.275543467069, 12106.818397724217, 12504.187227830162, 11166.385848778395, 11359.716007099558, 11457.828132577852, 11506.367149806842, 11543.076553875502, 9928.205743540644, 10191.592336306465, 10505.212109091695, 10640.680779576625, 10742.785144297226, 10043.799124017625, 10468.68593942183, 10520.842187367349, 10543.841842372523, 10560.683179504627], "unit": "score", "name": "yui.html", "value": 6739.458327620475}], "name": "dromaeo_css", "value": 7162.358277170924}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 104.0, 110.0, 110.0, 110.0, 100.0, 108.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [160.0, 123.0, 154.0, 170.0, 127.0, 158.0, 163.0, 125.0, 165.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 162.0, 162.0, 160.0, 164.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 74.0, 141.0, 74.0, 74.0, 72.0, 74.0, 161.0, 73.0], "unit": "score", "name": "audio-fft", "value": 89.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 146.0, 95.0, 94.0, 95.0, 147.0, 96.0, 95.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 55.0, 55.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 53.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 78.0, 78.0, 85.0, 79.0, 78.0, 79.0, 79.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 112.0, 110.0, 110.0, 121.0, 113.0, 117.0, 111.0, 108.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.4}, {"lowerIsBetter": true, "replicates": [142.0, 134.0, 140.0, 137.0, 138.0, 133.0, 134.0, 133.0, 133.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.7}], "name": "kraken", "value": 1475.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [169.98130205677376], "unit": "score", "name": "DeltaBlue", "value": 388.97219399999994}, {"lowerIsBetter": false, "replicates": [277.54648903691367], "unit": "score", "name": "Encrypt", "value": 959.0501430000003}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [991.0802775024777], "unit": "score", "name": "RayTrace", "value": 746.6489009999999}, {"lowerIsBetter": false, "replicates": [566.2514156285391], "unit": "score", "name": "Earley", "value": 1176.973658}, {"lowerIsBetter": false, "replicates": [10610.526315789473], "unit": "score", "name": "Boyer", "value": 62.81149305555559}, {"lowerIsBetter": false, "replicates": [39921.56862745098], "unit": "score", "name": "RegExp", "value": 22.819368860510817}, {"lowerIsBetter": false, "replicates": [518.1347150259068], "unit": "score", "name": "Splay", "value": 157.27763}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "NavierStokes", "value": 308.3636363636364}], "name": "v8_7", "value": 21965.86698850078}]} 23:15:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,35]]", "result": "21965.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,35]]", "result": "1475.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,35]]", "result": "7162.36"}}} 23:15:19 INFO - Return code: 0 23:15:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:15:19 INFO - # TBPL SUCCESS # 23:15:19 INFO - Running post-action listener: _resource_record_post_action 23:15:19 INFO - Running post-run listener: _resource_record_post_run 23:15:20 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 12288; Write bytes: 473190400; Read time: 32; Write time: 691788 23:15:20 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 0; Write bytes: 248049664; Read time: 0; Write time: 459332 23:15:20 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 12288; Write bytes: 225140736; Read time: 32; Write time: 232456 23:15:20 INFO - Running post-run listener: _upload_blobber_files 23:15:20 INFO - Blob upload gear active. 23:15:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:15:20 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 23:15:20 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'] 23:15:20 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 23:15:20 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:15:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:15:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:21 INFO - (blobuploader) - INFO - Done attempting. 23:15:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:15:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:15:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:22 INFO - (blobuploader) - INFO - Done attempting. 23:15:22 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:22 INFO - Return code: 0 23:15:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:15:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/d2f304858ddbdecb6a5f124b0f63a77ad08f115ec10015144c038afd5e7690f766655490825612a89dc5a21d3e0ab01580830576495a7672dbdef9a283b60e87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/a7c58504eecc595cfa332c446325c3872d92357b0e451f4563f4be20eedc7d96070d9ca9759f84bb4e0926adb724e0d4bfc3ebf897007c9b3f1b247d875e239b"} 23:15:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:15:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:15:22 INFO - Contents: 23:15:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/d2f304858ddbdecb6a5f124b0f63a77ad08f115ec10015144c038afd5e7690f766655490825612a89dc5a21d3e0ab01580830576495a7672dbdef9a283b60e87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/a7c58504eecc595cfa332c446325c3872d92357b0e451f4563f4be20eedc7d96070d9ca9759f84bb4e0926adb724e0d4bfc3ebf897007c9b3f1b247d875e239b"} 23:15:22 INFO - Running post-run listener: copy_logs_to_upload_dir 23:15:22 INFO - Copying logs to upload dir... 23:15:22 INFO - mkdir: /builds/slave/test/build/upload/logs 23:15:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.968034 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-02 23:15:22.421960) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 23:15:22.425097) ========= 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=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 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/d2f304858ddbdecb6a5f124b0f63a77ad08f115ec10015144c038afd5e7690f766655490825612a89dc5a21d3e0ab01580830576495a7672dbdef9a283b60e87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/a7c58504eecc595cfa332c446325c3872d92357b0e451f4563f4be20eedc7d96070d9ca9759f84bb4e0926adb724e0d4bfc3ebf897007c9b3f1b247d875e239b"} build_url:https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/aaOQtGCpRnu9LiPSSGLpfg/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/d2f304858ddbdecb6a5f124b0f63a77ad08f115ec10015144c038afd5e7690f766655490825612a89dc5a21d3e0ab01580830576495a7672dbdef9a283b60e87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/a7c58504eecc595cfa332c446325c3872d92357b0e451f4563f4be20eedc7d96070d9ca9759f84bb4e0926adb724e0d4bfc3ebf897007c9b3f1b247d875e239b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 23:15:22.449531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 23:15:22.449854) ========= 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=7de08804244eb36560b44971000001c3-1456987808.339529-1541909988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 23:15:22.532345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 23:15:22.532649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 23:15:22.532957) ========= ========= Total master_lag: 0.30 =========