builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1457727467.68 results: success (0) buildid: 20160311094013 builduid: 5c58504ac47643f29d85badfbb9238f0 revision: 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.679124) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.679483) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.679758) ========= 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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006321 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.710377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.710646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.756310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.756577) ========= 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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.811760) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.812034) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.812347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:47.812817) ========= 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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 12:17:48-- 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% 51.6M=0s 2016-03-11 12:17:48 (51.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164259 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.007300) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.007591) ========= 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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015619 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.063957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.064256) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e --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 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e --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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 12:17:48,369 truncating revision to first 12 chars 2016-03-11 12:17:48,370 Setting DEBUG logging. 2016-03-11 12:17:48,370 attempt 1/10 2016-03-11 12:17:48,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/7c842ac0b9cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 12:17:48,637 unpacking tar archive at: date-7c842ac0b9cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556280 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.633392) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.633692) ========= echo 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e'] 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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e program finished with exit code 0 elapsedTime=0.004715 script_repo_revision: '7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.717463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.717762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:48.732828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-11 12:17:48.733105) ========= /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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:17:49 INFO - MultiFileLogger online at 20160311 12:17:49 in /builds/slave/test 12:17:49 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 12:17:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:49 INFO - {'append_to_log': False, 12:17:49 INFO - 'base_work_dir': '/builds/slave/test', 12:17:49 INFO - 'blob_upload_branch': 'Date-Non-PGO', 12:17:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:49 INFO - 'branch': 'Date-Non-PGO', 12:17:49 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:49 INFO - 'config_files': ('talos/linux_config.py',), 12:17:49 INFO - 'default_actions': ('clobber', 12:17:49 INFO - 'read-buildbot-config', 12:17:49 INFO - 'download-and-extract', 12:17:49 INFO - 'populate-webroot', 12:17:49 INFO - 'create-virtualenv', 12:17:49 INFO - 'install', 12:17:49 INFO - 'run-tests'), 12:17:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:49 INFO - 'download_minidump_stackwalk': True, 12:17:49 INFO - 'download_symbols': 'ondemand', 12:17:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:49 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:49 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:49 INFO - 'installer_path': 'installer.exe', 12:17:49 INFO - 'log_level': 'info', 12:17:49 INFO - 'log_name': 'talos', 12:17:49 INFO - 'log_to_console': True, 12:17:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:17:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:17:49 INFO - 'opt_config_files': (), 12:17:49 INFO - 'pip_index': False, 12:17:49 INFO - 'sps_profile': False, 12:17:49 INFO - 'sps_profile_interval': 0, 12:17:49 INFO - 'suite': 'dromaeojs', 12:17:49 INFO - 'system_bits': '32', 12:17:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:49 INFO - 'title': 'talos-linux64-ix-018', 12:17:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:49 INFO - 'use_talos_json': True, 12:17:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:49 INFO - 'work_dir': 'build'} 12:17:49 INFO - ##### 12:17:49 INFO - ##### Running clobber step. 12:17:49 INFO - ##### 12:17:49 INFO - Running pre-action listener: _resource_record_pre_action 12:17:49 INFO - Running main action method: clobber 12:17:49 INFO - rmtree: /builds/slave/test/build 12:17:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:49 INFO - Running post-action listener: _resource_record_post_action 12:17:49 INFO - ##### 12:17:49 INFO - ##### Running read-buildbot-config step. 12:17:49 INFO - ##### 12:17:49 INFO - Running pre-action listener: _resource_record_pre_action 12:17:49 INFO - Running main action method: read_buildbot_config 12:17:49 INFO - Using buildbot properties: 12:17:49 INFO - { 12:17:49 INFO - "project": "", 12:17:49 INFO - "product": "firefox", 12:17:49 INFO - "script_repo_revision": "production", 12:17:49 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 12:17:49 INFO - "repository": "", 12:17:49 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 12:17:49 INFO - "buildid": "20160311094013", 12:17:49 INFO - "pgo_build": "False", 12:17:49 INFO - "basedir": "/builds/slave/test", 12:17:49 INFO - "buildnumber": 5, 12:17:49 INFO - "slavename": "talos-linux64-ix-018", 12:17:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:17:49 INFO - "platform": "ubuntu64_hw", 12:17:49 INFO - "scheduler": "tests-date-linux64-talos", 12:17:49 INFO - "branch": "date", 12:17:49 INFO - "repo_path": "projects/date", 12:17:49 INFO - "revision": "7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e", 12:17:49 INFO - "stage_platform": "linux64", 12:17:49 INFO - "builduid": "5c58504ac47643f29d85badfbb9238f0", 12:17:49 INFO - "slavebuilddir": "test" 12:17:49 INFO - } 12:17:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 12:17:49 INFO - Running post-action listener: _resource_record_post_action 12:17:49 INFO - ##### 12:17:49 INFO - ##### Running download-and-extract step. 12:17:49 INFO - ##### 12:17:49 INFO - Running pre-action listener: _resource_record_pre_action 12:17:49 INFO - Running main action method: download_and_extract 12:17:49 INFO - mkdir: /builds/slave/test/build/tests 12:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:49 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:17:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json 12:17:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json 12:17:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:17:58 INFO - Downloaded 1412 bytes. 12:17:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:17:58 INFO - Using the following test package requirements: 12:17:58 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:17:58 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:58 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:17:58 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:58 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 12:17:58 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:58 INFO - u'jsshell-linux-x86_64.zip'], 12:17:58 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:58 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:17:58 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:17:58 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:58 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 12:17:58 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:58 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 12:17:58 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:58 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:17:58 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:17:58 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:58 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:17:58 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:58 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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 12:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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 12:18:00 INFO - Downloaded 23091831 bytes. 12:18:00 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'] 12:18:00 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 12:18:01 INFO - Return code: 0 12:18:01 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 12:18:01 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')]} 12:18:01 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:18:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:18:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:18:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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 12:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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 12:18:04 INFO - Downloaded 23091831 bytes. 12:18:04 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'] 12:18:04 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 12:18:05 INFO - Return code: 0 12:18:05 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')]} 12:18:05 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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 12:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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 12:18:08 INFO - Downloaded 10706668 bytes. 12:18:08 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'] 12:18:08 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 12:18:08 INFO - Return code: 0 12:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:08 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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 12:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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 12:18:10 INFO - Downloaded 52848527 bytes. 12:18:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:18:10 INFO - mkdir: /builds/slave/test/properties 12:18:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:10 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:10 INFO - Contents: 12:18:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:18:11 INFO - Running post-action listener: _resource_record_post_action 12:18:11 INFO - Running post-action listener: set_extra_try_arguments 12:18:11 INFO - ##### 12:18:11 INFO - ##### Running populate-webroot step. 12:18:11 INFO - ##### 12:18:11 INFO - Running pre-action listener: _resource_record_pre_action 12:18:11 INFO - Running main action method: populate_webroot 12:18:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:11 INFO - '--tppagecycles', 12:18:11 INFO - '7'], 12:18:11 INFO - 'tests': ['tsvgm']}}, 12:18:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:18:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:18:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:18:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:11 INFO - 'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:11 INFO - 'tests': ['damp', 'tps']}, 12:18:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:11 INFO - 'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['damp', 'tps']}, 12:18:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:18:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:11 INFO - 'other': {'tests': ['a11yr', 12:18:11 INFO - 'ts_paint', 12:18:11 INFO - 'tpaint', 12:18:11 INFO - 'sessionrestore', 12:18:11 INFO - 'sessionrestore_no_auto_restore']}, 12:18:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['a11yr', 12:18:11 INFO - 'ts_paint', 12:18:11 INFO - 'tpaint', 12:18:11 INFO - 'sessionrestore', 12:18:11 INFO - 'sessionrestore_no_auto_restore']}, 12:18:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['a11yr', 12:18:11 INFO - 'ts_paint', 12:18:11 INFO - 'tpaint', 12:18:11 INFO - 'sessionrestore', 12:18:11 INFO - 'sessionrestore_no_auto_restore']}, 12:18:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['a11yr', 12:18:11 INFO - 'ts_paint', 12:18:11 INFO - 'tpaint', 12:18:11 INFO - 'sessionrestore', 12:18:11 INFO - 'sessionrestore_no_auto_restore']}, 12:18:11 INFO - 'other_l64': {'tests': ['a11yr', 12:18:11 INFO - 'ts_paint', 12:18:11 INFO - 'tpaint', 12:18:11 INFO - 'sessionrestore', 12:18:11 INFO - 'sessionrestore_no_auto_restore']}, 12:18:11 INFO - 'other_nol64': {'tests': ['a11yr', 12:18:11 INFO - 'ts_paint', 12:18:11 INFO - 'tpaint', 12:18:11 INFO - 'sessionrestore', 12:18:11 INFO - 'sessionrestore_no_auto_restore']}, 12:18:11 INFO - 'svgr': {'tests': ['tsvgx', 12:18:11 INFO - 'tsvgr_opacity', 12:18:11 INFO - 'tart', 12:18:11 INFO - 'tscrollx', 12:18:11 INFO - 'cart']}, 12:18:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['tsvgx', 12:18:11 INFO - 'tsvgr_opacity', 12:18:11 INFO - 'tart', 12:18:11 INFO - 'tscrollx', 12:18:11 INFO - 'cart']}, 12:18:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:11 INFO - 'tests': ['tp5o']}, 12:18:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:11 INFO - 'talos_options': ['--e10s'], 12:18:11 INFO - 'tests': ['tp5o']}, 12:18:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:11 INFO - 'talos_options': ['--xperf_path', 12:18:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:11 INFO - 'tests': ['tp5n']}, 12:18:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:11 INFO - 'talos_options': ['--e10s', 12:18:11 INFO - '--xperf_path', 12:18:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:11 INFO - 'tests': ['tp5n']}}, 12:18:11 INFO - 'talos.zip': {'path': '', 12:18:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:11 INFO - Running post-action listener: _resource_record_post_action 12:18:11 INFO - ##### 12:18:11 INFO - ##### Running create-virtualenv step. 12:18:11 INFO - ##### 12:18:11 INFO - Running pre-action listener: _resource_record_pre_action 12:18:11 INFO - Running main action method: create_virtualenv 12:18:11 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:11 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 12:18:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:11 INFO - Using real prefix '/usr' 12:18:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:12 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:14 INFO - Installing pip.................done. 12:18:14 INFO - Return code: 0 12:18:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:18:14 INFO - Using env: {'DISPLAY': ':0', 12:18:14 INFO - 'HOME': '/home/cltbld', 12:18:14 INFO - 'LANG': 'en_US.UTF-8', 12:18:14 INFO - 'LANGUAGE': 'en_US:en', 12:18:14 INFO - 'LOGNAME': 'cltbld', 12:18:14 INFO - 'MAIL': '/var/mail/cltbld', 12:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:14 INFO - 'MOZ_NO_REMOTE': '1', 12:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:14 INFO - 'NO_EM_RESTART': '1', 12:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:14 INFO - 'PWD': '/builds/slave/test', 12:18:14 INFO - 'SHELL': '/bin/bash', 12:18:14 INFO - 'SHLVL': '1', 12:18:14 INFO - 'TERM': 'linux', 12:18:14 INFO - 'TMOUT': '86400', 12:18:14 INFO - 'USER': 'cltbld', 12:18:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:14 INFO - '_': '/tools/buildbot/bin/python'} 12:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:14 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 12:18:14 INFO - Cleaning up... 12:18:14 INFO - Return code: 0 12:18:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:18:14 INFO - Using env: {'DISPLAY': ':0', 12:18:14 INFO - 'HOME': '/home/cltbld', 12:18:14 INFO - 'LANG': 'en_US.UTF-8', 12:18:14 INFO - 'LANGUAGE': 'en_US:en', 12:18:14 INFO - 'LOGNAME': 'cltbld', 12:18:14 INFO - 'MAIL': '/var/mail/cltbld', 12:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:14 INFO - 'MOZ_NO_REMOTE': '1', 12:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:14 INFO - 'NO_EM_RESTART': '1', 12:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:14 INFO - 'PWD': '/builds/slave/test', 12:18:14 INFO - 'SHELL': '/bin/bash', 12:18:14 INFO - 'SHLVL': '1', 12:18:14 INFO - 'TERM': 'linux', 12:18:14 INFO - 'TMOUT': '86400', 12:18:14 INFO - 'USER': 'cltbld', 12:18:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:14 INFO - '_': '/tools/buildbot/bin/python'} 12:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:14 INFO - Downloading/unpacking psutil>=0.7.1 12:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:16 INFO - Installing collected packages: psutil 12:18:16 INFO - Running setup.py install for psutil 12:18:16 INFO - building 'psutil._psutil_linux' extension 12:18:16 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 12:18:16 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 12:18:16 INFO - building 'psutil._psutil_posix' extension 12:18:16 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 12:18:16 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 12:18:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:16 INFO - Successfully installed psutil 12:18:16 INFO - Cleaning up... 12:18:17 INFO - Return code: 0 12:18:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:17 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 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:17 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 12:18:17 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 12:18:17 INFO - Using env: {'DISPLAY': ':0', 12:18:17 INFO - 'HOME': '/home/cltbld', 12:18:17 INFO - 'LANG': 'en_US.UTF-8', 12:18:17 INFO - 'LANGUAGE': 'en_US:en', 12:18:17 INFO - 'LOGNAME': 'cltbld', 12:18:17 INFO - 'MAIL': '/var/mail/cltbld', 12:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:17 INFO - 'MOZ_NO_REMOTE': '1', 12:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:17 INFO - 'NO_EM_RESTART': '1', 12:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:17 INFO - 'PWD': '/builds/slave/test', 12:18:17 INFO - 'SHELL': '/bin/bash', 12:18:17 INFO - 'SHLVL': '1', 12:18:17 INFO - 'TERM': 'linux', 12:18:17 INFO - 'TMOUT': '86400', 12:18:17 INFO - 'USER': 'cltbld', 12:18:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:17 INFO - '_': '/tools/buildbot/bin/python'} 12:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:18:17 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 12:18:17 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 12:18:17 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 12:18:17 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 12:18:17 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 12:18:17 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 12:18:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:18:19 INFO - Installing collected packages: mozsystemmonitor 12:18:19 INFO - Running setup.py install for mozsystemmonitor 12:18:19 INFO - Successfully installed mozsystemmonitor 12:18:19 INFO - Cleaning up... 12:18:19 INFO - Return code: 0 12:18:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:19 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 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:19 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 12:18:19 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 12:18:19 INFO - Using env: {'DISPLAY': ':0', 12:18:19 INFO - 'HOME': '/home/cltbld', 12:18:19 INFO - 'LANG': 'en_US.UTF-8', 12:18:19 INFO - 'LANGUAGE': 'en_US:en', 12:18:19 INFO - 'LOGNAME': 'cltbld', 12:18:19 INFO - 'MAIL': '/var/mail/cltbld', 12:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:19 INFO - 'MOZ_NO_REMOTE': '1', 12:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:19 INFO - 'NO_EM_RESTART': '1', 12:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:19 INFO - 'PWD': '/builds/slave/test', 12:18:19 INFO - 'SHELL': '/bin/bash', 12:18:19 INFO - 'SHLVL': '1', 12:18:19 INFO - 'TERM': 'linux', 12:18:19 INFO - 'TMOUT': '86400', 12:18:19 INFO - 'USER': 'cltbld', 12:18:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:19 INFO - '_': '/tools/buildbot/bin/python'} 12:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:19 INFO - Downloading/unpacking blobuploader==1.2.4 12:18:19 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 12:18:19 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 12:18:19 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 12:18:19 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 12:18:19 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 12:18:19 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 12:18:21 INFO - Downloading blobuploader-1.2.4.tar.gz 12:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:18:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:18:21 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 12:18:21 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 12:18:21 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 12:18:21 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 12:18:21 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 12:18:21 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 12:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:18:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:18:21 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 12:18:21 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 12:18:21 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 12:18:21 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 12:18:21 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 12:18:21 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 12:18:22 INFO - Downloading docopt-0.6.1.tar.gz 12:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:18:22 INFO - Installing collected packages: blobuploader, requests, docopt 12:18:22 INFO - Running setup.py install for blobuploader 12:18:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:18:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:18:22 INFO - Running setup.py install for requests 12:18:22 INFO - Running setup.py install for docopt 12:18:22 INFO - Successfully installed blobuploader requests docopt 12:18:22 INFO - Cleaning up... 12:18:22 INFO - Return code: 0 12:18:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:22 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 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:22 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 12:18:22 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 12:18:22 INFO - Using env: {'DISPLAY': ':0', 12:18:22 INFO - 'HOME': '/home/cltbld', 12:18:22 INFO - 'LANG': 'en_US.UTF-8', 12:18:22 INFO - 'LANGUAGE': 'en_US:en', 12:18:22 INFO - 'LOGNAME': 'cltbld', 12:18:22 INFO - 'MAIL': '/var/mail/cltbld', 12:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:22 INFO - 'MOZ_NO_REMOTE': '1', 12:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:22 INFO - 'NO_EM_RESTART': '1', 12:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:22 INFO - 'PWD': '/builds/slave/test', 12:18:22 INFO - 'SHELL': '/bin/bash', 12:18:22 INFO - 'SHLVL': '1', 12:18:22 INFO - 'TERM': 'linux', 12:18:22 INFO - 'TMOUT': '86400', 12:18:22 INFO - 'USER': 'cltbld', 12:18:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:22 INFO - '_': '/tools/buildbot/bin/python'} 12:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:23 INFO - Running setup.py (path:/tmp/pip-SFSght-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:23 INFO - Running setup.py (path:/tmp/pip-HP3mTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:23 INFO - Running setup.py (path:/tmp/pip-L__aoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:23 INFO - Running setup.py (path:/tmp/pip-d7vPc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:23 INFO - Running setup.py (path:/tmp/pip-Z7xANX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:23 INFO - Running setup.py (path:/tmp/pip-MncN4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:23 INFO - Running setup.py (path:/tmp/pip-NtcmX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:23 INFO - Running setup.py (path:/tmp/pip-Nb8a0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:23 INFO - Running setup.py (path:/tmp/pip-IYqfCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:23 INFO - Running setup.py (path:/tmp/pip-cSZw9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:23 INFO - Running setup.py (path:/tmp/pip-JxKIPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:23 INFO - Running setup.py (path:/tmp/pip-6q35Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:23 INFO - Running setup.py (path:/tmp/pip-fAaF0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:23 INFO - Running setup.py (path:/tmp/pip-CYzwYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:24 INFO - Running setup.py (path:/tmp/pip-zV3qrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:24 INFO - Running setup.py (path:/tmp/pip-Kvh_LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:24 INFO - Running setup.py (path:/tmp/pip-VSmqgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:18:24 INFO - Running setup.py install for manifestparser 12:18:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:18:24 INFO - Running setup.py install for mozcrash 12:18:24 INFO - Running setup.py install for mozdebug 12:18:24 INFO - Running setup.py install for mozdevice 12:18:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:18:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:18:24 INFO - Running setup.py install for mozfile 12:18:24 INFO - Running setup.py install for mozhttpd 12:18:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:18:24 INFO - Running setup.py install for mozinfo 12:18:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:18:24 INFO - Running setup.py install for mozInstall 12:18:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozleak 12:18:25 INFO - Running setup.py install for mozlog 12:18:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for moznetwork 12:18:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozprocess 12:18:25 INFO - Running setup.py install for mozprofile 12:18:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozrunner 12:18:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozscreenshot 12:18:25 INFO - Running setup.py install for moztest 12:18:25 INFO - Running setup.py install for mozversion 12:18:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:18:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:18:26 INFO - Cleaning up... 12:18:26 INFO - Return code: 0 12:18:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:26 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 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:26 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 12:18:26 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 12:18:26 INFO - Using env: {'DISPLAY': ':0', 12:18:26 INFO - 'HOME': '/home/cltbld', 12:18:26 INFO - 'LANG': 'en_US.UTF-8', 12:18:26 INFO - 'LANGUAGE': 'en_US:en', 12:18:26 INFO - 'LOGNAME': 'cltbld', 12:18:26 INFO - 'MAIL': '/var/mail/cltbld', 12:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:26 INFO - 'MOZ_NO_REMOTE': '1', 12:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:26 INFO - 'NO_EM_RESTART': '1', 12:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:26 INFO - 'PWD': '/builds/slave/test', 12:18:26 INFO - 'SHELL': '/bin/bash', 12:18:26 INFO - 'SHLVL': '1', 12:18:26 INFO - 'TERM': 'linux', 12:18:26 INFO - 'TMOUT': '86400', 12:18:26 INFO - 'USER': 'cltbld', 12:18:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:26 INFO - '_': '/tools/buildbot/bin/python'} 12:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:26 INFO - Running setup.py (path:/tmp/pip-7arLhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:26 INFO - Running setup.py (path:/tmp/pip-PjFWUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:26 INFO - Running setup.py (path:/tmp/pip-aO4KVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:26 INFO - Running setup.py (path:/tmp/pip-ISdAY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:26 INFO - Running setup.py (path:/tmp/pip-MeqHaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:26 INFO - Running setup.py (path:/tmp/pip-2YDYuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:26 INFO - Running setup.py (path:/tmp/pip-0JrcRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:26 INFO - Running setup.py (path:/tmp/pip-4c2hAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:26 INFO - Running setup.py (path:/tmp/pip-gDbjoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:26 INFO - Running setup.py (path:/tmp/pip-hgNGSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:26 INFO - Running setup.py (path:/tmp/pip-4INvgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:27 INFO - Running setup.py (path:/tmp/pip-LIJ0mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:27 INFO - Running setup.py (path:/tmp/pip-zbf4pC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:27 INFO - Running setup.py (path:/tmp/pip-hqvMin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:27 INFO - Running setup.py (path:/tmp/pip-xNFTCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:27 INFO - Running setup.py (path:/tmp/pip-oPo4cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:27 INFO - Running setup.py (path:/tmp/pip-6K6UvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:27 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)) 12:18:27 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)) 12:18:27 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)) 12:18:27 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)) 12:18:27 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)) 12:18:27 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)) 12:18:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:29 INFO - Downloading blessings-1.6.tar.gz 12:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:18:29 INFO - Installing collected packages: blessings 12:18:29 INFO - Running setup.py install for blessings 12:18:29 INFO - Successfully installed blessings 12:18:29 INFO - Cleaning up... 12:18:29 INFO - Return code: 0 12:18:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:18:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:29 INFO - Reading from file tmpfile_stdout 12:18:29 INFO - Current package versions: 12:18:29 INFO - argparse == 1.2.1 12:18:29 INFO - blessings == 1.6 12:18:29 INFO - blobuploader == 1.2.4 12:18:29 INFO - docopt == 0.6.1 12:18:29 INFO - manifestparser == 1.1 12:18:29 INFO - mozInstall == 1.12 12:18:29 INFO - mozcrash == 0.16 12:18:29 INFO - mozdebug == 0.1 12:18:29 INFO - mozdevice == 0.48 12:18:29 INFO - mozfile == 1.2 12:18:29 INFO - mozhttpd == 0.7 12:18:29 INFO - mozinfo == 0.9 12:18:29 INFO - mozleak == 0.1 12:18:29 INFO - mozlog == 3.1 12:18:29 INFO - moznetwork == 0.27 12:18:29 INFO - mozprocess == 0.22 12:18:29 INFO - mozprofile == 0.28 12:18:29 INFO - mozrunner == 6.11 12:18:29 INFO - mozscreenshot == 0.1 12:18:29 INFO - mozsystemmonitor == 0.0 12:18:29 INFO - moztest == 0.7 12:18:29 INFO - mozversion == 1.4 12:18:29 INFO - psutil == 3.1.1 12:18:29 INFO - requests == 1.2.3 12:18:29 INFO - wsgiref == 0.1.2 12:18:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:29 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 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:29 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 12:18:29 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 12:18:29 INFO - Using env: {'DISPLAY': ':0', 12:18:29 INFO - 'HOME': '/home/cltbld', 12:18:29 INFO - 'LANG': 'en_US.UTF-8', 12:18:29 INFO - 'LANGUAGE': 'en_US:en', 12:18:29 INFO - 'LOGNAME': 'cltbld', 12:18:29 INFO - 'MAIL': '/var/mail/cltbld', 12:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:29 INFO - 'MOZ_NO_REMOTE': '1', 12:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:29 INFO - 'NO_EM_RESTART': '1', 12:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:29 INFO - 'PWD': '/builds/slave/test', 12:18:29 INFO - 'SHELL': '/bin/bash', 12:18:29 INFO - 'SHLVL': '1', 12:18:29 INFO - 'TERM': 'linux', 12:18:29 INFO - 'TMOUT': '86400', 12:18:29 INFO - 'USER': 'cltbld', 12:18:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:29 INFO - '_': '/tools/buildbot/bin/python'} 12:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 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)) 12:18:29 INFO - Cleaning up... 12:18:29 INFO - Return code: 0 12:18:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:18:29 INFO - Using env: {'DISPLAY': ':0', 12:18:29 INFO - 'HOME': '/home/cltbld', 12:18:29 INFO - 'LANG': 'en_US.UTF-8', 12:18:29 INFO - 'LANGUAGE': 'en_US:en', 12:18:29 INFO - 'LOGNAME': 'cltbld', 12:18:29 INFO - 'MAIL': '/var/mail/cltbld', 12:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:29 INFO - 'MOZ_NO_REMOTE': '1', 12:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:29 INFO - 'NO_EM_RESTART': '1', 12:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:29 INFO - 'PWD': '/builds/slave/test', 12:18:29 INFO - 'SHELL': '/bin/bash', 12:18:29 INFO - 'SHLVL': '1', 12:18:29 INFO - 'TERM': 'linux', 12:18:30 INFO - 'TMOUT': '86400', 12:18:30 INFO - 'USER': 'cltbld', 12:18:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:30 INFO - '_': '/tools/buildbot/bin/python'} 12:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:30 INFO - Downloading/unpacking jsonschema 12:18:30 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 12:18:30 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 12:18:30 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 12:18:30 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 12:18:30 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 12:18:30 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 12:18:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:18:32 INFO - Downloading/unpacking functools32 (from jsonschema) 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 INFO - Downloading functools32-3.2.3-2.tar.gz 12:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:18:32 INFO - warning: no files found matching '*.txt' 12:18:32 INFO - no previously-included directories found matching 'build' 12:18:32 INFO - no previously-included directories found matching 'dist' 12:18:32 INFO - no previously-included directories found matching '.git*' 12:18:32 INFO - Installing collected packages: jsonschema, functools32 12:18:32 INFO - Running setup.py install for functools32 12:18:32 INFO - warning: no files found matching '*.txt' 12:18:32 INFO - no previously-included directories found matching 'build' 12:18:32 INFO - no previously-included directories found matching 'dist' 12:18:32 INFO - no previously-included directories found matching '.git*' 12:18:32 INFO - Successfully installed jsonschema functools32 12:18:32 INFO - Cleaning up... 12:18:32 INFO - Return code: 0 12:18:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f245b0bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2480e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, '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': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', '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 12:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:18:32 INFO - Using env: {'DISPLAY': ':0', 12:18:32 INFO - 'HOME': '/home/cltbld', 12:18:32 INFO - 'LANG': 'en_US.UTF-8', 12:18:32 INFO - 'LANGUAGE': 'en_US:en', 12:18:32 INFO - 'LOGNAME': 'cltbld', 12:18:32 INFO - 'MAIL': '/var/mail/cltbld', 12:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:32 INFO - 'MOZ_NO_REMOTE': '1', 12:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:32 INFO - 'NO_EM_RESTART': '1', 12:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:32 INFO - 'PWD': '/builds/slave/test', 12:18:32 INFO - 'SHELL': '/bin/bash', 12:18:32 INFO - 'SHLVL': '1', 12:18:32 INFO - 'TERM': 'linux', 12:18:32 INFO - 'TMOUT': '86400', 12:18:32 INFO - 'USER': 'cltbld', 12:18:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:32 INFO - '_': '/tools/buildbot/bin/python'} 12:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:32 INFO - Downloading/unpacking flake8 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:18:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:18:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:34 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 12:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:18:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:18:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:18:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:18:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:18:35 INFO - no previously-included directories found matching 'docs/_build' 12:18:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:18:35 INFO - Running setup.py install for pep8 12:18:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:18:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:18:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:18:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:18:35 INFO - no previously-included directories found matching 'docs/_build' 12:18:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:18:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:18:35 INFO - Cleaning up... 12:18:35 INFO - Return code: 0 12:18:35 INFO - Running post-action listener: _resource_record_post_action 12:18:35 INFO - Running post-action listener: _start_resource_monitoring 12:18:35 INFO - Starting resource monitoring. 12:18:35 INFO - ##### 12:18:35 INFO - ##### Running install step. 12:18:35 INFO - ##### 12:18:35 INFO - Running pre-action listener: _resource_record_pre_action 12:18:35 INFO - Running main action method: install 12:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:35 INFO - Reading from file tmpfile_stdout 12:18:35 INFO - Detecting whether we're running mozinstall >=1.0... 12:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:18:35 INFO - Reading from file tmpfile_stdout 12:18:35 INFO - Output received: 12:18:35 INFO - Usage: mozinstall [options] installer 12:18:35 INFO - Options: 12:18:35 INFO - -h, --help show this help message and exit 12:18:35 INFO - -d DEST, --destination=DEST 12:18:35 INFO - Directory to install application into. [default: 12:18:35 INFO - "/builds/slave/test"] 12:18:35 INFO - --app=APP Application being installed. [default: firefox] 12:18:35 INFO - mkdir: /builds/slave/test/build/application 12:18:35 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'] 12:18:35 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 12:18:48 INFO - Reading from file tmpfile_stdout 12:18:48 INFO - Output received: 12:18:48 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:48 INFO - Running post-action listener: _resource_record_post_action 12:18:48 INFO - ##### 12:18:48 INFO - ##### Running run-tests step. 12:18:48 INFO - ##### 12:18:48 INFO - Running pre-action listener: _resource_record_pre_action 12:18:48 INFO - Running main action method: run_tests 12:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:48 INFO - Python 2.7.3 12:18:48 INFO - Return code: 0 12:18:48 INFO - grabbing minidump binary from tooltool 12:18: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')]} 12:18:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2513430>, '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 0x247ef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f3c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:18:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:18:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:48 INFO - Return code: 0 12:18:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:18:49 INFO - Return code: 0 12:18:49 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/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 12:18:49 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/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 12:18:49 INFO - Using env: {'DISPLAY': ':0', 12:18:49 INFO - 'HOME': '/home/cltbld', 12:18:49 INFO - 'LANG': 'en_US.UTF-8', 12:18:49 INFO - 'LANGUAGE': 'en_US:en', 12:18:49 INFO - 'LOGNAME': 'cltbld', 12:18:49 INFO - 'MAIL': '/var/mail/cltbld', 12:18:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:49 INFO - 'MOZ_NO_REMOTE': '1', 12:18:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:49 INFO - 'NO_EM_RESTART': '1', 12:18:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:49 INFO - 'PWD': '/builds/slave/test', 12:18:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:49 INFO - 'SHELL': '/bin/bash', 12:18:49 INFO - 'SHLVL': '1', 12:18:49 INFO - 'TERM': 'linux', 12:18:49 INFO - 'TMOUT': '86400', 12:18:49 INFO - 'USER': 'cltbld', 12:18:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263', 12:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:49 INFO - '_': '/tools/buildbot/bin/python'} 12:18:49 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/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 12:18:49 INFO - mozversion application_buildid: 20160311094013 12:18:49 INFO - mozversion application_changeset: 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e 12:18:49 INFO - mozversion application_display_name: Firefox 12:18:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:49 INFO - mozversion application_name: Firefox 12:18:49 INFO - mozversion application_remotingname: firefox 12:18:49 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 12:18:49 INFO - mozversion application_vendor: Mozilla 12:18:49 INFO - mozversion application_version: 46.0 12:18:49 INFO - mozversion platform_buildid: 20160311094013 12:18:49 INFO - mozversion platform_changeset: 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e 12:18:49 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 12:18:49 INFO - mozversion platform_version: 46.0 12:18:49 INFO - using testdate: 1457727529 12:18:49 INFO - actual date: 1457727529 12:18:49 INFO - starting webserver on 'localhost:56511' 12:18:49 INFO - SUITE-START | Running 3 tests 12:18:49 INFO - TEST-START | dromaeo_css 12:18:49 INFO - operating with platform_type : linux_ 12:18:49 INFO - Initialising browser for dromaeo_css test... 12:18:49 INFO - TEST-INFO | started process 12078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsH4aFg/profile http://localhost:56511/getInfo.html) 12:18:53 INFO - PROCESS | 12078 | __metrics Screen width/height:1600/1200 12:18:53 INFO - PROCESS | 12078 | colorDepth:24 12:18:53 INFO - PROCESS | 12078 | Browser inner width/height: 1024/697 12:18:53 INFO - PROCESS | 12078 | __metrics 12:18:53 INFO - PROCESS | 12078 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:18:54 INFO - TEST-INFO | 12078: exit 0 12:18:54 INFO - Browser initialized. 12:18:54 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:54 INFO - TEST-INFO | started process 12170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsH4aFg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:06 INFO - PROCESS | 12170 | RSS: Main: 135753728 12:19:06 INFO - PROCESS | 12170 | 12:19:57 INFO - PROCESS | 12170 | 1457727597217 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] 12:22:04 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:56511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56511/tests/dromaeo/cssquery-ext.html) 12:22:06 INFO - PROCESS | 12170 | RSS: Main: 266186752 12:22:06 INFO - PROCESS | 12170 | 12:25:08 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:56511/tests/dromaeo/cssquery-ext.html (next: http://localhost:56511/tests/dromaeo/cssquery-jquery.html) 12:25:09 INFO - PROCESS | 12170 | RSS: Main: 223350784 12:25:09 INFO - PROCESS | 12170 | 12:28:10 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:56511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56511/tests/dromaeo/cssquery-mootools.html) 12:28:11 INFO - PROCESS | 12170 | RSS: Main: 224034816 12:28:11 INFO - PROCESS | 12170 | 12:31:13 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:56511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56511/tests/dromaeo/cssquery-prototype.html) 12:31:13 INFO - PROCESS | 12170 | RSS: Main: 203870208 12:31:13 INFO - PROCESS | 12170 | 12:34:16 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:56511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56511/tests/dromaeo/cssquery-yui.html) 12:34:16 INFO - PROCESS | 12170 | RSS: Main: 204181504 12:34:16 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:56511/tests/dromaeo/cssquery-yui.html (next: http://localhost:56511/tests/dromaeo/cssquery-dojo.html) 12:37:18 INFO - PROCESS | 12170 | RSS: Main: 237350912 12:37:18 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | __start_tp_report 12:37:18 INFO - PROCESS | 12170 | _x_x_mozilla_page_load 12:37:18 INFO - PROCESS | 12170 | _x_x_mozilla_page_load_details 12:37:18 INFO - PROCESS | 12170 | |i|pagename|runs| 12:37:18 INFO - PROCESS | 12170 | |0;dojo.html;3191.345774116306;3270.6729327067283;3299.6865297796717;3305.2728399752045;3327.4676051831702;5232.267482552436;5249.8687532811655;5267.13092339764;5272.736363181835;5281.18141688038;5259.815906443275;5295.8146464873735;5304.283921670573;5312.707801070939;5352.652077614962;4750.667453278272;4814.1575224335775;4828.855134345967;4835.78238979245;4845.37010188675;4888.462269150391;4893.853184404474;4914.459409464956;4919.754012299389;4926.3842019747535;4801.543853333945;4835.202191638393;4863.2461968394955;4890.706557606537;4916.0905232532095;4895.706257624536;4935.80256789728;4954.405471343426;4962.702237865704;4989.625778066623;4719.693219940693;4867.512094125164;4880.048390563841;4898.779554920037;4929.8028078876805;5076.466970968069;5166.044281807877;5214.713190774506;5217.243499692523;5228.163493841005;5640.5487560995025;5673.375928647845;5674.262345895048;5678.26182596264;5678.659280443187;5609.971950140223;5645.1532270159805;5694.5159661428825;5706.115552089433;5707.1153971134545;5322.840314790524;5373.489518495737;5402.756875940592;5403.2705584746345;5426.972865135649;5781;5784.739686714108;5785.50823180026;5794.652320860761;5795.1886735857015;5501.724913754297;5569.192467092249;5602.0196465618355;5602.2717046783655;5612.747426365823;5674.943250567441;5694.9430505695245;5700.857478562986;5701.71491425427;5707.258056452634;5653.802116925888;5662.518685911744;5664.773409063674;5664.801731939445;5671.461211184931;5487.506124448819;5577.330720313588;5578.63738856973;5656.123300888369;5662.235598194274;4400.603945644907;4412.227860124465;4412.801423935931;4420.778961051935;4442.8222871085445;3923.8038098095553;3948.980255098706;3961.2275606256503;3966.960330396717;4005.3591425372383;5267.71027593486;5289.841304760864;5317.946820531823;5376.516113549721;5390.703511306838;5715.599908006399;5731.828045158652;5736.225609542742;5741.511971482387;5747.942520574825;5401.7299135043095;5422.620416570881;5426.891462170814;5434.483724046209;5451.700156491352;4850.611951043908;4938.777755001033;4972.7513624318635;5026.120428924996;5042.873928151752;5812.651240925558;5833.7374818133285;5840.182374467578;5851.502622277069;5895.498882594941;5745.626534275342;5755.992701277176;5759.366469688247;5761;5761.934042202206;5784;5842.561807864512;5877.617954832922;5880.294364676266;5933.881322373615;5603.35561410443;5607.691576963143;5637.379888212376;5637.52081073097;5646.378898321099;5519.530839878495;5714.971425142848;5720.2849643794525;5721.05602575587;5739.9139012914;5427.457254274541;5507.9449205507435;5534.667919924817;5540.1135818270495;5549.694766787866;5628.774849006158;5634.690092044977;5635.182898479779;5639.295088113986;5645.294338207724;5521.061419558604;5521.972390138024;5536.031194540858;5540.279763630863;5546.833594992157;5538.169274608841;5620.74706638194;5621.831345059655;5636.351819540641;5721.399253078367;5408.107662235687;5422.5119739223655;5454.781808727766;5465.371482279589;5496.0931446310915 12:37:18 INFO - PROCESS | 12170 | |1;ext.html;533.8051611161926;562.2662425534678;568.1279236372168;586.580594874665;587.5945597537699;30513;31091.533626995555;31114.066578002697;31125.221869453275;38266.04334891629;41464.37803432951;42284.78857605708;42287;42314.57685423145;42358;8795.120487951202;9017.32370072244;9021.909780902173;9027;9030.322725795591;8650.524221167832;8812.250958668488;8834.028256891737;8835.337349698799;8836.116388361177;8753.912460875405;8831.60257788398;8835.072317406677;8840.38117331787;9102.453852768822;9008.36941414098;9073.183413492752;9094.090590940854;9095.226905713022;9099.226565741887;8740.825183496358;8969.237614802749;8972.775680607972;8996.640134394616;9000.144986226298;41060.79469602663;41561.1687766246;41582;41606.375904361455;41632.79183604093;3450.2236996675797;3671.192337685705;3679;3936.5079365079364;4041.333180025292;31138.84430577855;31566.842165789025;31653.52519712206;31675.049748507583;32058.839705801554;4294.484661840568;4333.566643335673;4408.14041261954;4431;4431.379606855043;269554;269802;270722;270827;271265;58726.70636646875;59528;59851;61388.38611613916;63019;57141.14288285679;57269.71365143148;57382.713086435135;57438.138427923615;57467.71266143726;15838.683226335408;15840.841591583936;15843.841561584468;15979.920100399424;16000.119993400242;13039.804402933964;13079.084464087613;13100.541481048118;13126.343682815821;13202.47190112404;20078.89960550188;20359;20377.592448151252;20588.691169632468;20609.07259173341;7595.772126836204;7687.654055567513;7714;7765.495242809199;7911.723089691834;947.545178314413;981.7594689301167;1004.708634495988;1007.7682133109425;1042.9530671119667;26398;26624.733752662614;26647;26994;27410.451790964467;1027.5222021759917;1081.0054749630358;1117.8211486162174;1202.2786328203008;1243.3907385381278;13990.790138147935;15262.465813696468;16052;16116.113613751122;16213.675726485404;279154;279416;279715;280152;280409;51636.48363516392;51756.74121629443;52157;52351.738241309315;52490;1376.9173849569058;1384.3286006286942;1435.3397437179015;1518.567208345616;1546.26552387615;29850.10449686513;29909.252268692588;32499.35001300008;32506.349873001935;32538.34923301568;48993.75503122604;49582;49658.255126172415;49696.751516242184;49707.751461242464;234647;236346;237911;238250;241292;41188.794056029525;41491.7925410371;41510.377344340464;42040;42646.5735342655;47413;47769;48396;48581.5141848577;49172.75413622909;39764.80117599393;40907.795461022506;40939.976500586534;41355.1728965425;41371.58628413798;37562.87311380554;37935.62064379431;38309.23381532409;38856.80571597124;38885.80557097196;37839.3118322217;38417.80791096027;38661.6133838658;38968.2206355877;38985.02537436473;33673.759006507775;36000.81999589985;36843.447348290334;37157.81421092877;37307.25385492329;27426.314342141606;27688.861555692092;28076.157715268575;28189.859050704614;28282.71717282883 12:37:18 INFO - PROCESS | 12170 | |2;jquery.html;384.5828123365398;387.7479638235147;390.51771062737515;391.670996363055;398.04667820569716;14758.827144584766;15114.39542418302;16561.75157372639;18122.728159077607;18122.99999999998;16179.029258244513;16212;16287.59281017975;18379.632407351844;18427.72358414625;6049.87900241996;6257.5619706620555;6273;6278.121063051177;6280.685965701719;4478.395416618763;4668.603168730662;6154.169187159721;6558.508111891627;6791.219009813861;6458.063580780784;6753.122094127756;6792.932070679304;6947.270536593661;7032.648367581626;5390.676559406448;6729.327067293256;6776.356246156607;6792.184937807446;6837.3162683731725;5456.154296084113;5458.918116228259;5462.426445223274;5465.562754979632;5466.070767969415;13933.651658708613;20596.5880682387;21180.788192118034;21229.363119106296;21544.461388465257;2222.3666255117214;2263.6717675936898;2270.7388650305097;2299.057386471539;2387.192428077214;10141.190793152775;10197.847032294521;10219.386836789816;10309.79380412395;10427.79144417115;1909.5226193451638;1975.654260504406;1987.3441764217773;1994.1026538057931;1999.4701404127918;58842.11736823951;59639.1054134184;61017.694911525155;61240.69379653073;61731.691341543454;10111.191104711605;10557.736056598493;11114.388708620942;11145.442727863574;11256.831147532794;13069.673258168621;14146.858531414555;14774.852251477563;14828.036177648633;14840.480583179753;8011.078725946591;8036.879446808302;8073.233042860918;8094.271515563628;8095.190480951976;7626.275503827128;7666.425018123663;7673.961630191813;7703.114141873644;7726.072871255486;4427.424434823517;4652.278896771006;4846.273059041172;4908.558229759339;4954.058728841508;1872.9906350468161;1946.883187008784;1966.852486063551;1967.2917749610128;2000.2699014859472;861.8276344731079;964.2575217082807;1014.8731408573929;1025.5795123999123;1025.9487025648837;16929.915350423416;16991.91504042472;17406.73357591266;17681;17860;967.0377973915998;977.0815433492494;982.4056445850158;993.7316924430363;998.1266391907081;9870.901290987142;10031.347962382568;10085.69742907714;10155.42709069953;10226.181905447545;541412;542313;542543;548396;654252;69399;74761.6261918687;77174.22825771783;77991;78051;1171.3147808531933;1198.8131749567865;1207.806750919866;1212.0969877441187;1219.1526888812368;15074.397024118913;15997.840021599635;16046.839531605001;16272.67454650924;16294.103824289303;27246;31137.532937006417;31414.685853141174;31676;33119.337613248084;41813;42184.36723449089;43167;43449.13101738011;43839;7475.850482990201;7884.29041386278;8091.1099779025435;8156.592170391338;8171.346292296721;9188.95405522968;9701.272404569545;11180;11241.38172400493;11694.532218711496;10029.598816047568;10086.546105425421;10142.37880910508;10211.897881021392;10939.890601094206;8477.660893564189;10384.584616615553;11019.559217631526;11032.338059716443;11034.793041391915;10003.499825008575;10081.747956300858;10400.635977740743;10526.894731052591;10572.8942710575;7704.653290602048;7719.884201736866;7772.1450640428375;7778.37772978149;7915.208479152038;7351.77944661661;10221.131203847755;10517.789644207227;10861.076808471369;10865.18511111654 12:37:18 INFO - PROCESS | 12170 | |3;mootools.html;1377.7244551089784;1531.1884701108413;1564.8200456947454;1721.5696075981004;1827.5431142214447;7385.81535461613;7912.802179945497;8057.274845263925;8128.837423251532;8130.674773009073;7874.291313781759;8115.2290532399475;8121.878171827428;8122.91877081229;8125.715599954003;2429.186222615426;2436.5857804173243;2446.7430919753438;2449.951000979979;2468.2348471973655;2417.033186725306;2471.4315707387314;2508.8118391120647;2510.7614776596283;2518.6347979542957;2469.4196863737006;2481.131603938625;2483.4536401991622;2494.5135698538793;2496.0889275414524;2361.2798096580623;2372.750861159571;2382.9285121446383;2426.3691440225493;2428.8299819012677;2404.507076049406;2405.687260656121;2415.5651982643117;2416.0698131219433;2416.1664225842055;8260.050094239179;8298.502089874626;8302.252797248277;8307.667693292262;8308.29379502743;4917.237828136645;5010.649254552182;5013.298138260647;5018.548330650259;5025.422076461217;3229.1442767666585;3258.2506023614465;3329.783564068328;3333.5499707539416;3338.2655815720505;1080.287010573018;1083.230906056693;1088.5101704233048;1090.138790355626;1095.6055819904827;11276.605318813885;11326.433678316134;11339.489722962486;11339.603113890975;11349.602763903305;4580;4595.954040459553;4618.769061546909;4642.744649044335;4650.837220697327;9608.519574021271;9628.47043412619;9656.662016829378;9657.32398732082;9668.323217374716;5089.287499750038;5110.744462776846;5136.357955255593;5138.07514647367;5146.742662866842;4199.748015119103;4264.33902745075;4636.698614590041;4697.694649847749;4745.383100196952;3829.9617003829603;3858.6913046956174;3871.535415750128;3884.941725874114;3908.257431088141;1302.9804552931714;1325.562564353761;1333.553259658006;1339.5043833781563;1342.1209108034254;1428.114568967247;1434.1610158057445;1446.6889618732023;1488.1443170176974;1491.3736230783097;7866.488678235896;7881.842363152819;7892.250236227549;7896.763097107096;7918.960405198052;547.9835604931858;550.771429856613;550.9724513774295;562.0304973919955;562.8508445262008;6193.6903154842075;6222.844428889314;6287.842803929847;6314.936850631527;6330.240371155491;9968.053034961667;10126;10142.543585538668;10282.948585257025;10318.845217321747;9856.457894815854;10013.148882345082;10131.13885319756;10180.745481363025;10206.744831379276;7911.446198766146;7923.801904952307;7930.722424715107;8012.158723334082;8016.519008859487;7702.499337543042;7774.533527988338;7775.883361749691;7797.064352277763;7818.569978651229;8975.28197744192;9055.954720226357;9074.90925090767;9095.772605684911;9206.125418085272;9223.76940576491;9405.764855878659;9430.95284523573;9545.761355966157;9551.474668893277;6540.967295163684;6701.798946031627;7026.156861176487;7312.378447831781;7391.039164908742;7834.294913457816;7858.528488290721;7864.567448790372;7907.56508392044;7910.367170626451;7223.530470519399;7430.4798664093;7450.254974502724;7484.962575187089;7533.773986780406;7106.857862842818;7367.2264412235945;7371.262873712586;7373.926260737324;7466.1040675117165;7260.419166466776;7265.09186351706;7268.927310726825;7314;7455.105387353552;6863.862722745617;6961.164660240804;6987.266337034742;6990.9300906990275;6991.755288564876;7096.219415864148;7100.680469378787;7123.82190445243;7126.35862772353;7131.42948564124 12:37:18 INFO - PROCESS | 12170 | |4;prototype.html;370.25763344494294;371.29083450609335;373.78320574067044;375.87032473796546;383.3865814696486;6030.125631783389;6050.576459647827;6066.363031881655;6066.8483287917825;6079.63522188669;5728.914066289009;5757.366689664133;5833.912491312633;5950.10748387742;5980.700964951757;4689.906201875978;4690.554397332248;4698.013417182396;4703.741294228816;4723.504032076634;4505.904754289255;4685.20351540239;4707.505711900252;4713.858584242478;4717.504662010474;4579.793909274074;4582.770861456914;4658.650601204906;4670.743109128996;4671;4634.2353511670535;4647.535246475376;4666.416697912761;4671.416072990876;4675.509071547473;4144.129732756125;4163.2298024865495;4170.562090980434;4178.080822219107;4181.644560212386;5547.944520554784;5651.9717401413145;5656.2929633795775;5656.717164141817;5663.716814159276;5370.382406023318;5436.483534064297;5439.048166570834;5445.1832225166145;5455.290812194429;6391.904121438182;6395.456386207178;6402.35976402356;6403.615783053032;6410.743570257184;4562.703424277412;4567.109413664337;4567.33773602829;4571.2000399929875;4574.245249533823;6504.089427480157;6551.475881929434;6621.602703837737;6622;6631.867362652768;4634.165850146938;4679.485256621769;4679.508651591534;4680.134175177603;4681.438227412732;4730.124926888537;4734.834280800155;4736.4316282046375;4740.976295118502;4744.810207591658;5402.945970540244;5402.972985135049;5407.0267351876255;5421.674699518042;5422.864428389322;6274.560780745395;6417.582857114273;6429.357064293533;6429.6142231466265;6431.453326467303;1655.1806855606312;1672.2809192047537;1675.388483203622;1675.3968571314317;1676.4048762689313;1129.4239937631703;1131.422974283105;1145.9083273338113;1146.3752255020868;1151.073385924339;6178.567500274938;6185.567010309235;6193.938060619426;6195.721192546346;6196.1635179250225;6424.839379015562;6611.404973552403;6611.900821487681;6613.371729685672;6618.271990081087;6086.087086936995;6136.355682653347;6220.942439785247;6244.594101383395;6254.718537665725;3525.7708248963736;3563.1448452371246;3566.8038257895546;3580.4987301777774;3581.7850928944345;6697.631630260383;6821.590704557742;6828.180618325832;6832.487563432763;6834.419074378733;6812.114425124702;6827.590344579242;6834.897476537856;6836.316368363224;6839.418649414756;6814.284500127415;6816;6817.625030623264;6822.863542729117;6850.0752398426575;6485.15692959931;6636.303188165173;6637.435817955527;6649.73401063952;6652.600843949379;6570.737170513126;6579.835504112435;6622.205335359788;6630.171228596426;6647.135872336566;6793.252742198255;6862.348076932683;6864.828379290558;6869.210040845367;6909.2745261746795;4598.954010459986;4669.719816810866;4671.813127474863;4672.042231342499;4672.7429991349445;6631.171103612049;6681.76613818514;6738.056672065817;6739.59562426256;6746.224184218681;6469.126667899774;6473.255575608677;6474.741010359533;6476.319986401549;6476.967615161894;6275.592086514362;6415.454686351713;6460.612363258219;6469.547131700924;6479.1901012373455;6356.046593011085;6375.139356186855;6379.553431259767;6384.201974753156;6390.137331460193;6501.772437964649;6503.967480162569;6504.284528701744;6510.479161666961;6513.73945042193;6222.782202622887;6344.175257216532;6350.587211831216;6355.5551111421755;6360.332165122781 12:37:18 INFO - PROCESS | 12170 | |5;yui.html;809.8339840332733;842.4818736477068;872.3457406944791;889.5596679643577;890.2255038116839;13633.1138475999;13778.448862045507;13783.862161378383;13831.58505244843;13833.861661383396;13420.463181472729;13484.797728034062;13495.66260843477;13524.864751352483;14527.92736036321;889.8932128144615;904.9366544341899;905.3345790843724;908.1372695938885;909.6770646420524;901.3600343755909;903.1690844423147;912.0469109780296;912.4206129108031;914.5655813488573;951.1629765806116;955.7610597350663;957.4398976598698;959.1032384720274;959.8032403357295;947.8436058050413;953.6423841059602;955.0878910640322;955.6082006377352;956.2445667922333;704.246456291768;706.8904319830434;707.9752208672671;709.3438569323407;709.4005565297316;13748.518801841987;13815.171089734647;13820.170789752647;13822.93088534551;13824.585262442142;12080.456379462945;12141.939290303491;12148.817767733492;12333.814992775115;12340.81488777669;10337.328073675262;10572.612788120307;10586.258961872672;10612.097971672418;10769.676909692722;3810.8666196682984;3837.2517359114986;3880.573136954961;3899.9610003900166;3908.1402091539817;44574.77712611449;45843;47711.76144119292;50326;52447.475525244256;10389.064984151462;10979.396133212591;11058.723531911606;11280.097592192606;11323.886761132284;19666.70499942502;19681.507962301057;19688.114034868464;19690.40928772139;19702.211911523664;7920.128785833554;8006.71976480832;8117.878231826528;8243.793905152419;8298.21166989135;4502.5047244803045;4571.794269257892;4589.33454649074;4600.010997635524;4613.700109492872;3186.060112266887;3211.405889910374;3213.9196520086716;3215;3216.7748257621743;541.7914103070267;586.6626689653466;592.1029640095259;592.9466348028698;593.8129489210885;604.5828378418877;620.252595622274;642.5855323316434;651.9087327774115;655.4494224851053;7379.963100184572;7485.812854678677;7641.197674244125;7756.573388463688;7810.218978102144;591.3701907468533;605.2555356911024;629.7040391016216;637.6174295422709;702.9841977914689;4362.476502819682;4382.145481631115;4643.674942753974;4826.95173048272;4847.927281090787;53389.46610533923;53900.73049634727;60617;61189;61564;46317.30524042142;53485.73257133689;54621.72689136529;54623.18065229025;55210;44479.33281000787;47967.760161199665;49802.75098624556;49933.75033124884;50787.492125079014;9184.908150918405;9822.852657210005;9824.557894894604;9878.4566848824;9976.650817221362;37315.25369492649;38105.618943811314;38221.80889095537;38874.4168837462;39688;44190.558094418644;49902.25146622731;50687.746561266955;50821;51006.23490647718;10574.735631609272;10831.295965762516;10932.289401189215;10963.068139207937;11013.229073964745;13281.628696073773;13375.197488150741;13422.39599218057;13600.319984000958;13609.727805444034;12318.199317044364;12360.196587221802;12361.381930903599;12425.37873106359;12672.112952093265;12443.813342799684;12508.749825003631;12520.624381268577;12737.29944853042;12991.935040324737;11246.325220486797;11470;12077.27536347822;12876.871231287942;13076.738465230452;10310.793784124426;10313.535890884777;10416.1667066636;10535.841962370723;10563.524641391003;10615;10887.673369798918;11077.889221107685;11113.110951124052;11152.609658661908 12:37:18 INFO - PROCESS | 12170 | __end_tp_report 12:37:18 INFO - PROCESS | 12170 | __start_cc_report 12:37:18 INFO - PROCESS | 12170 | _x_x_mozilla_cycle_collect,1039 12:37:18 INFO - PROCESS | 12170 | __end_cc_report 12:37:18 INFO - PROCESS | 12170 | __startTimestamp1457728638978__endTimestamp 12:37:18 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | ------- Summary: start ------- 12:37:18 INFO - PROCESS | 12170 | Number of tests: 6 12:37:18 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | [#0] dojo.html Cycles:165 Average:5297.99 Median:5501.72 stddev:561.21 (10.2%) stddev-sans-first:538.05 12:37:18 INFO - PROCESS | 12170 | Values: 3191.3 3270.7 3299.7 3305.3 3327.5 5232.3 5249.9 5267.1 5272.7 5281.2 5259.8 5295.8 5304.3 5312.7 5352.7 4750.7 4814.2 4828.9 4835.8 4845.4 4888.5 4893.9 4914.5 4919.8 4926.4 4801.5 4835.2 4863.2 4890.7 4916.1 4895.7 4935.8 4954.4 4962.7 4989.6 4719.7 4867.5 4880.0 4898.8 4929.8 5076.5 5166.0 5214.7 5217.2 5228.2 5640.5 5673.4 5674.3 5678.3 5678.7 5610.0 5645.2 5694.5 5706.1 5707.1 5322.8 5373.5 5402.8 5403.3 5427.0 5781.0 5784.7 5785.5 5794.7 5795.2 5501.7 5569.2 5602.0 5602.3 5612.7 5674.9 5694.9 5700.9 5701.7 5707.3 5653.8 5662.5 5664.8 5664.8 5671.5 5487.5 5577.3 5578.6 5656.1 5662.2 4400.6 4412.2 4412.8 4420.8 4442.8 3923.8 3949.0 3961.2 3967.0 4005.4 5267.7 5289.8 5317.9 5376.5 5390.7 5715.6 5731.8 5736.2 5741.5 5747.9 5401.7 5422.6 5426.9 5434.5 5451.7 4850.6 4938.8 4972.8 5026.1 5042.9 5812.7 5833.7 5840.2 5851.5 5895.5 5745.6 5756.0 5759.4 5761.0 5761.9 5784.0 5842.6 5877.6 5880.3 5933.9 5603.4 5607.7 5637.4 5637.5 5646.4 5519.5 5715.0 5720.3 5721.1 5739.9 5427.5 5507.9 5534.7 5540.1 5549.7 5628.8 5634.7 5635.2 5639.3 5645.3 5521.1 5522.0 5536.0 5540.3 5546.8 5538.2 5620.7 5621.8 5636.4 5721.4 5408.1 5422.5 5454.8 5465.4 5496.1 12:37:18 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | [#1] ext.html Cycles:180 Average:44856.32 Median:21460.77 stddev:68346.30 (318.5%) stddev-sans-first:68457.00 12:37:18 INFO - PROCESS | 12170 | Values: 533.8 562.3 568.1 586.6 587.6 30513.0 31091.5 31114.1 31125.2 38266.0 41464.4 42284.8 42287.0 42314.6 42358.0 8795.1 9017.3 9021.9 9027.0 9030.3 8650.5 8812.3 8834.0 8835.3 8836.1 8753.9 8831.6 8835.1 8840.4 9102.5 9008.4 9073.2 9094.1 9095.2 9099.2 8740.8 8969.2 8972.8 8996.6 9000.1 41060.8 41561.2 41582.0 41606.4 41632.8 3450.2 3671.2 3679.0 3936.5 4041.3 31138.8 31566.8 31653.5 31675.0 32058.8 4294.5 4333.6 4408.1 4431.0 4431.4 269554.0 269802.0 270722.0 270827.0 271265.0 58726.7 59528.0 59851.0 61388.4 63019.0 57141.1 57269.7 57382.7 57438.1 57467.7 15838.7 15840.8 15843.8 15979.9 16000.1 13039.8 13079.1 13100.5 13126.3 13202.5 20078.9 20359.0 20377.6 20588.7 20609.1 7595.8 7687.7 7714.0 7765.5 7911.7 947.5 981.8 1004.7 1007.8 1043.0 26398.0 26624.7 26647.0 26994.0 27410.5 1027.5 1081.0 1117.8 1202.3 1243.4 13990.8 15262.5 16052.0 16116.1 16213.7 279154.0 279416.0 279715.0 280152.0 280409.0 51636.5 51756.7 52157.0 52351.7 52490.0 1376.9 1384.3 1435.3 1518.6 1546.3 29850.1 29909.3 32499.4 32506.3 32538.3 48993.8 49582.0 49658.3 49696.8 49707.8 234647.0 236346.0 237911.0 238250.0 241292.0 41188.8 41491.8 41510.4 42040.0 42646.6 47413.0 47769.0 48396.0 48581.5 49172.8 39764.8 40907.8 40940.0 41355.2 41371.6 37562.9 37935.6 38309.2 38856.8 38885.8 37839.3 38417.8 38661.6 38968.2 38985.0 33673.8 36000.8 36843.4 37157.8 37307.3 27426.3 27688.9 28076.2 28189.9 28282.7 12:37:18 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | [#2] jquery.html Cycles:180 Average:28777.26 Median:31545.34 stddev:92678.07 (293.8%) stddev-sans-first:92913.53 12:37:18 INFO - PROCESS | 12170 | Values: 384.6 387.7 390.5 391.7 398.0 14758.8 15114.4 16561.8 18122.7 18123.0 16179.0 16212.0 16287.6 18379.6 18427.7 6049.9 6257.6 6273.0 6278.1 6280.7 4478.4 4668.6 6154.2 6558.5 6791.2 6458.1 6753.1 6792.9 6947.3 7032.6 5390.7 6729.3 6776.4 6792.2 6837.3 5456.2 5458.9 5462.4 5465.6 5466.1 13933.7 20596.6 21180.8 21229.4 21544.5 2222.4 2263.7 2270.7 2299.1 2387.2 10141.2 10197.8 10219.4 10309.8 10427.8 1909.5 1975.7 1987.3 1994.1 1999.5 58842.1 59639.1 61017.7 61240.7 61731.7 10111.2 10557.7 11114.4 11145.4 11256.8 13069.7 14146.9 14774.9 14828.0 14840.5 8011.1 8036.9 8073.2 8094.3 8095.2 7626.3 7666.4 7674.0 7703.1 7726.1 4427.4 4652.3 4846.3 4908.6 4954.1 1873.0 1946.9 1966.9 1967.3 2000.3 861.8 964.3 1014.9 1025.6 1025.9 16929.9 16991.9 17406.7 17681.0 17860.0 967.0 977.1 982.4 993.7 998.1 9870.9 10031.3 10085.7 10155.4 10226.2 541412.0 542313.0 542543.0 548396.0 654252.0 69399.0 74761.6 77174.2 77991.0 78051.0 1171.3 1198.8 1207.8 1212.1 1219.2 15074.4 15997.8 16046.8 16272.7 16294.1 27246.0 31137.5 31414.7 31676.0 33119.3 41813.0 42184.4 43167.0 43449.1 43839.0 7475.9 7884.3 8091.1 8156.6 8171.3 9189.0 9701.3 11180.0 11241.4 11694.5 10029.6 10086.5 10142.4 10211.9 10939.9 8477.7 10384.6 11019.6 11032.3 11034.8 10003.5 10081.7 10400.6 10526.9 10572.9 7704.7 7719.9 7772.1 7778.4 7915.2 7351.8 10221.1 10517.8 10861.1 10865.2 12:37:18 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | [#3] mootools.html Cycles:180 Average:5822.32 Median:556.50 stddev:3030.46 (544.6%) stddev-sans-first:3020.54 12:37:18 INFO - PROCESS | 12170 | Values: 1377.7 1531.2 1564.8 1721.6 1827.5 7385.8 7912.8 8057.3 8128.8 8130.7 7874.3 8115.2 8121.9 8122.9 8125.7 2429.2 2436.6 2446.7 2450.0 2468.2 2417.0 2471.4 2508.8 2510.8 2518.6 2469.4 2481.1 2483.5 2494.5 2496.1 2361.3 2372.8 2382.9 2426.4 2428.8 2404.5 2405.7 2415.6 2416.1 2416.2 8260.1 8298.5 8302.3 8307.7 8308.3 4917.2 5010.6 5013.3 5018.5 5025.4 3229.1 3258.3 3329.8 3333.5 3338.3 1080.3 1083.2 1088.5 1090.1 1095.6 11276.6 11326.4 11339.5 11339.6 11349.6 4580.0 4596.0 4618.8 4642.7 4650.8 9608.5 9628.5 9656.7 9657.3 9668.3 5089.3 5110.7 5136.4 5138.1 5146.7 4199.7 4264.3 4636.7 4697.7 4745.4 3830.0 3858.7 3871.5 3884.9 3908.3 1303.0 1325.6 1333.6 1339.5 1342.1 1428.1 1434.2 1446.7 1488.1 1491.4 7866.5 7881.8 7892.3 7896.8 7919.0 548.0 550.8 551.0 562.0 562.9 6193.7 6222.8 6287.8 6314.9 6330.2 9968.1 10126.0 10142.5 10282.9 10318.8 9856.5 10013.1 10131.1 10180.7 10206.7 7911.4 7923.8 7930.7 8012.2 8016.5 7702.5 7774.5 7775.9 7797.1 7818.6 8975.3 9056.0 9074.9 9095.8 9206.1 9223.8 9405.8 9431.0 9545.8 9551.5 6541.0 6701.8 7026.2 7312.4 7391.0 7834.3 7858.5 7864.6 7907.6 7910.4 7223.5 7430.5 7450.3 7485.0 7533.8 7106.9 7367.2 7371.3 7373.9 7466.1 7260.4 7265.1 7268.9 7314.0 7455.1 6863.9 6961.2 6987.3 6990.9 6991.8 7096.2 7100.7 7123.8 7126.4 7131.4 12:37:18 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | [#4] prototype.html Cycles:180 Average:5396.80 Median:6111.22 stddev:1597.83 (26.1%) stddev-sans-first:1557.13 12:37:18 INFO - PROCESS | 12170 | Values: 370.3 371.3 373.8 375.9 383.4 6030.1 6050.6 6066.4 6066.8 6079.6 5728.9 5757.4 5833.9 5950.1 5980.7 4689.9 4690.6 4698.0 4703.7 4723.5 4505.9 4685.2 4707.5 4713.9 4717.5 4579.8 4582.8 4658.7 4670.7 4671.0 4634.2 4647.5 4666.4 4671.4 4675.5 4144.1 4163.2 4170.6 4178.1 4181.6 5547.9 5652.0 5656.3 5656.7 5663.7 5370.4 5436.5 5439.0 5445.2 5455.3 6391.9 6395.5 6402.4 6403.6 6410.7 4562.7 4567.1 4567.3 4571.2 4574.2 6504.1 6551.5 6621.6 6622.0 6631.9 4634.2 4679.5 4679.5 4680.1 4681.4 4730.1 4734.8 4736.4 4741.0 4744.8 5402.9 5403.0 5407.0 5421.7 5422.9 6274.6 6417.6 6429.4 6429.6 6431.5 1655.2 1672.3 1675.4 1675.4 1676.4 1129.4 1131.4 1145.9 1146.4 1151.1 6178.6 6185.6 6193.9 6195.7 6196.2 6424.8 6611.4 6611.9 6613.4 6618.3 6086.1 6136.4 6220.9 6244.6 6254.7 3525.8 3563.1 3566.8 3580.5 3581.8 6697.6 6821.6 6828.2 6832.5 6834.4 6812.1 6827.6 6834.9 6836.3 6839.4 6814.3 6816.0 6817.6 6822.9 6850.1 6485.2 6636.3 6637.4 6649.7 6652.6 6570.7 6579.8 6622.2 6630.2 6647.1 6793.3 6862.3 6864.8 6869.2 6909.3 4599.0 4669.7 4671.8 4672.0 4672.7 6631.2 6681.8 6738.1 6739.6 6746.2 6469.1 6473.3 6474.7 6476.3 6477.0 6275.6 6415.5 6460.6 6469.5 6479.2 6356.0 6375.1 6379.6 6384.2 6390.1 6501.8 6504.0 6504.3 6510.5 6513.7 6222.8 6344.2 6350.6 6355.6 6360.3 12:37:18 INFO - PROCESS | 12170 | 12:37:18 INFO - PROCESS | 12170 | [#5] yui.html Cycles:180 Average:14502.14 Median:4537.15 stddev:16595.97 (365.8%) stddev-sans-first:16610.67 12:37:18 INFO - PROCESS | 12170 | Values: 809.8 842.5 872.3 889.6 890.2 13633.1 13778.4 13783.9 13831.6 13833.9 13420.5 13484.8 13495.7 13524.9 14527.9 889.9 904.9 905.3 908.1 909.7 901.4 903.2 912.0 912.4 914.6 951.2 955.8 957.4 959.1 959.8 947.8 953.6 955.1 955.6 956.2 704.2 706.9 708.0 709.3 709.4 13748.5 13815.2 13820.2 13822.9 13824.6 12080.5 12141.9 12148.8 12333.8 12340.8 10337.3 10572.6 10586.3 10612.1 10769.7 3810.9 3837.3 3880.6 3900.0 3908.1 44574.8 45843.0 47711.8 50326.0 52447.5 10389.1 10979.4 11058.7 11280.1 11323.9 19666.7 19681.5 19688.1 19690.4 19702.2 7920.1 8006.7 8117.9 8243.8 8298.2 4502.5 4571.8 4589.3 4600.0 4613.7 3186.1 3211.4 3213.9 3215.0 3216.8 541.8 586.7 592.1 592.9 593.8 604.6 620.3 642.6 651.9 655.4 7380.0 7485.8 7641.2 7756.6 7810.2 591.4 605.3 629.7 637.6 703.0 4362.5 4382.1 4643.7 4827.0 4847.9 53389.5 53900.7 60617.0 61189.0 61564.0 46317.3 53485.7 54621.7 54623.2 55210.0 44479.3 47967.8 49802.8 49933.8 50787.5 9184.9 9822.9 9824.6 9878.5 9976.7 37315.3 38105.6 38221.8 38874.4 39688.0 44190.6 49902.3 50687.7 50821.0 51006.2 10574.7 10831.3 10932.3 10963.1 11013.2 13281.6 13375.2 13422.4 13600.3 13609.7 12318.2 12360.2 12361.4 12425.4 12672.1 12443.8 12508.7 12520.6 12737.3 12991.9 11246.3 11470.0 12077.3 12876.9 13076.7 10310.8 10313.5 10416.2 10535.8 10563.5 10615.0 10887.7 11077.9 11113.1 11152.6 12:37:18 INFO - PROCESS | 12170 | -------- Summary: end -------- 12:37:18 INFO - PROCESS | 12170 | 12:37:19 INFO - TEST-INFO | 12170: exit 0 12:37:19 INFO - TEST-OK | dromaeo_css | took 1109950ms 12:37:19 INFO - TEST-START | kraken 12:37:19 INFO - operating with platform_type : linux_ 12:37:19 INFO - Initialising browser for kraken test... 12:37:19 INFO - TEST-INFO | started process 12359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0vOvIi/profile http://localhost:56511/getInfo.html) 12:37:23 INFO - PROCESS | 12359 | __metrics Screen width/height:1600/1200 12:37:23 INFO - PROCESS | 12359 | colorDepth:24 12:37:23 INFO - PROCESS | 12359 | Browser inner width/height: 1024/697 12:37:23 INFO - PROCESS | 12359 | __metrics 12:37:23 INFO - PROCESS | 12359 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:37:24 INFO - TEST-INFO | 12359: exit 0 12:37:24 INFO - Browser initialized. 12:37:24 INFO - Running cycle 1/1 for kraken test... 12:37:24 INFO - TEST-INFO | started process 12449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0vOvIi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:35 INFO - PROCESS | 12449 | RSS: Main: 136060928 12:37:35 INFO - PROCESS | 12449 | 12:37:38 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56511/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:38 INFO - PROCESS | 12449 | RSS: Main: 170201088 12:37:38 INFO - PROCESS | 12449 | 12:37:41 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56511/tests/kraken/driver.html?testName=audio-dft) 12:37:42 INFO - PROCESS | 12449 | RSS: Main: 167211008 12:37:42 INFO - PROCESS | 12449 | 12:37:44 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56511/tests/kraken/driver.html?testName=audio-fft) 12:37:45 INFO - PROCESS | 12449 | RSS: Main: 165683200 12:37:45 INFO - PROCESS | 12449 | 12:37:47 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56511/tests/kraken/driver.html?testName=audio-oscillator) 12:37:48 INFO - PROCESS | 12449 | RSS: Main: 165675008 12:37:48 INFO - PROCESS | 12449 | 12:37:50 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:50 INFO - PROCESS | 12449 | RSS: Main: 163962880 12:37:50 INFO - PROCESS | 12449 | 12:37:53 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56511/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:54 INFO - PROCESS | 12449 | RSS: Main: 164491264 12:37:54 INFO - PROCESS | 12449 | 12:37:57 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56511/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:58 INFO - PROCESS | 12449 | RSS: Main: 165769216 12:37:58 INFO - PROCESS | 12449 | 12:38:00 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56511/tests/kraken/driver.html?testName=json-parse-financial) 12:38:01 INFO - PROCESS | 12449 | RSS: Main: 164003840 12:38:01 INFO - PROCESS | 12449 | 12:38:03 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:38:03 INFO - PROCESS | 12449 | RSS: Main: 169672704 12:38:03 INFO - PROCESS | 12449 | 12:38:05 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56511/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:38:05 INFO - PROCESS | 12449 | RSS: Main: 166432768 12:38:05 INFO - PROCESS | 12449 | 12:38:07 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:38:08 INFO - PROCESS | 12449 | RSS: Main: 170545152 12:38:08 INFO - PROCESS | 12449 | 12:38:10 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:38:11 INFO - PROCESS | 12449 | RSS: Main: 175816704 12:38:11 INFO - PROCESS | 12449 | 12:38:13 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:38:14 INFO - PROCESS | 12449 | RSS: Main: 175415296 12:38:14 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:56511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56511/tests/kraken/driver.html?testName=ai-astar) 12:38:16 INFO - PROCESS | 12449 | RSS: Main: 236822528 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | __start_tp_report 12:38:16 INFO - PROCESS | 12449 | _x_x_mozilla_page_load 12:38:16 INFO - PROCESS | 12449 | _x_x_mozilla_page_load_details 12:38:16 INFO - PROCESS | 12449 | |i|pagename|runs| 12:38:16 INFO - PROCESS | 12449 | |0;ai-astar;108;109;105;109;110;109;99;109;109;109 12:38:16 INFO - PROCESS | 12449 | |1;audio-beat-detection;146;128;146;160;134;161;149;126;163;124 12:38:16 INFO - PROCESS | 12449 | |2;audio-dft;163;163;164;163;162;163;161;166;164;159 12:38:16 INFO - PROCESS | 12449 | |3;audio-fft;73;74;74;159;72;72;72;73;149;74 12:38:16 INFO - PROCESS | 12449 | |4;audio-oscillator;95;95;138;94;96;96;145;95;94;137 12:38:16 INFO - PROCESS | 12449 | |5;imaging-gaussian-blur;109;108;108;109;109;109;109;109;110;109 12:38:16 INFO - PROCESS | 12449 | |6;imaging-darkroom;145;146;145;147;146;146;145;145;146;145 12:38:16 INFO - PROCESS | 12449 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;96 12:38:16 INFO - PROCESS | 12449 | |8;json-parse-financial;54;54;54;56;54;56;54;54;53;53 12:38:16 INFO - PROCESS | 12449 | |9;json-stringify-tinderbox;65;64;64;63;64;65;66;65;65;65 12:38:16 INFO - PROCESS | 12449 | |10;stanford-crypto-aes;76;77;86;79;76;77;79;76;77;78 12:38:16 INFO - PROCESS | 12449 | |11;stanford-crypto-ccm;115;109;110;114;109;112;109;113;119;109 12:38:16 INFO - PROCESS | 12449 | |12;stanford-crypto-pbkdf2;138;135;146;131;137;131;131;132;130;130 12:38:16 INFO - PROCESS | 12449 | |13;stanford-crypto-sha256-iterative;63;65;65;65;65;64;64;65;66;63 12:38:16 INFO - PROCESS | 12449 | __end_tp_report 12:38:16 INFO - PROCESS | 12449 | __start_cc_report 12:38:16 INFO - PROCESS | 12449 | _x_x_mozilla_cycle_collect,922 12:38:16 INFO - PROCESS | 12449 | __end_cc_report 12:38:16 INFO - PROCESS | 12449 | __startTimestamp1457728696310__endTimestamp 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | ------- Summary: start ------- 12:38:16 INFO - PROCESS | 12449 | Number of tests: 14 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.31 (3.0%) stddev-sans-first:3.50 12:38:16 INFO - PROCESS | 12449 | Values: 108.0 109.0 105.0 109.0 110.0 109.0 99.0 109.0 109.0 109.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:147.50 stddev:14.97 (10.2%) stddev-sans-first:15.86 12:38:16 INFO - PROCESS | 12449 | Values: 146.0 128.0 146.0 160.0 134.0 161.0 149.0 126.0 163.0 124.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 12:38:16 INFO - PROCESS | 12449 | Values: 163.0 163.0 164.0 163.0 162.0 163.0 161.0 166.0 164.0 159.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#3] audio-fft Cycles:10 Average:89.20 Median:73.00 stddev:34.24 (46.9%) stddev-sans-first:35.82 12:38:16 INFO - PROCESS | 12449 | Values: 73.0 74.0 74.0 159.0 72.0 72.0 72.0 73.0 149.0 74.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:95.00 stddev:21.84 (23.0%) stddev-sans-first:22.62 12:38:16 INFO - PROCESS | 12449 | Values: 95.0 95.0 138.0 94.0 96.0 96.0 145.0 95.0 94.0 137.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:38:16 INFO - PROCESS | 12449 | Values: 109.0 108.0 108.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 12:38:16 INFO - PROCESS | 12449 | Values: 145.0 146.0 145.0 147.0 146.0 146.0 145.0 145.0 146.0 145.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:38:16 INFO - PROCESS | 12449 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 12:38:16 INFO - PROCESS | 12449 | Values: 54.0 54.0 54.0 56.0 54.0 56.0 54.0 54.0 53.0 53.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 12:38:16 INFO - PROCESS | 12449 | Values: 65.0 64.0 64.0 63.0 64.0 65.0 66.0 65.0 65.0 65.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.50 stddev:3.00 (3.9%) stddev-sans-first:3.08 12:38:16 INFO - PROCESS | 12449 | Values: 76.0 77.0 86.0 79.0 76.0 77.0 79.0 76.0 77.0 78.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#11] stanford-crypto-ccm Cycles:10 Average:111.90 Median:112.50 stddev:3.38 (3.0%) stddev-sans-first:3.40 12:38:16 INFO - PROCESS | 12449 | Values: 115.0 109.0 110.0 114.0 109.0 112.0 109.0 113.0 119.0 109.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.10 Median:133.50 stddev:5.09 (3.8%) stddev-sans-first:5.20 12:38:16 INFO - PROCESS | 12449 | Values: 138.0 135.0 146.0 131.0 137.0 131.0 131.0 132.0 130.0 130.0 12:38:16 INFO - PROCESS | 12449 | 12:38:16 INFO - PROCESS | 12449 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:0.87 12:38:16 INFO - PROCESS | 12449 | Values: 63.0 65.0 65.0 65.0 65.0 64.0 64.0 65.0 66.0 63.0 12:38:16 INFO - PROCESS | 12449 | -------- Summary: end -------- 12:38:16 INFO - PROCESS | 12449 | 12:38:17 INFO - TEST-INFO | 12449: exit 0 12:38:17 INFO - TEST-OK | kraken | took 57510ms 12:38:17 INFO - TEST-START | v8_7 12:38:17 INFO - operating with platform_type : linux_ 12:38:17 INFO - Initialising browser for v8_7 test... 12:38:17 INFO - TEST-INFO | started process 12701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLaaWin/profile http://localhost:56511/getInfo.html) 12:38:20 INFO - PROCESS | 12701 | __metrics Screen width/height:1600/1200 12:38:20 INFO - PROCESS | 12701 | colorDepth:24 12:38:20 INFO - PROCESS | 12701 | Browser inner width/height: 1024/697 12:38:20 INFO - PROCESS | 12701 | __metrics 12:38:21 INFO - PROCESS | 12701 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:38:22 INFO - TEST-INFO | 12701: exit 0 12:38:22 INFO - Browser initialized. 12:38:22 INFO - Running cycle 1/1 for v8_7 test... 12:38:22 INFO - TEST-INFO | started process 12789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLaaWin/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:33 INFO - PROCESS | 12789 | RSS: Main: 135520256 12:38:33 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | Cycle 1(1): loaded http://localhost:56511/tests/v8_7/run.html (next: http://localhost:56511/tests/v8_7/run.html) 12:38:56 INFO - PROCESS | 12789 | RSS: Main: 420872192 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | __start_tp_report 12:38:56 INFO - PROCESS | 12789 | _x_x_mozilla_page_load 12:38:56 INFO - PROCESS | 12789 | _x_x_mozilla_page_load_details 12:38:56 INFO - PROCESS | 12789 | |i|pagename|runs| 12:38:56 INFO - PROCESS | 12789 | |0;Richards;166.14055490945339 12:38:56 INFO - PROCESS | 12789 | |1;DeltaBlue;169.29067208396816 12:38:56 INFO - PROCESS | 12789 | |2;Encrypt;278.00945232137894 12:38:56 INFO - PROCESS | 12789 | |3;Decrypt;5159.79381443299 12:38:56 INFO - PROCESS | 12789 | |4;RayTrace;967.1179883945841 12:38:56 INFO - PROCESS | 12789 | |5;Earley;559.5970900951315 12:38:56 INFO - PROCESS | 12789 | |6;Boyer;10680.851063829787 12:38:56 INFO - PROCESS | 12789 | |7;RegExp;40540 12:38:56 INFO - PROCESS | 12789 | |8;Splay;512.557662737058 12:38:56 INFO - PROCESS | 12789 | |9;NavierStokes;4817.307692307692 12:38:56 INFO - PROCESS | 12789 | __end_tp_report 12:38:56 INFO - PROCESS | 12789 | __startTimestamp1457728736414__endTimestamp 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | ------- Summary: start ------- 12:38:56 INFO - PROCESS | 12789 | Number of tests: 10 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 166.1 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#1] DeltaBlue Cycles:1 Average:169.29 Median:169.29 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 169.3 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 278.0 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 5159.8 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#4] RayTrace Cycles:1 Average:967.12 Median:967.12 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 967.1 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#5] Earley Cycles:1 Average:559.60 Median:559.60 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 559.6 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#6] Boyer Cycles:1 Average:10680.85 Median:10680.85 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 10680.9 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#7] RegExp Cycles:1 Average:40540.00 Median:40540.00 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 40540.0 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#8] Splay Cycles:1 Average:512.56 Median:512.56 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 512.6 12:38:56 INFO - PROCESS | 12789 | 12:38:56 INFO - PROCESS | 12789 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 12:38:56 INFO - PROCESS | 12789 | Values: 4817.3 12:38:56 INFO - PROCESS | 12789 | -------- Summary: end -------- 12:38:56 INFO - PROCESS | 12789 | 12:38:57 INFO - TEST-INFO | 12789: exit 0 12:38:57 INFO - TEST-OK | v8_7 | took 40059ms 12:38:57 INFO - SUITE-END | took 1207s 12:38:57 INFO - Completed test suite (00:20:07) 12:38:57 INFO - Working with test: dromaeo_css 12:38:57 INFO - Generating results file: dromaeo_css 12:38:57 INFO - Working with test: kraken 12:38:57 INFO - Generating results file: kraken 12:38:57 INFO - javascript benchmark 12:38:57 INFO - Working with test: v8_7 12:38:57 INFO - Generating results file: v8_7 12:38:57 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,35]] 12:38:57 INFO - process_Request line: dromaeo_css 7163.85 graph.html#tests=[[72,181,35]] 12:38:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:57 INFO - process_Request line: kraken 1469.60 graph.html#tests=[[232,181,35]] 12:38:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:57 INFO - process_Request line: v8_7 22040.79 graph.html#tests=[[230,181,35]] 12:38:57 INFO - RETURN: dromaeo_css: 7163.85 12:38:57 INFO - RETURN: kraken: 1469.60 12:38:57 INFO - RETURN: v8_7: 22040.79 12:38:57 INFO - javascript benchmark 12:38:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3191.345774116306, 3270.6729327067283, 3299.6865297796717, 3305.2728399752045, 3327.4676051831702, 5232.267482552436, 5249.8687532811655, 5267.13092339764, 5272.736363181835, 5281.18141688038, 5259.815906443275, 5295.8146464873735, 5304.283921670573, 5312.707801070939, 5352.652077614962, 4750.667453278272, 4814.1575224335775, 4828.855134345967, 4835.78238979245, 4845.37010188675, 4888.462269150391, 4893.853184404474, 4914.459409464956, 4919.754012299389, 4926.3842019747535, 4801.543853333945, 4835.202191638393, 4863.2461968394955, 4890.706557606537, 4916.0905232532095, 4895.706257624536, 4935.80256789728, 4954.405471343426, 4962.702237865704, 4989.625778066623, 4719.693219940693, 4867.512094125164, 4880.048390563841, 4898.779554920037, 4929.8028078876805, 5076.466970968069, 5166.044281807877, 5214.713190774506, 5217.243499692523, 5228.163493841005, 5640.5487560995025, 5673.375928647845, 5674.262345895048, 5678.26182596264, 5678.659280443187, 5609.971950140223, 5645.1532270159805, 5694.5159661428825, 5706.115552089433, 5707.1153971134545, 5322.840314790524, 5373.489518495737, 5402.756875940592, 5403.2705584746345, 5426.972865135649, 5781.0, 5784.739686714108, 5785.50823180026, 5794.652320860761, 5795.1886735857015, 5501.724913754297, 5569.192467092249, 5602.0196465618355, 5602.2717046783655, 5612.747426365823, 5674.943250567441, 5694.9430505695245, 5700.857478562986, 5701.71491425427, 5707.258056452634, 5653.802116925888, 5662.518685911744, 5664.773409063674, 5664.801731939445, 5671.461211184931, 5487.506124448819, 5577.330720313588, 5578.63738856973, 5656.123300888369, 5662.235598194274, 4400.603945644907, 4412.227860124465, 4412.801423935931, 4420.778961051935, 4442.8222871085445, 3923.8038098095553, 3948.980255098706, 3961.2275606256503, 3966.960330396717, 4005.3591425372383, 5267.71027593486, 5289.841304760864, 5317.946820531823, 5376.516113549721, 5390.703511306838, 5715.599908006399, 5731.828045158652, 5736.225609542742, 5741.511971482387, 5747.942520574825, 5401.7299135043095, 5422.620416570881, 5426.891462170814, 5434.483724046209, 5451.700156491352, 4850.611951043908, 4938.777755001033, 4972.7513624318635, 5026.120428924996, 5042.873928151752, 5812.651240925558, 5833.7374818133285, 5840.182374467578, 5851.502622277069, 5895.498882594941, 5745.626534275342, 5755.992701277176, 5759.366469688247, 5761.0, 5761.934042202206, 5784.0, 5842.561807864512, 5877.617954832922, 5880.294364676266, 5933.881322373615, 5603.35561410443, 5607.691576963143, 5637.379888212376, 5637.52081073097, 5646.378898321099, 5519.530839878495, 5714.971425142848, 5720.2849643794525, 5721.05602575587, 5739.9139012914, 5427.457254274541, 5507.9449205507435, 5534.667919924817, 5540.1135818270495, 5549.694766787866, 5628.774849006158, 5634.690092044977, 5635.182898479779, 5639.295088113986, 5645.294338207724, 5521.061419558604, 5521.972390138024, 5536.031194540858, 5540.279763630863, 5546.833594992157, 5538.169274608841, 5620.74706638194, 5621.831345059655, 5636.351819540641, 5721.399253078367, 5408.107662235687, 5422.5119739223655, 5454.781808727766, 5465.371482279589, 5496.0931446310915], "unit": "score", "name": "dojo.html", "value": 5263.385770136813}, {"lowerIsBetter": false, "replicates": [533.8051611161926, 562.2662425534678, 568.1279236372168, 586.580594874665, 587.5945597537699, 30513.0, 31091.533626995555, 31114.066578002697, 31125.221869453275, 38266.04334891629, 41464.37803432951, 42284.78857605708, 42287.0, 42314.57685423145, 42358.0, 8795.120487951202, 9017.32370072244, 9021.909780902173, 9027.0, 9030.322725795591, 8650.524221167832, 8812.250958668488, 8834.028256891737, 8835.337349698799, 8836.116388361177, 8753.912460875405, 8831.60257788398, 8835.072317406677, 8840.38117331787, 9102.453852768822, 9008.36941414098, 9073.183413492752, 9094.090590940854, 9095.226905713022, 9099.226565741887, 8740.825183496358, 8969.237614802749, 8972.775680607972, 8996.640134394616, 9000.144986226298, 41060.79469602663, 41561.1687766246, 41582.0, 41606.375904361455, 41632.79183604093, 3450.2236996675797, 3671.192337685705, 3679.0, 3936.5079365079364, 4041.333180025292, 31138.84430577855, 31566.842165789025, 31653.52519712206, 31675.049748507583, 32058.839705801554, 4294.484661840568, 4333.566643335673, 4408.14041261954, 4431.0, 4431.379606855043, 269554.0, 269802.0, 270722.0, 270827.0, 271265.0, 58726.70636646875, 59528.0, 59851.0, 61388.38611613916, 63019.0, 57141.14288285679, 57269.71365143148, 57382.713086435135, 57438.138427923615, 57467.71266143726, 15838.683226335408, 15840.841591583936, 15843.841561584468, 15979.920100399424, 16000.119993400242, 13039.804402933964, 13079.084464087613, 13100.541481048118, 13126.343682815821, 13202.47190112404, 20078.89960550188, 20359.0, 20377.592448151252, 20588.691169632468, 20609.07259173341, 7595.772126836204, 7687.654055567513, 7714.0, 7765.495242809199, 7911.723089691834, 947.545178314413, 981.7594689301167, 1004.708634495988, 1007.7682133109425, 1042.9530671119667, 26398.0, 26624.733752662614, 26647.0, 26994.0, 27410.451790964467, 1027.5222021759917, 1081.0054749630358, 1117.8211486162174, 1202.2786328203008, 1243.3907385381278, 13990.790138147935, 15262.465813696468, 16052.0, 16116.113613751122, 16213.675726485404, 279154.0, 279416.0, 279715.0, 280152.0, 280409.0, 51636.48363516392, 51756.74121629443, 52157.0, 52351.738241309315, 52490.0, 1376.9173849569058, 1384.3286006286942, 1435.3397437179015, 1518.567208345616, 1546.26552387615, 29850.10449686513, 29909.252268692588, 32499.35001300008, 32506.349873001935, 32538.34923301568, 48993.75503122604, 49582.0, 49658.255126172415, 49696.751516242184, 49707.751461242464, 234647.0, 236346.0, 237911.0, 238250.0, 241292.0, 41188.794056029525, 41491.7925410371, 41510.377344340464, 42040.0, 42646.5735342655, 47413.0, 47769.0, 48396.0, 48581.5141848577, 49172.75413622909, 39764.80117599393, 40907.795461022506, 40939.976500586534, 41355.1728965425, 41371.58628413798, 37562.87311380554, 37935.62064379431, 38309.23381532409, 38856.80571597124, 38885.80557097196, 37839.3118322217, 38417.80791096027, 38661.6133838658, 38968.2206355877, 38985.02537436473, 33673.759006507775, 36000.81999589985, 36843.447348290334, 37157.81421092877, 37307.25385492329, 27426.314342141606, 27688.861555692092, 28076.157715268575, 28189.859050704614, 28282.71717282883], "unit": "score", "name": "ext.html", "value": 19111.63053293141}, {"lowerIsBetter": false, "replicates": [384.5828123365398, 387.7479638235147, 390.51771062737515, 391.670996363055, 398.04667820569716, 14758.827144584766, 15114.39542418302, 16561.75157372639, 18122.728159077607, 18122.99999999998, 16179.029258244513, 16212.0, 16287.59281017975, 18379.632407351844, 18427.72358414625, 6049.87900241996, 6257.5619706620555, 6273.0, 6278.121063051177, 6280.685965701719, 4478.395416618763, 4668.603168730662, 6154.169187159721, 6558.508111891627, 6791.219009813861, 6458.063580780784, 6753.122094127756, 6792.932070679304, 6947.270536593661, 7032.648367581626, 5390.676559406448, 6729.327067293256, 6776.356246156607, 6792.184937807446, 6837.3162683731725, 5456.154296084113, 5458.918116228259, 5462.426445223274, 5465.562754979632, 5466.070767969415, 13933.651658708613, 20596.5880682387, 21180.788192118034, 21229.363119106296, 21544.461388465257, 2222.3666255117214, 2263.6717675936898, 2270.7388650305097, 2299.057386471539, 2387.192428077214, 10141.190793152775, 10197.847032294521, 10219.386836789816, 10309.79380412395, 10427.79144417115, 1909.5226193451638, 1975.654260504406, 1987.3441764217773, 1994.1026538057931, 1999.4701404127918, 58842.11736823951, 59639.1054134184, 61017.694911525155, 61240.69379653073, 61731.691341543454, 10111.191104711605, 10557.736056598493, 11114.388708620942, 11145.442727863574, 11256.831147532794, 13069.673258168621, 14146.858531414555, 14774.852251477563, 14828.036177648633, 14840.480583179753, 8011.078725946591, 8036.879446808302, 8073.233042860918, 8094.271515563628, 8095.190480951976, 7626.275503827128, 7666.425018123663, 7673.961630191813, 7703.114141873644, 7726.072871255486, 4427.424434823517, 4652.278896771006, 4846.273059041172, 4908.558229759339, 4954.058728841508, 1872.9906350468161, 1946.883187008784, 1966.852486063551, 1967.2917749610128, 2000.2699014859472, 861.8276344731079, 964.2575217082807, 1014.8731408573929, 1025.5795123999123, 1025.9487025648837, 16929.915350423416, 16991.91504042472, 17406.73357591266, 17681.0, 17860.0, 967.0377973915998, 977.0815433492494, 982.4056445850158, 993.7316924430363, 998.1266391907081, 9870.901290987142, 10031.347962382568, 10085.69742907714, 10155.42709069953, 10226.181905447545, 541412.0, 542313.0, 542543.0, 548396.0, 654252.0, 69399.0, 74761.6261918687, 77174.22825771783, 77991.0, 78051.0, 1171.3147808531933, 1198.8131749567865, 1207.806750919866, 1212.0969877441187, 1219.1526888812368, 15074.397024118913, 15997.840021599635, 16046.839531605001, 16272.67454650924, 16294.103824289303, 27246.0, 31137.532937006417, 31414.685853141174, 31676.0, 33119.337613248084, 41813.0, 42184.36723449089, 43167.0, 43449.13101738011, 43839.0, 7475.850482990201, 7884.29041386278, 8091.1099779025435, 8156.592170391338, 8171.346292296721, 9188.95405522968, 9701.272404569545, 11180.0, 11241.38172400493, 11694.532218711496, 10029.598816047568, 10086.546105425421, 10142.37880910508, 10211.897881021392, 10939.890601094206, 8477.660893564189, 10384.584616615553, 11019.559217631526, 11032.338059716443, 11034.793041391915, 10003.499825008575, 10081.747956300858, 10400.635977740743, 10526.894731052591, 10572.8942710575, 7704.653290602048, 7719.884201736866, 7772.1450640428375, 7778.37772978149, 7915.208479152038, 7351.77944661661, 10221.131203847755, 10517.789644207227, 10861.076808471369, 10865.18511111654], "unit": "score", "name": "jquery.html", "value": 8683.348242591268}, {"lowerIsBetter": false, "replicates": [1377.7244551089784, 1531.1884701108413, 1564.8200456947454, 1721.5696075981004, 1827.5431142214447, 7385.81535461613, 7912.802179945497, 8057.274845263925, 8128.837423251532, 8130.674773009073, 7874.291313781759, 8115.2290532399475, 8121.878171827428, 8122.91877081229, 8125.715599954003, 2429.186222615426, 2436.5857804173243, 2446.7430919753438, 2449.951000979979, 2468.2348471973655, 2417.033186725306, 2471.4315707387314, 2508.8118391120647, 2510.7614776596283, 2518.6347979542957, 2469.4196863737006, 2481.131603938625, 2483.4536401991622, 2494.5135698538793, 2496.0889275414524, 2361.2798096580623, 2372.750861159571, 2382.9285121446383, 2426.3691440225493, 2428.8299819012677, 2404.507076049406, 2405.687260656121, 2415.5651982643117, 2416.0698131219433, 2416.1664225842055, 8260.050094239179, 8298.502089874626, 8302.252797248277, 8307.667693292262, 8308.29379502743, 4917.237828136645, 5010.649254552182, 5013.298138260647, 5018.548330650259, 5025.422076461217, 3229.1442767666585, 3258.2506023614465, 3329.783564068328, 3333.5499707539416, 3338.2655815720505, 1080.287010573018, 1083.230906056693, 1088.5101704233048, 1090.138790355626, 1095.6055819904827, 11276.605318813885, 11326.433678316134, 11339.489722962486, 11339.603113890975, 11349.602763903305, 4580.0, 4595.954040459553, 4618.769061546909, 4642.744649044335, 4650.837220697327, 9608.519574021271, 9628.47043412619, 9656.662016829378, 9657.32398732082, 9668.323217374716, 5089.287499750038, 5110.744462776846, 5136.357955255593, 5138.07514647367, 5146.742662866842, 4199.748015119103, 4264.33902745075, 4636.698614590041, 4697.694649847749, 4745.383100196952, 3829.9617003829603, 3858.6913046956174, 3871.535415750128, 3884.941725874114, 3908.257431088141, 1302.9804552931714, 1325.562564353761, 1333.553259658006, 1339.5043833781563, 1342.1209108034254, 1428.114568967247, 1434.1610158057445, 1446.6889618732023, 1488.1443170176974, 1491.3736230783097, 7866.488678235896, 7881.842363152819, 7892.250236227549, 7896.763097107096, 7918.960405198052, 547.9835604931858, 550.771429856613, 550.9724513774295, 562.0304973919955, 562.8508445262008, 6193.6903154842075, 6222.844428889314, 6287.842803929847, 6314.936850631527, 6330.240371155491, 9968.053034961667, 10126.0, 10142.543585538668, 10282.948585257025, 10318.845217321747, 9856.457894815854, 10013.148882345082, 10131.13885319756, 10180.745481363025, 10206.744831379276, 7911.446198766146, 7923.801904952307, 7930.722424715107, 8012.158723334082, 8016.519008859487, 7702.499337543042, 7774.533527988338, 7775.883361749691, 7797.064352277763, 7818.569978651229, 8975.28197744192, 9055.954720226357, 9074.90925090767, 9095.772605684911, 9206.125418085272, 9223.76940576491, 9405.764855878659, 9430.95284523573, 9545.761355966157, 9551.474668893277, 6540.967295163684, 6701.798946031627, 7026.156861176487, 7312.378447831781, 7391.039164908742, 7834.294913457816, 7858.528488290721, 7864.567448790372, 7907.56508392044, 7910.367170626451, 7223.530470519399, 7430.4798664093, 7450.254974502724, 7484.962575187089, 7533.773986780406, 7106.857862842818, 7367.2264412235945, 7371.262873712586, 7373.926260737324, 7466.1040675117165, 7260.419166466776, 7265.09186351706, 7268.927310726825, 7314.0, 7455.105387353552, 6863.862722745617, 6961.164660240804, 6987.266337034742, 6990.9300906990275, 6991.755288564876, 7096.219415864148, 7100.680469378787, 7123.82190445243, 7126.35862772353, 7131.42948564124], "unit": "score", "name": "mootools.html", "value": 4724.352700879561}, {"lowerIsBetter": false, "replicates": [370.25763344494294, 371.29083450609335, 373.78320574067044, 375.87032473796546, 383.3865814696486, 6030.125631783389, 6050.576459647827, 6066.363031881655, 6066.8483287917825, 6079.63522188669, 5728.914066289009, 5757.366689664133, 5833.912491312633, 5950.10748387742, 5980.700964951757, 4689.906201875978, 4690.554397332248, 4698.013417182396, 4703.741294228816, 4723.504032076634, 4505.904754289255, 4685.20351540239, 4707.505711900252, 4713.858584242478, 4717.504662010474, 4579.793909274074, 4582.770861456914, 4658.650601204906, 4670.743109128996, 4671.0, 4634.2353511670535, 4647.535246475376, 4666.416697912761, 4671.416072990876, 4675.509071547473, 4144.129732756125, 4163.2298024865495, 4170.562090980434, 4178.080822219107, 4181.644560212386, 5547.944520554784, 5651.9717401413145, 5656.2929633795775, 5656.717164141817, 5663.716814159276, 5370.382406023318, 5436.483534064297, 5439.048166570834, 5445.1832225166145, 5455.290812194429, 6391.904121438182, 6395.456386207178, 6402.35976402356, 6403.615783053032, 6410.743570257184, 4562.703424277412, 4567.109413664337, 4567.33773602829, 4571.2000399929875, 4574.245249533823, 6504.089427480157, 6551.475881929434, 6621.602703837737, 6622.0, 6631.867362652768, 4634.165850146938, 4679.485256621769, 4679.508651591534, 4680.134175177603, 4681.438227412732, 4730.124926888537, 4734.834280800155, 4736.4316282046375, 4740.976295118502, 4744.810207591658, 5402.945970540244, 5402.972985135049, 5407.0267351876255, 5421.674699518042, 5422.864428389322, 6274.560780745395, 6417.582857114273, 6429.357064293533, 6429.6142231466265, 6431.453326467303, 1655.1806855606312, 1672.2809192047537, 1675.388483203622, 1675.3968571314317, 1676.4048762689313, 1129.4239937631703, 1131.422974283105, 1145.9083273338113, 1146.3752255020868, 1151.073385924339, 6178.567500274938, 6185.567010309235, 6193.938060619426, 6195.721192546346, 6196.1635179250225, 6424.839379015562, 6611.404973552403, 6611.900821487681, 6613.371729685672, 6618.271990081087, 6086.087086936995, 6136.355682653347, 6220.942439785247, 6244.594101383395, 6254.718537665725, 3525.7708248963736, 3563.1448452371246, 3566.8038257895546, 3580.4987301777774, 3581.7850928944345, 6697.631630260383, 6821.590704557742, 6828.180618325832, 6832.487563432763, 6834.419074378733, 6812.114425124702, 6827.590344579242, 6834.897476537856, 6836.316368363224, 6839.418649414756, 6814.284500127415, 6816.0, 6817.625030623264, 6822.863542729117, 6850.0752398426575, 6485.15692959931, 6636.303188165173, 6637.435817955527, 6649.73401063952, 6652.600843949379, 6570.737170513126, 6579.835504112435, 6622.205335359788, 6630.171228596426, 6647.135872336566, 6793.252742198255, 6862.348076932683, 6864.828379290558, 6869.210040845367, 6909.2745261746795, 4598.954010459986, 4669.719816810866, 4671.813127474863, 4672.042231342499, 4672.7429991349445, 6631.171103612049, 6681.76613818514, 6738.056672065817, 6739.59562426256, 6746.224184218681, 6469.126667899774, 6473.255575608677, 6474.741010359533, 6476.319986401549, 6476.967615161894, 6275.592086514362, 6415.454686351713, 6460.612363258219, 6469.547131700924, 6479.1901012373455, 6356.046593011085, 6375.139356186855, 6379.553431259767, 6384.201974753156, 6390.137331460193, 6501.772437964649, 6503.967480162569, 6504.284528701744, 6510.479161666961, 6513.73945042193, 6222.782202622887, 6344.175257216532, 6350.587211831216, 6355.5551111421755, 6360.332165122781], "unit": "score", "name": "prototype.html", "value": 4890.959069991629}, {"lowerIsBetter": false, "replicates": [809.8339840332733, 842.4818736477068, 872.3457406944791, 889.5596679643577, 890.2255038116839, 13633.1138475999, 13778.448862045507, 13783.862161378383, 13831.58505244843, 13833.861661383396, 13420.463181472729, 13484.797728034062, 13495.66260843477, 13524.864751352483, 14527.92736036321, 889.8932128144615, 904.9366544341899, 905.3345790843724, 908.1372695938885, 909.6770646420524, 901.3600343755909, 903.1690844423147, 912.0469109780296, 912.4206129108031, 914.5655813488573, 951.1629765806116, 955.7610597350663, 957.4398976598698, 959.1032384720274, 959.8032403357295, 947.8436058050413, 953.6423841059602, 955.0878910640322, 955.6082006377352, 956.2445667922333, 704.246456291768, 706.8904319830434, 707.9752208672671, 709.3438569323407, 709.4005565297316, 13748.518801841987, 13815.171089734647, 13820.170789752647, 13822.93088534551, 13824.585262442142, 12080.456379462945, 12141.939290303491, 12148.817767733492, 12333.814992775115, 12340.81488777669, 10337.328073675262, 10572.612788120307, 10586.258961872672, 10612.097971672418, 10769.676909692722, 3810.8666196682984, 3837.2517359114986, 3880.573136954961, 3899.9610003900166, 3908.1402091539817, 44574.77712611449, 45843.0, 47711.76144119292, 50326.0, 52447.475525244256, 10389.064984151462, 10979.396133212591, 11058.723531911606, 11280.097592192606, 11323.886761132284, 19666.70499942502, 19681.507962301057, 19688.114034868464, 19690.40928772139, 19702.211911523664, 7920.128785833554, 8006.71976480832, 8117.878231826528, 8243.793905152419, 8298.21166989135, 4502.5047244803045, 4571.794269257892, 4589.33454649074, 4600.010997635524, 4613.700109492872, 3186.060112266887, 3211.405889910374, 3213.9196520086716, 3215.0, 3216.7748257621743, 541.7914103070267, 586.6626689653466, 592.1029640095259, 592.9466348028698, 593.8129489210885, 604.5828378418877, 620.252595622274, 642.5855323316434, 651.9087327774115, 655.4494224851053, 7379.963100184572, 7485.812854678677, 7641.197674244125, 7756.573388463688, 7810.218978102144, 591.3701907468533, 605.2555356911024, 629.7040391016216, 637.6174295422709, 702.9841977914689, 4362.476502819682, 4382.145481631115, 4643.674942753974, 4826.95173048272, 4847.927281090787, 53389.46610533923, 53900.73049634727, 60617.0, 61189.0, 61564.0, 46317.30524042142, 53485.73257133689, 54621.72689136529, 54623.18065229025, 55210.0, 44479.33281000787, 47967.760161199665, 49802.75098624556, 49933.75033124884, 50787.492125079014, 9184.908150918405, 9822.852657210005, 9824.557894894604, 9878.4566848824, 9976.650817221362, 37315.25369492649, 38105.618943811314, 38221.80889095537, 38874.4168837462, 39688.0, 44190.558094418644, 49902.25146622731, 50687.746561266955, 50821.0, 51006.23490647718, 10574.735631609272, 10831.295965762516, 10932.289401189215, 10963.068139207937, 11013.229073964745, 13281.628696073773, 13375.197488150741, 13422.39599218057, 13600.319984000958, 13609.727805444034, 12318.199317044364, 12360.196587221802, 12361.381930903599, 12425.37873106359, 12672.112952093265, 12443.813342799684, 12508.749825003631, 12520.624381268577, 12737.29944853042, 12991.935040324737, 11246.325220486797, 11470.0, 12077.27536347822, 12876.871231287942, 13076.738465230452, 10310.793784124426, 10313.535890884777, 10416.1667066636, 10535.841962370723, 10563.524641391003, 10615.0, 10887.673369798918, 11077.889221107685, 11113.110951124052, 11152.609658661908], "unit": "score", "name": "yui.html", "value": 6696.619603552237}], "name": "dromaeo_css", "value": 7163.850846772352}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 109.0, 110.0, 109.0, 99.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [146.0, 128.0, 146.0, 160.0, 134.0, 161.0, 149.0, 126.0, 163.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 163.0, 162.0, 163.0, 161.0, 166.0, 164.0, 159.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 159.0, 72.0, 72.0, 72.0, 73.0, 149.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 138.0, 94.0, 96.0, 96.0, 145.0, 95.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 54.0, 56.0, 54.0, 56.0, 54.0, 54.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.2}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 63.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 86.0, 79.0, 76.0, 77.0, 79.0, 76.0, 77.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.1}, {"lowerIsBetter": true, "replicates": [115.0, 109.0, 110.0, 114.0, 109.0, 112.0, 109.0, 113.0, 119.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.9}, {"lowerIsBetter": true, "replicates": [138.0, 135.0, 146.0, 131.0, 137.0, 131.0, 131.0, 132.0, 130.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.1}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 66.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.5}], "name": "kraken", "value": 1469.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [169.29067208396816], "unit": "score", "name": "DeltaBlue", "value": 390.55902599999985}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [967.1179883945841], "unit": "score", "name": "RayTrace", "value": 765.1486259999999}, {"lowerIsBetter": false, "replicates": [559.5970900951315], "unit": "score", "name": "Earley", "value": 1190.9693809999999}, {"lowerIsBetter": false, "replicates": [10680.851063829787], "unit": "score", "name": "Boyer", "value": 62.397930278884424}, {"lowerIsBetter": false, "replicates": [40540.0], "unit": "score", "name": "RegExp", "value": 22.47126295017266}, {"lowerIsBetter": false, "replicates": [512.557662737058], "unit": "score", "name": "Splay", "value": 158.98894099999993}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 22040.785503289917}]} 12:38:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,35]]", "result": "22040.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,35]]", "result": "1469.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,35]]", "result": "7163.85"}}} 12:38:57 INFO - Return code: 0 12:38:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:38:57 INFO - # TBPL SUCCESS # 12:38:57 INFO - Running post-action listener: _resource_record_post_action 12:38:57 INFO - Running post-run listener: _resource_record_post_run 12:38:58 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 462684160; Read time: 0; Write time: 377156 12:38:58 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 234172416; Read time: 0; Write time: 262032 12:38:58 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 0; Write bytes: 228192256; Read time: 0; Write time: 115100 12:38:58 INFO - Running post-run listener: _upload_blobber_files 12:38:58 INFO - Blob upload gear active. 12:38:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:38:58 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 12:38:58 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'] 12:38:58 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 12:38:59 INFO - (blobuploader) - INFO - Open directory for files ... 12:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:38:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:38:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:59 INFO - (blobuploader) - INFO - Done attempting. 12:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:00 INFO - (blobuploader) - INFO - Done attempting. 12:39:00 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:00 INFO - Return code: 0 12:39:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/1c79efbf884d9aa40ead21024a8841805c63cccbf1f5bd7eb22c1c3aa24c4bb89f145dd87b05425c4642d1ed751c3de0a68397a70bda1ca993b32bb6db3ae06d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/df66e119b22917c1fcc4043bca624633e4a0144000ecee10aec18fbfe8812760a2f5ac77123fef14192bb58ec25ffc1604c02ce43f46a499c66136ea2c7d7106"} 12:39:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:00 INFO - Contents: 12:39:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/1c79efbf884d9aa40ead21024a8841805c63cccbf1f5bd7eb22c1c3aa24c4bb89f145dd87b05425c4642d1ed751c3de0a68397a70bda1ca993b32bb6db3ae06d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/df66e119b22917c1fcc4043bca624633e4a0144000ecee10aec18fbfe8812760a2f5ac77123fef14192bb58ec25ffc1604c02ce43f46a499c66136ea2c7d7106"} 12:39:00 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:00 INFO - Copying logs to upload dir... 12:39:00 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.952324 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-11 12:39:00.704833) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:00.708382) ========= 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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 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/1c79efbf884d9aa40ead21024a8841805c63cccbf1f5bd7eb22c1c3aa24c4bb89f145dd87b05425c4642d1ed751c3de0a68397a70bda1ca993b32bb6db3ae06d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/df66e119b22917c1fcc4043bca624633e4a0144000ecee10aec18fbfe8812760a2f5ac77123fef14192bb58ec25ffc1604c02ce43f46a499c66136ea2c7d7106"} build_url:https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/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/1c79efbf884d9aa40ead21024a8841805c63cccbf1f5bd7eb22c1c3aa24c4bb89f145dd87b05425c4642d1ed751c3de0a68397a70bda1ca993b32bb6db3ae06d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/df66e119b22917c1fcc4043bca624633e4a0144000ecee10aec18fbfe8812760a2f5ac77123fef14192bb58ec25ffc1604c02ce43f46a499c66136ea2c7d7106"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:00.733769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:00.734126) ========= 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=62c568580acbfdaac3eec7be000001dc-1457726920.215284-58635263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:00.818814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 12:39:00.819146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 12:39:00.819460) ========= ========= Total master_lag: 0.35 =========