builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1470065992.78 results: success (0) buildid: 20160801071850 builduid: a5421adf0f99458c8cb93aecfecd13ce revision: 192c7f9edb1cfbb7d6cfdd9e526ac0a766a9156b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:52.779030) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:52.779490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:52.779809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:52.883682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:52.883983) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 08:39:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.9M=0s 2016-08-01 08:39:53 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:53.018330) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:53.018655) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017363 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:53.105357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:53.105722) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 192c7f9edb1cfbb7d6cfdd9e526ac0a766a9156b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 192c7f9edb1cfbb7d6cfdd9e526ac0a766a9156b --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=78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 08:39:53,451 truncating revision to first 12 chars 2016-08-01 08:39:53,451 Setting DEBUG logging. 2016-08-01 08:39:53,451 attempt 1/10 2016-08-01 08:39:53,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/192c7f9edb1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 08:39:53,987 unpacking tar archive at: autoland-192c7f9edb1c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.947498 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:54.067105) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:54.067559) ========= script_repo_revision: 192c7f9edb1cfbb7d6cfdd9e526ac0a766a9156b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:54.068041) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:54.068419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 08:39:54.079615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-08-01 08:39:54.079924) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:39:54 INFO - MultiFileLogger online at 20160801 08:39:54 in /builds/slave/test 08:39:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 08:39:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:39:54 INFO - {'append_to_log': False, 08:39:54 INFO - 'base_work_dir': '/builds/slave/test', 08:39:54 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:39:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:39:54 INFO - 'branch': 'Autoland-Non-PGO', 08:39:54 INFO - 'buildbot_json_path': 'buildprops.json', 08:39:54 INFO - 'config_files': ('talos/linux_config.py',), 08:39:54 INFO - 'default_actions': ('clobber', 08:39:54 INFO - 'read-buildbot-config', 08:39:54 INFO - 'download-and-extract', 08:39:54 INFO - 'populate-webroot', 08:39:54 INFO - 'create-virtualenv', 08:39:54 INFO - 'install', 08:39:54 INFO - 'run-tests'), 08:39:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:39:54 INFO - 'download_minidump_stackwalk': True, 08:39:54 INFO - 'download_symbols': 'ondemand', 08:39:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:39:54 INFO - 'tooltool.py': '/tools/tooltool.py', 08:39:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:39:54 INFO - '/tools/misc-python/virtualenv.py')}, 08:39:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:39:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:39:54 INFO - 'installer_path': 'installer.exe', 08:39:54 INFO - 'log_level': 'info', 08:39:54 INFO - 'log_name': 'talos', 08:39:54 INFO - 'log_to_console': True, 08:39:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:39:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:39:54 INFO - 'opt_config_files': (), 08:39:54 INFO - 'pip_index': False, 08:39:54 INFO - 'sps_profile': False, 08:39:54 INFO - 'sps_profile_interval': 0, 08:39:54 INFO - 'suite': 'dromaeojs', 08:39:54 INFO - 'system_bits': '32', 08:39:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:39:54 INFO - 'title': 'talos-linux64-ix-019', 08:39:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:39:54 INFO - 'use_talos_json': True, 08:39:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:39:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:39:54 INFO - 'work_dir': 'build'} 08:39:54 INFO - [mozharness: 2016-08-01 15:39:54.513824Z] Running clobber step. 08:39:54 INFO - Running pre-action listener: _resource_record_pre_action 08:39:54 INFO - Running main action method: clobber 08:39:54 INFO - rmtree: /builds/slave/test/build 08:39:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:39:54 INFO - Running post-action listener: _resource_record_post_action 08:39:54 INFO - [mozharness: 2016-08-01 15:39:54.974801Z] Finished clobber step (success) 08:39:54 INFO - [mozharness: 2016-08-01 15:39:54.974904Z] Running read-buildbot-config step. 08:39:54 INFO - Running pre-action listener: _resource_record_pre_action 08:39:54 INFO - Running main action method: read_buildbot_config 08:39:54 INFO - Using buildbot properties: 08:39:54 INFO - { 08:39:54 INFO - "project": "", 08:39:54 INFO - "product": "firefox", 08:39:54 INFO - "script_repo_revision": "production", 08:39:54 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:39:54 INFO - "repository": "", 08:39:54 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 08:39:54 INFO - "buildid": "20160801071850", 08:39:54 INFO - "pgo_build": "False", 08:39:54 INFO - "basedir": "/builds/slave/test", 08:39:54 INFO - "buildnumber": 114, 08:39:54 INFO - "slavename": "talos-linux64-ix-019", 08:39:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:39:54 INFO - "platform": "ubuntu64_hw", 08:39:54 INFO - "scheduler": "tests-autoland-linux64-talos", 08:39:54 INFO - "branch": "autoland", 08:39:54 INFO - "repo_path": "integration/autoland", 08:39:54 INFO - "revision": "192c7f9edb1cfbb7d6cfdd9e526ac0a766a9156b", 08:39:54 INFO - "stage_platform": "linux64", 08:39:54 INFO - "builduid": "a5421adf0f99458c8cb93aecfecd13ce", 08:39:54 INFO - "slavebuilddir": "test" 08:39:54 INFO - } 08:39:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:39:54 INFO - Running post-action listener: _resource_record_post_action 08:39:54 INFO - [mozharness: 2016-08-01 15:39:54.977368Z] Finished read-buildbot-config step (success) 08:39:54 INFO - [mozharness: 2016-08-01 15:39:54.977459Z] Running download-and-extract step. 08:39:54 INFO - Running pre-action listener: _resource_record_pre_action 08:39:54 INFO - Running main action method: download_and_extract 08:39:54 INFO - mkdir: /builds/slave/test/build/tests 08:39:54 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')]} 08:39:54 INFO - https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:39:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:39:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:39:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:40:03 INFO - Downloaded 1361 bytes. 08:40:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:03 INFO - Using the following test package requirements: 08:40:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:40:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'jsshell-linux-x86_64.zip'], 08:40:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:40:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:40:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:03 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')]} 08:40:03 INFO - https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:08 INFO - Downloaded 20237696 bytes. 08:40:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:40:10 INFO - Return code: 0 08:40:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:40: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')]} 08:40:10 INFO - https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:18 INFO - Downloaded 20237696 bytes. 08:40:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:40:19 INFO - Return code: 0 08:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:19 INFO - https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:40:21 INFO - Downloaded 14413723 bytes. 08:40:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:40:21 INFO - Return code: 0 08:40: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')]} 08:40:21 INFO - https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:40:22 INFO - Downloaded 55669406 bytes. 08:40:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:22 INFO - mkdir: /builds/slave/test/properties 08:40:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:22 INFO - Contents: 08:40:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:23 INFO - Running post-action listener: _resource_record_post_action 08:40:23 INFO - Running post-action listener: set_extra_try_arguments 08:40:23 INFO - [mozharness: 2016-08-01 15:40:23.491709Z] Finished download-and-extract step (success) 08:40:23 INFO - [mozharness: 2016-08-01 15:40:23.492036Z] Running populate-webroot step. 08:40:23 INFO - Running pre-action listener: _resource_record_pre_action 08:40:23 INFO - Running main action method: populate_webroot 08:40:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:23 INFO - '--tppagecycles', 08:40:23 INFO - '7'], 08:40:23 INFO - 'tests': ['tsvgm']}}, 08:40:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:23 INFO - 'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:23 INFO - 'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['damp', 'tps']}, 08:40:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:23 INFO - 'tests': ['damp', 'tps']}, 08:40:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['dromaeo_dom']}, 08:40:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['basic_compositor_video']}, 08:40:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['tsvgx', 08:40:23 INFO - 'tsvgr_opacity', 08:40:23 INFO - 'tart', 08:40:23 INFO - 'tscrollx', 08:40:23 INFO - 'cart']}, 08:40:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:23 INFO - 'tsvgr_opacity', 08:40:23 INFO - 'tart', 08:40:23 INFO - 'tscrollx', 08:40:23 INFO - 'cart']}, 08:40:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:23 INFO - 'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['tp5o']}, 08:40:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:23 INFO - 'tests': ['tp5o']}, 08:40:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:23 INFO - 'talos_options': ['--disable-e10s', 08:40:23 INFO - '--xperf_path', 08:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:23 INFO - 'tests': ['tp5n']}, 08:40:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:23 INFO - 'talos_options': ['--xperf_path', 08:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:23 INFO - 'tests': ['tp5n']}}, 08:40:23 INFO - 'talos.zip': {'path': '', 08:40:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:23 INFO - Running post-action listener: _resource_record_post_action 08:40:23 INFO - [mozharness: 2016-08-01 15:40:23.512210Z] Finished populate-webroot step (success) 08:40:23 INFO - [mozharness: 2016-08-01 15:40:23.512300Z] Running create-virtualenv step. 08:40:23 INFO - Running pre-action listener: _resource_record_pre_action 08:40:23 INFO - Running main action method: create_virtualenv 08:40:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:23 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 08:40:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:23 INFO - Using real prefix '/usr' 08:40:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:26 INFO - Installing pip.................done. 08:40:26 INFO - Return code: 0 08:40:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:26 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 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:26 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 08:40:26 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 08:40:26 INFO - Using env: {'DISPLAY': ':0', 08:40:26 INFO - 'HOME': '/home/cltbld', 08:40:26 INFO - 'LANG': 'en_US.UTF-8', 08:40:26 INFO - 'LANGUAGE': 'en_US:en', 08:40:26 INFO - 'LOGNAME': 'cltbld', 08:40:26 INFO - 'MAIL': '/var/mail/cltbld', 08:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:26 INFO - 'MOZ_NO_REMOTE': '1', 08:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:26 INFO - 'NO_EM_RESTART': '1', 08:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:26 INFO - 'PWD': '/builds/slave/test', 08:40:26 INFO - 'SHELL': '/bin/bash', 08:40:26 INFO - 'SHLVL': '1', 08:40:26 INFO - 'TERM': 'linux', 08:40:26 INFO - 'TMOUT': '86400', 08:40:26 INFO - 'USER': 'cltbld', 08:40:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:26 INFO - '_': '/tools/buildbot/bin/python'} 08:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:26 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 08:40:26 INFO - Cleaning up... 08:40:26 INFO - Return code: 0 08:40:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:26 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:26 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>=3.1.1'] in /builds/slave/test/build 08:40:26 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>=3.1.1 08:40:26 INFO - Using env: {'DISPLAY': ':0', 08:40:26 INFO - 'HOME': '/home/cltbld', 08:40:26 INFO - 'LANG': 'en_US.UTF-8', 08:40:26 INFO - 'LANGUAGE': 'en_US:en', 08:40:26 INFO - 'LOGNAME': 'cltbld', 08:40:26 INFO - 'MAIL': '/var/mail/cltbld', 08:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:26 INFO - 'MOZ_NO_REMOTE': '1', 08:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:26 INFO - 'NO_EM_RESTART': '1', 08:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:26 INFO - 'PWD': '/builds/slave/test', 08:40:26 INFO - 'SHELL': '/bin/bash', 08:40:26 INFO - 'SHLVL': '1', 08:40:26 INFO - 'TERM': 'linux', 08:40:26 INFO - 'TMOUT': '86400', 08:40:26 INFO - 'USER': 'cltbld', 08:40:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:26 INFO - '_': '/tools/buildbot/bin/python'} 08:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:26 INFO - Downloading/unpacking psutil>=3.1.1 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:28 INFO - Installing collected packages: psutil 08:40:28 INFO - Running setup.py install for psutil 08:40:28 INFO - building 'psutil._psutil_linux' extension 08:40:28 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 08:40:28 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 08:40:28 INFO - building 'psutil._psutil_posix' extension 08:40:28 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 08:40:28 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 08:40:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:29 INFO - Successfully installed psutil 08:40:29 INFO - Cleaning up... 08:40:29 INFO - Return code: 0 08:40:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:40:29 INFO - Using env: {'DISPLAY': ':0', 08:40:29 INFO - 'HOME': '/home/cltbld', 08:40:29 INFO - 'LANG': 'en_US.UTF-8', 08:40:29 INFO - 'LANGUAGE': 'en_US:en', 08:40:29 INFO - 'LOGNAME': 'cltbld', 08:40:29 INFO - 'MAIL': '/var/mail/cltbld', 08:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:29 INFO - 'MOZ_NO_REMOTE': '1', 08:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:29 INFO - 'NO_EM_RESTART': '1', 08:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:29 INFO - 'PWD': '/builds/slave/test', 08:40:29 INFO - 'SHELL': '/bin/bash', 08:40:29 INFO - 'SHLVL': '1', 08:40:29 INFO - 'TERM': 'linux', 08:40:29 INFO - 'TMOUT': '86400', 08:40:29 INFO - 'USER': 'cltbld', 08:40:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:29 INFO - '_': '/tools/buildbot/bin/python'} 08:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:31 INFO - Installing collected packages: mozsystemmonitor 08:40:31 INFO - Running setup.py install for mozsystemmonitor 08:40:31 INFO - Successfully installed mozsystemmonitor 08:40:31 INFO - Cleaning up... 08:40:31 INFO - Return code: 0 08:40:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:31 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==2.5.1'] in /builds/slave/test/build 08:40:31 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==2.5.1 08:40:31 INFO - Using env: {'DISPLAY': ':0', 08:40:31 INFO - 'HOME': '/home/cltbld', 08:40:31 INFO - 'LANG': 'en_US.UTF-8', 08:40:31 INFO - 'LANGUAGE': 'en_US:en', 08:40:31 INFO - 'LOGNAME': 'cltbld', 08:40:31 INFO - 'MAIL': '/var/mail/cltbld', 08:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:31 INFO - 'MOZ_NO_REMOTE': '1', 08:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:31 INFO - 'NO_EM_RESTART': '1', 08:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:31 INFO - 'PWD': '/builds/slave/test', 08:40:31 INFO - 'SHELL': '/bin/bash', 08:40:31 INFO - 'SHLVL': '1', 08:40:31 INFO - 'TERM': 'linux', 08:40:31 INFO - 'TMOUT': '86400', 08:40:31 INFO - 'USER': 'cltbld', 08:40:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:31 INFO - '_': '/tools/buildbot/bin/python'} 08:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:31 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:33 INFO - warning: no files found matching '*.txt' 08:40:33 INFO - no previously-included directories found matching 'build' 08:40:33 INFO - no previously-included directories found matching 'dist' 08:40:33 INFO - no previously-included directories found matching '.git*' 08:40:33 INFO - Installing collected packages: jsonschema, functools32 08:40:33 INFO - Running setup.py install for functools32 08:40:33 INFO - warning: no files found matching '*.txt' 08:40:33 INFO - no previously-included directories found matching 'build' 08:40:33 INFO - no previously-included directories found matching 'dist' 08:40:33 INFO - no previously-included directories found matching '.git*' 08:40:33 INFO - Successfully installed jsonschema functools32 08:40:33 INFO - Cleaning up... 08:40:33 INFO - Return code: 0 08:40:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:40:33 INFO - Using env: {'DISPLAY': ':0', 08:40:33 INFO - 'HOME': '/home/cltbld', 08:40:33 INFO - 'LANG': 'en_US.UTF-8', 08:40:33 INFO - 'LANGUAGE': 'en_US:en', 08:40:33 INFO - 'LOGNAME': 'cltbld', 08:40:33 INFO - 'MAIL': '/var/mail/cltbld', 08:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:33 INFO - 'MOZ_NO_REMOTE': '1', 08:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:33 INFO - 'NO_EM_RESTART': '1', 08:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:33 INFO - 'PWD': '/builds/slave/test', 08:40:33 INFO - 'SHELL': '/bin/bash', 08:40:33 INFO - 'SHLVL': '1', 08:40:33 INFO - 'TERM': 'linux', 08:40:33 INFO - 'TMOUT': '86400', 08:40:33 INFO - 'USER': 'cltbld', 08:40:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:33 INFO - '_': '/tools/buildbot/bin/python'} 08:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:34 INFO - Cleaning up... 08:40:34 INFO - Return code: 0 08:40:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:34 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')]} 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:34 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')]} 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:34 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 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:34 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 08:40:34 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 08:40:34 INFO - Using env: {'DISPLAY': ':0', 08:40:34 INFO - 'HOME': '/home/cltbld', 08:40:34 INFO - 'LANG': 'en_US.UTF-8', 08:40:34 INFO - 'LANGUAGE': 'en_US:en', 08:40:34 INFO - 'LOGNAME': 'cltbld', 08:40:34 INFO - 'MAIL': '/var/mail/cltbld', 08:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:34 INFO - 'MOZ_NO_REMOTE': '1', 08:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:34 INFO - 'NO_EM_RESTART': '1', 08:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:34 INFO - 'PWD': '/builds/slave/test', 08:40:34 INFO - 'SHELL': '/bin/bash', 08:40:34 INFO - 'SHLVL': '1', 08:40:34 INFO - 'TERM': 'linux', 08:40:34 INFO - 'TMOUT': '86400', 08:40:34 INFO - 'USER': 'cltbld', 08:40:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:34 INFO - '_': '/tools/buildbot/bin/python'} 08:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:34 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - Downloading docopt-0.6.1.tar.gz 08:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:37 INFO - Running setup.py install for blobuploader 08:40:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:37 INFO - Running setup.py install for requests 08:40:37 INFO - Running setup.py install for docopt 08:40:37 INFO - Successfully installed blobuploader requests docopt 08:40:37 INFO - Cleaning up... 08:40:37 INFO - Return code: 0 08:40:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:37 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 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:37 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 08:40:37 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 08:40:37 INFO - Using env: {'DISPLAY': ':0', 08:40:37 INFO - 'HOME': '/home/cltbld', 08:40:37 INFO - 'LANG': 'en_US.UTF-8', 08:40:37 INFO - 'LANGUAGE': 'en_US:en', 08:40:37 INFO - 'LOGNAME': 'cltbld', 08:40:37 INFO - 'MAIL': '/var/mail/cltbld', 08:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:37 INFO - 'MOZ_NO_REMOTE': '1', 08:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:37 INFO - 'NO_EM_RESTART': '1', 08:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:37 INFO - 'PWD': '/builds/slave/test', 08:40:37 INFO - 'SHELL': '/bin/bash', 08:40:37 INFO - 'SHLVL': '1', 08:40:37 INFO - 'TERM': 'linux', 08:40:37 INFO - 'TMOUT': '86400', 08:40:37 INFO - 'USER': 'cltbld', 08:40:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:37 INFO - '_': '/tools/buildbot/bin/python'} 08:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:37 INFO - Running setup.py (path:/tmp/pip-CPc1xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:37 INFO - Running setup.py (path:/tmp/pip-yrqBgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:38 INFO - Running setup.py (path:/tmp/pip-G6fpEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:38 INFO - Running setup.py (path:/tmp/pip-dfB1Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:38 INFO - Running setup.py (path:/tmp/pip-fqDDPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:38 INFO - Running setup.py (path:/tmp/pip-q7Zw1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:38 INFO - Running setup.py (path:/tmp/pip-vbLtI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:38 INFO - Running setup.py (path:/tmp/pip-zl5Xc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:38 INFO - Running setup.py (path:/tmp/pip-uE5IOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:38 INFO - Running setup.py (path:/tmp/pip-ax5DIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:38 INFO - Running setup.py (path:/tmp/pip-l3RZ8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:38 INFO - Running setup.py (path:/tmp/pip-WgHa_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:38 INFO - Running setup.py (path:/tmp/pip-ogu37B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:38 INFO - Running setup.py (path:/tmp/pip-BupiUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:38 INFO - Running setup.py (path:/tmp/pip-k0IXoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:38 INFO - Running setup.py (path:/tmp/pip-Ll4_Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:39 INFO - Running setup.py (path:/tmp/pip-FWAPN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:39 INFO - Running setup.py install for manifestparser 08:40:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Running setup.py install for mozcrash 08:40:39 INFO - Running setup.py install for mozdebug 08:40:39 INFO - Running setup.py install for mozdevice 08:40:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Running setup.py install for mozfile 08:40:39 INFO - Running setup.py install for mozhttpd 08:40:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Running setup.py install for mozinfo 08:40:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Running setup.py install for mozInstall 08:40:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:39 INFO - Running setup.py install for mozleak 08:40:39 INFO - Running setup.py install for mozlog 08:40:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:40 INFO - Running setup.py install for moznetwork 08:40:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:40 INFO - Running setup.py install for mozprocess 08:40:40 INFO - Running setup.py install for mozprofile 08:40:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:40 INFO - Running setup.py install for mozrunner 08:40:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:40 INFO - Running setup.py install for mozscreenshot 08:40:40 INFO - Running setup.py install for moztest 08:40:40 INFO - Running setup.py install for mozversion 08:40:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:40 INFO - Cleaning up... 08:40:40 INFO - Return code: 0 08:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:40 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')]} 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 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')]} 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 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 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:40 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 08:40:40 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 08:40:40 INFO - Using env: {'DISPLAY': ':0', 08:40:40 INFO - 'HOME': '/home/cltbld', 08:40:40 INFO - 'LANG': 'en_US.UTF-8', 08:40:40 INFO - 'LANGUAGE': 'en_US:en', 08:40:40 INFO - 'LOGNAME': 'cltbld', 08:40:40 INFO - 'MAIL': '/var/mail/cltbld', 08:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:40 INFO - 'MOZ_NO_REMOTE': '1', 08:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:40 INFO - 'NO_EM_RESTART': '1', 08:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:40 INFO - 'PWD': '/builds/slave/test', 08:40:40 INFO - 'SHELL': '/bin/bash', 08:40:40 INFO - 'SHLVL': '1', 08:40:40 INFO - 'TERM': 'linux', 08:40:40 INFO - 'TMOUT': '86400', 08:40:40 INFO - 'USER': 'cltbld', 08:40:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:40 INFO - '_': '/tools/buildbot/bin/python'} 08:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:41 INFO - Running setup.py (path:/tmp/pip-391jPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:41 INFO - Running setup.py (path:/tmp/pip-ouGfzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:41 INFO - Running setup.py (path:/tmp/pip-xvfZ4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:41 INFO - Running setup.py (path:/tmp/pip-f7Q2K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:41 INFO - Running setup.py (path:/tmp/pip-Tavy_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:41 INFO - Running setup.py (path:/tmp/pip-P3tRkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:41 INFO - Running setup.py (path:/tmp/pip-0P2sR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:41 INFO - Running setup.py (path:/tmp/pip-4KR5Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:41 INFO - Running setup.py (path:/tmp/pip-0M2x1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:41 INFO - Running setup.py (path:/tmp/pip-8s4fyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:41 INFO - Running setup.py (path:/tmp/pip-9yTBVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:41 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:41 INFO - Running setup.py (path:/tmp/pip-cMybMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:42 INFO - Running setup.py (path:/tmp/pip-RMKXqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:42 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)) 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:42 INFO - Running setup.py (path:/tmp/pip-mtgw0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:42 INFO - Running setup.py (path:/tmp/pip-gAI0lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:42 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)) 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:42 INFO - Running setup.py (path:/tmp/pip-HJu17J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:42 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)) 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:42 INFO - Running setup.py (path:/tmp/pip-4Z3W2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:42 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)) 08:40:42 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)) 08:40:42 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)) 08:40:42 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)) 08:40:42 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)) 08:40:42 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)) 08:40:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:44 INFO - Downloading blessings-1.6.tar.gz 08:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:44 INFO - Installing collected packages: blessings 08:40:44 INFO - Running setup.py install for blessings 08:40:44 INFO - Successfully installed blessings 08:40:44 INFO - Cleaning up... 08:40:44 INFO - Return code: 0 08:40:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:44 INFO - Reading from file tmpfile_stdout 08:40:44 INFO - Current package versions: 08:40:44 INFO - argparse == 1.2.1 08:40:44 INFO - blessings == 1.6 08:40:44 INFO - blobuploader == 1.2.4 08:40:44 INFO - docopt == 0.6.1 08:40:44 INFO - functools32 == 3.2.3-2 08:40:44 INFO - jsonschema == 2.5.1 08:40:44 INFO - manifestparser == 1.1 08:40:44 INFO - mozInstall == 1.12 08:40:44 INFO - mozcrash == 0.17 08:40:44 INFO - mozdebug == 0.1 08:40:44 INFO - mozdevice == 0.48 08:40:44 INFO - mozfile == 1.2 08:40:44 INFO - mozhttpd == 0.7 08:40:44 INFO - mozinfo == 0.9 08:40:44 INFO - mozleak == 0.1 08:40:44 INFO - mozlog == 3.3 08:40:44 INFO - moznetwork == 0.27 08:40:44 INFO - mozprocess == 0.23 08:40:44 INFO - mozprofile == 0.28 08:40:44 INFO - mozrunner == 6.12 08:40:44 INFO - mozscreenshot == 0.1 08:40:44 INFO - mozsystemmonitor == 0.3 08:40:44 INFO - moztest == 0.7 08:40:44 INFO - mozversion == 1.4 08:40:44 INFO - psutil == 3.1.1 08:40:44 INFO - requests == 1.2.3 08:40:44 INFO - wsgiref == 0.1.2 08:40:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:44 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 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:44 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 08:40:44 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 08:40:44 INFO - Using env: {'DISPLAY': ':0', 08:40:44 INFO - 'HOME': '/home/cltbld', 08:40:44 INFO - 'LANG': 'en_US.UTF-8', 08:40:44 INFO - 'LANGUAGE': 'en_US:en', 08:40:44 INFO - 'LOGNAME': 'cltbld', 08:40:44 INFO - 'MAIL': '/var/mail/cltbld', 08:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:44 INFO - 'MOZ_NO_REMOTE': '1', 08:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:44 INFO - 'NO_EM_RESTART': '1', 08:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:44 INFO - 'PWD': '/builds/slave/test', 08:40:44 INFO - 'SHELL': '/bin/bash', 08:40:44 INFO - 'SHLVL': '1', 08:40:44 INFO - 'TERM': 'linux', 08:40:44 INFO - 'TMOUT': '86400', 08:40:44 INFO - 'USER': 'cltbld', 08:40:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:44 INFO - '_': '/tools/buildbot/bin/python'} 08:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 INFO - Cleaning up... 08:40:44 INFO - Return code: 0 08:40:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:44 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 0x26ca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', '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 08:40:44 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 08:40:44 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 08:40:44 INFO - Using env: {'DISPLAY': ':0', 08:40:44 INFO - 'HOME': '/home/cltbld', 08:40:44 INFO - 'LANG': 'en_US.UTF-8', 08:40:44 INFO - 'LANGUAGE': 'en_US:en', 08:40:44 INFO - 'LOGNAME': 'cltbld', 08:40:44 INFO - 'MAIL': '/var/mail/cltbld', 08:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:44 INFO - 'MOZ_NO_REMOTE': '1', 08:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:44 INFO - 'NO_EM_RESTART': '1', 08:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:44 INFO - 'PWD': '/builds/slave/test', 08:40:44 INFO - 'SHELL': '/bin/bash', 08:40:44 INFO - 'SHLVL': '1', 08:40:44 INFO - 'TERM': 'linux', 08:40:44 INFO - 'TMOUT': '86400', 08:40:44 INFO - 'USER': 'cltbld', 08:40:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:44 INFO - '_': '/tools/buildbot/bin/python'} 08:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:45 INFO - Cleaning up... 08:40:45 INFO - Return code: 0 08:40:45 INFO - Running post-action listener: _resource_record_post_action 08:40:45 INFO - Running post-action listener: _start_resource_monitoring 08:40:45 INFO - Starting resource monitoring. 08:40:45 INFO - [mozharness: 2016-08-01 15:40:45.162529Z] Finished create-virtualenv step (success) 08:40:45 INFO - [mozharness: 2016-08-01 15:40:45.163007Z] Running install step. 08:40:45 INFO - Running pre-action listener: _resource_record_pre_action 08:40:45 INFO - Running main action method: install 08:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:45 INFO - Reading from file tmpfile_stdout 08:40:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:45 INFO - Reading from file tmpfile_stdout 08:40:45 INFO - Output received: 08:40:45 INFO - Usage: mozinstall [options] installer 08:40:45 INFO - Options: 08:40:45 INFO - -h, --help show this help message and exit 08:40:45 INFO - -d DEST, --destination=DEST 08:40:45 INFO - Directory to install application into. [default: 08:40:45 INFO - "/builds/slave/test"] 08:40:45 INFO - --app=APP Application being installed. [default: firefox] 08:40:45 INFO - mkdir: /builds/slave/test/build/application 08:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:41:01 INFO - Reading from file tmpfile_stdout 08:41:01 INFO - Output received: 08:41:01 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:01 INFO - Running post-action listener: _resource_record_post_action 08:41:01 INFO - [mozharness: 2016-08-01 15:41:01.458533Z] Finished install step (success) 08:41:01 INFO - [mozharness: 2016-08-01 15:41:01.458808Z] Running run-tests step. 08:41:01 INFO - Running pre-action listener: _resource_record_pre_action 08:41:01 INFO - Running main action method: run_tests 08:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:01 INFO - Python 2.7.3 08:41:01 INFO - Return code: 0 08:41:01 INFO - grabbing minidump binary from tooltool 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:01 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29893b0>, '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 0x298a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:01 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 08:41:01 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 08:41:01 INFO - Calling ['/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'] with output_timeout 600 08:41:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:01 INFO - Return code: 0 08:41:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 08:41:01 INFO - Using env: {'DISPLAY': ':0', 08:41:01 INFO - 'HOME': '/home/cltbld', 08:41:01 INFO - 'LANG': 'en_US.UTF-8', 08:41:01 INFO - 'LANGUAGE': 'en_US:en', 08:41:01 INFO - 'LOGNAME': 'cltbld', 08:41:01 INFO - 'MAIL': '/var/mail/cltbld', 08:41:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:01 INFO - 'MOZ_NO_REMOTE': '1', 08:41:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:01 INFO - 'NO_EM_RESTART': '1', 08:41:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:01 INFO - 'PWD': '/builds/slave/test', 08:41:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:01 INFO - 'SHELL': '/bin/bash', 08:41:01 INFO - 'SHLVL': '1', 08:41:01 INFO - 'TERM': 'linux', 08:41:01 INFO - 'TMOUT': '86400', 08:41:01 INFO - 'USER': 'cltbld', 08:41:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326', 08:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:01 INFO - '_': '/tools/buildbot/bin/python'} 08:41:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:41:01 INFO - mozversion application_buildid: 20160801071850 08:41:01 INFO - mozversion application_changeset: 192c7f9edb1cfbb7d6cfdd9e526ac0a766a9156b 08:41:01 INFO - mozversion application_display_name: Nightly 08:41:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:01 INFO - mozversion application_name: Firefox 08:41:01 INFO - mozversion application_remotingname: firefox 08:41:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:41:01 INFO - mozversion application_vendor: Mozilla 08:41:01 INFO - mozversion application_version: 50.0a1 08:41:01 INFO - mozversion platform_buildid: 20160801071850 08:41:01 INFO - mozversion platform_changeset: 192c7f9edb1cfbb7d6cfdd9e526ac0a766a9156b 08:41:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:41:01 INFO - mozversion platform_version: 50.0a1 08:41:01 INFO - using testdate: 1470066061 08:41:01 INFO - actual date: 1470066061 08:41:01 INFO - starting webserver on 'localhost:37363' 08:41:01 INFO - SUITE-START | Running 2 tests 08:41:01 INFO - TEST-START | dromaeo_css 08:41:01 INFO - operating with platform_type : linux_ 08:41:01 INFO - Initialising browser for dromaeo_css test... 08:41:01 INFO - TEST-INFO | started process 3172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQMpTsG/profile http://localhost:37363/getInfo.html) 08:41:06 INFO - PROCESS | 3172 | __metrics Screen width/height:1600/1200 08:41:06 INFO - PROCESS | 3172 | colorDepth:24 08:41:06 INFO - PROCESS | 3172 | Browser inner width/height: 1024/697 08:41:06 INFO - PROCESS | 3172 | __metrics 08:41:07 INFO - PROCESS | 3172 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:41:07 INFO - PROCESS | 3172 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:08 INFO - TEST-INFO | 3172: exit 0 08:41:08 INFO - Browser initialized. 08:41:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:08 INFO - TEST-INFO | started process 3253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQMpTsG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:20 INFO - PROCESS | 3253 | RSS: Main: 157335552 08:41:20 INFO - PROCESS | 3253 | 08:42:12 INFO - PROCESS | 3253 | 1470066132557 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] 08:44:24 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:37363/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37363/tests/dromaeo/cssquery-ext.html) 08:44:25 INFO - PROCESS | 3253 | RSS: Main: 252907520 08:44:25 INFO - PROCESS | 3253 | 08:47:28 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:37363/tests/dromaeo/cssquery-ext.html (next: http://localhost:37363/tests/dromaeo/cssquery-jquery.html) 08:47:28 INFO - PROCESS | 3253 | RSS: Main: 243167232 08:47:28 INFO - PROCESS | 3253 | 08:50:31 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:37363/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37363/tests/dromaeo/cssquery-mootools.html) 08:50:31 INFO - PROCESS | 3253 | RSS: Main: 189865984 08:50:31 INFO - PROCESS | 3253 | 08:53:33 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:37363/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37363/tests/dromaeo/cssquery-prototype.html) 08:53:34 INFO - PROCESS | 3253 | RSS: Main: 189378560 08:53:34 INFO - PROCESS | 3253 | 08:56:37 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:37363/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37363/tests/dromaeo/cssquery-yui.html) 08:56:38 INFO - PROCESS | 3253 | RSS: Main: 190775296 08:56:38 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:37363/tests/dromaeo/cssquery-yui.html (next: http://localhost:37363/tests/dromaeo/cssquery-dojo.html) 08:59:41 INFO - PROCESS | 3253 | RSS: Main: 282267648 08:59:41 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | __start_tp_report 08:59:41 INFO - PROCESS | 3253 | _x_x_mozilla_page_load 08:59:41 INFO - PROCESS | 3253 | _x_x_mozilla_page_load_details 08:59:41 INFO - PROCESS | 3253 | |i|pagename|runs| 08:59:41 INFO - PROCESS | 3253 | |0;dojo.html;2607.282997175778;2630.51335502932;2643.8149329546927;2653.6417583626217;2658.7075421703616;4530.320451932212;4648.790804413801;4716.740579268139;4728.834490792828;4731.57415832575;4757.714537127775;4769.165396055694;4817.036592681469;4833.154198015351;4839.854804355866;4331;4338.067315527161;4418;4476.9552304476865;4558.407407037081;4465.68740188187;4507.4365704286965;4517.616002639779;4523.185826551219;4541.931871021938;4250.574942505756;4323.870283891489;4334.284843000901;4339.067100573392;4388.078503514266;4330.350447432878;4352.325389564622;4353.151135528573;4413.933790993137;4436.800343984496;4344.326629372453;4374.58441448062;4384.079343337903;4414.823407063714;4419.801108950105;4571.062932098912;4736.6447516436065;4795.424549054101;4797.856064318076;4802.111609352246;5022.121128802445;5063.240513922904;5068.72122033288;5068.949310506885;5125.743712814382;5102.132637451642;5127.820526281562;5145.459726728677;5169.612279079047;5181.637285390024;4640.69835460694;4708.670393072521;4812.254100614446;4828;4837.080954618611;5204.193350030676;5245.1345527988215;5284.101702710548;5292.92060619091;5303.0719624066405;5026.070177017264;5077.949220507748;5079.949200508022;5080.695158290514;5081.7967281309075;4899.730514821719;5041.420236672756;5161.690298582097;5164.948350516522;5165.845024649267;5019;5092.337996060563;5093.159628661304;5129.204973229155;5148.794048238104;5055.469175736568;5068.518490743373;5090.872728181751;5095.082885080721;5121.667091639031;4210.052738133957;4235.237657221668;4369.453818272716;4387.473503179639;4424.823007079681;3697.556293244828;3711.9443208351895;3727.6645101940953;3757.0607348162957;3820.0449887528116;4385.649148068147;4396.802143903532;4403.647708183337;4433.866983990485;4442.622377097983;4945.258211268267;5060.367454068241;5065.290859279704;5073.16292811682;5101.464346243665;4360.236958532244;4393.0994146199955;4402.779861006937;4410.757408342572;4458.308962110878;4576.8626941191815;4607.838725644587;4608.585227329557;4610.746408947473;4661.813527458864;4697.7651117444675;4819.469858315582;4829.66192366531;4836.250381190921;4856.125897338513;5047.29337892688;5074.3657042869645;5078.695278283315;5086.364204474441;5147.974260128675;4814.494478079751;4839.612830973443;4842.104210721028;4864.197407427735;4866.489018653132;4845.442774081026;4939.678920870132;4950.554450099365;4950.653454258168;5001.949980500149;4989.80040798364;5044.621653376085;5075.5178258065425;5086.3896332440345;5129.58963282929;4971.950280497149;4978.5270399312;4978.800847966041;4992.15133427311;5044.344235249394;4783.736894470838;4944.950550494593;4958.231474121517;4967.925481117713;5006.023825354021;4818.132736107535;4822.8794280143275;4872.707637541617;4911.901761964669;4933.925991110208;4989.525995030466;4991;4994.101061808909;5008.449070602158;5015.247712842956;4739.3838800955655;4861.343718598086;4875.1712208923855;4882.658213924991;4910.337104490848 08:59:41 INFO - PROCESS | 3253 | |1;ext.html;547.3349879895926;560.6131769079333;562.7608266486743;575.3182478762667;575.933767616724;28649.427011459757;39554.80222598887;40677.38983915236;40705.796471017675;44352.673549483756;42406.787966060205;42602.14795704084;42718;42830.14339713204;42960.35559466611;7313.378362839138;7442.851142977151;7597.974273473065;7602.277783610548;7602.73390431335;7275.781726548212;7524.510906791041;7525.66134523945;9773.951130244339;10014.048665376778;9901.257405694601;9932.453715045669;9938.900610993906;9995.750106247366;9996.400215987063;10001.949990250003;10042.799144017152;10043.196544276478;10108.898911010943;10125.746856328577;9938.105570498617;9998.350107243006;10021.24840636948;10021.749456263578;10024.047715467019;39688.20623587541;39780.20439591221;39855.20289594192;39908.20183596341;40241.59758402437;3086.5215891536845;3143.9371212575847;3261.706446419834;3332.800031998088;3483.8083905385192;29475.852620736758;29770.576383715932;29857.552136717968;30065.398692026254;31003.22491937697;3101.3332133591384;3221.4040402525607;3243.3999710053718;3273.3780581689402;3420.9486857697157;249181;253365;253681;253825;254224;32035.839820800746;54963.175552366745;55497;55553.72223138859;55560;32247.67752322494;33933.32133357369;33959.4906076409;34089;34133;13123.868761312455;13301.467941282433;13305.135166214164;13306.201627902357;13316.134451260637;10724.463776811128;10824;10879.564817407374;10881.782364352826;10886.346819190874;7311.378532824663;7481;7503.5497870127965;7628.69485220596;7651.234876512304;3099.8760049597763;3114.2525793809777;3140.6702296259023;3144.402563512925;3146.6853314668806;882.6248844241172;895.8745775591423;896.3098414221014;908.2416182487697;915.7893684452613;28421;28563;28946;29312.267193319913;29377.118686439015;932.6083045121065;960.9903900960901;977.6382738386842;1021.3616489693941;1036.4972988100765;14974.401023958919;15182;15191;15218.758511402359;15481.845181548266;379310;379719;380291;382200;383215;43758;49104.508954909994;49745.75127124414;50192;50254;1173.3546549397797;1196.6111013920336;1209.2079687804678;1210.8183772434206;1212.4301578258205;28142.577861332506;29063.564046538897;29540.556891646214;30015.249618759706;30185.396292073598;43708;43968.12063758771;44019.55980440283;44117;44164.337534937644;319008;320815;351715;360688;363066;38117.42823857589;38507.6149238504;38514.80742596269;38523.073846308136;38838.6116138835;42818.78590607027;43212.783936080115;43268.13463730771;43470.78264608657;43645;36586.29200683463;36682;36943;37565.248695026494;38352.23295534129;36334.27331453409;37190.62809371872;37215.06962325964;37556.81221593874;38050.80974595109;35595.466068008485;36343.63656363403;36500.63499364972;36786.63213367832;36834.26331473302;31644;33221.33557328888;33659.66340336565;34013;34023;25222.873885630455;25781.87109064443;25890.22329330123;26044.73955260423;26136.09677371007 08:59:41 INFO - PROCESS | 3253 | |2;jquery.html;338.6461148100235;350.6651148153512;351.4920939242795;357.7263393503969;374.4252572301518;12713.36433178342;16083.83916160838;16465.34138634453;17196.914015429935;17352.132393380343;16361.263743131558;16751.83248167518;17296.56758581033;17441.30234790607;17461.7380739289;4926.261060840867;5022.472640372763;5115.9488405116035;5132.204508301201;5135.35808023997;3767.6797472214894;5047.520485553867;5066.620003499734;5569.721513924287;5855.824325270228;5872.911906321408;5890.381509941437;5894.410558944114;5894.528437724993;5895.263092113486;5166.276721259008;5404.864878378033;5438.048341540215;5538.695371754552;5918.082697181943;5363.54409875161;5365.007473617393;5374.5700343972385;5375.865603359908;5377.274068000809;12293.200941938745;12557.811632825424;12582.496700131984;12691.984641228679;13097;1784.7144456886965;1839.2183322088192;1870.3453791173117;1893.5550145715883;1993.2624928776302;8911.465312081296;9002.874640669916;9141;9444.433333999981;9577.760555986086;1681.4031018988205;1761.6124452620404;1774.112943528236;1795.2908601102622;1804.4496428589275;67890.66054669744;68698;69278;71333.2866671337;72039.63980180118;9116.908830911738;9235.492047937429;9246.676366327281;9961.701148965543;10196.184305255561;13925.303734813218;13932.58202253934;13954.09298395601;13959;13962.511312104027;6939.340762627542;7037.085178926809;7111.826548619523;7157.6779044943105;7160.713571457188;6565.310642382577;6608.669566521655;6762.594244345355;6773.525853190328;6804.727810887608;4319.244132276839;4359.302511598193;4375.803088861009;4388.736675799462;4457.7771111444945;1737.6003519190403;1792.4801807475947;1798.8111248319;1804.2318527842788;1822.6172503774092;694.6665600511783;790.4822341366414;853.5604163855619;934.0379409208526;940.1022023967095;16491.505254842374;16932.492025239262;17454.738178927328;17526.912365438347;18135.183916723778;846.5301757524633;848.499385362639;865.1175800683268;872.4198408058696;890.3722875372847;9332.486713230837;9829.852552211723;9948.751281218027;9971.855638319958;9976.152027077635;358731;360517;360729.7854042957;368470;371130;76241.61879190568;77055.99136056138;77076;78630;78693;877.8288233794349;900.9144131307515;917.8898532176181;923.2521657457481;924.611663101499;15065.623359416102;15217.163056032025;15683.686326273639;15752.212389380256;15851.445199417965;29685.257868553457;33645.327093457505;38915.416268756555;38963.610363896;39137.608623913395;47009;51647;52124.739376302874;54055;54500;5948.196993405835;5984.8803023940145;7550.35821955118;7678.040244969379;7722.92277077222;11130.387828669178;11475.8278625819;11749.47127379253;12019.338936358234;12074.335911524951;4831.154547954165;9755.170810481188;9819.214462843098;10116.84824727615;10592.629257975934;9859.556319965763;10197.796044079225;10215.846762298721;10293.228007899288;10418.426986515511;9349.813003740022;9602.471864047544;9723.46520941355;9905.108540231413;10444.843327350247;7110.146782386147;7311.744088956861;7415.962920185365;7518.097828260644;7836.490628109154;8400.705975290835;9191.494467804336;9401.952990235006;9485.66800161991;9553.808923821345 08:59:41 INFO - PROCESS | 3253 | |3;mootools.html;1330.9201447913126;1384.9584512464626;1428.2715814934381;1620.100844031562;1628.096406494396;7049.083619129512;7651.0818701755725;7659.080910290766;7673;7678.385729141669;6281.717322720478;7204.927950720491;7435.5538667679975;7442.47902646815;7511.323980841723;2193.9451513712165;2221.555688862234;2226.3321003698907;2226.599212141814;2227.40973641985;2137.187868609926;2177.553601511694;2179.825613950888;2184.159098746978;2186.114623577446;2151.5481748832763;2165.4586353411646;2167.1548096242477;2174.1738139507042;2227.265002549163;2121.1939463004037;2130.3502431758384;2130.7336582927132;2139.764625891151;2142.9249976250912;2126.8404869634683;2167.295628920607;2169.5552411755552;2172.4460262633083;2173.0221400369896;7562.584057876815;7649.38804895607;7655.578943158124;7664.65509052094;7671.156172820985;4458.420405347317;4571.765623281695;4579.862604121881;4588.26587745959;4590.449146102489;2834.220589337928;2956.7486763625116;2988.1782509809977;2998.250437390652;3003.2041509000132;835.5279267214005;873.9956300218522;904.7104926423547;905.8460061789511;923.0308176414737;10271.69184924446;10309.329893556895;10340.121089707383;10348.58605655773;10352.5341359639;3975.4633124528395;4179.414881916534;4185.079282557833;4291.141771645684;4291.442112525352;8773.341999350074;8776.561171941377;8779.341549383695;8783.604737786814;8792.692255771017;4551.886202844889;4553.977230113828;4559.065391594715;4559.840405585788;4562.771861406916;3546.680798728127;4026.1947610478023;4166.979165104155;4174.5616710244985;4184.727992680466;3553.218291975761;3611.63883611642;3689.7786132832116;3690;3698.0569954661387;1163.139276935079;1221.7312191317897;1223.9816402753966;1228.3919459867245;1237.7462620163026;772.4940164192462;787.6101329841765;795.8448102619933;800.5556915911609;808.0505406147753;5105.310783044316;5136.768845401966;5175.301334319894;5194.740262986836;5280.3663560373;396.2471304521432;414.50880706363057;416.2486711485737;417.3447687131175;421.0673358510913;3625;3634.818259087035;3636.61815509373;3675.081229692577;3693.501377314028;8976.102389760972;9198.540072996324;9231.630734770533;9281.767955801159;9281.90718092824;9184.586693598803;9199.954000229956;9203.401778884485;9206.217471514863;9206.631734730536;7059.71761129549;7120.35916767483;7132.928670713331;7134.964325178445;7154.499185056996;5129.92305115431;5222.477752224747;5226.8954620908125;5238.423773384849;5291.365036195682;8327.750167494985;8431.030431500456;8559.95720021396;8685.956570217108;8686.78283042929;8554.443961142506;8627.22354988054;8709.825803484022;8786.341024423065;8790.38467307308;5660.349059858169;6198.411150940653;6278.874422511615;6311.495080393649;6426.807195783947;7062.858742825218;7286.125664920031;7289.562626242442;7289.562626242442;7307.3058059484265;6354.17395738551;6419.165508483868;6553.311902250195;6602.768903088561;6699.665016749045;6386.744530218739;6463.870722585616;6477.255115661571;6506.837329066811;6527.086207930988;5857.970710146422;6045.848853778691;6047.606905551125;6052.66710330936;6063.211782468427;4532.425653887453;4604.8388306409115;4629.629629629689;4690.530946905419;4736.171170045297;4528.88677783058;4609.216433206296;4619.561141691668;4674.69614475058;4799.784009719641 08:59:41 INFO - PROCESS | 3253 | |4;prototype.html;287.04843443983196;294.54051679380177;300.3302635123674;311.2949170129658;314.60202843403084;4794.976025119874;4838.177509823329;4854.223324268118;4856.902861942759;4890.486498917616;4754.500777418373;4770.091963214716;4822.228443449048;4835.927461088087;4855.397718752812;3625.148090198808;3671.8347674354586;3738.214974855284;3741.2330472253125;3780.2439512097553;3767.284215998965;3769.9057523561855;3770.6802619083237;3772.3775577029755;3781.4327850822324;3746.8126593670345;3748.9062773430746;3750.699944004487;3752.624737526253;3762.454444105603;3567.8751243706474;3615.1201375284836;3720.3489389356755;3740.682042026404;3744.251149770057;3308.470644696837;3309.834508274601;3318.1870441741926;3320.96679033209;3325.93348133036;4630.861074167747;4654.976725116353;4660.906781864378;4669.32294817253;4673.345731597579;4156.38147966782;4255.148970205972;4273.67947403946;4273.764942928137;4283.892902677458;4967.180415231483;4979.676321039121;4990.326305948723;4991.4758950310425;5000.399952005782;3626.878276208421;3627.2201476682376;3628.3853685110134;3630.4191329387436;3631.346357655621;4977.701337919736;5224.660397074178;5227.398849132361;5253;5259.447757985433;3549.9290014199573;3593.8023408712247;3599.4060979938017;3601.603823579404;3606.2967721294094;3628.8185590720886;3636.781793092423;3637.436197389409;3642.763220390666;3662.7069834413714;4190.979045104755;4197.412362269285;4201.831926722958;4205.684573656988;4206.8737937861915;4802.975985120052;5014.21995191709;5026.949730502722;5069.214271787879;5069.771860266297;1279.1238001968682;1291.9935400322938;1292.5799115287382;1292.65744577687;1292.7866901961072;825.9132791056973;836.6318819719304;840.562907288219;843.6751850537587;855.4012191465998;4395.604395604411;4425.778711064499;4454.465464144323;4479.126570318756;4485.058137791035;5106.4382917879;5122.948770512322;5131.2559678846355;5131.717755523482;5140.3317568716575;4322.092360604245;4434.600885920283;4444.799984000728;4460.710053846489;4484.439445069366;2684.637573927534;2702.7972902032425;2728.0997270900557;2734.398432344881;2740.068376751874;4850.199717046718;4852.660313778002;4863.5379638934955;4870.902581948341;4877.463479017305;5123.513266239701;5221.921671174935;5224.399194092652;5242.9737851311265;5246.842594722164;4864.367632207861;4879.682820616648;4882.707037577757;4885.926711099336;4890.828820991248;5082.847514574569;5092.821751238689;5096.796128154832;5115.897682046412;5136.8202112925865;4868.269759536098;5015.824446144367;5021.271915572294;5044.445111037856;5046.697198168122;4847.3698419205275;4868.561829435368;4875.7074575525585;4890.9021819562695;4902.338184345068;3619.167591454033;3619.438986957026;3621.1852333224815;3658;3663.68858647018;4838.685485443435;4997.925446029121;5069.949300506948;5081.4918508148885;5110.310108135354;4924.606031517542;4939.9259011114145;4957.4051113865125;4965.205567109245;4979.950200497949;4943.775301114441;4953.306537084739;4957.553820156203;4967.776450059829;4972.3535940328975;4665.48679645232;4844.8304309349005;4899.534544218293;4906.165951788276;4910.9263361050325;4817.67513933657;4913.729744864067;4961.429435614806;4977.303177555073;5060.01329740697;4956.603471722182;4963.429205641398;4970.080535101018;4975.5522003019905;4985.725785081855 08:59:41 INFO - PROCESS | 3253 | |5;yui.html;656;683.1255992329819;706.9847102109501;727.9162896266928;752.9397648188144;12476.563320283793;12865.163764355322;12909.967202623791;12973.545925892595;13166.078374513776;13555.864441355583;14173.787393189084;14248.857511424883;14918.254087295647;14943.402263909458;760.1220590218293;780.1652232111643;781.2734157233771;781.402227296116;782.3819182845546;612.5528364294046;737.2958824322785;756.7994481462417;767.0871662721344;775.4649291988538;816.8325493273894;818.5907046476761;820.3929092471587;820.429801288105;820.6758330459495;810.7243537197381;815.5677490929817;818.4598165210962;819.6762278899802;820.0446479850966;466.1353189832845;568.8520984544007;583.4253260538367;583.7314835175824;590.6692252338661;12314.81527777084;12342.506299748;12381.442835072443;12416.689582760504;12466.937665311707;12348.444320005532;12401.441935112942;12563.371831408393;13233;13752.243626600533;10647.467626618638;10830.241883068189;10840.295380800302;11088.168387370899;11218.439078046065;3246.2695893423793;3315.7015868571943;3319;3392.542006829071;3473.0449126490166;57704.13443798346;58481.7075914622;60265.6986715068;60631.09053364203;60666.0900086499;9294.209992150743;9451;9452.57463414148;9627.56675949584;9685.273604479693;19176.71234931477;19554.60890782205;19573;19595.216191352185;19596.804031959782;6721.126253587003;6924.619145947021;6967.198772141167;7061.89407158893;7118.466115041392;3495.2485215678753;3625.7824530527723;3643.1256498440184;3655.853765849336;3675.3016926783826;2777.388974425623;2880.4527139843362;2883.783716221292;2884.2500949752794;2889.942201155965;474.18440282713675;481.1507688929043;484.8424262114827;493.314293132546;493.65444189067796;564.2692712936757;571.5998800839429;580.4630716587141;602.457787990803;604.7883240865661;7741.380689544935;7817.296443320129;7847.607619618996;7882.132965373804;8189.7133600323705;527.4382782336799;566.8894565559676;604.5496105401504;604.8246008657441;614.640435345328;3604.4953706481115;3678.2275722098657;3852.9422058669143;3917.8236979335998;3936.2127574485216;102543;105764;106394;106953.46523267489;107526;87032;88269;89963;90551.54724226469;90764.09235907688;79126.20873791189;79412.60293698494;79879;80198.37619485582;80220.59889700514;7423;7579.1284002340435;7596.8480630385975;7775.533467991712;7845.646945887563;34211.4868276981;43337.3499397503;44251.557484424746;45545.31682024706;46478;61422;61683;67873;70620.64689676519;72494.63752681203;8796.340274479311;8857.468551886908;8959.462432253826;9203.263738901005;9355.812883742423;10784.137269018616;11186.993170614684;11983.28100313984;12055.397230138633;12168.634940951786;11927.701807454883;12345.197562158432;12444.502219911103;12848.229106253655;12861.549845755728;11666.88333116658;12130.818037729265;12582.056345774286;13018.414171362501;13068.215907045607;10495.055445009986;10599.258051936291;10645.733856653645;11163.776724465628;11189;9275.582598783207;9743.56153973087;9790.314677972474;10001;10239.9136850201;9459.574319155518;10069.84895226587;10121.797564048826;10129.139023183112;10234.283600147919 08:59:41 INFO - PROCESS | 3253 | __end_tp_report 08:59:41 INFO - PROCESS | 3253 | __start_cc_report 08:59:41 INFO - PROCESS | 3253 | _x_x_mozilla_cycle_collect,1054 08:59:41 INFO - PROCESS | 3253 | __end_cc_report 08:59:41 INFO - PROCESS | 3253 | __startTimestamp1470067181572__endTimestamp 08:59:41 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | ------- Summary: start ------- 08:59:41 INFO - PROCESS | 3253 | Number of tests: 6 08:59:41 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | [#0] dojo.html Cycles:165 Average:4709.35 Median:4837.08 stddev:495.74 (10.2%) stddev-sans-first:469.03 08:59:41 INFO - PROCESS | 3253 | Values: 2607.3 2630.5 2643.8 2653.6 2658.7 4530.3 4648.8 4716.7 4728.8 4731.6 4757.7 4769.2 4817.0 4833.2 4839.9 4331.0 4338.1 4418.0 4477.0 4558.4 4465.7 4507.4 4517.6 4523.2 4541.9 4250.6 4323.9 4334.3 4339.1 4388.1 4330.4 4352.3 4353.2 4413.9 4436.8 4344.3 4374.6 4384.1 4414.8 4419.8 4571.1 4736.6 4795.4 4797.9 4802.1 5022.1 5063.2 5068.7 5068.9 5125.7 5102.1 5127.8 5145.5 5169.6 5181.6 4640.7 4708.7 4812.3 4828.0 4837.1 5204.2 5245.1 5284.1 5292.9 5303.1 5026.1 5077.9 5079.9 5080.7 5081.8 4899.7 5041.4 5161.7 5164.9 5165.8 5019.0 5092.3 5093.2 5129.2 5148.8 5055.5 5068.5 5090.9 5095.1 5121.7 4210.1 4235.2 4369.5 4387.5 4424.8 3697.6 3711.9 3727.7 3757.1 3820.0 4385.6 4396.8 4403.6 4433.9 4442.6 4945.3 5060.4 5065.3 5073.2 5101.5 4360.2 4393.1 4402.8 4410.8 4458.3 4576.9 4607.8 4608.6 4610.7 4661.8 4697.8 4819.5 4829.7 4836.3 4856.1 5047.3 5074.4 5078.7 5086.4 5148.0 4814.5 4839.6 4842.1 4864.2 4866.5 4845.4 4939.7 4950.6 4950.7 5001.9 4989.8 5044.6 5075.5 5086.4 5129.6 4972.0 4978.5 4978.8 4992.2 5044.3 4783.7 4945.0 4958.2 4967.9 5006.0 4818.1 4822.9 4872.7 4911.9 4933.9 4989.5 4991.0 4994.1 5008.4 5015.2 4739.4 4861.3 4875.2 4882.7 4910.3 08:59:41 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | [#1] ext.html Cycles:180 Average:47819.29 Median:36422.14 stddev:86961.84 (238.8%) stddev-sans-first:87133.36 08:59:41 INFO - PROCESS | 3253 | Values: 547.3 560.6 562.8 575.3 575.9 28649.4 39554.8 40677.4 40705.8 44352.7 42406.8 42602.1 42718.0 42830.1 42960.4 7313.4 7442.9 7598.0 7602.3 7602.7 7275.8 7524.5 7525.7 9774.0 10014.0 9901.3 9932.5 9938.9 9995.8 9996.4 10001.9 10042.8 10043.2 10108.9 10125.7 9938.1 9998.4 10021.2 10021.7 10024.0 39688.2 39780.2 39855.2 39908.2 40241.6 3086.5 3143.9 3261.7 3332.8 3483.8 29475.9 29770.6 29857.6 30065.4 31003.2 3101.3 3221.4 3243.4 3273.4 3420.9 249181.0 253365.0 253681.0 253825.0 254224.0 32035.8 54963.2 55497.0 55553.7 55560.0 32247.7 33933.3 33959.5 34089.0 34133.0 13123.9 13301.5 13305.1 13306.2 13316.1 10724.5 10824.0 10879.6 10881.8 10886.3 7311.4 7481.0 7503.5 7628.7 7651.2 3099.9 3114.3 3140.7 3144.4 3146.7 882.6 895.9 896.3 908.2 915.8 28421.0 28563.0 28946.0 29312.3 29377.1 932.6 961.0 977.6 1021.4 1036.5 14974.4 15182.0 15191.0 15218.8 15481.8 379310.0 379719.0 380291.0 382200.0 383215.0 43758.0 49104.5 49745.8 50192.0 50254.0 1173.4 1196.6 1209.2 1210.8 1212.4 28142.6 29063.6 29540.6 30015.2 30185.4 43708.0 43968.1 44019.6 44117.0 44164.3 319008.0 320815.0 351715.0 360688.0 363066.0 38117.4 38507.6 38514.8 38523.1 38838.6 42818.8 43212.8 43268.1 43470.8 43645.0 36586.3 36682.0 36943.0 37565.2 38352.2 36334.3 37190.6 37215.1 37556.8 38050.8 35595.5 36343.6 36500.6 36786.6 36834.3 31644.0 33221.3 33659.7 34013.0 34023.0 25222.9 25781.9 25890.2 26044.7 26136.1 08:59:41 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | [#2] jquery.html Cycles:180 Average:23278.92 Median:28744.14 stddev:60366.44 (210.0%) stddev-sans-first:60511.21 08:59:41 INFO - PROCESS | 3253 | Values: 338.6 350.7 351.5 357.7 374.4 12713.4 16083.8 16465.3 17196.9 17352.1 16361.3 16751.8 17296.6 17441.3 17461.7 4926.3 5022.5 5115.9 5132.2 5135.4 3767.7 5047.5 5066.6 5569.7 5855.8 5872.9 5890.4 5894.4 5894.5 5895.3 5166.3 5404.9 5438.0 5538.7 5918.1 5363.5 5365.0 5374.6 5375.9 5377.3 12293.2 12557.8 12582.5 12692.0 13097.0 1784.7 1839.2 1870.3 1893.6 1993.3 8911.5 9002.9 9141.0 9444.4 9577.8 1681.4 1761.6 1774.1 1795.3 1804.4 67890.7 68698.0 69278.0 71333.3 72039.6 9116.9 9235.5 9246.7 9961.7 10196.2 13925.3 13932.6 13954.1 13959.0 13962.5 6939.3 7037.1 7111.8 7157.7 7160.7 6565.3 6608.7 6762.6 6773.5 6804.7 4319.2 4359.3 4375.8 4388.7 4457.8 1737.6 1792.5 1798.8 1804.2 1822.6 694.7 790.5 853.6 934.0 940.1 16491.5 16932.5 17454.7 17526.9 18135.2 846.5 848.5 865.1 872.4 890.4 9332.5 9829.9 9948.8 9971.9 9976.2 358731.0 360517.0 360729.8 368470.0 371130.0 76241.6 77056.0 77076.0 78630.0 78693.0 877.8 900.9 917.9 923.3 924.6 15065.6 15217.2 15683.7 15752.2 15851.4 29685.3 33645.3 38915.4 38963.6 39137.6 47009.0 51647.0 52124.7 54055.0 54500.0 5948.2 5984.9 7550.4 7678.0 7722.9 11130.4 11475.8 11749.5 12019.3 12074.3 4831.2 9755.2 9819.2 10116.8 10592.6 9859.6 10197.8 10215.8 10293.2 10418.4 9349.8 9602.5 9723.5 9905.1 10444.8 7110.1 7311.7 7416.0 7518.1 7836.5 8400.7 9191.5 9402.0 9485.7 9553.8 08:59:41 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | [#3] mootools.html Cycles:180 Average:4987.75 Median:5117.62 stddev:2754.90 (53.8%) stddev-sans-first:2748.92 08:59:41 INFO - PROCESS | 3253 | Values: 1330.9 1385.0 1428.3 1620.1 1628.1 7049.1 7651.1 7659.1 7673.0 7678.4 6281.7 7204.9 7435.6 7442.5 7511.3 2193.9 2221.6 2226.3 2226.6 2227.4 2137.2 2177.6 2179.8 2184.2 2186.1 2151.5 2165.5 2167.2 2174.2 2227.3 2121.2 2130.4 2130.7 2139.8 2142.9 2126.8 2167.3 2169.6 2172.4 2173.0 7562.6 7649.4 7655.6 7664.7 7671.2 4458.4 4571.8 4579.9 4588.3 4590.4 2834.2 2956.7 2988.2 2998.3 3003.2 835.5 874.0 904.7 905.8 923.0 10271.7 10309.3 10340.1 10348.6 10352.5 3975.5 4179.4 4185.1 4291.1 4291.4 8773.3 8776.6 8779.3 8783.6 8792.7 4551.9 4554.0 4559.1 4559.8 4562.8 3546.7 4026.2 4167.0 4174.6 4184.7 3553.2 3611.6 3689.8 3690.0 3698.1 1163.1 1221.7 1224.0 1228.4 1237.7 772.5 787.6 795.8 800.6 808.1 5105.3 5136.8 5175.3 5194.7 5280.4 396.2 414.5 416.2 417.3 421.1 3625.0 3634.8 3636.6 3675.1 3693.5 8976.1 9198.5 9231.6 9281.8 9281.9 9184.6 9200.0 9203.4 9206.2 9206.6 7059.7 7120.4 7132.9 7135.0 7154.5 5129.9 5222.5 5226.9 5238.4 5291.4 8327.8 8431.0 8560.0 8686.0 8686.8 8554.4 8627.2 8709.8 8786.3 8790.4 5660.3 6198.4 6278.9 6311.5 6426.8 7062.9 7286.1 7289.6 7289.6 7307.3 6354.2 6419.2 6553.3 6602.8 6699.7 6386.7 6463.9 6477.3 6506.8 6527.1 5858.0 6045.8 6047.6 6052.7 6063.2 4532.4 4604.8 4629.6 4690.5 4736.2 4528.9 4609.2 4619.6 4674.7 4799.8 08:59:41 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | [#4] prototype.html Cycles:180 Average:4151.23 Median:4819.95 stddev:1200.17 (24.9%) stddev-sans-first:1167.97 08:59:41 INFO - PROCESS | 3253 | Values: 287.0 294.5 300.3 311.3 314.6 4795.0 4838.2 4854.2 4856.9 4890.5 4754.5 4770.1 4822.2 4835.9 4855.4 3625.1 3671.8 3738.2 3741.2 3780.2 3767.3 3769.9 3770.7 3772.4 3781.4 3746.8 3748.9 3750.7 3752.6 3762.5 3567.9 3615.1 3720.3 3740.7 3744.3 3308.5 3309.8 3318.2 3321.0 3325.9 4630.9 4655.0 4660.9 4669.3 4673.3 4156.4 4255.1 4273.7 4273.8 4283.9 4967.2 4979.7 4990.3 4991.5 5000.4 3626.9 3627.2 3628.4 3630.4 3631.3 4977.7 5224.7 5227.4 5253.0 5259.4 3549.9 3593.8 3599.4 3601.6 3606.3 3628.8 3636.8 3637.4 3642.8 3662.7 4191.0 4197.4 4201.8 4205.7 4206.9 4803.0 5014.2 5026.9 5069.2 5069.8 1279.1 1292.0 1292.6 1292.7 1292.8 825.9 836.6 840.6 843.7 855.4 4395.6 4425.8 4454.5 4479.1 4485.1 5106.4 5122.9 5131.3 5131.7 5140.3 4322.1 4434.6 4444.8 4460.7 4484.4 2684.6 2702.8 2728.1 2734.4 2740.1 4850.2 4852.7 4863.5 4870.9 4877.5 5123.5 5221.9 5224.4 5243.0 5246.8 4864.4 4879.7 4882.7 4885.9 4890.8 5082.8 5092.8 5096.8 5115.9 5136.8 4868.3 5015.8 5021.3 5044.4 5046.7 4847.4 4868.6 4875.7 4890.9 4902.3 3619.2 3619.4 3621.2 3658.0 3663.7 4838.7 4997.9 5069.9 5081.5 5110.3 4924.6 4939.9 4957.4 4965.2 4980.0 4943.8 4953.3 4957.6 4967.8 4972.4 4665.5 4844.8 4899.5 4906.2 4910.9 4817.7 4913.7 4961.4 4977.3 5060.0 4956.6 4963.4 4970.1 4975.6 4985.7 08:59:41 INFO - PROCESS | 3253 | 08:59:41 INFO - PROCESS | 3253 | [#5] yui.html Cycles:180 Average:18192.74 Median:493.48 stddev:26875.64 (5446.1%) stddev-sans-first:26918.78 08:59:41 INFO - PROCESS | 3253 | Values: 656.0 683.1 707.0 727.9 752.9 12476.6 12865.2 12910.0 12973.5 13166.1 13555.9 14173.8 14248.9 14918.3 14943.4 760.1 780.2 781.3 781.4 782.4 612.6 737.3 756.8 767.1 775.5 816.8 818.6 820.4 820.4 820.7 810.7 815.6 818.5 819.7 820.0 466.1 568.9 583.4 583.7 590.7 12314.8 12342.5 12381.4 12416.7 12466.9 12348.4 12401.4 12563.4 13233.0 13752.2 10647.5 10830.2 10840.3 11088.2 11218.4 3246.3 3315.7 3319.0 3392.5 3473.0 57704.1 58481.7 60265.7 60631.1 60666.1 9294.2 9451.0 9452.6 9627.6 9685.3 19176.7 19554.6 19573.0 19595.2 19596.8 6721.1 6924.6 6967.2 7061.9 7118.5 3495.2 3625.8 3643.1 3655.9 3675.3 2777.4 2880.5 2883.8 2884.3 2889.9 474.2 481.2 484.8 493.3 493.7 564.3 571.6 580.5 602.5 604.8 7741.4 7817.3 7847.6 7882.1 8189.7 527.4 566.9 604.5 604.8 614.6 3604.5 3678.2 3852.9 3917.8 3936.2 102543.0 105764.0 106394.0 106953.5 107526.0 87032.0 88269.0 89963.0 90551.5 90764.1 79126.2 79412.6 79879.0 80198.4 80220.6 7423.0 7579.1 7596.8 7775.5 7845.6 34211.5 43337.3 44251.6 45545.3 46478.0 61422.0 61683.0 67873.0 70620.6 72494.6 8796.3 8857.5 8959.5 9203.3 9355.8 10784.1 11187.0 11983.3 12055.4 12168.6 11927.7 12345.2 12444.5 12848.2 12861.5 11666.9 12130.8 12582.1 13018.4 13068.2 10495.1 10599.3 10645.7 11163.8 11189.0 9275.6 9743.6 9790.3 10001.0 10239.9 9459.6 10069.8 10121.8 10129.1 10234.3 08:59:41 INFO - PROCESS | 3253 | -------- Summary: end -------- 08:59:41 INFO - PROCESS | 3253 | 08:59:42 INFO - TEST-INFO | 3253: exit 0 08:59:42 INFO - TEST-OK | dromaeo_css | took 1120682ms 08:59:42 INFO - TEST-START | kraken 08:59:42 INFO - operating with platform_type : linux_ 08:59:42 INFO - Initialising browser for kraken test... 08:59:42 INFO - TEST-INFO | started process 3439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWuacnM/profile http://localhost:37363/getInfo.html) 08:59:46 INFO - PROCESS | 3439 | __metrics Screen width/height:1600/1200 08:59:46 INFO - PROCESS | 3439 | colorDepth:24 08:59:46 INFO - PROCESS | 3439 | Browser inner width/height: 1024/697 08:59:46 INFO - PROCESS | 3439 | __metrics 08:59:47 INFO - PROCESS | 3439 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:59:47 INFO - PROCESS | 3439 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:48 INFO - TEST-INFO | 3439: exit 0 08:59:48 INFO - Browser initialized. 08:59:48 INFO - Running cycle 1/1 for kraken test... 08:59:48 INFO - TEST-INFO | started process 3517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWuacnM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:00 INFO - PROCESS | 3517 | RSS: Main: 157442048 09:00:00 INFO - PROCESS | 3517 | 09:00:03 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37363/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:04 INFO - PROCESS | 3517 | RSS: Main: 213479424 09:00:04 INFO - PROCESS | 3517 | 09:00:07 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37363/tests/kraken/driver.html?testName=audio-dft) 09:00:07 INFO - PROCESS | 3517 | RSS: Main: 192471040 09:00:07 INFO - PROCESS | 3517 | 09:00:11 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37363/tests/kraken/driver.html?testName=audio-fft) 09:00:11 INFO - PROCESS | 3517 | RSS: Main: 273092608 09:00:11 INFO - PROCESS | 3517 | 09:00:14 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37363/tests/kraken/driver.html?testName=audio-oscillator) 09:00:14 INFO - PROCESS | 3517 | RSS: Main: 181141504 09:00:14 INFO - PROCESS | 3517 | 09:00:16 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37363/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:17 INFO - PROCESS | 3517 | RSS: Main: 185167872 09:00:17 INFO - PROCESS | 3517 | 09:00:20 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37363/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:21 INFO - PROCESS | 3517 | RSS: Main: 221597696 09:00:21 INFO - PROCESS | 3517 | 09:00:24 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37363/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:25 INFO - PROCESS | 3517 | RSS: Main: 215453696 09:00:25 INFO - PROCESS | 3517 | 09:00:28 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37363/tests/kraken/driver.html?testName=json-parse-financial) 09:00:28 INFO - PROCESS | 3517 | RSS: Main: 218857472 09:00:28 INFO - PROCESS | 3517 | 09:00:30 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37363/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:31 INFO - PROCESS | 3517 | RSS: Main: 184147968 09:00:31 INFO - PROCESS | 3517 | 09:00:33 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37363/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:33 INFO - PROCESS | 3517 | RSS: Main: 189566976 09:00:33 INFO - PROCESS | 3517 | 09:00:35 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37363/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:36 INFO - PROCESS | 3517 | RSS: Main: 195080192 09:00:36 INFO - PROCESS | 3517 | 09:00:39 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:39 INFO - PROCESS | 3517 | RSS: Main: 189599744 09:00:39 INFO - PROCESS | 3517 | 09:00:42 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:43 INFO - PROCESS | 3517 | RSS: Main: 192090112 09:00:43 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:37363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37363/tests/kraken/driver.html?testName=ai-astar) 09:00:45 INFO - PROCESS | 3517 | RSS: Main: 243023872 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | __start_tp_report 09:00:45 INFO - PROCESS | 3517 | _x_x_mozilla_page_load 09:00:45 INFO - PROCESS | 3517 | _x_x_mozilla_page_load_details 09:00:45 INFO - PROCESS | 3517 | |i|pagename|runs| 09:00:45 INFO - PROCESS | 3517 | |0;ai-astar;105;115;113;115;114;115;113;114;113;112 09:00:45 INFO - PROCESS | 3517 | |1;audio-beat-detection;148;125;124;190;129;129;152;127;173;124 09:00:45 INFO - PROCESS | 3517 | |2;audio-dft;160;161;161;163;159;161;162;163;161;161 09:00:45 INFO - PROCESS | 3517 | |3;audio-fft;75;76;76;130;76;76;76;76;98;76 09:00:45 INFO - PROCESS | 3517 | |4;audio-oscillator;86;85;112;84;85;85;126;84;85;127 09:00:45 INFO - PROCESS | 3517 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;116 09:00:45 INFO - PROCESS | 3517 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;146 09:00:45 INFO - PROCESS | 3517 | |7;imaging-desaturate;95;95;94;95;95;94;94;102;94;94 09:00:45 INFO - PROCESS | 3517 | |8;json-parse-financial;63;62;62;62;62;63;64;63;62;62 09:00:45 INFO - PROCESS | 3517 | |9;json-stringify-tinderbox;65;66;65;65;64;66;66;65;69;65 09:00:45 INFO - PROCESS | 3517 | |10;stanford-crypto-aes;80;80;79;89;82;80;79;83;78;82 09:00:45 INFO - PROCESS | 3517 | |11;stanford-crypto-ccm;133;128;139;128;137;136;137;130;189;128 09:00:45 INFO - PROCESS | 3517 | |12;stanford-crypto-pbkdf2;169;165;169;164;165;163;164;167;167;166 09:00:45 INFO - PROCESS | 3517 | |13;stanford-crypto-sha256-iterative;67;67;68;68;66;68;66;67;69;66 09:00:45 INFO - PROCESS | 3517 | __end_tp_report 09:00:45 INFO - PROCESS | 3517 | __start_cc_report 09:00:45 INFO - PROCESS | 3517 | _x_x_mozilla_cycle_collect,1943 09:00:45 INFO - PROCESS | 3517 | __end_cc_report 09:00:45 INFO - PROCESS | 3517 | __startTimestamp1470067245360__endTimestamp 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | ------- Summary: start ------- 09:00:45 INFO - PROCESS | 3517 | Number of tests: 14 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.96 (2.6%) stddev-sans-first:1.09 09:00:45 INFO - PROCESS | 3517 | Values: 105.0 115.0 113.0 115.0 114.0 115.0 113.0 114.0 113.0 112.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:138.50 stddev:23.34 (16.8%) stddev-sans-first:24.65 09:00:45 INFO - PROCESS | 3517 | Values: 148.0 125.0 124.0 190.0 129.0 129.0 152.0 127.0 173.0 124.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 09:00:45 INFO - PROCESS | 3517 | Values: 160.0 161.0 161.0 163.0 159.0 161.0 162.0 163.0 161.0 161.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:17.76 (23.4%) stddev-sans-first:18.57 09:00:45 INFO - PROCESS | 3517 | Values: 75.0 76.0 76.0 130.0 76.0 76.0 76.0 76.0 98.0 76.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:18.22 (21.4%) stddev-sans-first:18.97 09:00:45 INFO - PROCESS | 3517 | Values: 86.0 85.0 112.0 84.0 85.0 85.0 126.0 84.0 85.0 127.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:00:45 INFO - PROCESS | 3517 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 09:00:45 INFO - PROCESS | 3517 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:2.44 (2.6%) stddev-sans-first:2.59 09:00:45 INFO - PROCESS | 3517 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 94.0 102.0 94.0 94.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 09:00:45 INFO - PROCESS | 3517 | Values: 63.0 62.0 62.0 62.0 62.0 63.0 64.0 63.0 62.0 62.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:1.35 (2.1%) stddev-sans-first:1.41 09:00:45 INFO - PROCESS | 3517 | Values: 65.0 66.0 65.0 65.0 64.0 66.0 66.0 65.0 69.0 65.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:3.16 (3.9%) stddev-sans-first:3.32 09:00:45 INFO - PROCESS | 3517 | Values: 80.0 80.0 79.0 89.0 82.0 80.0 79.0 83.0 78.0 82.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:136.50 stddev:18.24 (13.4%) stddev-sans-first:19.24 09:00:45 INFO - PROCESS | 3517 | Values: 133.0 128.0 139.0 128.0 137.0 136.0 137.0 130.0 189.0 128.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.50 stddev:2.08 (1.2%) stddev-sans-first:1.88 09:00:45 INFO - PROCESS | 3517 | Values: 169.0 165.0 169.0 164.0 165.0 163.0 164.0 167.0 167.0 166.0 09:00:45 INFO - PROCESS | 3517 | 09:00:45 INFO - PROCESS | 3517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:1.09 09:00:45 INFO - PROCESS | 3517 | Values: 67.0 67.0 68.0 68.0 66.0 68.0 66.0 67.0 69.0 66.0 09:00:45 INFO - PROCESS | 3517 | -------- Summary: end -------- 09:00:45 INFO - PROCESS | 3517 | 09:00:46 INFO - TEST-INFO | 3517: exit 0 09:00:46 INFO - TEST-OK | kraken | took 64054ms 09:00:46 INFO - SUITE-END | took 1184s 09:00:46 INFO - Completed test suite (00:19:44) 09:00:46 INFO - javascript benchmark 09:00:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.282997175778, 2630.51335502932, 2643.8149329546927, 2653.6417583626217, 2658.7075421703616, 4530.320451932212, 4648.790804413801, 4716.740579268139, 4728.834490792828, 4731.57415832575, 4757.714537127775, 4769.165396055694, 4817.036592681469, 4833.154198015351, 4839.854804355866, 4331.0, 4338.067315527161, 4418.0, 4476.9552304476865, 4558.407407037081, 4465.68740188187, 4507.4365704286965, 4517.616002639779, 4523.185826551219, 4541.931871021938, 4250.574942505756, 4323.870283891489, 4334.284843000901, 4339.067100573392, 4388.078503514266, 4330.350447432878, 4352.325389564622, 4353.151135528573, 4413.933790993137, 4436.800343984496, 4344.326629372453, 4374.58441448062, 4384.079343337903, 4414.823407063714, 4419.801108950105, 4571.062932098912, 4736.6447516436065, 4795.424549054101, 4797.856064318076, 4802.111609352246, 5022.121128802445, 5063.240513922904, 5068.72122033288, 5068.949310506885, 5125.743712814382, 5102.132637451642, 5127.820526281562, 5145.459726728677, 5169.612279079047, 5181.637285390024, 4640.69835460694, 4708.670393072521, 4812.254100614446, 4828.0, 4837.080954618611, 5204.193350030676, 5245.1345527988215, 5284.101702710548, 5292.92060619091, 5303.0719624066405, 5026.070177017264, 5077.949220507748, 5079.949200508022, 5080.695158290514, 5081.7967281309075, 4899.730514821719, 5041.420236672756, 5161.690298582097, 5164.948350516522, 5165.845024649267, 5019.0, 5092.337996060563, 5093.159628661304, 5129.204973229155, 5148.794048238104, 5055.469175736568, 5068.518490743373, 5090.872728181751, 5095.082885080721, 5121.667091639031, 4210.052738133957, 4235.237657221668, 4369.453818272716, 4387.473503179639, 4424.823007079681, 3697.556293244828, 3711.9443208351895, 3727.6645101940953, 3757.0607348162957, 3820.0449887528116, 4385.649148068147, 4396.802143903532, 4403.647708183337, 4433.866983990485, 4442.622377097983, 4945.258211268267, 5060.367454068241, 5065.290859279704, 5073.16292811682, 5101.464346243665, 4360.236958532244, 4393.0994146199955, 4402.779861006937, 4410.757408342572, 4458.308962110878, 4576.8626941191815, 4607.838725644587, 4608.585227329557, 4610.746408947473, 4661.813527458864, 4697.7651117444675, 4819.469858315582, 4829.66192366531, 4836.250381190921, 4856.125897338513, 5047.29337892688, 5074.3657042869645, 5078.695278283315, 5086.364204474441, 5147.974260128675, 4814.494478079751, 4839.612830973443, 4842.104210721028, 4864.197407427735, 4866.489018653132, 4845.442774081026, 4939.678920870132, 4950.554450099365, 4950.653454258168, 5001.949980500149, 4989.80040798364, 5044.621653376085, 5075.5178258065425, 5086.3896332440345, 5129.58963282929, 4971.950280497149, 4978.5270399312, 4978.800847966041, 4992.15133427311, 5044.344235249394, 4783.736894470838, 4944.950550494593, 4958.231474121517, 4967.925481117713, 5006.023825354021, 4818.132736107535, 4822.8794280143275, 4872.707637541617, 4911.901761964669, 4933.925991110208, 4989.525995030466, 4991.0, 4994.101061808909, 5008.449070602158, 5015.247712842956, 4739.3838800955655, 4861.343718598086, 4875.1712208923855, 4882.658213924991, 4910.337104490848], "value": 4677.39191427186, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3349879895926, 560.6131769079333, 562.7608266486743, 575.3182478762667, 575.933767616724, 28649.427011459757, 39554.80222598887, 40677.38983915236, 40705.796471017675, 44352.673549483756, 42406.787966060205, 42602.14795704084, 42718.0, 42830.14339713204, 42960.35559466611, 7313.378362839138, 7442.851142977151, 7597.974273473065, 7602.277783610548, 7602.73390431335, 7275.781726548212, 7524.510906791041, 7525.66134523945, 9773.951130244339, 10014.048665376778, 9901.257405694601, 9932.453715045669, 9938.900610993906, 9995.750106247366, 9996.400215987063, 10001.949990250003, 10042.799144017152, 10043.196544276478, 10108.898911010943, 10125.746856328577, 9938.105570498617, 9998.350107243006, 10021.24840636948, 10021.749456263578, 10024.047715467019, 39688.20623587541, 39780.20439591221, 39855.20289594192, 39908.20183596341, 40241.59758402437, 3086.5215891536845, 3143.9371212575847, 3261.706446419834, 3332.800031998088, 3483.8083905385192, 29475.852620736758, 29770.576383715932, 29857.552136717968, 30065.398692026254, 31003.22491937697, 3101.3332133591384, 3221.4040402525607, 3243.3999710053718, 3273.3780581689402, 3420.9486857697157, 249181.0, 253365.0, 253681.0, 253825.0, 254224.0, 32035.839820800746, 54963.175552366745, 55497.0, 55553.72223138859, 55560.0, 32247.67752322494, 33933.32133357369, 33959.4906076409, 34089.0, 34133.0, 13123.868761312455, 13301.467941282433, 13305.135166214164, 13306.201627902357, 13316.134451260637, 10724.463776811128, 10824.0, 10879.564817407374, 10881.782364352826, 10886.346819190874, 7311.378532824663, 7481.0, 7503.5497870127965, 7628.69485220596, 7651.234876512304, 3099.8760049597763, 3114.2525793809777, 3140.6702296259023, 3144.402563512925, 3146.6853314668806, 882.6248844241172, 895.8745775591423, 896.3098414221014, 908.2416182487697, 915.7893684452613, 28421.0, 28563.0, 28946.0, 29312.267193319913, 29377.118686439015, 932.6083045121065, 960.9903900960901, 977.6382738386842, 1021.3616489693941, 1036.4972988100765, 14974.401023958919, 15182.0, 15191.0, 15218.758511402359, 15481.845181548266, 379310.0, 379719.0, 380291.0, 382200.0, 383215.0, 43758.0, 49104.508954909994, 49745.75127124414, 50192.0, 50254.0, 1173.3546549397797, 1196.6111013920336, 1209.2079687804678, 1210.8183772434206, 1212.4301578258205, 28142.577861332506, 29063.564046538897, 29540.556891646214, 30015.249618759706, 30185.396292073598, 43708.0, 43968.12063758771, 44019.55980440283, 44117.0, 44164.337534937644, 319008.0, 320815.0, 351715.0, 360688.0, 363066.0, 38117.42823857589, 38507.6149238504, 38514.80742596269, 38523.073846308136, 38838.6116138835, 42818.78590607027, 43212.783936080115, 43268.13463730771, 43470.78264608657, 43645.0, 36586.29200683463, 36682.0, 36943.0, 37565.248695026494, 38352.23295534129, 36334.27331453409, 37190.62809371872, 37215.06962325964, 37556.81221593874, 38050.80974595109, 35595.466068008485, 36343.63656363403, 36500.63499364972, 36786.63213367832, 36834.26331473302, 31644.0, 33221.33557328888, 33659.66340336565, 34013.0, 34023.0, 25222.873885630455, 25781.87109064443, 25890.22329330123, 26044.73955260423, 26136.09677371007], "value": 17210.486770475025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.6461148100235, 350.6651148153512, 351.4920939242795, 357.7263393503969, 374.4252572301518, 12713.36433178342, 16083.83916160838, 16465.34138634453, 17196.914015429935, 17352.132393380343, 16361.263743131558, 16751.83248167518, 17296.56758581033, 17441.30234790607, 17461.7380739289, 4926.261060840867, 5022.472640372763, 5115.9488405116035, 5132.204508301201, 5135.35808023997, 3767.6797472214894, 5047.520485553867, 5066.620003499734, 5569.721513924287, 5855.824325270228, 5872.911906321408, 5890.381509941437, 5894.410558944114, 5894.528437724993, 5895.263092113486, 5166.276721259008, 5404.864878378033, 5438.048341540215, 5538.695371754552, 5918.082697181943, 5363.54409875161, 5365.007473617393, 5374.5700343972385, 5375.865603359908, 5377.274068000809, 12293.200941938745, 12557.811632825424, 12582.496700131984, 12691.984641228679, 13097.0, 1784.7144456886965, 1839.2183322088192, 1870.3453791173117, 1893.5550145715883, 1993.2624928776302, 8911.465312081296, 9002.874640669916, 9141.0, 9444.433333999981, 9577.760555986086, 1681.4031018988205, 1761.6124452620404, 1774.112943528236, 1795.2908601102622, 1804.4496428589275, 67890.66054669744, 68698.0, 69278.0, 71333.2866671337, 72039.63980180118, 9116.908830911738, 9235.492047937429, 9246.676366327281, 9961.701148965543, 10196.184305255561, 13925.303734813218, 13932.58202253934, 13954.09298395601, 13959.0, 13962.511312104027, 6939.340762627542, 7037.085178926809, 7111.826548619523, 7157.6779044943105, 7160.713571457188, 6565.310642382577, 6608.669566521655, 6762.594244345355, 6773.525853190328, 6804.727810887608, 4319.244132276839, 4359.302511598193, 4375.803088861009, 4388.736675799462, 4457.7771111444945, 1737.6003519190403, 1792.4801807475947, 1798.8111248319, 1804.2318527842788, 1822.6172503774092, 694.6665600511783, 790.4822341366414, 853.5604163855619, 934.0379409208526, 940.1022023967095, 16491.505254842374, 16932.492025239262, 17454.738178927328, 17526.912365438347, 18135.183916723778, 846.5301757524633, 848.499385362639, 865.1175800683268, 872.4198408058696, 890.3722875372847, 9332.486713230837, 9829.852552211723, 9948.751281218027, 9971.855638319958, 9976.152027077635, 358731.0, 360517.0, 360729.7854042957, 368470.0, 371130.0, 76241.61879190568, 77055.99136056138, 77076.0, 78630.0, 78693.0, 877.8288233794349, 900.9144131307515, 917.8898532176181, 923.2521657457481, 924.611663101499, 15065.623359416102, 15217.163056032025, 15683.686326273639, 15752.212389380256, 15851.445199417965, 29685.257868553457, 33645.327093457505, 38915.416268756555, 38963.610363896, 39137.608623913395, 47009.0, 51647.0, 52124.739376302874, 54055.0, 54500.0, 5948.196993405835, 5984.8803023940145, 7550.35821955118, 7678.040244969379, 7722.92277077222, 11130.387828669178, 11475.8278625819, 11749.47127379253, 12019.338936358234, 12074.335911524951, 4831.154547954165, 9755.170810481188, 9819.214462843098, 10116.84824727615, 10592.629257975934, 9859.556319965763, 10197.796044079225, 10215.846762298721, 10293.228007899288, 10418.426986515511, 9349.813003740022, 9602.471864047544, 9723.46520941355, 9905.108540231413, 10444.843327350247, 7110.146782386147, 7311.744088956861, 7415.962920185365, 7518.097828260644, 7836.490628109154, 8400.705975290835, 9191.494467804336, 9401.952990235006, 9485.66800161991, 9553.808923821345], "value": 7957.980948029799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.9201447913126, 1384.9584512464626, 1428.2715814934381, 1620.100844031562, 1628.096406494396, 7049.083619129512, 7651.0818701755725, 7659.080910290766, 7673.0, 7678.385729141669, 6281.717322720478, 7204.927950720491, 7435.5538667679975, 7442.47902646815, 7511.323980841723, 2193.9451513712165, 2221.555688862234, 2226.3321003698907, 2226.599212141814, 2227.40973641985, 2137.187868609926, 2177.553601511694, 2179.825613950888, 2184.159098746978, 2186.114623577446, 2151.5481748832763, 2165.4586353411646, 2167.1548096242477, 2174.1738139507042, 2227.265002549163, 2121.1939463004037, 2130.3502431758384, 2130.7336582927132, 2139.764625891151, 2142.9249976250912, 2126.8404869634683, 2167.295628920607, 2169.5552411755552, 2172.4460262633083, 2173.0221400369896, 7562.584057876815, 7649.38804895607, 7655.578943158124, 7664.65509052094, 7671.156172820985, 4458.420405347317, 4571.765623281695, 4579.862604121881, 4588.26587745959, 4590.449146102489, 2834.220589337928, 2956.7486763625116, 2988.1782509809977, 2998.250437390652, 3003.2041509000132, 835.5279267214005, 873.9956300218522, 904.7104926423547, 905.8460061789511, 923.0308176414737, 10271.69184924446, 10309.329893556895, 10340.121089707383, 10348.58605655773, 10352.5341359639, 3975.4633124528395, 4179.414881916534, 4185.079282557833, 4291.141771645684, 4291.442112525352, 8773.341999350074, 8776.561171941377, 8779.341549383695, 8783.604737786814, 8792.692255771017, 4551.886202844889, 4553.977230113828, 4559.065391594715, 4559.840405585788, 4562.771861406916, 3546.680798728127, 4026.1947610478023, 4166.979165104155, 4174.5616710244985, 4184.727992680466, 3553.218291975761, 3611.63883611642, 3689.7786132832116, 3690.0, 3698.0569954661387, 1163.139276935079, 1221.7312191317897, 1223.9816402753966, 1228.3919459867245, 1237.7462620163026, 772.4940164192462, 787.6101329841765, 795.8448102619933, 800.5556915911609, 808.0505406147753, 5105.310783044316, 5136.768845401966, 5175.301334319894, 5194.740262986836, 5280.3663560373, 396.2471304521432, 414.50880706363057, 416.2486711485737, 417.3447687131175, 421.0673358510913, 3625.0, 3634.818259087035, 3636.61815509373, 3675.081229692577, 3693.501377314028, 8976.102389760972, 9198.540072996324, 9231.630734770533, 9281.767955801159, 9281.90718092824, 9184.586693598803, 9199.954000229956, 9203.401778884485, 9206.217471514863, 9206.631734730536, 7059.71761129549, 7120.35916767483, 7132.928670713331, 7134.964325178445, 7154.499185056996, 5129.92305115431, 5222.477752224747, 5226.8954620908125, 5238.423773384849, 5291.365036195682, 8327.750167494985, 8431.030431500456, 8559.95720021396, 8685.956570217108, 8686.78283042929, 8554.443961142506, 8627.22354988054, 8709.825803484022, 8786.341024423065, 8790.38467307308, 5660.349059858169, 6198.411150940653, 6278.874422511615, 6311.495080393649, 6426.807195783947, 7062.858742825218, 7286.125664920031, 7289.562626242442, 7289.562626242442, 7307.3058059484265, 6354.17395738551, 6419.165508483868, 6553.311902250195, 6602.768903088561, 6699.665016749045, 6386.744530218739, 6463.870722585616, 6477.255115661571, 6506.837329066811, 6527.086207930988, 5857.970710146422, 6045.848853778691, 6047.606905551125, 6052.66710330936, 6063.211782468427, 4532.425653887453, 4604.8388306409115, 4629.629629629689, 4690.530946905419, 4736.171170045297, 4528.88677783058, 4609.216433206296, 4619.561141691668, 4674.69614475058, 4799.784009719641], "value": 3978.3657048808927, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.04843443983196, 294.54051679380177, 300.3302635123674, 311.2949170129658, 314.60202843403084, 4794.976025119874, 4838.177509823329, 4854.223324268118, 4856.902861942759, 4890.486498917616, 4754.500777418373, 4770.091963214716, 4822.228443449048, 4835.927461088087, 4855.397718752812, 3625.148090198808, 3671.8347674354586, 3738.214974855284, 3741.2330472253125, 3780.2439512097553, 3767.284215998965, 3769.9057523561855, 3770.6802619083237, 3772.3775577029755, 3781.4327850822324, 3746.8126593670345, 3748.9062773430746, 3750.699944004487, 3752.624737526253, 3762.454444105603, 3567.8751243706474, 3615.1201375284836, 3720.3489389356755, 3740.682042026404, 3744.251149770057, 3308.470644696837, 3309.834508274601, 3318.1870441741926, 3320.96679033209, 3325.93348133036, 4630.861074167747, 4654.976725116353, 4660.906781864378, 4669.32294817253, 4673.345731597579, 4156.38147966782, 4255.148970205972, 4273.67947403946, 4273.764942928137, 4283.892902677458, 4967.180415231483, 4979.676321039121, 4990.326305948723, 4991.4758950310425, 5000.399952005782, 3626.878276208421, 3627.2201476682376, 3628.3853685110134, 3630.4191329387436, 3631.346357655621, 4977.701337919736, 5224.660397074178, 5227.398849132361, 5253.0, 5259.447757985433, 3549.9290014199573, 3593.8023408712247, 3599.4060979938017, 3601.603823579404, 3606.2967721294094, 3628.8185590720886, 3636.781793092423, 3637.436197389409, 3642.763220390666, 3662.7069834413714, 4190.979045104755, 4197.412362269285, 4201.831926722958, 4205.684573656988, 4206.8737937861915, 4802.975985120052, 5014.21995191709, 5026.949730502722, 5069.214271787879, 5069.771860266297, 1279.1238001968682, 1291.9935400322938, 1292.5799115287382, 1292.65744577687, 1292.7866901961072, 825.9132791056973, 836.6318819719304, 840.562907288219, 843.6751850537587, 855.4012191465998, 4395.604395604411, 4425.778711064499, 4454.465464144323, 4479.126570318756, 4485.058137791035, 5106.4382917879, 5122.948770512322, 5131.2559678846355, 5131.717755523482, 5140.3317568716575, 4322.092360604245, 4434.600885920283, 4444.799984000728, 4460.710053846489, 4484.439445069366, 2684.637573927534, 2702.7972902032425, 2728.0997270900557, 2734.398432344881, 2740.068376751874, 4850.199717046718, 4852.660313778002, 4863.5379638934955, 4870.902581948341, 4877.463479017305, 5123.513266239701, 5221.921671174935, 5224.399194092652, 5242.9737851311265, 5246.842594722164, 4864.367632207861, 4879.682820616648, 4882.707037577757, 4885.926711099336, 4890.828820991248, 5082.847514574569, 5092.821751238689, 5096.796128154832, 5115.897682046412, 5136.8202112925865, 4868.269759536098, 5015.824446144367, 5021.271915572294, 5044.445111037856, 5046.697198168122, 4847.3698419205275, 4868.561829435368, 4875.7074575525585, 4890.9021819562695, 4902.338184345068, 3619.167591454033, 3619.438986957026, 3621.1852333224815, 3658.0, 3663.68858647018, 4838.685485443435, 4997.925446029121, 5069.949300506948, 5081.4918508148885, 5110.310108135354, 4924.606031517542, 4939.9259011114145, 4957.4051113865125, 4965.205567109245, 4979.950200497949, 4943.775301114441, 4953.306537084739, 4957.553820156203, 4967.776450059829, 4972.3535940328975, 4665.48679645232, 4844.8304309349005, 4899.534544218293, 4906.165951788276, 4910.9263361050325, 4817.67513933657, 4913.729744864067, 4961.429435614806, 4977.303177555073, 5060.01329740697, 4956.603471722182, 4963.429205641398, 4970.080535101018, 4975.5522003019905, 4985.725785081855], "value": 3770.646144884816, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.0, 683.1255992329819, 706.9847102109501, 727.9162896266928, 752.9397648188144, 12476.563320283793, 12865.163764355322, 12909.967202623791, 12973.545925892595, 13166.078374513776, 13555.864441355583, 14173.787393189084, 14248.857511424883, 14918.254087295647, 14943.402263909458, 760.1220590218293, 780.1652232111643, 781.2734157233771, 781.402227296116, 782.3819182845546, 612.5528364294046, 737.2958824322785, 756.7994481462417, 767.0871662721344, 775.4649291988538, 816.8325493273894, 818.5907046476761, 820.3929092471587, 820.429801288105, 820.6758330459495, 810.7243537197381, 815.5677490929817, 818.4598165210962, 819.6762278899802, 820.0446479850966, 466.1353189832845, 568.8520984544007, 583.4253260538367, 583.7314835175824, 590.6692252338661, 12314.81527777084, 12342.506299748, 12381.442835072443, 12416.689582760504, 12466.937665311707, 12348.444320005532, 12401.441935112942, 12563.371831408393, 13233.0, 13752.243626600533, 10647.467626618638, 10830.241883068189, 10840.295380800302, 11088.168387370899, 11218.439078046065, 3246.2695893423793, 3315.7015868571943, 3319.0, 3392.542006829071, 3473.0449126490166, 57704.13443798346, 58481.7075914622, 60265.6986715068, 60631.09053364203, 60666.0900086499, 9294.209992150743, 9451.0, 9452.57463414148, 9627.56675949584, 9685.273604479693, 19176.71234931477, 19554.60890782205, 19573.0, 19595.216191352185, 19596.804031959782, 6721.126253587003, 6924.619145947021, 6967.198772141167, 7061.89407158893, 7118.466115041392, 3495.2485215678753, 3625.7824530527723, 3643.1256498440184, 3655.853765849336, 3675.3016926783826, 2777.388974425623, 2880.4527139843362, 2883.783716221292, 2884.2500949752794, 2889.942201155965, 474.18440282713675, 481.1507688929043, 484.8424262114827, 493.314293132546, 493.65444189067796, 564.2692712936757, 571.5998800839429, 580.4630716587141, 602.457787990803, 604.7883240865661, 7741.380689544935, 7817.296443320129, 7847.607619618996, 7882.132965373804, 8189.7133600323705, 527.4382782336799, 566.8894565559676, 604.5496105401504, 604.8246008657441, 614.640435345328, 3604.4953706481115, 3678.2275722098657, 3852.9422058669143, 3917.8236979335998, 3936.2127574485216, 102543.0, 105764.0, 106394.0, 106953.46523267489, 107526.0, 87032.0, 88269.0, 89963.0, 90551.54724226469, 90764.09235907688, 79126.20873791189, 79412.60293698494, 79879.0, 80198.37619485582, 80220.59889700514, 7423.0, 7579.1284002340435, 7596.8480630385975, 7775.533467991712, 7845.646945887563, 34211.4868276981, 43337.3499397503, 44251.557484424746, 45545.31682024706, 46478.0, 61422.0, 61683.0, 67873.0, 70620.64689676519, 72494.63752681203, 8796.340274479311, 8857.468551886908, 8959.462432253826, 9203.263738901005, 9355.812883742423, 10784.137269018616, 11186.993170614684, 11983.28100313984, 12055.397230138633, 12168.634940951786, 11927.701807454883, 12345.197562158432, 12444.502219911103, 12848.229106253655, 12861.549845755728, 11666.88333116658, 12130.818037729265, 12582.056345774286, 13018.414171362501, 13068.215907045607, 10495.055445009986, 10599.258051936291, 10645.733856653645, 11163.776724465628, 11189.0, 9275.582598783207, 9743.56153973087, 9790.314677972474, 10001.0, 10239.9136850201, 9459.574319155518, 10069.84895226587, 10121.797564048826, 10129.139023183112, 10234.283600147919], "value": 6500.7604748025, "unit": "score"}], "name": "dromaeo_css", "value": 6299.253660680281, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 113.0, 115.0, 114.0, 115.0, 113.0, 114.0, 113.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 124.0, 190.0, 129.0, 129.0, 152.0, 127.0, 173.0, 124.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 163.0, 159.0, 161.0, 162.0, 163.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 130.0, 76.0, 76.0, 76.0, 76.0, 98.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 112.0, 84.0, 85.0, 85.0, 126.0, 84.0, 85.0, 127.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 102.0, 94.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 64.0, 66.0, 66.0, 65.0, 69.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 89.0, 82.0, 80.0, 79.0, 83.0, 78.0, 82.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 139.0, 128.0, 137.0, 136.0, 137.0, 130.0, 189.0, 128.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 169.0, 164.0, 165.0, 163.0, 164.0, 167.0, 167.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 66.0, 68.0, 66.0, 67.0, 69.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1534.8000000000002, "alertThreshold": 2.0}]} 09:00:46 INFO - Return code: 0 09:00:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:00:46 INFO - # TBPL SUCCESS # 09:00:46 INFO - Running post-action listener: _resource_record_post_action 09:00:46 INFO - [mozharness: 2016-08-01 16:00:46.646036Z] Finished run-tests step (success) 09:00:46 INFO - Running post-run listener: _resource_record_post_run 09:00:46 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522264576; Read time: 156; Write time: 368492 09:00:46 INFO - TinderboxPrint: CPU usage
13.0% 09:00:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 156 09:00:46 INFO - TinderboxPrint: I/O write bytes / time
522,264,576 / 368,492 09:00:46 INFO - TinderboxPrint: CPU idle
8,340.4 (87.0%) 09:00:46 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 09:00:46 INFO - TinderboxPrint: Swap in / out
0 / 0 09:00:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237441024; Read time: 0; Write time: 213336 09:00:46 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284823552; Read time: 156; Write time: 155156 09:00:47 INFO - Running post-run listener: _upload_blobber_files 09:00:47 INFO - Blob upload gear active. 09:00:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:47 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 09:00:47 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:00:47 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:00:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:00:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:00:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:48 INFO - (blobuploader) - INFO - Done attempting. 09:00:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:00:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:49 INFO - (blobuploader) - INFO - Done attempting. 09:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:53 INFO - (blobuploader) - INFO - Done attempting. 09:00:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:53 INFO - Return code: 0 09:00:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42ce4544cde17b6884aafede7c35755e85f166540b5e51ee80e740f1c32b0315cb56ac8fd4f86e0db8e7c42e3e2f286fc88f43ad987bec6ca0df047400092be7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/661914fcdb849ed3e60664bc3a448bf0b27e93417cd73cb93d79cceae9de51ed2dd67760818fd2137aaef0d09998d633ba7fe99a4d25b04e9e6ca1d30e125ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f2026be4a75e41d99136f500e73842440676ee2df13851dd6b21f6ecf1cbf333d89550668bb8f85e12531581f0eb9dd2b5295b64f5a132995d2e51c586f924dc"} 09:00:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:53 INFO - Contents: 09:00:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42ce4544cde17b6884aafede7c35755e85f166540b5e51ee80e740f1c32b0315cb56ac8fd4f86e0db8e7c42e3e2f286fc88f43ad987bec6ca0df047400092be7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/661914fcdb849ed3e60664bc3a448bf0b27e93417cd73cb93d79cceae9de51ed2dd67760818fd2137aaef0d09998d633ba7fe99a4d25b04e9e6ca1d30e125ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f2026be4a75e41d99136f500e73842440676ee2df13851dd6b21f6ecf1cbf333d89550668bb8f85e12531581f0eb9dd2b5295b64f5a132995d2e51c586f924dc"} 09:00:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:53 INFO - Copying logs to upload dir... 09:00:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.987260 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-08-01 09:00:53.085889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 09:00:53.091676) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42ce4544cde17b6884aafede7c35755e85f166540b5e51ee80e740f1c32b0315cb56ac8fd4f86e0db8e7c42e3e2f286fc88f43ad987bec6ca0df047400092be7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/661914fcdb849ed3e60664bc3a448bf0b27e93417cd73cb93d79cceae9de51ed2dd67760818fd2137aaef0d09998d633ba7fe99a4d25b04e9e6ca1d30e125ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f2026be4a75e41d99136f500e73842440676ee2df13851dd6b21f6ecf1cbf333d89550668bb8f85e12531581f0eb9dd2b5295b64f5a132995d2e51c586f924dc"} build_url:https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/ZXeA8p38TwWx2PwOe-OB6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42ce4544cde17b6884aafede7c35755e85f166540b5e51ee80e740f1c32b0315cb56ac8fd4f86e0db8e7c42e3e2f286fc88f43ad987bec6ca0df047400092be7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/661914fcdb849ed3e60664bc3a448bf0b27e93417cd73cb93d79cceae9de51ed2dd67760818fd2137aaef0d09998d633ba7fe99a4d25b04e9e6ca1d30e125ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f2026be4a75e41d99136f500e73842440676ee2df13851dd6b21f6ecf1cbf333d89550668bb8f85e12531581f0eb9dd2b5295b64f5a132995d2e51c586f924dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 09:00:53.117713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 09:00:53.118058) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470065490.122981-1525055326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 09:00:53.201118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 09:00:53.201475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 09:00:53.201786) ========= ========= Total master_lag: 0.21 =========