builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1461863384.3 results: success (0) buildid: 20160428073622 builduid: 397a7264fd924cb598c1b1bc3cfdae37 revision: f241151c616953e1dbbb29e4757dda10a56a3dd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.299911) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.300387) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.300686) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.317589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.317873) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 10:09:45-- 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% 111M=0s 2016-04-28 10:09:45 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.415230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.415516) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.466829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:44.467437) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f241151c616953e1dbbb29e4757dda10a56a3dd2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f241151c616953e1dbbb29e4757dda10a56a3dd2 --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=9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 10:09:45,379 truncating revision to first 12 chars 2016-04-28 10:09:45,379 Setting DEBUG logging. 2016-04-28 10:09:45,379 attempt 1/10 2016-04-28 10:09:45,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f241151c6169?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 10:09:45,638 unpacking tar archive at: mozilla-inbound-f241151c6169/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:45.056195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:45.056534) ========= script_repo_revision: f241151c616953e1dbbb29e4757dda10a56a3dd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:45.056977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:45.057252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 10:09:45.067452) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-28 10:09:45.067831) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:09:46 INFO - MultiFileLogger online at 20160428 10:09:46 in /builds/slave/test 10:09:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:09:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:09:46 INFO - {'append_to_log': False, 10:09:46 INFO - 'base_work_dir': '/builds/slave/test', 10:09:46 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:09:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:09:46 INFO - 'branch': 'Mozilla-Inbound', 10:09:46 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:46 INFO - 'config_files': ('talos/linux_config.py',), 10:09:46 INFO - 'default_actions': ('clobber', 10:09:46 INFO - 'read-buildbot-config', 10:09:46 INFO - 'download-and-extract', 10:09:46 INFO - 'populate-webroot', 10:09:46 INFO - 'create-virtualenv', 10:09:46 INFO - 'install', 10:09:46 INFO - 'run-tests'), 10:09:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:46 INFO - 'download_minidump_stackwalk': True, 10:09:46 INFO - 'download_symbols': 'ondemand', 10:09:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:46 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:46 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:46 INFO - 'installer_path': 'installer.exe', 10:09:46 INFO - 'log_level': 'info', 10:09:46 INFO - 'log_name': 'talos', 10:09:46 INFO - 'log_to_console': True, 10:09:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:09:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:09:46 INFO - 'opt_config_files': (), 10:09:46 INFO - 'pip_index': False, 10:09:46 INFO - 'sps_profile': False, 10:09:46 INFO - 'sps_profile_interval': 0, 10:09:46 INFO - 'suite': 'dromaeojs', 10:09:46 INFO - 'system_bits': '32', 10:09:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:46 INFO - 'title': 'talos-linux64-ix-040', 10:09:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:46 INFO - 'use_talos_json': True, 10:09:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:09:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:46 INFO - 'work_dir': 'build'} 10:09:46 INFO - ##### 10:09:46 INFO - ##### Running clobber step. 10:09:46 INFO - ##### 10:09:46 INFO - Running pre-action listener: _resource_record_pre_action 10:09:46 INFO - Running main action method: clobber 10:09:46 INFO - rmtree: /builds/slave/test/build 10:09:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:09:47 INFO - Running post-action listener: _resource_record_post_action 10:09:47 INFO - ##### 10:09:47 INFO - ##### Running read-buildbot-config step. 10:09:47 INFO - ##### 10:09:47 INFO - Running pre-action listener: _resource_record_pre_action 10:09:47 INFO - Running main action method: read_buildbot_config 10:09:47 INFO - Using buildbot properties: 10:09:47 INFO - { 10:09:47 INFO - "project": "", 10:09:47 INFO - "product": "firefox", 10:09:47 INFO - "script_repo_revision": "production", 10:09:47 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:09:47 INFO - "repository": "", 10:09:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:09:47 INFO - "buildid": "20160428073622", 10:09:47 INFO - "pgo_build": "True", 10:09:47 INFO - "basedir": "/builds/slave/test", 10:09:47 INFO - "buildnumber": 1764, 10:09:47 INFO - "slavename": "talos-linux64-ix-040", 10:09:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:09:47 INFO - "platform": "ubuntu64_hw", 10:09:47 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:09:47 INFO - "branch": "mozilla-inbound", 10:09:47 INFO - "repo_path": "integration/mozilla-inbound", 10:09:47 INFO - "revision": "f241151c616953e1dbbb29e4757dda10a56a3dd2", 10:09:47 INFO - "stage_platform": "linux64-pgo", 10:09:47 INFO - "builduid": "397a7264fd924cb598c1b1bc3cfdae37", 10:09:47 INFO - "slavebuilddir": "test" 10:09:47 INFO - } 10:09:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:09:47 INFO - Running post-action listener: _resource_record_post_action 10:09:47 INFO - ##### 10:09:47 INFO - ##### Running download-and-extract step. 10:09:47 INFO - ##### 10:09:47 INFO - Running pre-action listener: _resource_record_pre_action 10:09:47 INFO - Running main action method: download_and_extract 10:09:47 INFO - mkdir: /builds/slave/test/build/tests 10:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:47 INFO - https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:09:48 INFO - Downloaded 1361 bytes. 10:09:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:09:48 INFO - Using the following test package requirements: 10:09:48 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:09:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:09:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:48 INFO - u'jsshell-linux-x86_64.zip'], 10:09:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:09:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:09:48 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:09:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:09:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:09:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:09: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')]} 10:09:48 INFO - https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:09:51 INFO - Downloaded 23873309 bytes. 10:09:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:52 INFO - Return code: 0 10:09:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:52 INFO - https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:09:56 INFO - Downloaded 23873309 bytes. 10:09:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:57 INFO - Return code: 0 10:09:57 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')]} 10:09:57 INFO - https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:09:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:09:59 INFO - Downloaded 10840145 bytes. 10:09:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:10:00 INFO - Return code: 0 10:10:00 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')]} 10:10:00 INFO - https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:10:01 INFO - Downloaded 58409502 bytes. 10:10:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:10:01 INFO - mkdir: /builds/slave/test/properties 10:10:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:10:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:10:01 INFO - Contents: 10:10:01 INFO - build_url:https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:10:02 INFO - Running post-action listener: _resource_record_post_action 10:10:02 INFO - Running post-action listener: set_extra_try_arguments 10:10:02 INFO - ##### 10:10:02 INFO - ##### Running populate-webroot step. 10:10:02 INFO - ##### 10:10:02 INFO - Running pre-action listener: _resource_record_pre_action 10:10:02 INFO - Running main action method: populate_webroot 10:10:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:10:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:10:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:10:02 INFO - '--tppagecycles', 10:10:02 INFO - '7'], 10:10:02 INFO - 'tests': ['tsvgm']}}, 10:10:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:10:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:10:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:10:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:10:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:02 INFO - 'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:02 INFO - 'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['damp', 'tps']}, 10:10:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:02 INFO - 'tests': ['damp', 'tps']}, 10:10:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['dromaeo_dom']}, 10:10:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:10:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['a11yr', 10:10:02 INFO - 'ts_paint', 10:10:02 INFO - 'tpaint', 10:10:02 INFO - 'sessionrestore', 10:10:02 INFO - 'sessionrestore_no_auto_restore', 10:10:02 INFO - 'tabpaint']}, 10:10:02 INFO - 'other-e10s': {'tests': ['a11yr', 10:10:02 INFO - 'ts_paint', 10:10:02 INFO - 'tpaint', 10:10:02 INFO - 'sessionrestore', 10:10:02 INFO - 'sessionrestore_no_auto_restore', 10:10:02 INFO - 'tabpaint']}, 10:10:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:10:02 INFO - 'ts_paint', 10:10:02 INFO - 'tpaint', 10:10:02 INFO - 'sessionrestore', 10:10:02 INFO - 'sessionrestore_no_auto_restore', 10:10:02 INFO - 'tabpaint']}, 10:10:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:10:02 INFO - 'ts_paint', 10:10:02 INFO - 'tpaint', 10:10:02 INFO - 'sessionrestore', 10:10:02 INFO - 'sessionrestore_no_auto_restore', 10:10:02 INFO - 'tabpaint']}, 10:10:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['a11yr', 10:10:02 INFO - 'ts_paint', 10:10:02 INFO - 'tpaint', 10:10:02 INFO - 'sessionrestore', 10:10:02 INFO - 'sessionrestore_no_auto_restore', 10:10:02 INFO - 'tabpaint']}, 10:10:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['a11yr', 10:10:02 INFO - 'ts_paint', 10:10:02 INFO - 'tpaint', 10:10:02 INFO - 'sessionrestore', 10:10:02 INFO - 'sessionrestore_no_auto_restore', 10:10:02 INFO - 'tabpaint']}, 10:10:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['tsvgx', 10:10:02 INFO - 'tsvgr_opacity', 10:10:02 INFO - 'tart', 10:10:02 INFO - 'tscrollx', 10:10:02 INFO - 'cart']}, 10:10:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:10:02 INFO - 'tsvgr_opacity', 10:10:02 INFO - 'tart', 10:10:02 INFO - 'tscrollx', 10:10:02 INFO - 'cart']}, 10:10:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:02 INFO - 'talos_options': ['--disable-e10s'], 10:10:02 INFO - 'tests': ['tp5o']}, 10:10:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:02 INFO - 'tests': ['tp5o']}, 10:10:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:02 INFO - 'talos_options': ['--disable-e10s', 10:10:02 INFO - '--xperf_path', 10:10:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:02 INFO - 'tests': ['tp5n']}, 10:10:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:02 INFO - 'talos_options': ['--xperf_path', 10:10:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:02 INFO - 'tests': ['tp5n']}}, 10:10:02 INFO - 'talos.zip': {'path': '', 10:10:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:10:02 INFO - Running post-action listener: _resource_record_post_action 10:10:02 INFO - ##### 10:10:02 INFO - ##### Running create-virtualenv step. 10:10:02 INFO - ##### 10:10:02 INFO - Running pre-action listener: _resource_record_pre_action 10:10:03 INFO - Running main action method: create_virtualenv 10:10:03 INFO - Creating virtualenv /builds/slave/test/build/venv 10:10:03 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 10:10:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:10:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:10:03 INFO - Using real prefix '/usr' 10:10:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:10:03 INFO - Installing distribute.............................................................................................................................................................................................done. 10:10:05 INFO - Installing pip.................done. 10:10:05 INFO - Return code: 0 10:10:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:05 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:05 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 10:10:05 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 10:10:05 INFO - Using env: {'DISPLAY': ':0', 10:10:05 INFO - 'HOME': '/home/cltbld', 10:10:05 INFO - 'LANG': 'en_US.UTF-8', 10:10:05 INFO - 'LANGUAGE': 'en_US:en', 10:10:05 INFO - 'LOGNAME': 'cltbld', 10:10:05 INFO - 'MAIL': '/var/mail/cltbld', 10:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:05 INFO - 'MOZ_NO_REMOTE': '1', 10:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:05 INFO - 'NO_EM_RESTART': '1', 10:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:05 INFO - 'PWD': '/builds/slave/test', 10:10:05 INFO - 'SHELL': '/bin/bash', 10:10:05 INFO - 'SHLVL': '1', 10:10:05 INFO - 'TERM': 'linux', 10:10:05 INFO - 'TMOUT': '86400', 10:10:05 INFO - 'USER': 'cltbld', 10:10:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:05 INFO - '_': '/tools/buildbot/bin/python'} 10:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:05 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 10:10:05 INFO - Cleaning up... 10:10:05 INFO - Return code: 0 10:10:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:05 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:05 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 10:10:05 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 10:10:05 INFO - Using env: {'DISPLAY': ':0', 10:10:05 INFO - 'HOME': '/home/cltbld', 10:10:05 INFO - 'LANG': 'en_US.UTF-8', 10:10:05 INFO - 'LANGUAGE': 'en_US:en', 10:10:05 INFO - 'LOGNAME': 'cltbld', 10:10:05 INFO - 'MAIL': '/var/mail/cltbld', 10:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:05 INFO - 'MOZ_NO_REMOTE': '1', 10:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:05 INFO - 'NO_EM_RESTART': '1', 10:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:05 INFO - 'PWD': '/builds/slave/test', 10:10:05 INFO - 'SHELL': '/bin/bash', 10:10:05 INFO - 'SHLVL': '1', 10:10:05 INFO - 'TERM': 'linux', 10:10:05 INFO - 'TMOUT': '86400', 10:10:05 INFO - 'USER': 'cltbld', 10:10:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:05 INFO - '_': '/tools/buildbot/bin/python'} 10:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:05 INFO - Downloading/unpacking psutil>=0.7.1 10:10:05 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 10:10:05 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 10:10:05 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 10:10:05 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 10:10:05 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 10:10:05 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 10:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:08 INFO - Installing collected packages: psutil 10:10:08 INFO - Running setup.py install for psutil 10:10:08 INFO - building 'psutil._psutil_linux' extension 10:10:08 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 10:10:08 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 10:10:08 INFO - building 'psutil._psutil_posix' extension 10:10:08 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 10:10:08 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 10:10:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:08 INFO - Successfully installed psutil 10:10:08 INFO - Cleaning up... 10:10:08 INFO - Return code: 0 10:10:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:08 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:08 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 10:10:08 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 10:10:08 INFO - Using env: {'DISPLAY': ':0', 10:10:08 INFO - 'HOME': '/home/cltbld', 10:10:08 INFO - 'LANG': 'en_US.UTF-8', 10:10:08 INFO - 'LANGUAGE': 'en_US:en', 10:10:08 INFO - 'LOGNAME': 'cltbld', 10:10:08 INFO - 'MAIL': '/var/mail/cltbld', 10:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:08 INFO - 'MOZ_NO_REMOTE': '1', 10:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:08 INFO - 'NO_EM_RESTART': '1', 10:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:08 INFO - 'PWD': '/builds/slave/test', 10:10:08 INFO - 'SHELL': '/bin/bash', 10:10:08 INFO - 'SHLVL': '1', 10:10:08 INFO - 'TERM': 'linux', 10:10:08 INFO - 'TMOUT': '86400', 10:10:08 INFO - 'USER': 'cltbld', 10:10:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:08 INFO - '_': '/tools/buildbot/bin/python'} 10:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:10:08 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 10:10:08 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 10:10:08 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 10:10:08 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 10:10:08 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 10:10:08 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 10:10:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:10:10 INFO - Installing collected packages: mozsystemmonitor 10:10:10 INFO - Running setup.py install for mozsystemmonitor 10:10:10 INFO - Successfully installed mozsystemmonitor 10:10:10 INFO - Cleaning up... 10:10:10 INFO - Return code: 0 10:10:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10:10 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')]} 10:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:10 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')]} 10:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:10 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:10 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 10:10:10 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 10:10:10 INFO - Using env: {'DISPLAY': ':0', 10:10:10 INFO - 'HOME': '/home/cltbld', 10:10:10 INFO - 'LANG': 'en_US.UTF-8', 10:10:10 INFO - 'LANGUAGE': 'en_US:en', 10:10:10 INFO - 'LOGNAME': 'cltbld', 10:10:10 INFO - 'MAIL': '/var/mail/cltbld', 10:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:10 INFO - 'MOZ_NO_REMOTE': '1', 10:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:10 INFO - 'NO_EM_RESTART': '1', 10:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:10 INFO - 'PWD': '/builds/slave/test', 10:10:10 INFO - 'SHELL': '/bin/bash', 10:10:10 INFO - 'SHLVL': '1', 10:10:10 INFO - 'TERM': 'linux', 10:10:10 INFO - 'TMOUT': '86400', 10:10:10 INFO - 'USER': 'cltbld', 10:10:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:10 INFO - '_': '/tools/buildbot/bin/python'} 10:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:11 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:11 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 10:10:11 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 10:10:11 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 10:10:11 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 10:10:11 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 10:10:11 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 10:10:12 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10:12 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 10:10:12 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 10:10:12 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 10:10:12 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 10:10:12 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 10:10:12 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 10:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:13 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 10:10:13 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 10:10:13 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 10:10:13 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 10:10:13 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 10:10:13 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 10:10:13 INFO - Downloading docopt-0.6.1.tar.gz 10:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:13 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:13 INFO - Running setup.py install for blobuploader 10:10:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:13 INFO - Running setup.py install for requests 10:10:14 INFO - Running setup.py install for docopt 10:10:14 INFO - Successfully installed blobuploader requests docopt 10:10:14 INFO - Cleaning up... 10:10:14 INFO - Return code: 0 10:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:14 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:14 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 10:10:14 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 10:10:14 INFO - Using env: {'DISPLAY': ':0', 10:10:14 INFO - 'HOME': '/home/cltbld', 10:10:14 INFO - 'LANG': 'en_US.UTF-8', 10:10:14 INFO - 'LANGUAGE': 'en_US:en', 10:10:14 INFO - 'LOGNAME': 'cltbld', 10:10:14 INFO - 'MAIL': '/var/mail/cltbld', 10:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:14 INFO - 'MOZ_NO_REMOTE': '1', 10:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:14 INFO - 'NO_EM_RESTART': '1', 10:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:14 INFO - 'PWD': '/builds/slave/test', 10:10:14 INFO - 'SHELL': '/bin/bash', 10:10:14 INFO - 'SHLVL': '1', 10:10:14 INFO - 'TERM': 'linux', 10:10:14 INFO - 'TMOUT': '86400', 10:10:14 INFO - 'USER': 'cltbld', 10:10:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:14 INFO - '_': '/tools/buildbot/bin/python'} 10:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:14 INFO - Running setup.py (path:/tmp/pip-N8Flgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:14 INFO - Running setup.py (path:/tmp/pip-v36E6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:14 INFO - Running setup.py (path:/tmp/pip-COAYar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:14 INFO - Running setup.py (path:/tmp/pip-0aoPzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:14 INFO - Running setup.py (path:/tmp/pip-r8aiov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:14 INFO - Running setup.py (path:/tmp/pip-ZHaZmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:14 INFO - Running setup.py (path:/tmp/pip-d_a2PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:14 INFO - Running setup.py (path:/tmp/pip-K30XLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:15 INFO - Running setup.py (path:/tmp/pip-9SZlgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:15 INFO - Running setup.py (path:/tmp/pip-1mFiQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:15 INFO - Running setup.py (path:/tmp/pip-6UdlmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:15 INFO - Running setup.py (path:/tmp/pip-UtA0NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:15 INFO - Running setup.py (path:/tmp/pip-sugMrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:15 INFO - Running setup.py (path:/tmp/pip-Fj2WH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:15 INFO - Running setup.py (path:/tmp/pip-WB5WcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:15 INFO - Running setup.py (path:/tmp/pip-jsYhYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:15 INFO - Running setup.py (path:/tmp/pip-s8soyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:15 INFO - Running setup.py install for manifestparser 10:10:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:15 INFO - Running setup.py install for mozcrash 10:10:15 INFO - Running setup.py install for mozdebug 10:10:15 INFO - Running setup.py install for mozdevice 10:10:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Running setup.py install for mozfile 10:10:16 INFO - Running setup.py install for mozhttpd 10:10:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Running setup.py install for mozinfo 10:10:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Running setup.py install for mozInstall 10:10:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Running setup.py install for mozleak 10:10:16 INFO - Running setup.py install for mozlog 10:10:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Running setup.py install for moznetwork 10:10:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:16 INFO - Running setup.py install for mozprocess 10:10:16 INFO - Running setup.py install for mozprofile 10:10:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:17 INFO - Running setup.py install for mozrunner 10:10:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:17 INFO - Running setup.py install for mozscreenshot 10:10:17 INFO - Running setup.py install for moztest 10:10:17 INFO - Running setup.py install for mozversion 10:10:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:17 INFO - Cleaning up... 10:10:17 INFO - Return code: 0 10:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:17 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:17 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 10:10:17 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 10:10:17 INFO - Using env: {'DISPLAY': ':0', 10:10:17 INFO - 'HOME': '/home/cltbld', 10:10:17 INFO - 'LANG': 'en_US.UTF-8', 10:10:17 INFO - 'LANGUAGE': 'en_US:en', 10:10:17 INFO - 'LOGNAME': 'cltbld', 10:10:17 INFO - 'MAIL': '/var/mail/cltbld', 10:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:17 INFO - 'MOZ_NO_REMOTE': '1', 10:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:17 INFO - 'NO_EM_RESTART': '1', 10:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:17 INFO - 'PWD': '/builds/slave/test', 10:10:17 INFO - 'SHELL': '/bin/bash', 10:10:17 INFO - 'SHLVL': '1', 10:10:17 INFO - 'TERM': 'linux', 10:10:17 INFO - 'TMOUT': '86400', 10:10:17 INFO - 'USER': 'cltbld', 10:10:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:17 INFO - '_': '/tools/buildbot/bin/python'} 10:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:17 INFO - Running setup.py (path:/tmp/pip-1gj2jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:17 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)) 10:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:17 INFO - Running setup.py (path:/tmp/pip-co96vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:17 INFO - Running setup.py (path:/tmp/pip-7EKWXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:17 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)) 10:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:17 INFO - Running setup.py (path:/tmp/pip-g4toS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:17 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)) 10:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:17 INFO - Running setup.py (path:/tmp/pip-ctgeEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:18 INFO - Running setup.py (path:/tmp/pip-ailge8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:18 INFO - Running setup.py (path:/tmp/pip-adg_pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:18 INFO - Running setup.py (path:/tmp/pip-06O7t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:18 INFO - Running setup.py (path:/tmp/pip-R94mcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:18 INFO - Running setup.py (path:/tmp/pip-bZdwI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:18 INFO - Running setup.py (path:/tmp/pip-gidOnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:18 INFO - Running setup.py (path:/tmp/pip-tlmlu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:18 INFO - Running setup.py (path:/tmp/pip-v26lCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:18 INFO - Running setup.py (path:/tmp/pip-oi59wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:18 INFO - Running setup.py (path:/tmp/pip-CzzuUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:18 INFO - Running setup.py (path:/tmp/pip-kz9OyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:18 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)) 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:18 INFO - Running setup.py (path:/tmp/pip-ylL9a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:18 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)) 10:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:10:18 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)) 10:10:18 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)) 10:10:18 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)) 10:10:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:18 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 10:10:18 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 10:10:18 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 10:10:18 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 10:10:18 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 10:10:18 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 10:10:20 INFO - Downloading blessings-1.6.tar.gz 10:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:20 INFO - Installing collected packages: blessings 10:10:20 INFO - Running setup.py install for blessings 10:10:20 INFO - Successfully installed blessings 10:10:20 INFO - Cleaning up... 10:10:21 INFO - Return code: 0 10:10:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:21 INFO - Reading from file tmpfile_stdout 10:10:21 INFO - Current package versions: 10:10:21 INFO - argparse == 1.2.1 10:10:21 INFO - blessings == 1.6 10:10:21 INFO - blobuploader == 1.2.4 10:10:21 INFO - docopt == 0.6.1 10:10:21 INFO - manifestparser == 1.1 10:10:21 INFO - mozInstall == 1.12 10:10:21 INFO - mozcrash == 0.17 10:10:21 INFO - mozdebug == 0.1 10:10:21 INFO - mozdevice == 0.48 10:10:21 INFO - mozfile == 1.2 10:10:21 INFO - mozhttpd == 0.7 10:10:21 INFO - mozinfo == 0.9 10:10:21 INFO - mozleak == 0.1 10:10:21 INFO - mozlog == 3.1 10:10:21 INFO - moznetwork == 0.27 10:10:21 INFO - mozprocess == 0.22 10:10:21 INFO - mozprofile == 0.28 10:10:21 INFO - mozrunner == 6.11 10:10:21 INFO - mozscreenshot == 0.1 10:10:21 INFO - mozsystemmonitor == 0.0 10:10:21 INFO - moztest == 0.7 10:10:21 INFO - mozversion == 1.4 10:10:21 INFO - psutil == 3.1.1 10:10:21 INFO - requests == 1.2.3 10:10:21 INFO - wsgiref == 0.1.2 10:10:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:21 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:21 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 10:10:21 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 10:10:21 INFO - Using env: {'DISPLAY': ':0', 10:10:21 INFO - 'HOME': '/home/cltbld', 10:10:21 INFO - 'LANG': 'en_US.UTF-8', 10:10:21 INFO - 'LANGUAGE': 'en_US:en', 10:10:21 INFO - 'LOGNAME': 'cltbld', 10:10:21 INFO - 'MAIL': '/var/mail/cltbld', 10:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:21 INFO - 'MOZ_NO_REMOTE': '1', 10:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:21 INFO - 'NO_EM_RESTART': '1', 10:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:21 INFO - 'PWD': '/builds/slave/test', 10:10:21 INFO - 'SHELL': '/bin/bash', 10:10:21 INFO - 'SHLVL': '1', 10:10:21 INFO - 'TERM': 'linux', 10:10:21 INFO - 'TMOUT': '86400', 10:10:21 INFO - 'USER': 'cltbld', 10:10:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:21 INFO - '_': '/tools/buildbot/bin/python'} 10:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 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)) 10:10:21 INFO - Cleaning up... 10:10:21 INFO - Return code: 0 10:10:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:21 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:21 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 10:10:21 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 10:10:21 INFO - Using env: {'DISPLAY': ':0', 10:10:21 INFO - 'HOME': '/home/cltbld', 10:10:21 INFO - 'LANG': 'en_US.UTF-8', 10:10:21 INFO - 'LANGUAGE': 'en_US:en', 10:10:21 INFO - 'LOGNAME': 'cltbld', 10:10:21 INFO - 'MAIL': '/var/mail/cltbld', 10:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:21 INFO - 'MOZ_NO_REMOTE': '1', 10:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:21 INFO - 'NO_EM_RESTART': '1', 10:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:21 INFO - 'PWD': '/builds/slave/test', 10:10:21 INFO - 'SHELL': '/bin/bash', 10:10:21 INFO - 'SHLVL': '1', 10:10:21 INFO - 'TERM': 'linux', 10:10:21 INFO - 'TMOUT': '86400', 10:10:21 INFO - 'USER': 'cltbld', 10:10:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:21 INFO - '_': '/tools/buildbot/bin/python'} 10:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:21 INFO - Downloading/unpacking jsonschema 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:10:23 INFO - Downloading/unpacking functools32 (from jsonschema) 10:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:10:23 INFO - warning: no files found matching '*.txt' 10:10:23 INFO - no previously-included directories found matching 'build' 10:10:23 INFO - no previously-included directories found matching 'dist' 10:10:23 INFO - no previously-included directories found matching '.git*' 10:10:23 INFO - Installing collected packages: jsonschema, functools32 10:10:23 INFO - Running setup.py install for functools32 10:10:23 INFO - warning: no files found matching '*.txt' 10:10:23 INFO - no previously-included directories found matching 'build' 10:10:23 INFO - no previously-included directories found matching 'dist' 10:10:23 INFO - no previously-included directories found matching '.git*' 10:10:23 INFO - Successfully installed jsonschema functools32 10:10:23 INFO - Cleaning up... 10:10:24 INFO - Return code: 0 10:10:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:24 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 0x7fae9437df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', '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 10:10:24 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 10:10:24 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 10:10:24 INFO - Using env: {'DISPLAY': ':0', 10:10:24 INFO - 'HOME': '/home/cltbld', 10:10:24 INFO - 'LANG': 'en_US.UTF-8', 10:10:24 INFO - 'LANGUAGE': 'en_US:en', 10:10:24 INFO - 'LOGNAME': 'cltbld', 10:10:24 INFO - 'MAIL': '/var/mail/cltbld', 10:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:24 INFO - 'MOZ_NO_REMOTE': '1', 10:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:24 INFO - 'NO_EM_RESTART': '1', 10:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:24 INFO - 'PWD': '/builds/slave/test', 10:10:24 INFO - 'SHELL': '/bin/bash', 10:10:24 INFO - 'SHLVL': '1', 10:10:24 INFO - 'TERM': 'linux', 10:10:24 INFO - 'TMOUT': '86400', 10:10:24 INFO - 'USER': 'cltbld', 10:10:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:24 INFO - '_': '/tools/buildbot/bin/python'} 10:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:24 INFO - Downloading/unpacking flake8 10:10:24 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 10:10:24 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 10:10:24 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 10:10:24 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 10:10:24 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 10:10:24 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 10:10:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:10:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:10:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:10:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:10:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:10:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:10:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:10:26 INFO - no previously-included directories found matching 'docs/_build' 10:10:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:10:26 INFO - Running setup.py install for pep8 10:10:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:10:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:10:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:10:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:10:26 INFO - no previously-included directories found matching 'docs/_build' 10:10:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:10:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:10:27 INFO - Cleaning up... 10:10:27 INFO - Return code: 0 10:10:27 INFO - Running post-action listener: _resource_record_post_action 10:10:27 INFO - Running post-action listener: _start_resource_monitoring 10:10:27 INFO - Starting resource monitoring. 10:10:27 INFO - ##### 10:10:27 INFO - ##### Running install step. 10:10:27 INFO - ##### 10:10:27 INFO - Running pre-action listener: _resource_record_pre_action 10:10:27 INFO - Running main action method: install 10:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:27 INFO - Reading from file tmpfile_stdout 10:10:27 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:27 INFO - Reading from file tmpfile_stdout 10:10:27 INFO - Output received: 10:10:27 INFO - Usage: mozinstall [options] installer 10:10:27 INFO - Options: 10:10:27 INFO - -h, --help show this help message and exit 10:10:27 INFO - -d DEST, --destination=DEST 10:10:27 INFO - Directory to install application into. [default: 10:10:27 INFO - "/builds/slave/test"] 10:10:27 INFO - --app=APP Application being installed. [default: firefox] 10:10:27 INFO - mkdir: /builds/slave/test/build/application 10:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:10:44 INFO - Reading from file tmpfile_stdout 10:10:44 INFO - Output received: 10:10:44 INFO - /builds/slave/test/build/application/firefox/firefox 10:10:44 INFO - Running post-action listener: _resource_record_post_action 10:10:44 INFO - ##### 10:10:44 INFO - ##### Running run-tests step. 10:10:44 INFO - ##### 10:10:44 INFO - Running pre-action listener: _resource_record_pre_action 10:10:44 INFO - Running main action method: run_tests 10:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:10:44 INFO - Python 2.7.3 10:10:44 INFO - Return code: 0 10:10:44 INFO - grabbing minidump binary from tooltool 10:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:44 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 0x1ef2410>, '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 0x1ef3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:10:44 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 10:10:44 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 10:10:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:10:44 INFO - Return code: 0 10:10:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:10:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:10:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:10:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:10:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:10:45 INFO - Return code: 0 10:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 10:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 10:10:45 INFO - Using env: {'DISPLAY': ':0', 10:10:45 INFO - 'HOME': '/home/cltbld', 10:10:45 INFO - 'LANG': 'en_US.UTF-8', 10:10:45 INFO - 'LANGUAGE': 'en_US:en', 10:10:45 INFO - 'LOGNAME': 'cltbld', 10:10:45 INFO - 'MAIL': '/var/mail/cltbld', 10:10:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:10:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:45 INFO - 'MOZ_NO_REMOTE': '1', 10:10:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:45 INFO - 'NO_EM_RESTART': '1', 10:10:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:45 INFO - 'PWD': '/builds/slave/test', 10:10:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:10:45 INFO - 'SHELL': '/bin/bash', 10:10:45 INFO - 'SHLVL': '1', 10:10:45 INFO - 'TERM': 'linux', 10:10:45 INFO - 'TMOUT': '86400', 10:10:45 INFO - 'USER': 'cltbld', 10:10:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585', 10:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:45 INFO - '_': '/tools/buildbot/bin/python'} 10:10:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 10:10:45 INFO - mozversion application_buildid: 20160428073622 10:10:45 INFO - mozversion application_changeset: f241151c616953e1dbbb29e4757dda10a56a3dd2 10:10:45 INFO - mozversion application_display_name: Nightly 10:10:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:10:45 INFO - mozversion application_name: Firefox 10:10:45 INFO - mozversion application_remotingname: firefox 10:10:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:10:45 INFO - mozversion application_vendor: Mozilla 10:10:45 INFO - mozversion application_version: 49.0a1 10:10:45 INFO - mozversion platform_buildid: 20160428073622 10:10:45 INFO - mozversion platform_changeset: f241151c616953e1dbbb29e4757dda10a56a3dd2 10:10:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:10:45 INFO - mozversion platform_version: 49.0a1 10:10:45 INFO - using testdate: 1461863445 10:10:45 INFO - actual date: 1461863445 10:10:45 INFO - starting webserver on 'localhost:33054' 10:10:45 INFO - SUITE-START | Running 2 tests 10:10:45 INFO - TEST-START | dromaeo_css 10:10:45 INFO - operating with platform_type : linux_ 10:10:45 INFO - Initialising browser for dromaeo_css test... 10:10:45 INFO - TEST-INFO | started process 20788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxasBHf/profile http://localhost:33054/getInfo.html) 10:10:49 INFO - PROCESS | 20788 | __metrics Screen width/height:1600/1200 10:10:49 INFO - PROCESS | 20788 | colorDepth:24 10:10:49 INFO - PROCESS | 20788 | Browser inner width/height: 1024/697 10:10:49 INFO - PROCESS | 20788 | __metrics 10:10:50 ERROR - PROCESS | 20788 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:10:51 INFO - TEST-INFO | 20788: exit 0 10:10:51 INFO - Browser initialized. 10:10:51 INFO - Running cycle 1/1 for dromaeo_css test... 10:10:51 INFO - TEST-INFO | started process 20868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxasBHf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:03 INFO - PROCESS | 20868 | RSS: Main: 154685440 10:11:03 INFO - PROCESS | 20868 | 10:11:54 INFO - PROCESS | 20868 | 1461863514106 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] 10:14:01 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:33054/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33054/tests/dromaeo/cssquery-ext.html) 10:14:02 INFO - PROCESS | 20868 | RSS: Main: 243576832 10:14:02 INFO - PROCESS | 20868 | 10:17:04 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:33054/tests/dromaeo/cssquery-ext.html (next: http://localhost:33054/tests/dromaeo/cssquery-jquery.html) 10:17:05 INFO - PROCESS | 20868 | RSS: Main: 233308160 10:17:05 INFO - PROCESS | 20868 | 10:20:07 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:33054/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33054/tests/dromaeo/cssquery-mootools.html) 10:20:07 INFO - PROCESS | 20868 | RSS: Main: 241037312 10:20:07 INFO - PROCESS | 20868 | 10:23:09 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:33054/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33054/tests/dromaeo/cssquery-prototype.html) 10:23:10 INFO - PROCESS | 20868 | RSS: Main: 233693184 10:23:10 INFO - PROCESS | 20868 | 10:26:12 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:33054/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33054/tests/dromaeo/cssquery-yui.html) 10:26:13 INFO - PROCESS | 20868 | RSS: Main: 225132544 10:26:13 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:33054/tests/dromaeo/cssquery-yui.html (next: http://localhost:33054/tests/dromaeo/cssquery-dojo.html) 10:29:15 INFO - PROCESS | 20868 | RSS: Main: 282468352 10:29:15 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | __start_tp_report 10:29:15 INFO - PROCESS | 20868 | _x_x_mozilla_page_load 10:29:15 INFO - PROCESS | 20868 | _x_x_mozilla_page_load_details 10:29:15 INFO - PROCESS | 20868 | |i|pagename|runs| 10:29:15 INFO - PROCESS | 20868 | |0;dojo.html;3068.432340017097;3101.1626860747615;3124.9531257031135;3125.8749650014;3154.1010811918595;5055.823046193384;5139.743012849357;5152.768125434355;5184.7148406837605;5198.636095473314;5175.120229560975;5178.870528236796;5182.714950677711;5190.377154741427;5226.608004399675;4743.169945259583;4746;4780.498047704993;4793.065352256294;4883.584895283905;4811.398575178103;4817.181079216542;4865.951340486603;4877.365942427497;4925.581325587312;4633.513481084488;4677.602403795681;4777.378940737716;4808.711477311355;4824.493428190025;4729.0541891621815;4767.189577771787;4779.259214821708;4783.880402989918;4821.63837712173;4663.88340291492;4679.742614156254;4681.32120842476;4688.46082700487;4738.739369334719;4959.553640172402;5051.343325367716;5062.949370506321;5095.949040509585;5128.538431541142;5391.406945236021;5411.594130440193;5413.945860541384;5422.83731488052;5426.864328391783;5410.810621628263;5422.024035673578;5423.186522021689;5430.456954304577;5469.535089517396;5003;5207.557357624606;5277.762500687479;5281;5290.894182116374;5642.153676948408;5649.209110724501;5649.4350564944;5650.180723795027;5679.517241034476;5278.287431196816;5429.104197807317;5443.809466668727;5443.965646527226;5447.428020057916;5422.972885135549;5447.12845944647;5450.31871016123;5507.531859791882;5522.0336441123445;5448.264484294648;5451.48210919962;5452.59105567084;5454.699991500426;5454.8909021819345;5374.3013408256675;5414.972925135349;5460.754266058037;5464.295681990323;5517.006938751063;4163.812628431728;4182.247195504778;4189.350650649154;4217.768022758778;4220.493540775126;3737.1965027519213;3755.004923695223;3761.191343861083;3780.981095094562;3798.487204227449;5066.797328106908;5100.668456550312;5165.199394093921;5190.780166660832;5204.817831375959;5543.861403464865;5573.191887176336;5575.944240557624;5577.721113944368;5594.440555944373;5204.843854684365;5230.503102205284;5247.239150323182;5255.211718242294;5296.92054619181;4517.909641807146;4640.767961601974;4674.041821426599;4733.2900064989835;4742.976285118552;5746.5977381583725;5793.102069179284;5801.390853960358;5801.82594522165;5808.041673123887;5591.608587398843;5601.6358936668985;5603.355614104267;5608.130739735348;5614.550835933197;5427.457254274541;5660.943390566042;5677.063284558001;5739.5695322850115;5752.309722833287;5475.123980163314;5475.780968761205;5479.178123281539;5486.478784515464;5487.368952570346;5319.4414586467865;5558.777648893999;5569.749361278833;5571.554275657856;5617.466340697627;5315.574754019592;5352.9732351338;5359.973200133974;5395.514403703685;5407.188921661782;5320.813771517978;5328.813491527933;5333.280007199133;5334.039872822929;5378.515933565998;5127.256547800623;5252.185911183773;5252.579793616425;5260.73696315175;5271.367435907716;5350.277712508761;5404.675719456845;5405.702686352131;5437.429069947599;5452.400235974119;5304.814331498379;5311.070562651597;5313.203019547099;5315.654482458628;5360.758765855624 10:29:15 INFO - PROCESS | 20868 | |1;ext.html;593.8752861899001;634.1660716158254;640.9616421397337;647.0262255305764;654.3652656922786;31482.212944676365;37230;38217;38272.80863595682;38399.616003839954;44450.55549444505;45790.77104614472;45830;45840;45896;7779.533228006309;7950.0857401399;8698.304135669132;8923.196912277894;8927.642894284221;9847.704568862946;10020.098191162793;10025.44860032698;10060.647877324294;10064.144547713453;9951.203903687687;10122.240831937597;10131.392116472998;10132.392056476636;10143.543540540693;7707.61461926907;9932.801343973153;10072.848907266396;10075.647352342632;10075.697729068139;10002.39985600859;10144.087032167066;10160.89839101607;10161.644342447978;10167.440790756506;36949.44575831365;37671.4349284761;37672.24655506902;37706;37759;3464;3506.263684626206;3696.6050070574092;3831.4635950966886;4221.345691417835;31628.36743265145;31878.681213187803;32057;32161.1959701007;32184.03447896567;4280.143971205771;4348.804303806336;4361.760103194355;4364.323529852878;4513.165064463052;327827;328695;329547;330204;331498;54621.1806822898;54815.72592137014;54825.725871370385;54900.45099549033;55007;59183.40816591779;59338;59502.40497595055;59600.70199648974;59614.701926490954;15721.213939302988;15866.68266634684;15984.280707368196;15995;16008.359665613245;10535.15718742514;10601.628942986958;10607.787844243072;10662.147028237723;11479.942600287111;15942.920285398499;16188.352465901233;16217.189140542925;16234.51296461108;16237.918810405872;4400.693290577454;5457.890842183134;6032.3967603239325;6249.281332646713;6430.742770289136;1057.038095333243;1063.707480442869;1114.8494953181216;1133.557912414159;1148.6668866028924;28297.57553636697;28307.591486573296;28722.712772872423;29352.853235733684;31285;1031.1338475680463;1120.798256313855;1191.3566673995945;1199.0767109325946;1203.1337437045313;14609.561713148623;14929.253537323091;15061.924690376478;15069.849301506845;15562.766558501631;360821;366958;370116;370608;370637;55208;56288;56517;56521;56685.14972275419;1362.2167253829089;1403.8034675145284;1404.024203178781;1413.7313910357;1498.980693128683;29485.410291794473;29649.25876853096;29703.25741856471;30141.397172056873;30704.232394190323;48263.5173648259;48841.51158488512;49107.26339104988;49162.26256606225;49208.753956229986;439380;439813;441724;441822;444475;22900.885495573082;24944.750552494243;25310.74689253084;27019.32451688645;27342;39433.80283098566;39714.20571588494;39994.40008399818;40233.79883100566;41158.588414115475;34969.125771855906;35107;35135.64864351324;35307.64692353044;35514.64485355217;34876.302473950884;35072;35582.288354233286;35908.46137307995;35918.8204058978;37266;37787;37866.24267514579;38197;38351.80824095861;33489.665103348656;33540.832295838365;34890.82554587211;34940.65059349374;35205.11987200341;26841.328966775985;26904.73095269022;27014.1895743128;27032.459350813268;27071.59392609073 10:29:15 INFO - PROCESS | 20868 | |2;jquery.html;389.99025024374396;398.48794299325374;399.45075521158407;407.0799992018039;412.74409865883155;17727.82272177278;18009.459716208534;18328.633427331446;18344.266229350844;18402.171902264396;16121.677566448694;16362.427315043977;16636.168191590434;16930.661386772255;17088.829111708877;5524.226608274835;5613.214150019001;5665.2351932489;5670.036093864032;5674.631148975324;5425.267588875491;5592.496675299222;5598.804041858536;5609.158626206081;5612.522935550483;5513.924784666991;5576.024195765745;5586.301712285965;5589.441055894418;5601.80393686221;5406.513413792758;5536.778528858841;5568.3596386415675;5571.13647384656;5572.4148964358765;4982.028504441635;4982.352294201731;4986.526280003394;5227.47725227478;5484.314460692413;13472.25902575358;13676.794848077287;13829.239391833446;13830.723385532334;20649.79350206494;2309.226409152936;2317.073170731704;2332.6734257204007;2504.2987963370288;2566.7561581649716;8928.15182557656;9314.673986410511;9473.66842160528;9965.501724913798;10017.198624110053;1875.5029917071986;1885.556894129892;1962.7840937496865;2001.7998200179866;2050.2721533855415;80100.19899800986;80189.59905200437;82820;82833.17166828315;84490.57754711248;10360.740981475372;10679.679609611723;10889.292196007234;10970.780584388427;10985.61550345734;15214.239288035555;15365.231738413035;15368.231588420535;15387.076775393512;15407.306671199824;7451.403887688972;7468.439867009996;7478.85042299151;7594.772156835304;7688.9615551923;7015.684294206773;7172.489628630042;7238.792168388587;7244;7273.3817625502425;4663.51033141522;4752.334673145762;4753.027493590122;4818.277258411196;4824.49342819006;1771.1321452488446;1834.6698643483635;1844.8524118070522;1854.4900152457913;1889.395393474075;915.6474757218385;997.9501024948723;1000.7448100734266;1038.2213339995003;1076.0853274716585;17595.472135835946;18146.727799083023;18268.81731182671;18363;18409.723854142198;981.7790997025612;1020.505055048301;1023.65195833417;1046.9371837689612;1083;9943.403395796131;9960.701178964642;10215.540300686487;10273.178145748323;10318.1745460363;506131;507894;510422;520966;523455;91082.54458727664;91498.54250728704;92251.5387423072;93796.53101734584;94303;1034.5654824973528;1036.528379587286;1037.408677054087;1049.21833234241;1052.3159946034984;15973.760393594337;16000.8399916004;16093.597660058123;16152.434664787146;16260.349586016428;36314.8184259077;39113.217735645696;39372;40073.799631002825;41019.79490102531;43870;47142.29286560636;47624;47815;48044.27933581069;8147.959260203898;8187.754367368989;8229.79425514367;8320.791980200544;8461.534615596202;12584.874151258371;13084.214947103204;13138;13271.867281327062;13436;11250.268732532359;11611.245269057485;11634.243774154653;12039.819402708792;12264;11241.38172400493;11380.772384552098;11382.601608943978;11503.597374091867;11597;11847.644570662895;12122.696932576757;12185.573504927284;12275.93862030684;12301.138920275853;8308.427376228039;8339.124391939002;8351.95824020876;8404.579771011548;8589.957050214709;11515.424228788695;11803.645890623295;12068.336241506802;12160.087993400353;12233.816492752438 10:29:15 INFO - PROCESS | 20868 | |3;mootools.html;1318.6637407461108;1472.5287907869483;1484.3468873695574;1632.5347276026328;1767.0634563681244;7297.744578939738;8141.877871831927;8340.999080110396;8372.246497815187;8376.120507346732;8091.757247282576;8191.0580283267445;8243.793905152374;8246.134155913633;8275.958620206906;2007.8594498385119;2070.5858828234336;2071.275053731197;2332.650102484624;2371.92884213473;2304.7925686688195;2341.718993720756;2354.5290941811622;2354.81161507079;2360.634101714237;2250.2349201271563;2260.7965283124518;2273.2498275569023;2276.7040284762957;2288.3249441414823;2014.899255037257;2262.2986874069093;2310.4339436838;2316.791488766011;2317.188983855654;2285.1544928376443;2314.687517185192;2317.1774020222915;2318.953620927589;2320.2923108451914;8163.795905102361;8217.753467395987;8225.547594882279;8228.177182281785;8229.876551851727;4949.109160351171;5035.571976382012;5133.948660513422;5140.1518749406305;5141.537261646432;3214.5499630051813;3291.1936575538907;3388.847501862422;3444.569428821397;3452.1197094740933;1117.2961034548264;1123.1239633086207;1123.3709122891125;1130.604288499027;1149.5918948773149;11675.708107297301;11717.589884354007;11742.706432339175;11775.116866235066;11792.174547781658;4514.61625761814;4594;4671.719696818202;4689.343491911135;4691.085238378551;9850.21198304134;9882.258830587734;9882.851757223647;9885.258605604464;9891.752706182258;5176.7411629418375;5192.506711862367;5196.636235463481;5202.167653175474;5206.375234971828;4209.852655157116;4590.839320623762;4702.6708130431225;4736.194846876039;4881.389826271716;3877.84488620452;3978.6618137458063;4012.0371110933747;4026.939595906064;4028.194361127786;1276.5978716704394;1279.9232046077266;1287.6137158852307;1288.2206265209413;1300.746354460871;991.7371896447447;997.4514017290461;1002.1331548210891;1004.3823048825066;1016.3190662256306;5705.771769129271;5850.531957443394;5917.112433135064;5921.6743079131065;6139.815805525842;439.67903430495915;448.2133855084371;457.4807593381469;463.9443266808005;468.4729679111;3831.59768224338;4016.096378314856;4065.3495440729343;4079.97960010204;4096.713230073866;9720.125188733047;10010.04904534068;10259.487025648688;10268.743281418025;10288.176945844314;10043.698689039195;10086.899131008597;10090.646827361006;10091.243156763272;10099;7483.663235154431;7589.620518974029;7681.654325555363;7760.9223907761325;7768.844623107506;5798.768049277982;5913.34953155144;5920.555958303058;5994.460498554977;6017.338092809699;8655.69705060345;8809.823803524021;9060.139286767746;9088.772780680536;9236.353455258337;9263.76840578991;9373.265945799776;9453.810923781624;9459.621615135593;9473.242140628596;6979.267176946348;6995.230524642184;7165.713371465083;7187.820304492429;7321.926780732338;7963.402744794048;7973.083095444098;8019.83960320802;8032.236937490929;8033.678652854054;7131;7162.498625096193;7368.115826100902;7486.850262994819;7495.437842161969;7090.893636595352;7092.432605391659;7122.644559049452;7300.160481544478;7308.96345518269;6845.726170953106;6932.341427564374;6954.3393377629045;6958.686859091252;6965.129358830146;5199.349832736075;5288.65623734456;5324.068288049653;5421.810236641699;5447;5242.68543887368;5299.364076310867;5325.893482130413;5372.247885295984;5472.20653005304 10:29:15 INFO - PROCESS | 20868 | |4;prototype.html;315.8499712636498;321.66707457781195;322.0981252493019;327.54961927349893;330.8924599505161;5198.220266959958;5202.583793296537;5237.690577355661;5272.6836389816635;5307.230451584523;5161.122609156443;5161.561267292284;5185.948140518593;5198.350206224222;5210;3899.610038996092;3956.821943012557;4116.259073366793;4126.236646220444;4160.271952408331;4121.464209652741;4141.62725354718;4149.08720081583;4162.271602469571;4170.666346692273;3895.071939390006;4076.3274059780247;4088.8773336799795;4094.222097801423;4113.588641135892;3959.722819402643;4074.5517993020744;4098.467199264077;4110.09577892866;4141.233871733739;3629.6007439181667;3630.110622897381;3640.0899775056237;3652.7990960497164;3658.9634103659155;4988.90022199554;5017.8960628662;5018.322526458955;5047.722375269359;5048.545630893237;4610.3315019322345;4732.834350797705;4748.216544270192;4751.14479393709;4752.1683705351425;5366.731663416853;5425.810096646638;5428.511433970922;5455.563554915597;5460.399356070869;4046.7167298289132;4047.2714911316248;4053.1691003344245;4064.4919385076864;4080.8777586163746;5521.4478552144865;5634.915476267818;5651.350094739117;5678;5707.62900411476;4107.712460127762;4116.279651061052;4116.9826784875195;4126.504819421689;4144.91710165795;4141.979290103591;4164.7501149930495;4167.458230430025;4182.372644103409;4187.560306167869;4547.909041819211;4658.557437043475;4665.9501612137;4679.532046795362;4681.963345944525;5484.7531861066345;5499.202615620713;5521.806736764194;5521.889562208814;5522.432069087893;1510.7582786754067;1519.4302136698739;1522.444307827635;1523.2155439948435;1524.4969160177116;1032.566322144701;1036.8652075230173;1042.7914417116608;1047.7747284333905;1048.9737756555994;5611.6352437091455;5614.603165085065;5625.38120806711;5633.521150702154;5637.802676906371;5949.553783466257;5970.313413957364;5976.7908123215475;5978.103284507359;6004.3395226525045;5538.335399752055;5549.6200736886785;5624.89066600025;5658.660480371191;5675.893200825882;3171.6035495563056;3178.98410507946;3188.98405507971;3201.1196920846487;3206.9679303206667;5625.521830644359;5937.703114844327;6221.720022598904;6229.844253893689;6277.780277690259;5708.857278567986;5731.283589551306;5777.306723193244;5801.361850196475;5809.912851307234;5829.242198514251;5923.259592550931;5923.555733320019;5936.228290322317;5942.64344139353;5554.333699890098;5685.857853553694;5686.57350698691;5689.6586204827845;5690.943090569207;5558.3607885092115;5565.638233514808;5569.805056823154;5587.3015873015875;5623.662580245198;5695.715214239189;5845.041910959876;5859.238299021271;5903.350631430625;5914.053751399755;3961.6632586230494;3966.3257246267626;4010.6991975601363;4020.1959608079087;4026.1142548639255;5377.462253774591;5390.326209223847;5620.803271885465;5657.179708942098;5670.291213598301;5429.099815064696;5482.314710661168;5484.314460692413;5496.444153468657;5531.806386776443;5420.322459692538;5443.856790074129;5448.318960129984;5464.114880366267;5486.451354864482;5197.376314842243;5351;5364.249005139206;5365.839024829262;5422.105352616932;5420.647657902224;5446.319210098738;5489.862753431196;5491.133014774996;5518.944810551843;5342.706151161723;5386.192071189353;5400.272862204719;5426.186072089218;5431.158170483582 10:29:15 INFO - PROCESS | 20868 | |5;yui.html;750.9023826902502;776.0919723923009;802.4864086984331;822.1819289806635;833.287539154023;14030.579082627524;14474.421023159088;14528.491502797404;14529.200893950841;14551.05418147821;11450.656480305604;13254.403551840167;13278.601641950732;13328;13331.400086996084;795.8527672380599;826.0459169659024;827.1108558299821;827.3711978896052;827.8468483330603;816.6733306677318;821.9753407397787;823.1110400767187;823.2261674026425;825.9297959673435;708.4651088428229;826.5123577089516;870.9520976346298;871.9258862996653;873.8077622922947;845.2561745663838;846.8687353460224;846.9745907622781;849.8257857139272;857.498363457375;617.3178637605427;617.478230894893;617.7004152985799;624.7376102037156;629.515273239603;13233.139845910082;13291.53479628218;13327.600171994856;13356.933215333958;13397.129186602937;13213.14114582549;14061.718765624733;14108.717825643429;14157.716845663132;14248.21634810085;11097.1677124216;11506.13703972197;11643.883561164364;11891.405429728478;11921.701957451047;3817.3701339278987;3847.172857835551;3849.6727778138893;3927.253821773854;3931.8820435386983;53588.73205633986;53663.46336536624;55655.165172522444;56212.718936405465;56661;11130.443477826077;11238.494267757971;11430.485628146753;11479.368634725004;11480.942595287137;19844.90077549603;19847.404577862686;19852.10665520055;19884.60230795405;20084.497887552927;8035.678572857137;8035.959820200978;8192.877106843402;8389.916100839035;8466.40735148546;4664.277037059193;4664.603508701731;4674.228752255908;4700;4778.1638213312535;3227.564278822376;3257.2182676158027;3274.5415641810164;3295.505674148849;3298.8515516801804;593.857474206196;598.7006496751624;599.8830228105564;604.6583680220662;606.6633018674678;533.5678100738414;569.9088145896636;652.954293199481;673.5049738442241;688.8415664397216;9787.41547187029;10067.44024595866;10069.48919001979;10099.213684094737;10296.073109390114;625.6996641612052;724.7535837815168;736.2048987093925;761.208343322949;769.1923480345615;4510.571495707903;4562.817487300471;4774.092922344744;4789.281607758864;4906.239532872411;65076.34923650703;65705.67147164233;66068.66965665238;67774.66112669405;68119;56037;56173.71913140408;57926.420735792104;58758.41241587615;59813.401865980784;50925;52621.473785262424;52640;53345.46654533483;54341.72829135908;9032.864507032531;9087.727368178965;9113.544322783702;9147.542622868697;9166.404183728037;34678.65321346754;35059.824700877354;35118.64881351256;35531.82234088813;35639.10902227465;41703.16593668049;45977;46220.306695398926;46330.76834615805;46692.299615505115;11755.823662644896;11859.644210673694;11918.821217681914;11948.820767688318;12049.578264760692;10637.574497020032;11313;13164.275964822027;13811.309434528033;14718.852811471748;13115.606531804062;13187;13342.733145336844;13461.596152115451;13618.319084045559;12263.325517096646;12404.317762523147;12777.872221277668;13186.802197966847;13505.729885402041;12766.106372553832;13046.217226966412;13178.670533236746;13347.733045339233;13690.86309136896;10877.728056798644;11207.103431725605;11294.265872718248;11339.603113891304;11774.587889423829;10320.12278956297;10500.369977801356;10503.264771465923;10807;11052.586908441119 10:29:15 INFO - PROCESS | 20868 | __end_tp_report 10:29:15 INFO - PROCESS | 20868 | __start_cc_report 10:29:15 INFO - PROCESS | 20868 | _x_x_mozilla_cycle_collect,770 10:29:15 INFO - PROCESS | 20868 | __end_cc_report 10:29:15 INFO - PROCESS | 20868 | __startTimestamp1461864555966__endTimestamp 10:29:15 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | ------- Summary: start ------- 10:29:15 INFO - PROCESS | 20868 | Number of tests: 6 10:29:15 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | [#0] dojo.html Cycles:165 Average:5126.39 Median:5311.07 stddev:559.25 (10.5%) stddev-sans-first:537.16 10:29:15 INFO - PROCESS | 20868 | Values: 3068.4 3101.2 3125.0 3125.9 3154.1 5055.8 5139.7 5152.8 5184.7 5198.6 5175.1 5178.9 5182.7 5190.4 5226.6 4743.2 4746.0 4780.5 4793.1 4883.6 4811.4 4817.2 4866.0 4877.4 4925.6 4633.5 4677.6 4777.4 4808.7 4824.5 4729.1 4767.2 4779.3 4783.9 4821.6 4663.9 4679.7 4681.3 4688.5 4738.7 4959.6 5051.3 5062.9 5095.9 5128.5 5391.4 5411.6 5413.9 5422.8 5426.9 5410.8 5422.0 5423.2 5430.5 5469.5 5003.0 5207.6 5277.8 5281.0 5290.9 5642.2 5649.2 5649.4 5650.2 5679.5 5278.3 5429.1 5443.8 5444.0 5447.4 5423.0 5447.1 5450.3 5507.5 5522.0 5448.3 5451.5 5452.6 5454.7 5454.9 5374.3 5415.0 5460.8 5464.3 5517.0 4163.8 4182.2 4189.4 4217.8 4220.5 3737.2 3755.0 3761.2 3781.0 3798.5 5066.8 5100.7 5165.2 5190.8 5204.8 5543.9 5573.2 5575.9 5577.7 5594.4 5204.8 5230.5 5247.2 5255.2 5296.9 4517.9 4640.8 4674.0 4733.3 4743.0 5746.6 5793.1 5801.4 5801.8 5808.0 5591.6 5601.6 5603.4 5608.1 5614.6 5427.5 5660.9 5677.1 5739.6 5752.3 5475.1 5475.8 5479.2 5486.5 5487.4 5319.4 5558.8 5569.7 5571.6 5617.5 5315.6 5353.0 5360.0 5395.5 5407.2 5320.8 5328.8 5333.3 5334.0 5378.5 5127.3 5252.2 5252.6 5260.7 5271.4 5350.3 5404.7 5405.7 5437.4 5452.4 5304.8 5311.1 5313.2 5315.7 5360.8 10:29:15 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | [#1] ext.html Cycles:180 Average:53585.43 Median:35089.50 stddev:100923.36 (287.6%) stddev-sans-first:101128.05 10:29:15 INFO - PROCESS | 20868 | Values: 593.9 634.2 641.0 647.0 654.4 31482.2 37230.0 38217.0 38272.8 38399.6 44450.6 45790.8 45830.0 45840.0 45896.0 7779.5 7950.1 8698.3 8923.2 8927.6 9847.7 10020.1 10025.4 10060.6 10064.1 9951.2 10122.2 10131.4 10132.4 10143.5 7707.6 9932.8 10072.8 10075.6 10075.7 10002.4 10144.1 10160.9 10161.6 10167.4 36949.4 37671.4 37672.2 37706.0 37759.0 3464.0 3506.3 3696.6 3831.5 4221.3 31628.4 31878.7 32057.0 32161.2 32184.0 4280.1 4348.8 4361.8 4364.3 4513.2 327827.0 328695.0 329547.0 330204.0 331498.0 54621.2 54815.7 54825.7 54900.5 55007.0 59183.4 59338.0 59502.4 59600.7 59614.7 15721.2 15866.7 15984.3 15995.0 16008.4 10535.2 10601.6 10607.8 10662.1 11479.9 15942.9 16188.4 16217.2 16234.5 16237.9 4400.7 5457.9 6032.4 6249.3 6430.7 1057.0 1063.7 1114.8 1133.6 1148.7 28297.6 28307.6 28722.7 29352.9 31285.0 1031.1 1120.8 1191.4 1199.1 1203.1 14609.6 14929.3 15061.9 15069.8 15562.8 360821.0 366958.0 370116.0 370608.0 370637.0 55208.0 56288.0 56517.0 56521.0 56685.1 1362.2 1403.8 1404.0 1413.7 1499.0 29485.4 29649.3 29703.3 30141.4 30704.2 48263.5 48841.5 49107.3 49162.3 49208.8 439380.0 439813.0 441724.0 441822.0 444475.0 22900.9 24944.8 25310.7 27019.3 27342.0 39433.8 39714.2 39994.4 40233.8 41158.6 34969.1 35107.0 35135.6 35307.6 35514.6 34876.3 35072.0 35582.3 35908.5 35918.8 37266.0 37787.0 37866.2 38197.0 38351.8 33489.7 33540.8 34890.8 34940.7 35205.1 26841.3 26904.7 27014.2 27032.5 27071.6 10:29:15 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | [#2] jquery.html Cycles:180 Average:28836.81 Median:19440.79 stddev:84608.29 (435.2%) stddev-sans-first:84818.68 10:29:15 INFO - PROCESS | 20868 | Values: 390.0 398.5 399.5 407.1 412.7 17727.8 18009.5 18328.6 18344.3 18402.2 16121.7 16362.4 16636.2 16930.7 17088.8 5524.2 5613.2 5665.2 5670.0 5674.6 5425.3 5592.5 5598.8 5609.2 5612.5 5513.9 5576.0 5586.3 5589.4 5601.8 5406.5 5536.8 5568.4 5571.1 5572.4 4982.0 4982.4 4986.5 5227.5 5484.3 13472.3 13676.8 13829.2 13830.7 20649.8 2309.2 2317.1 2332.7 2504.3 2566.8 8928.2 9314.7 9473.7 9965.5 10017.2 1875.5 1885.6 1962.8 2001.8 2050.3 80100.2 80189.6 82820.0 82833.2 84490.6 10360.7 10679.7 10889.3 10970.8 10985.6 15214.2 15365.2 15368.2 15387.1 15407.3 7451.4 7468.4 7478.9 7594.8 7689.0 7015.7 7172.5 7238.8 7244.0 7273.4 4663.5 4752.3 4753.0 4818.3 4824.5 1771.1 1834.7 1844.9 1854.5 1889.4 915.6 998.0 1000.7 1038.2 1076.1 17595.5 18146.7 18268.8 18363.0 18409.7 981.8 1020.5 1023.7 1046.9 1083.0 9943.4 9960.7 10215.5 10273.2 10318.2 506131.0 507894.0 510422.0 520966.0 523455.0 91082.5 91498.5 92251.5 93796.5 94303.0 1034.6 1036.5 1037.4 1049.2 1052.3 15973.8 16000.8 16093.6 16152.4 16260.3 36314.8 39113.2 39372.0 40073.8 41019.8 43870.0 47142.3 47624.0 47815.0 48044.3 8148.0 8187.8 8229.8 8320.8 8461.5 12584.9 13084.2 13138.0 13271.9 13436.0 11250.3 11611.2 11634.2 12039.8 12264.0 11241.4 11380.8 11382.6 11503.6 11597.0 11847.6 12122.7 12185.6 12275.9 12301.1 8308.4 8339.1 8352.0 8404.6 8590.0 11515.4 11803.6 12068.3 12160.1 12233.8 10:29:15 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | [#3] mootools.html Cycles:180 Average:5530.65 Median:5140.84 stddev:3050.85 (59.3%) stddev-sans-first:3042.99 10:29:15 INFO - PROCESS | 20868 | Values: 1318.7 1472.5 1484.3 1632.5 1767.1 7297.7 8141.9 8341.0 8372.2 8376.1 8091.8 8191.1 8243.8 8246.1 8276.0 2007.9 2070.6 2071.3 2332.7 2371.9 2304.8 2341.7 2354.5 2354.8 2360.6 2250.2 2260.8 2273.2 2276.7 2288.3 2014.9 2262.3 2310.4 2316.8 2317.2 2285.2 2314.7 2317.2 2319.0 2320.3 8163.8 8217.8 8225.5 8228.2 8229.9 4949.1 5035.6 5133.9 5140.2 5141.5 3214.5 3291.2 3388.8 3444.6 3452.1 1117.3 1123.1 1123.4 1130.6 1149.6 11675.7 11717.6 11742.7 11775.1 11792.2 4514.6 4594.0 4671.7 4689.3 4691.1 9850.2 9882.3 9882.9 9885.3 9891.8 5176.7 5192.5 5196.6 5202.2 5206.4 4209.9 4590.8 4702.7 4736.2 4881.4 3877.8 3978.7 4012.0 4026.9 4028.2 1276.6 1279.9 1287.6 1288.2 1300.7 991.7 997.5 1002.1 1004.4 1016.3 5705.8 5850.5 5917.1 5921.7 6139.8 439.7 448.2 457.5 463.9 468.5 3831.6 4016.1 4065.3 4080.0 4096.7 9720.1 10010.0 10259.5 10268.7 10288.2 10043.7 10086.9 10090.6 10091.2 10099.0 7483.7 7589.6 7681.7 7760.9 7768.8 5798.8 5913.3 5920.6 5994.5 6017.3 8655.7 8809.8 9060.1 9088.8 9236.4 9263.8 9373.3 9453.8 9459.6 9473.2 6979.3 6995.2 7165.7 7187.8 7321.9 7963.4 7973.1 8019.8 8032.2 8033.7 7131.0 7162.5 7368.1 7486.9 7495.4 7090.9 7092.4 7122.6 7300.2 7309.0 6845.7 6932.3 6954.3 6958.7 6965.1 5199.3 5288.7 5324.1 5421.8 5447.0 5242.7 5299.4 5325.9 5372.2 5472.2 10:29:15 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | [#4] prototype.html Cycles:180 Average:4680.86 Median:5324.97 stddev:1358.64 (25.5%) stddev-sans-first:1322.36 10:29:15 INFO - PROCESS | 20868 | Values: 315.8 321.7 322.1 327.5 330.9 5198.2 5202.6 5237.7 5272.7 5307.2 5161.1 5161.6 5185.9 5198.4 5210.0 3899.6 3956.8 4116.3 4126.2 4160.3 4121.5 4141.6 4149.1 4162.3 4170.7 3895.1 4076.3 4088.9 4094.2 4113.6 3959.7 4074.6 4098.5 4110.1 4141.2 3629.6 3630.1 3640.1 3652.8 3659.0 4988.9 5017.9 5018.3 5047.7 5048.5 4610.3 4732.8 4748.2 4751.1 4752.2 5366.7 5425.8 5428.5 5455.6 5460.4 4046.7 4047.3 4053.2 4064.5 4080.9 5521.4 5634.9 5651.4 5678.0 5707.6 4107.7 4116.3 4117.0 4126.5 4144.9 4142.0 4164.8 4167.5 4182.4 4187.6 4547.9 4658.6 4666.0 4679.5 4682.0 5484.8 5499.2 5521.8 5521.9 5522.4 1510.8 1519.4 1522.4 1523.2 1524.5 1032.6 1036.9 1042.8 1047.8 1049.0 5611.6 5614.6 5625.4 5633.5 5637.8 5949.6 5970.3 5976.8 5978.1 6004.3 5538.3 5549.6 5624.9 5658.7 5675.9 3171.6 3179.0 3189.0 3201.1 3207.0 5625.5 5937.7 6221.7 6229.8 6277.8 5708.9 5731.3 5777.3 5801.4 5809.9 5829.2 5923.3 5923.6 5936.2 5942.6 5554.3 5685.9 5686.6 5689.7 5690.9 5558.4 5565.6 5569.8 5587.3 5623.7 5695.7 5845.0 5859.2 5903.4 5914.1 3961.7 3966.3 4010.7 4020.2 4026.1 5377.5 5390.3 5620.8 5657.2 5670.3 5429.1 5482.3 5484.3 5496.4 5531.8 5420.3 5443.9 5448.3 5464.1 5486.5 5197.4 5351.0 5364.2 5365.8 5422.1 5420.6 5446.3 5489.9 5491.1 5518.9 5342.7 5386.2 5400.3 5426.2 5431.2 10:29:15 INFO - PROCESS | 20868 | 10:29:15 INFO - PROCESS | 20868 | [#5] yui.html Cycles:180 Average:15191.54 Median:4536.69 stddev:17837.63 (393.2%) stddev-sans-first:17854.71 10:29:15 INFO - PROCESS | 20868 | Values: 750.9 776.1 802.5 822.2 833.3 14030.6 14474.4 14528.5 14529.2 14551.1 11450.7 13254.4 13278.6 13328.0 13331.4 795.9 826.0 827.1 827.4 827.8 816.7 822.0 823.1 823.2 825.9 708.5 826.5 871.0 871.9 873.8 845.3 846.9 847.0 849.8 857.5 617.3 617.5 617.7 624.7 629.5 13233.1 13291.5 13327.6 13356.9 13397.1 13213.1 14061.7 14108.7 14157.7 14248.2 11097.2 11506.1 11643.9 11891.4 11921.7 3817.4 3847.2 3849.7 3927.3 3931.9 53588.7 53663.5 55655.2 56212.7 56661.0 11130.4 11238.5 11430.5 11479.4 11480.9 19844.9 19847.4 19852.1 19884.6 20084.5 8035.7 8036.0 8192.9 8389.9 8466.4 4664.3 4664.6 4674.2 4700.0 4778.2 3227.6 3257.2 3274.5 3295.5 3298.9 593.9 598.7 599.9 604.7 606.7 533.6 569.9 653.0 673.5 688.8 9787.4 10067.4 10069.5 10099.2 10296.1 625.7 724.8 736.2 761.2 769.2 4510.6 4562.8 4774.1 4789.3 4906.2 65076.3 65705.7 66068.7 67774.7 68119.0 56037.0 56173.7 57926.4 58758.4 59813.4 50925.0 52621.5 52640.0 53345.5 54341.7 9032.9 9087.7 9113.5 9147.5 9166.4 34678.7 35059.8 35118.6 35531.8 35639.1 41703.2 45977.0 46220.3 46330.8 46692.3 11755.8 11859.6 11918.8 11948.8 12049.6 10637.6 11313.0 13164.3 13811.3 14718.9 13115.6 13187.0 13342.7 13461.6 13618.3 12263.3 12404.3 12777.9 13186.8 13505.7 12766.1 13046.2 13178.7 13347.7 13690.9 10877.7 11207.1 11294.3 11339.6 11774.6 10320.1 10500.4 10503.3 10807.0 11052.6 10:29:15 INFO - PROCESS | 20868 | -------- Summary: end -------- 10:29:15 INFO - PROCESS | 20868 | 10:29:16 INFO - TEST-INFO | 20868: exit 0 10:29:16 INFO - TEST-OK | dromaeo_css | took 1111445ms 10:29:16 INFO - TEST-START | kraken 10:29:16 INFO - operating with platform_type : linux_ 10:29:16 INFO - Initialising browser for kraken test... 10:29:16 INFO - TEST-INFO | started process 21052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmNSlte/profile http://localhost:33054/getInfo.html) 10:29:20 INFO - PROCESS | 21052 | __metrics Screen width/height:1600/1200 10:29:20 INFO - PROCESS | 21052 | colorDepth:24 10:29:20 INFO - PROCESS | 21052 | Browser inner width/height: 1024/697 10:29:20 INFO - PROCESS | 21052 | __metrics 10:29:21 ERROR - PROCESS | 21052 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:29:22 INFO - TEST-INFO | 21052: exit 0 10:29:22 INFO - Browser initialized. 10:29:22 INFO - Running cycle 1/1 for kraken test... 10:29:22 INFO - TEST-INFO | started process 21139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmNSlte/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:34 INFO - PROCESS | 21139 | RSS: Main: 154222592 10:29:34 INFO - PROCESS | 21139 | 10:29:36 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33054/tests/kraken/driver.html?testName=audio-beat-detection) 10:29:37 INFO - PROCESS | 21139 | RSS: Main: 210120704 10:29:37 INFO - PROCESS | 21139 | 10:29:40 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33054/tests/kraken/driver.html?testName=audio-dft) 10:29:41 INFO - PROCESS | 21139 | RSS: Main: 195375104 10:29:41 INFO - PROCESS | 21139 | 10:29:44 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33054/tests/kraken/driver.html?testName=audio-fft) 10:29:44 INFO - PROCESS | 21139 | RSS: Main: 266391552 10:29:44 INFO - PROCESS | 21139 | 10:29:46 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33054/tests/kraken/driver.html?testName=audio-oscillator) 10:29:47 INFO - PROCESS | 21139 | RSS: Main: 174026752 10:29:47 INFO - PROCESS | 21139 | 10:29:49 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33054/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:29:50 INFO - PROCESS | 21139 | RSS: Main: 178102272 10:29:50 INFO - PROCESS | 21139 | 10:29:53 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33054/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:53 INFO - PROCESS | 21139 | RSS: Main: 214839296 10:29:53 INFO - PROCESS | 21139 | 10:29:57 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33054/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:57 INFO - PROCESS | 21139 | RSS: Main: 215224320 10:29:57 INFO - PROCESS | 21139 | 10:30:00 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33054/tests/kraken/driver.html?testName=json-parse-financial) 10:30:01 INFO - PROCESS | 21139 | RSS: Main: 215310336 10:30:01 INFO - PROCESS | 21139 | 10:30:02 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33054/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:30:03 INFO - PROCESS | 21139 | RSS: Main: 203386880 10:30:03 INFO - PROCESS | 21139 | 10:30:05 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33054/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:30:05 INFO - PROCESS | 21139 | RSS: Main: 203624448 10:30:05 INFO - PROCESS | 21139 | 10:30:07 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33054/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:08 INFO - PROCESS | 21139 | RSS: Main: 215568384 10:30:08 INFO - PROCESS | 21139 | 10:30:10 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:11 INFO - PROCESS | 21139 | RSS: Main: 223862784 10:30:11 INFO - PROCESS | 21139 | 10:30:14 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:30:14 INFO - PROCESS | 21139 | RSS: Main: 220930048 10:30:14 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | Cycle 1(1): loaded http://localhost:33054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33054/tests/kraken/driver.html?testName=ai-astar) 10:30:16 INFO - PROCESS | 21139 | RSS: Main: 283860992 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | __start_tp_report 10:30:16 INFO - PROCESS | 21139 | _x_x_mozilla_page_load 10:30:16 INFO - PROCESS | 21139 | _x_x_mozilla_page_load_details 10:30:16 INFO - PROCESS | 21139 | |i|pagename|runs| 10:30:16 INFO - PROCESS | 21139 | |0;ai-astar;112;112;107;110;110;111;101;112;110;110 10:30:16 INFO - PROCESS | 21139 | |1;audio-beat-detection;155;135;161;189;128;155;151;129;187;139 10:30:16 INFO - PROCESS | 21139 | |2;audio-dft;160;161;160;160;159;160;163;160;161;161 10:30:16 INFO - PROCESS | 21139 | |3;audio-fft;73;77;126;118;73;74;76;121;100;75 10:30:16 INFO - PROCESS | 21139 | |4;audio-oscillator;93;93;144;93;93;94;145;93;93;149 10:30:16 INFO - PROCESS | 21139 | |5;imaging-gaussian-blur;117;116;117;117;118;117;117;116;117;117 10:30:16 INFO - PROCESS | 21139 | |6;imaging-darkroom;145;145;145;145;144;146;146;145;145;145 10:30:16 INFO - PROCESS | 21139 | |7;imaging-desaturate;95;95;94;95;95;95;94;94;94;94 10:30:16 INFO - PROCESS | 21139 | |8;json-parse-financial;57;57;68;57;57;58;58;75;55;54 10:30:16 INFO - PROCESS | 21139 | |9;json-stringify-tinderbox;62;62;61;62;63;60;61;61;61;62 10:30:16 INFO - PROCESS | 21139 | |10;stanford-crypto-aes;75;76;75;76;78;77;77;78;77;84 10:30:16 INFO - PROCESS | 21139 | |11;stanford-crypto-ccm;123;122;123;123;120;121;122;124;156;128 10:30:16 INFO - PROCESS | 21139 | |12;stanford-crypto-pbkdf2;169;166;167;165;169;169;169;171;165;164 10:30:16 INFO - PROCESS | 21139 | |13;stanford-crypto-sha256-iterative;69;67;70;67;68;79;66;67;66;67 10:30:16 INFO - PROCESS | 21139 | __end_tp_report 10:30:16 INFO - PROCESS | 21139 | __start_cc_report 10:30:16 INFO - PROCESS | 21139 | _x_x_mozilla_cycle_collect,1641 10:30:16 INFO - PROCESS | 21139 | __end_cc_report 10:30:16 INFO - PROCESS | 21139 | __startTimestamp1461864616847__endTimestamp 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | ------- Summary: start ------- 10:30:16 INFO - PROCESS | 21139 | Number of tests: 14 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:3.34 (3.0%) stddev-sans-first:3.42 10:30:16 INFO - PROCESS | 21139 | Values: 112.0 112.0 107.0 110.0 110.0 111.0 101.0 112.0 110.0 110.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:155.00 stddev:21.73 (14.0%) stddev-sans-first:23.03 10:30:16 INFO - PROCESS | 21139 | Values: 155.0 135.0 161.0 189.0 128.0 155.0 151.0 129.0 187.0 139.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 10:30:16 INFO - PROCESS | 21139 | Values: 160.0 161.0 160.0 160.0 159.0 160.0 163.0 160.0 161.0 161.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#3] audio-fft Cycles:10 Average:91.30 Median:73.50 stddev:22.48 (30.6%) stddev-sans-first:22.85 10:30:16 INFO - PROCESS | 21139 | Values: 73.0 77.0 126.0 118.0 73.0 74.0 76.0 121.0 100.0 75.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.00 stddev:25.56 (27.5%) stddev-sans-first:26.45 10:30:16 INFO - PROCESS | 21139 | Values: 93.0 93.0 144.0 93.0 93.0 94.0 145.0 93.0 93.0 149.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:30:16 INFO - PROCESS | 21139 | Values: 117.0 116.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:30:16 INFO - PROCESS | 21139 | Values: 145.0 145.0 145.0 145.0 144.0 146.0 146.0 145.0 145.0 145.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:30:16 INFO - PROCESS | 21139 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:57.50 stddev:6.60 (11.5%) stddev-sans-first:6.94 10:30:16 INFO - PROCESS | 21139 | Values: 57.0 57.0 68.0 57.0 57.0 58.0 58.0 75.0 55.0 54.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 10:30:16 INFO - PROCESS | 21139 | Values: 62.0 62.0 61.0 62.0 63.0 60.0 61.0 61.0 61.0 62.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.00 stddev:2.58 (3.4%) stddev-sans-first:2.60 10:30:16 INFO - PROCESS | 21139 | Values: 75.0 76.0 75.0 76.0 78.0 77.0 77.0 78.0 77.0 84.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:123.00 stddev:10.69 (8.7%) stddev-sans-first:11.27 10:30:16 INFO - PROCESS | 21139 | Values: 123.0 122.0 123.0 123.0 120.0 121.0 122.0 124.0 156.0 128.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:169.00 stddev:2.32 (1.4%) stddev-sans-first:2.39 10:30:16 INFO - PROCESS | 21139 | Values: 169.0 166.0 167.0 165.0 169.0 169.0 169.0 171.0 165.0 164.0 10:30:16 INFO - PROCESS | 21139 | 10:30:16 INFO - PROCESS | 21139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:67.50 stddev:3.86 (5.7%) stddev-sans-first:4.10 10:30:16 INFO - PROCESS | 21139 | Values: 69.0 67.0 70.0 67.0 68.0 79.0 66.0 67.0 66.0 67.0 10:30:16 INFO - PROCESS | 21139 | -------- Summary: end -------- 10:30:16 INFO - PROCESS | 21139 | 10:30:17 INFO - TEST-INFO | 21139: exit 0 10:30:17 INFO - TEST-OK | kraken | took 61133ms 10:30:17 INFO - SUITE-END | took 1172s 10:30:18 INFO - Completed test suite (00:19:32) 10:30:18 INFO - javascript benchmark 10:30:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.432340017097, 3101.1626860747615, 3124.9531257031135, 3125.8749650014, 3154.1010811918595, 5055.823046193384, 5139.743012849357, 5152.768125434355, 5184.7148406837605, 5198.636095473314, 5175.120229560975, 5178.870528236796, 5182.714950677711, 5190.377154741427, 5226.608004399675, 4743.169945259583, 4746.0, 4780.498047704993, 4793.065352256294, 4883.584895283905, 4811.398575178103, 4817.181079216542, 4865.951340486603, 4877.365942427497, 4925.581325587312, 4633.513481084488, 4677.602403795681, 4777.378940737716, 4808.711477311355, 4824.493428190025, 4729.0541891621815, 4767.189577771787, 4779.259214821708, 4783.880402989918, 4821.63837712173, 4663.88340291492, 4679.742614156254, 4681.32120842476, 4688.46082700487, 4738.739369334719, 4959.553640172402, 5051.343325367716, 5062.949370506321, 5095.949040509585, 5128.538431541142, 5391.406945236021, 5411.594130440193, 5413.945860541384, 5422.83731488052, 5426.864328391783, 5410.810621628263, 5422.024035673578, 5423.186522021689, 5430.456954304577, 5469.535089517396, 5003.0, 5207.557357624606, 5277.762500687479, 5281.0, 5290.894182116374, 5642.153676948408, 5649.209110724501, 5649.4350564944, 5650.180723795027, 5679.517241034476, 5278.287431196816, 5429.104197807317, 5443.809466668727, 5443.965646527226, 5447.428020057916, 5422.972885135549, 5447.12845944647, 5450.31871016123, 5507.531859791882, 5522.0336441123445, 5448.264484294648, 5451.48210919962, 5452.59105567084, 5454.699991500426, 5454.8909021819345, 5374.3013408256675, 5414.972925135349, 5460.754266058037, 5464.295681990323, 5517.006938751063, 4163.812628431728, 4182.247195504778, 4189.350650649154, 4217.768022758778, 4220.493540775126, 3737.1965027519213, 3755.004923695223, 3761.191343861083, 3780.981095094562, 3798.487204227449, 5066.797328106908, 5100.668456550312, 5165.199394093921, 5190.780166660832, 5204.817831375959, 5543.861403464865, 5573.191887176336, 5575.944240557624, 5577.721113944368, 5594.440555944373, 5204.843854684365, 5230.503102205284, 5247.239150323182, 5255.211718242294, 5296.92054619181, 4517.909641807146, 4640.767961601974, 4674.041821426599, 4733.2900064989835, 4742.976285118552, 5746.5977381583725, 5793.102069179284, 5801.390853960358, 5801.82594522165, 5808.041673123887, 5591.608587398843, 5601.6358936668985, 5603.355614104267, 5608.130739735348, 5614.550835933197, 5427.457254274541, 5660.943390566042, 5677.063284558001, 5739.5695322850115, 5752.309722833287, 5475.123980163314, 5475.780968761205, 5479.178123281539, 5486.478784515464, 5487.368952570346, 5319.4414586467865, 5558.777648893999, 5569.749361278833, 5571.554275657856, 5617.466340697627, 5315.574754019592, 5352.9732351338, 5359.973200133974, 5395.514403703685, 5407.188921661782, 5320.813771517978, 5328.813491527933, 5333.280007199133, 5334.039872822929, 5378.515933565998, 5127.256547800623, 5252.185911183773, 5252.579793616425, 5260.73696315175, 5271.367435907716, 5350.277712508761, 5404.675719456845, 5405.702686352131, 5437.429069947599, 5452.400235974119, 5304.814331498379, 5311.070562651597, 5313.203019547099, 5315.654482458628, 5360.758765855624], "value": 5090.6653405184325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.8752861899001, 634.1660716158254, 640.9616421397337, 647.0262255305764, 654.3652656922786, 31482.212944676365, 37230.0, 38217.0, 38272.80863595682, 38399.616003839954, 44450.55549444505, 45790.77104614472, 45830.0, 45840.0, 45896.0, 7779.533228006309, 7950.0857401399, 8698.304135669132, 8923.196912277894, 8927.642894284221, 9847.704568862946, 10020.098191162793, 10025.44860032698, 10060.647877324294, 10064.144547713453, 9951.203903687687, 10122.240831937597, 10131.392116472998, 10132.392056476636, 10143.543540540693, 7707.61461926907, 9932.801343973153, 10072.848907266396, 10075.647352342632, 10075.697729068139, 10002.39985600859, 10144.087032167066, 10160.89839101607, 10161.644342447978, 10167.440790756506, 36949.44575831365, 37671.4349284761, 37672.24655506902, 37706.0, 37759.0, 3464.0, 3506.263684626206, 3696.6050070574092, 3831.4635950966886, 4221.345691417835, 31628.36743265145, 31878.681213187803, 32057.0, 32161.1959701007, 32184.03447896567, 4280.143971205771, 4348.804303806336, 4361.760103194355, 4364.323529852878, 4513.165064463052, 327827.0, 328695.0, 329547.0, 330204.0, 331498.0, 54621.1806822898, 54815.72592137014, 54825.725871370385, 54900.45099549033, 55007.0, 59183.40816591779, 59338.0, 59502.40497595055, 59600.70199648974, 59614.701926490954, 15721.213939302988, 15866.68266634684, 15984.280707368196, 15995.0, 16008.359665613245, 10535.15718742514, 10601.628942986958, 10607.787844243072, 10662.147028237723, 11479.942600287111, 15942.920285398499, 16188.352465901233, 16217.189140542925, 16234.51296461108, 16237.918810405872, 4400.693290577454, 5457.890842183134, 6032.3967603239325, 6249.281332646713, 6430.742770289136, 1057.038095333243, 1063.707480442869, 1114.8494953181216, 1133.557912414159, 1148.6668866028924, 28297.57553636697, 28307.591486573296, 28722.712772872423, 29352.853235733684, 31285.0, 1031.1338475680463, 1120.798256313855, 1191.3566673995945, 1199.0767109325946, 1203.1337437045313, 14609.561713148623, 14929.253537323091, 15061.924690376478, 15069.849301506845, 15562.766558501631, 360821.0, 366958.0, 370116.0, 370608.0, 370637.0, 55208.0, 56288.0, 56517.0, 56521.0, 56685.14972275419, 1362.2167253829089, 1403.8034675145284, 1404.024203178781, 1413.7313910357, 1498.980693128683, 29485.410291794473, 29649.25876853096, 29703.25741856471, 30141.397172056873, 30704.232394190323, 48263.5173648259, 48841.51158488512, 49107.26339104988, 49162.26256606225, 49208.753956229986, 439380.0, 439813.0, 441724.0, 441822.0, 444475.0, 22900.885495573082, 24944.750552494243, 25310.74689253084, 27019.32451688645, 27342.0, 39433.80283098566, 39714.20571588494, 39994.40008399818, 40233.79883100566, 41158.588414115475, 34969.125771855906, 35107.0, 35135.64864351324, 35307.64692353044, 35514.64485355217, 34876.302473950884, 35072.0, 35582.288354233286, 35908.46137307995, 35918.8204058978, 37266.0, 37787.0, 37866.24267514579, 38197.0, 38351.80824095861, 33489.665103348656, 33540.832295838365, 34890.82554587211, 34940.65059349374, 35205.11987200341, 26841.328966775985, 26904.73095269022, 27014.1895743128, 27032.459350813268, 27071.59392609073], "value": 19135.212883281907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.99025024374396, 398.48794299325374, 399.45075521158407, 407.0799992018039, 412.74409865883155, 17727.82272177278, 18009.459716208534, 18328.633427331446, 18344.266229350844, 18402.171902264396, 16121.677566448694, 16362.427315043977, 16636.168191590434, 16930.661386772255, 17088.829111708877, 5524.226608274835, 5613.214150019001, 5665.2351932489, 5670.036093864032, 5674.631148975324, 5425.267588875491, 5592.496675299222, 5598.804041858536, 5609.158626206081, 5612.522935550483, 5513.924784666991, 5576.024195765745, 5586.301712285965, 5589.441055894418, 5601.80393686221, 5406.513413792758, 5536.778528858841, 5568.3596386415675, 5571.13647384656, 5572.4148964358765, 4982.028504441635, 4982.352294201731, 4986.526280003394, 5227.47725227478, 5484.314460692413, 13472.25902575358, 13676.794848077287, 13829.239391833446, 13830.723385532334, 20649.79350206494, 2309.226409152936, 2317.073170731704, 2332.6734257204007, 2504.2987963370288, 2566.7561581649716, 8928.15182557656, 9314.673986410511, 9473.66842160528, 9965.501724913798, 10017.198624110053, 1875.5029917071986, 1885.556894129892, 1962.7840937496865, 2001.7998200179866, 2050.2721533855415, 80100.19899800986, 80189.59905200437, 82820.0, 82833.17166828315, 84490.57754711248, 10360.740981475372, 10679.679609611723, 10889.292196007234, 10970.780584388427, 10985.61550345734, 15214.239288035555, 15365.231738413035, 15368.231588420535, 15387.076775393512, 15407.306671199824, 7451.403887688972, 7468.439867009996, 7478.85042299151, 7594.772156835304, 7688.9615551923, 7015.684294206773, 7172.489628630042, 7238.792168388587, 7244.0, 7273.3817625502425, 4663.51033141522, 4752.334673145762, 4753.027493590122, 4818.277258411196, 4824.49342819006, 1771.1321452488446, 1834.6698643483635, 1844.8524118070522, 1854.4900152457913, 1889.395393474075, 915.6474757218385, 997.9501024948723, 1000.7448100734266, 1038.2213339995003, 1076.0853274716585, 17595.472135835946, 18146.727799083023, 18268.81731182671, 18363.0, 18409.723854142198, 981.7790997025612, 1020.505055048301, 1023.65195833417, 1046.9371837689612, 1083.0, 9943.403395796131, 9960.701178964642, 10215.540300686487, 10273.178145748323, 10318.1745460363, 506131.0, 507894.0, 510422.0, 520966.0, 523455.0, 91082.54458727664, 91498.54250728704, 92251.5387423072, 93796.53101734584, 94303.0, 1034.5654824973528, 1036.528379587286, 1037.408677054087, 1049.21833234241, 1052.3159946034984, 15973.760393594337, 16000.8399916004, 16093.597660058123, 16152.434664787146, 16260.349586016428, 36314.8184259077, 39113.217735645696, 39372.0, 40073.799631002825, 41019.79490102531, 43870.0, 47142.29286560636, 47624.0, 47815.0, 48044.27933581069, 8147.959260203898, 8187.754367368989, 8229.79425514367, 8320.791980200544, 8461.534615596202, 12584.874151258371, 13084.214947103204, 13138.0, 13271.867281327062, 13436.0, 11250.268732532359, 11611.245269057485, 11634.243774154653, 12039.819402708792, 12264.0, 11241.38172400493, 11380.772384552098, 11382.601608943978, 11503.597374091867, 11597.0, 11847.644570662895, 12122.696932576757, 12185.573504927284, 12275.93862030684, 12301.138920275853, 8308.427376228039, 8339.124391939002, 8351.95824020876, 8404.579771011548, 8589.957050214709, 11515.424228788695, 11803.645890623295, 12068.336241506802, 12160.087993400353, 12233.816492752438], "value": 8865.747995926227, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.6637407461108, 1472.5287907869483, 1484.3468873695574, 1632.5347276026328, 1767.0634563681244, 7297.744578939738, 8141.877871831927, 8340.999080110396, 8372.246497815187, 8376.120507346732, 8091.757247282576, 8191.0580283267445, 8243.793905152374, 8246.134155913633, 8275.958620206906, 2007.8594498385119, 2070.5858828234336, 2071.275053731197, 2332.650102484624, 2371.92884213473, 2304.7925686688195, 2341.718993720756, 2354.5290941811622, 2354.81161507079, 2360.634101714237, 2250.2349201271563, 2260.7965283124518, 2273.2498275569023, 2276.7040284762957, 2288.3249441414823, 2014.899255037257, 2262.2986874069093, 2310.4339436838, 2316.791488766011, 2317.188983855654, 2285.1544928376443, 2314.687517185192, 2317.1774020222915, 2318.953620927589, 2320.2923108451914, 8163.795905102361, 8217.753467395987, 8225.547594882279, 8228.177182281785, 8229.876551851727, 4949.109160351171, 5035.571976382012, 5133.948660513422, 5140.1518749406305, 5141.537261646432, 3214.5499630051813, 3291.1936575538907, 3388.847501862422, 3444.569428821397, 3452.1197094740933, 1117.2961034548264, 1123.1239633086207, 1123.3709122891125, 1130.604288499027, 1149.5918948773149, 11675.708107297301, 11717.589884354007, 11742.706432339175, 11775.116866235066, 11792.174547781658, 4514.61625761814, 4594.0, 4671.719696818202, 4689.343491911135, 4691.085238378551, 9850.21198304134, 9882.258830587734, 9882.851757223647, 9885.258605604464, 9891.752706182258, 5176.7411629418375, 5192.506711862367, 5196.636235463481, 5202.167653175474, 5206.375234971828, 4209.852655157116, 4590.839320623762, 4702.6708130431225, 4736.194846876039, 4881.389826271716, 3877.84488620452, 3978.6618137458063, 4012.0371110933747, 4026.939595906064, 4028.194361127786, 1276.5978716704394, 1279.9232046077266, 1287.6137158852307, 1288.2206265209413, 1300.746354460871, 991.7371896447447, 997.4514017290461, 1002.1331548210891, 1004.3823048825066, 1016.3190662256306, 5705.771769129271, 5850.531957443394, 5917.112433135064, 5921.6743079131065, 6139.815805525842, 439.67903430495915, 448.2133855084371, 457.4807593381469, 463.9443266808005, 468.4729679111, 3831.59768224338, 4016.096378314856, 4065.3495440729343, 4079.97960010204, 4096.713230073866, 9720.125188733047, 10010.04904534068, 10259.487025648688, 10268.743281418025, 10288.176945844314, 10043.698689039195, 10086.899131008597, 10090.646827361006, 10091.243156763272, 10099.0, 7483.663235154431, 7589.620518974029, 7681.654325555363, 7760.9223907761325, 7768.844623107506, 5798.768049277982, 5913.34953155144, 5920.555958303058, 5994.460498554977, 6017.338092809699, 8655.69705060345, 8809.823803524021, 9060.139286767746, 9088.772780680536, 9236.353455258337, 9263.76840578991, 9373.265945799776, 9453.810923781624, 9459.621615135593, 9473.242140628596, 6979.267176946348, 6995.230524642184, 7165.713371465083, 7187.820304492429, 7321.926780732338, 7963.402744794048, 7973.083095444098, 8019.83960320802, 8032.236937490929, 8033.678652854054, 7131.0, 7162.498625096193, 7368.115826100902, 7486.850262994819, 7495.437842161969, 7090.893636595352, 7092.432605391659, 7122.644559049452, 7300.160481544478, 7308.96345518269, 6845.726170953106, 6932.341427564374, 6954.3393377629045, 6958.686859091252, 6965.129358830146, 5199.349832736075, 5288.65623734456, 5324.068288049653, 5421.810236641699, 5447.0, 5242.68543887368, 5299.364076310867, 5325.893482130413, 5372.247885295984, 5472.20653005304], "value": 4412.291659798288, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.8499712636498, 321.66707457781195, 322.0981252493019, 327.54961927349893, 330.8924599505161, 5198.220266959958, 5202.583793296537, 5237.690577355661, 5272.6836389816635, 5307.230451584523, 5161.122609156443, 5161.561267292284, 5185.948140518593, 5198.350206224222, 5210.0, 3899.610038996092, 3956.821943012557, 4116.259073366793, 4126.236646220444, 4160.271952408331, 4121.464209652741, 4141.62725354718, 4149.08720081583, 4162.271602469571, 4170.666346692273, 3895.071939390006, 4076.3274059780247, 4088.8773336799795, 4094.222097801423, 4113.588641135892, 3959.722819402643, 4074.5517993020744, 4098.467199264077, 4110.09577892866, 4141.233871733739, 3629.6007439181667, 3630.110622897381, 3640.0899775056237, 3652.7990960497164, 3658.9634103659155, 4988.90022199554, 5017.8960628662, 5018.322526458955, 5047.722375269359, 5048.545630893237, 4610.3315019322345, 4732.834350797705, 4748.216544270192, 4751.14479393709, 4752.1683705351425, 5366.731663416853, 5425.810096646638, 5428.511433970922, 5455.563554915597, 5460.399356070869, 4046.7167298289132, 4047.2714911316248, 4053.1691003344245, 4064.4919385076864, 4080.8777586163746, 5521.4478552144865, 5634.915476267818, 5651.350094739117, 5678.0, 5707.62900411476, 4107.712460127762, 4116.279651061052, 4116.9826784875195, 4126.504819421689, 4144.91710165795, 4141.979290103591, 4164.7501149930495, 4167.458230430025, 4182.372644103409, 4187.560306167869, 4547.909041819211, 4658.557437043475, 4665.9501612137, 4679.532046795362, 4681.963345944525, 5484.7531861066345, 5499.202615620713, 5521.806736764194, 5521.889562208814, 5522.432069087893, 1510.7582786754067, 1519.4302136698739, 1522.444307827635, 1523.2155439948435, 1524.4969160177116, 1032.566322144701, 1036.8652075230173, 1042.7914417116608, 1047.7747284333905, 1048.9737756555994, 5611.6352437091455, 5614.603165085065, 5625.38120806711, 5633.521150702154, 5637.802676906371, 5949.553783466257, 5970.313413957364, 5976.7908123215475, 5978.103284507359, 6004.3395226525045, 5538.335399752055, 5549.6200736886785, 5624.89066600025, 5658.660480371191, 5675.893200825882, 3171.6035495563056, 3178.98410507946, 3188.98405507971, 3201.1196920846487, 3206.9679303206667, 5625.521830644359, 5937.703114844327, 6221.720022598904, 6229.844253893689, 6277.780277690259, 5708.857278567986, 5731.283589551306, 5777.306723193244, 5801.361850196475, 5809.912851307234, 5829.242198514251, 5923.259592550931, 5923.555733320019, 5936.228290322317, 5942.64344139353, 5554.333699890098, 5685.857853553694, 5686.57350698691, 5689.6586204827845, 5690.943090569207, 5558.3607885092115, 5565.638233514808, 5569.805056823154, 5587.3015873015875, 5623.662580245198, 5695.715214239189, 5845.041910959876, 5859.238299021271, 5903.350631430625, 5914.053751399755, 3961.6632586230494, 3966.3257246267626, 4010.6991975601363, 4020.1959608079087, 4026.1142548639255, 5377.462253774591, 5390.326209223847, 5620.803271885465, 5657.179708942098, 5670.291213598301, 5429.099815064696, 5482.314710661168, 5484.314460692413, 5496.444153468657, 5531.806386776443, 5420.322459692538, 5443.856790074129, 5448.318960129984, 5464.114880366267, 5486.451354864482, 5197.376314842243, 5351.0, 5364.249005139206, 5365.839024829262, 5422.105352616932, 5420.647657902224, 5446.319210098738, 5489.862753431196, 5491.133014774996, 5518.944810551843, 5342.706151161723, 5386.192071189353, 5400.272862204719, 5426.186072089218, 5431.158170483582], "value": 4255.5664432300955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.9023826902502, 776.0919723923009, 802.4864086984331, 822.1819289806635, 833.287539154023, 14030.579082627524, 14474.421023159088, 14528.491502797404, 14529.200893950841, 14551.05418147821, 11450.656480305604, 13254.403551840167, 13278.601641950732, 13328.0, 13331.400086996084, 795.8527672380599, 826.0459169659024, 827.1108558299821, 827.3711978896052, 827.8468483330603, 816.6733306677318, 821.9753407397787, 823.1110400767187, 823.2261674026425, 825.9297959673435, 708.4651088428229, 826.5123577089516, 870.9520976346298, 871.9258862996653, 873.8077622922947, 845.2561745663838, 846.8687353460224, 846.9745907622781, 849.8257857139272, 857.498363457375, 617.3178637605427, 617.478230894893, 617.7004152985799, 624.7376102037156, 629.515273239603, 13233.139845910082, 13291.53479628218, 13327.600171994856, 13356.933215333958, 13397.129186602937, 13213.14114582549, 14061.718765624733, 14108.717825643429, 14157.716845663132, 14248.21634810085, 11097.1677124216, 11506.13703972197, 11643.883561164364, 11891.405429728478, 11921.701957451047, 3817.3701339278987, 3847.172857835551, 3849.6727778138893, 3927.253821773854, 3931.8820435386983, 53588.73205633986, 53663.46336536624, 55655.165172522444, 56212.718936405465, 56661.0, 11130.443477826077, 11238.494267757971, 11430.485628146753, 11479.368634725004, 11480.942595287137, 19844.90077549603, 19847.404577862686, 19852.10665520055, 19884.60230795405, 20084.497887552927, 8035.678572857137, 8035.959820200978, 8192.877106843402, 8389.916100839035, 8466.40735148546, 4664.277037059193, 4664.603508701731, 4674.228752255908, 4700.0, 4778.1638213312535, 3227.564278822376, 3257.2182676158027, 3274.5415641810164, 3295.505674148849, 3298.8515516801804, 593.857474206196, 598.7006496751624, 599.8830228105564, 604.6583680220662, 606.6633018674678, 533.5678100738414, 569.9088145896636, 652.954293199481, 673.5049738442241, 688.8415664397216, 9787.41547187029, 10067.44024595866, 10069.48919001979, 10099.213684094737, 10296.073109390114, 625.6996641612052, 724.7535837815168, 736.2048987093925, 761.208343322949, 769.1923480345615, 4510.571495707903, 4562.817487300471, 4774.092922344744, 4789.281607758864, 4906.239532872411, 65076.34923650703, 65705.67147164233, 66068.66965665238, 67774.66112669405, 68119.0, 56037.0, 56173.71913140408, 57926.420735792104, 58758.41241587615, 59813.401865980784, 50925.0, 52621.473785262424, 52640.0, 53345.46654533483, 54341.72829135908, 9032.864507032531, 9087.727368178965, 9113.544322783702, 9147.542622868697, 9166.404183728037, 34678.65321346754, 35059.824700877354, 35118.64881351256, 35531.82234088813, 35639.10902227465, 41703.16593668049, 45977.0, 46220.306695398926, 46330.76834615805, 46692.299615505115, 11755.823662644896, 11859.644210673694, 11918.821217681914, 11948.820767688318, 12049.578264760692, 10637.574497020032, 11313.0, 13164.275964822027, 13811.309434528033, 14718.852811471748, 13115.606531804062, 13187.0, 13342.733145336844, 13461.596152115451, 13618.319084045559, 12263.325517096646, 12404.317762523147, 12777.872221277668, 13186.802197966847, 13505.729885402041, 12766.106372553832, 13046.217226966412, 13178.670533236746, 13347.733045339233, 13690.86309136896, 10877.728056798644, 11207.103431725605, 11294.265872718248, 11339.603113891304, 11774.587889423829, 10320.12278956297, 10500.369977801356, 10503.264771465923, 10807.0, 11052.586908441119], "value": 6795.569358386566, "unit": "score"}], "name": "dromaeo_css", "value": 6924.1949177874385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 107.0, 110.0, 110.0, 111.0, 101.0, 112.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 135.0, 161.0, 189.0, 128.0, 155.0, 151.0, 129.0, 187.0, 139.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 159.0, 160.0, 163.0, 160.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 126.0, 118.0, 73.0, 74.0, 76.0, 121.0, 100.0, 75.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 144.0, 93.0, 93.0, 94.0, 145.0, 93.0, 93.0, 149.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 144.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 68.0, 57.0, 57.0, 58.0, 58.0, 75.0, 55.0, 54.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 63.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 76.0, 78.0, 77.0, 77.0, 78.0, 77.0, 84.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 123.0, 123.0, 120.0, 121.0, 122.0, 124.0, 156.0, 128.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 167.0, 165.0, 169.0, 169.0, 169.0, 171.0, 165.0, 164.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 70.0, 67.0, 68.0, 79.0, 66.0, 67.0, 66.0, 67.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1540.3, "alertThreshold": 2.0}]} 10:30:18 INFO - Return code: 0 10:30:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:30:18 ERROR - # TBPL SUCCESS # 10:30:18 INFO - Running post-action listener: _resource_record_post_action 10:30:18 INFO - Running post-run listener: _resource_record_post_run 10:30:19 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 534536192; Read time: 0; Write time: 411080 10:30:19 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244686848; Read time: 0; Write time: 254788 10:30:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 289849344; Read time: 0; Write time: 156292 10:30:19 INFO - Running post-run listener: _upload_blobber_files 10:30:19 INFO - Blob upload gear active. 10:30:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:19 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 10:30:19 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:30:19 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:30:19 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:30:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:30:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:20 INFO - (blobuploader) - INFO - Done attempting. 10:30:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:30:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:21 INFO - (blobuploader) - INFO - Done attempting. 10:30:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:30:21 INFO - Return code: 0 10:30:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:30:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:30:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/401607da3526a342c35a3bf85a30f101d997547f7deea3a5e11392bd87ce7a93dd1dbd3fa7873f9594bf2d4bb080c2ec372ed9910f694789e0ef08b5241244f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94b55c4343b1d13a8172c20fadf69902e9bb217de798155776c18c36b2038dc2d24ceeda23285488116354a69899de43a3e41eaf83407af760bd7841c84d8bc7"} 10:30:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:30:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:30:21 INFO - Contents: 10:30:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/401607da3526a342c35a3bf85a30f101d997547f7deea3a5e11392bd87ce7a93dd1dbd3fa7873f9594bf2d4bb080c2ec372ed9910f694789e0ef08b5241244f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94b55c4343b1d13a8172c20fadf69902e9bb217de798155776c18c36b2038dc2d24ceeda23285488116354a69899de43a3e41eaf83407af760bd7841c84d8bc7"} 10:30:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:30:21 INFO - Copying logs to upload dir... 10:30:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:30:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.414724 ========= master_lag: 16.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-28 10:30:37.385594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 10:30:37.389158) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/401607da3526a342c35a3bf85a30f101d997547f7deea3a5e11392bd87ce7a93dd1dbd3fa7873f9594bf2d4bb080c2ec372ed9910f694789e0ef08b5241244f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94b55c4343b1d13a8172c20fadf69902e9bb217de798155776c18c36b2038dc2d24ceeda23285488116354a69899de43a3e41eaf83407af760bd7841c84d8bc7"} build_url:https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/SATGbVniRUSmpHfqkneWUQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/401607da3526a342c35a3bf85a30f101d997547f7deea3a5e11392bd87ce7a93dd1dbd3fa7873f9594bf2d4bb080c2ec372ed9910f694789e0ef08b5241244f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94b55c4343b1d13a8172c20fadf69902e9bb217de798155776c18c36b2038dc2d24ceeda23285488116354a69899de43a3e41eaf83407af760bd7841c84d8bc7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 10:30:37.431642) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:30:37.432184) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461863293.195041-273458585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.95 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:30:38.390594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 10:30:38.390936) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 10:30:38.652528) ========= ========= Total master_lag: 17.95 =========