builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1470037676.73 results: success (0) buildid: 20160731232923 builduid: e9987f9ac3424cb29e05217a39a89a76 revision: 6c5e03c243216f5748c81297a14952e6fe9fc300 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.732449) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.732877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.733152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.752968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.753260) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470036872.600807-431168425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 00:47:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.9M=0s 2016-08-01 00:47:56 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095630 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.864950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.865235) ========= 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=745a4373a2a16df560f216e000000264-1470036872.600807-431168425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015751 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.917563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:56.917883) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6c5e03c243216f5748c81297a14952e6fe9fc300 --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 6c5e03c243216f5748c81297a14952e6fe9fc300 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470036872.600807-431168425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 00:47:56,969 truncating revision to first 12 chars 2016-08-01 00:47:56,969 Setting DEBUG logging. 2016-08-01 00:47:56,969 attempt 1/10 2016-08-01 00:47:56,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6c5e03c24321?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 00:47:57,286 unpacking tar archive at: autoland-6c5e03c24321/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664390 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:57.598632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:57.598951) ========= script_repo_revision: 6c5e03c243216f5748c81297a14952e6fe9fc300 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:57.599460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:57.599791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 00:47:57.610743) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-01 00:47:57.611083) ========= /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=745a4373a2a16df560f216e000000264-1470036872.600807-431168425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:47:57 INFO - MultiFileLogger online at 20160801 00:47:57 in /builds/slave/test 00:47:57 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 00:47:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:47:57 INFO - {'append_to_log': False, 00:47:57 INFO - 'base_work_dir': '/builds/slave/test', 00:47:57 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 00:47:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:47:57 INFO - 'branch': 'Autoland-Non-PGO', 00:47:57 INFO - 'buildbot_json_path': 'buildprops.json', 00:47:57 INFO - 'config_files': ('talos/linux_config.py',), 00:47:57 INFO - 'default_actions': ('clobber', 00:47:57 INFO - 'read-buildbot-config', 00:47:57 INFO - 'download-and-extract', 00:47:57 INFO - 'populate-webroot', 00:47:57 INFO - 'create-virtualenv', 00:47:57 INFO - 'install', 00:47:57 INFO - 'run-tests'), 00:47:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:47:57 INFO - 'download_minidump_stackwalk': True, 00:47:57 INFO - 'download_symbols': 'ondemand', 00:47:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:47:57 INFO - 'tooltool.py': '/tools/tooltool.py', 00:47:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:47:57 INFO - '/tools/misc-python/virtualenv.py')}, 00:47:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:47:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:47:57 INFO - 'installer_path': 'installer.exe', 00:47:57 INFO - 'log_level': 'info', 00:47:57 INFO - 'log_name': 'talos', 00:47:57 INFO - 'log_to_console': True, 00:47:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:47:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:47:57 INFO - 'opt_config_files': (), 00:47:57 INFO - 'pip_index': False, 00:47:57 INFO - 'sps_profile': False, 00:47:57 INFO - 'sps_profile_interval': 0, 00:47:57 INFO - 'suite': 'dromaeojs', 00:47:57 INFO - 'system_bits': '32', 00:47:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:47:57 INFO - 'title': 'talos-linux64-ix-032', 00:47:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:47:57 INFO - 'use_talos_json': True, 00:47:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:47:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:47:57 INFO - 'work_dir': 'build'} 00:47:57 INFO - [mozharness: 2016-08-01 07:47:57.746616Z] Running clobber step. 00:47:57 INFO - Running pre-action listener: _resource_record_pre_action 00:47:57 INFO - Running main action method: clobber 00:47:57 INFO - rmtree: /builds/slave/test/build 00:47:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:47:58 INFO - Running post-action listener: _resource_record_post_action 00:47:58 INFO - [mozharness: 2016-08-01 07:47:58.688445Z] Finished clobber step (success) 00:47:58 INFO - [mozharness: 2016-08-01 07:47:58.688545Z] Running read-buildbot-config step. 00:47:58 INFO - Running pre-action listener: _resource_record_pre_action 00:47:58 INFO - Running main action method: read_buildbot_config 00:47:58 INFO - Using buildbot properties: 00:47:58 INFO - { 00:47:58 INFO - "project": "", 00:47:58 INFO - "product": "firefox", 00:47:58 INFO - "script_repo_revision": "production", 00:47:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 00:47:58 INFO - "repository": "", 00:47:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 00:47:58 INFO - "buildid": "20160731232923", 00:47:58 INFO - "pgo_build": "False", 00:47:58 INFO - "basedir": "/builds/slave/test", 00:47:58 INFO - "buildnumber": 195, 00:47:58 INFO - "slavename": "talos-linux64-ix-032", 00:47:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:47:58 INFO - "platform": "ubuntu64_hw", 00:47:58 INFO - "scheduler": "tests-autoland-linux64-talos", 00:47:58 INFO - "branch": "autoland", 00:47:58 INFO - "repo_path": "integration/autoland", 00:47:58 INFO - "revision": "6c5e03c243216f5748c81297a14952e6fe9fc300", 00:47:58 INFO - "stage_platform": "linux64", 00:47:58 INFO - "builduid": "e9987f9ac3424cb29e05217a39a89a76", 00:47:58 INFO - "slavebuilddir": "test" 00:47:58 INFO - } 00:47:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:47:58 INFO - Running post-action listener: _resource_record_post_action 00:47:58 INFO - [mozharness: 2016-08-01 07:47:58.690960Z] Finished read-buildbot-config step (success) 00:47:58 INFO - [mozharness: 2016-08-01 07:47:58.691049Z] Running download-and-extract step. 00:47:58 INFO - Running pre-action listener: _resource_record_pre_action 00:47:58 INFO - Running main action method: download_and_extract 00:47:58 INFO - mkdir: /builds/slave/test/build/tests 00:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:58 INFO - https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:47:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:47:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:47:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:47:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:01 INFO - Downloaded 1361 bytes. 00:48:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:48:01 INFO - Using the following test package requirements: 00:48:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:48:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:48:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:01 INFO - u'jsshell-linux-x86_64.zip'], 00:48:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:48:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:48:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:48:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:48:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:48:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:48: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')]} 00:48:01 INFO - https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:48:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:48:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:02 INFO - Downloaded 20237696 bytes. 00:48:02 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'] 00:48:02 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 00:48:03 INFO - Return code: 0 00:48:03 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 00:48: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')]} 00:48:03 INFO - https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:12 INFO - Downloaded 20237696 bytes. 00:48:12 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'] 00:48:12 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 00:48:13 INFO - Return code: 0 00:48:13 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')]} 00:48:13 INFO - https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:14 INFO - Downloaded 14413723 bytes. 00:48:14 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'] 00:48:14 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 00:48:14 INFO - Return code: 0 00:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:14 INFO - https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:48:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:48:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:48:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a99FpB0lTz6t7MBuDr3jIg/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 00:48:15 INFO - Downloaded 55657597 bytes. 00:48:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:48:15 INFO - mkdir: /builds/slave/test/properties 00:48:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:48:15 INFO - Writing to file /builds/slave/test/properties/build_url 00:48:15 INFO - Contents: 00:48:15 INFO - build_url:https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:48:16 INFO - Running post-action listener: _resource_record_post_action 00:48:16 INFO - Running post-action listener: set_extra_try_arguments 00:48:16 INFO - [mozharness: 2016-08-01 07:48:16.366220Z] Finished download-and-extract step (success) 00:48:16 INFO - [mozharness: 2016-08-01 07:48:16.366451Z] Running populate-webroot step. 00:48:16 INFO - Running pre-action listener: _resource_record_pre_action 00:48:16 INFO - Running main action method: populate_webroot 00:48:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:48:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:48:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:48:16 INFO - '--tppagecycles', 00:48:16 INFO - '7'], 00:48:16 INFO - 'tests': ['tsvgm']}}, 00:48:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:48:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:48:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:48:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:48:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:16 INFO - 'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:16 INFO - 'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['damp', 'tps']}, 00:48:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:16 INFO - 'tests': ['damp', 'tps']}, 00:48:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['dromaeo_dom']}, 00:48:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:48:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['basic_compositor_video']}, 00:48:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:48:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['a11yr', 00:48:16 INFO - 'ts_paint', 00:48:16 INFO - 'tpaint', 00:48:16 INFO - 'sessionrestore', 00:48:16 INFO - 'sessionrestore_no_auto_restore', 00:48:16 INFO - 'tabpaint']}, 00:48:16 INFO - 'other-e10s': {'tests': ['a11yr', 00:48:16 INFO - 'ts_paint', 00:48:16 INFO - 'tpaint', 00:48:16 INFO - 'sessionrestore', 00:48:16 INFO - 'sessionrestore_no_auto_restore', 00:48:16 INFO - 'tabpaint']}, 00:48:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:48:16 INFO - 'ts_paint', 00:48:16 INFO - 'tpaint', 00:48:16 INFO - 'sessionrestore', 00:48:16 INFO - 'sessionrestore_no_auto_restore', 00:48:16 INFO - 'tabpaint']}, 00:48:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:48:16 INFO - 'ts_paint', 00:48:16 INFO - 'tpaint', 00:48:16 INFO - 'sessionrestore', 00:48:16 INFO - 'sessionrestore_no_auto_restore', 00:48:16 INFO - 'tabpaint']}, 00:48:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['a11yr', 00:48:16 INFO - 'ts_paint', 00:48:16 INFO - 'tpaint', 00:48:16 INFO - 'sessionrestore', 00:48:16 INFO - 'sessionrestore_no_auto_restore', 00:48:16 INFO - 'tabpaint']}, 00:48:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['a11yr', 00:48:16 INFO - 'ts_paint', 00:48:16 INFO - 'tpaint', 00:48:16 INFO - 'sessionrestore', 00:48:16 INFO - 'sessionrestore_no_auto_restore', 00:48:16 INFO - 'tabpaint']}, 00:48:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['tsvgx', 00:48:16 INFO - 'tsvgr_opacity', 00:48:16 INFO - 'tart', 00:48:16 INFO - 'tscrollx', 00:48:16 INFO - 'cart']}, 00:48:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:48:16 INFO - 'tsvgr_opacity', 00:48:16 INFO - 'tart', 00:48:16 INFO - 'tscrollx', 00:48:16 INFO - 'cart']}, 00:48:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:16 INFO - 'talos_options': ['--disable-e10s'], 00:48:16 INFO - 'tests': ['tp5o']}, 00:48:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:16 INFO - 'tests': ['tp5o']}, 00:48:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:16 INFO - 'talos_options': ['--disable-e10s', 00:48:16 INFO - '--xperf_path', 00:48:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:16 INFO - 'tests': ['tp5n']}, 00:48:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:16 INFO - 'talos_options': ['--xperf_path', 00:48:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:16 INFO - 'tests': ['tp5n']}}, 00:48:16 INFO - 'talos.zip': {'path': '', 00:48:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:48:16 INFO - Running post-action listener: _resource_record_post_action 00:48:16 INFO - [mozharness: 2016-08-01 07:48:16.381534Z] Finished populate-webroot step (success) 00:48:16 INFO - [mozharness: 2016-08-01 07:48:16.381623Z] Running create-virtualenv step. 00:48:16 INFO - Running pre-action listener: _resource_record_pre_action 00:48:16 INFO - Running main action method: create_virtualenv 00:48:16 INFO - Creating virtualenv /builds/slave/test/build/venv 00:48:16 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 00:48:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:48:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:48:16 INFO - Using real prefix '/usr' 00:48:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:48:17 INFO - Installing distribute.............................................................................................................................................................................................done. 00:48:19 INFO - Installing pip.................done. 00:48:19 INFO - Return code: 0 00:48:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:48: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')]} 00:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:48:19 INFO - Using env: {'DISPLAY': ':0', 00:48:19 INFO - 'HOME': '/home/cltbld', 00:48:19 INFO - 'LANG': 'en_US.UTF-8', 00:48:19 INFO - 'LANGUAGE': 'en_US:en', 00:48:19 INFO - 'LOGNAME': 'cltbld', 00:48:19 INFO - 'MAIL': '/var/mail/cltbld', 00:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:19 INFO - 'MOZ_NO_REMOTE': '1', 00:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:19 INFO - 'NO_EM_RESTART': '1', 00:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:19 INFO - 'PWD': '/builds/slave/test', 00:48:19 INFO - 'SHELL': '/bin/bash', 00:48:19 INFO - 'SHLVL': '1', 00:48:19 INFO - 'TERM': 'linux', 00:48:19 INFO - 'TMOUT': '86400', 00:48:19 INFO - 'USER': 'cltbld', 00:48:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:19 INFO - '_': '/tools/buildbot/bin/python'} 00:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:19 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 00:48:19 INFO - Cleaning up... 00:48:19 INFO - Return code: 0 00:48:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:48: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')]} 00:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:48:19 INFO - Using env: {'DISPLAY': ':0', 00:48:19 INFO - 'HOME': '/home/cltbld', 00:48:19 INFO - 'LANG': 'en_US.UTF-8', 00:48:19 INFO - 'LANGUAGE': 'en_US:en', 00:48:19 INFO - 'LOGNAME': 'cltbld', 00:48:19 INFO - 'MAIL': '/var/mail/cltbld', 00:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:19 INFO - 'MOZ_NO_REMOTE': '1', 00:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:19 INFO - 'NO_EM_RESTART': '1', 00:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:19 INFO - 'PWD': '/builds/slave/test', 00:48:19 INFO - 'SHELL': '/bin/bash', 00:48:19 INFO - 'SHLVL': '1', 00:48:19 INFO - 'TERM': 'linux', 00:48:19 INFO - 'TMOUT': '86400', 00:48:19 INFO - 'USER': 'cltbld', 00:48:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:19 INFO - '_': '/tools/buildbot/bin/python'} 00:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:19 INFO - Downloading/unpacking psutil>=3.1.1 00:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:48:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:21 INFO - Installing collected packages: psutil 00:48:21 INFO - Running setup.py install for psutil 00:48:21 INFO - building 'psutil._psutil_linux' extension 00:48:21 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 00:48:21 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 00:48:21 INFO - building 'psutil._psutil_posix' extension 00:48:21 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 00:48:22 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 00:48:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:22 INFO - Successfully installed psutil 00:48:22 INFO - Cleaning up... 00:48:22 INFO - Return code: 0 00:48:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:22 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 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:22 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 00:48:22 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 00:48:22 INFO - Using env: {'DISPLAY': ':0', 00:48:22 INFO - 'HOME': '/home/cltbld', 00:48:22 INFO - 'LANG': 'en_US.UTF-8', 00:48:22 INFO - 'LANGUAGE': 'en_US:en', 00:48:22 INFO - 'LOGNAME': 'cltbld', 00:48:22 INFO - 'MAIL': '/var/mail/cltbld', 00:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:22 INFO - 'MOZ_NO_REMOTE': '1', 00:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:22 INFO - 'NO_EM_RESTART': '1', 00:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:22 INFO - 'PWD': '/builds/slave/test', 00:48:22 INFO - 'SHELL': '/bin/bash', 00:48:22 INFO - 'SHLVL': '1', 00:48:22 INFO - 'TERM': 'linux', 00:48:22 INFO - 'TMOUT': '86400', 00:48:22 INFO - 'USER': 'cltbld', 00:48:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:22 INFO - '_': '/tools/buildbot/bin/python'} 00:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:48:22 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 00:48:22 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 00:48:22 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 00:48:22 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 00:48:22 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 00:48:22 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 00:48:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:48:24 INFO - Installing collected packages: mozsystemmonitor 00:48:24 INFO - Running setup.py install for mozsystemmonitor 00:48:24 INFO - Successfully installed mozsystemmonitor 00:48:24 INFO - Cleaning up... 00:48:24 INFO - Return code: 0 00:48:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:48:24 INFO - Using env: {'DISPLAY': ':0', 00:48:24 INFO - 'HOME': '/home/cltbld', 00:48:24 INFO - 'LANG': 'en_US.UTF-8', 00:48:24 INFO - 'LANGUAGE': 'en_US:en', 00:48:24 INFO - 'LOGNAME': 'cltbld', 00:48:24 INFO - 'MAIL': '/var/mail/cltbld', 00:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:24 INFO - 'MOZ_NO_REMOTE': '1', 00:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:24 INFO - 'NO_EM_RESTART': '1', 00:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:24 INFO - 'PWD': '/builds/slave/test', 00:48:24 INFO - 'SHELL': '/bin/bash', 00:48:24 INFO - 'SHLVL': '1', 00:48:24 INFO - 'TERM': 'linux', 00:48:24 INFO - 'TMOUT': '86400', 00:48:24 INFO - 'USER': 'cltbld', 00:48:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:24 INFO - '_': '/tools/buildbot/bin/python'} 00:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:24 INFO - Downloading/unpacking jsonschema==2.5.1 00:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:48:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:26 INFO - Downloading functools32-3.2.3-2.tar.gz 00:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:48:26 INFO - warning: no files found matching '*.txt' 00:48:26 INFO - no previously-included directories found matching 'build' 00:48:26 INFO - no previously-included directories found matching 'dist' 00:48:26 INFO - no previously-included directories found matching '.git*' 00:48:26 INFO - Installing collected packages: jsonschema, functools32 00:48:26 INFO - Running setup.py install for functools32 00:48:26 INFO - warning: no files found matching '*.txt' 00:48:26 INFO - no previously-included directories found matching 'build' 00:48:26 INFO - no previously-included directories found matching 'dist' 00:48:26 INFO - no previously-included directories found matching '.git*' 00:48:26 INFO - Successfully installed jsonschema functools32 00:48:26 INFO - Cleaning up... 00:48:27 INFO - Return code: 0 00:48:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:27 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 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:27 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 00:48:27 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 00:48:27 INFO - Using env: {'DISPLAY': ':0', 00:48:27 INFO - 'HOME': '/home/cltbld', 00:48:27 INFO - 'LANG': 'en_US.UTF-8', 00:48:27 INFO - 'LANGUAGE': 'en_US:en', 00:48:27 INFO - 'LOGNAME': 'cltbld', 00:48:27 INFO - 'MAIL': '/var/mail/cltbld', 00:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:27 INFO - 'MOZ_NO_REMOTE': '1', 00:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:27 INFO - 'NO_EM_RESTART': '1', 00:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:27 INFO - 'PWD': '/builds/slave/test', 00:48:27 INFO - 'SHELL': '/bin/bash', 00:48:27 INFO - 'SHLVL': '1', 00:48:27 INFO - 'TERM': 'linux', 00:48:27 INFO - 'TMOUT': '86400', 00:48:27 INFO - 'USER': 'cltbld', 00:48:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:27 INFO - '_': '/tools/buildbot/bin/python'} 00:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:48:27 INFO - Cleaning up... 00:48:27 INFO - Return code: 0 00:48:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:27 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 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:27 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 00:48:27 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 00:48:27 INFO - Using env: {'DISPLAY': ':0', 00:48:27 INFO - 'HOME': '/home/cltbld', 00:48:27 INFO - 'LANG': 'en_US.UTF-8', 00:48:27 INFO - 'LANGUAGE': 'en_US:en', 00:48:27 INFO - 'LOGNAME': 'cltbld', 00:48:27 INFO - 'MAIL': '/var/mail/cltbld', 00:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:27 INFO - 'MOZ_NO_REMOTE': '1', 00:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:27 INFO - 'NO_EM_RESTART': '1', 00:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:27 INFO - 'PWD': '/builds/slave/test', 00:48:27 INFO - 'SHELL': '/bin/bash', 00:48:27 INFO - 'SHLVL': '1', 00:48:27 INFO - 'TERM': 'linux', 00:48:27 INFO - 'TMOUT': '86400', 00:48:27 INFO - 'USER': 'cltbld', 00:48:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:27 INFO - '_': '/tools/buildbot/bin/python'} 00:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:27 INFO - Downloading/unpacking blobuploader==1.2.4 00:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:29 INFO - Downloading blobuploader-1.2.4.tar.gz 00:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:48:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:48:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:30 INFO - Downloading docopt-0.6.1.tar.gz 00:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:48:30 INFO - Installing collected packages: blobuploader, requests, docopt 00:48:30 INFO - Running setup.py install for blobuploader 00:48:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:48:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:48:30 INFO - Running setup.py install for requests 00:48:30 INFO - Running setup.py install for docopt 00:48:30 INFO - Successfully installed blobuploader requests docopt 00:48:30 INFO - Cleaning up... 00:48:30 INFO - Return code: 0 00:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:30 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 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:30 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 00:48:30 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 00:48:30 INFO - Using env: {'DISPLAY': ':0', 00:48:30 INFO - 'HOME': '/home/cltbld', 00:48:30 INFO - 'LANG': 'en_US.UTF-8', 00:48:30 INFO - 'LANGUAGE': 'en_US:en', 00:48:30 INFO - 'LOGNAME': 'cltbld', 00:48:30 INFO - 'MAIL': '/var/mail/cltbld', 00:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:30 INFO - 'MOZ_NO_REMOTE': '1', 00:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:30 INFO - 'NO_EM_RESTART': '1', 00:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:30 INFO - 'PWD': '/builds/slave/test', 00:48:30 INFO - 'SHELL': '/bin/bash', 00:48:30 INFO - 'SHLVL': '1', 00:48:30 INFO - 'TERM': 'linux', 00:48:30 INFO - 'TMOUT': '86400', 00:48:30 INFO - 'USER': 'cltbld', 00:48:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:30 INFO - '_': '/tools/buildbot/bin/python'} 00:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:48:30 INFO - Running setup.py (path:/tmp/pip-s6l_Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:48:31 INFO - Running setup.py (path:/tmp/pip-FyvcJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:48:31 INFO - Running setup.py (path:/tmp/pip-0fdv65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:48:31 INFO - Running setup.py (path:/tmp/pip-H16FTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:48:31 INFO - Running setup.py (path:/tmp/pip-H11W_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:48:31 INFO - Running setup.py (path:/tmp/pip-x0KF6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:48:31 INFO - Running setup.py (path:/tmp/pip-e1ELPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:48:31 INFO - Running setup.py (path:/tmp/pip-H8SFNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:48:31 INFO - Running setup.py (path:/tmp/pip-BTWdQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:48:31 INFO - Running setup.py (path:/tmp/pip-mtSKn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:48:31 INFO - Running setup.py (path:/tmp/pip-DJVvaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:48:31 INFO - Running setup.py (path:/tmp/pip-Wgy24Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:48:31 INFO - Running setup.py (path:/tmp/pip-wE8Xgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:48:31 INFO - Running setup.py (path:/tmp/pip-Ye67_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:31 INFO - Running setup.py (path:/tmp/pip-7mzJmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:48:32 INFO - Running setup.py (path:/tmp/pip-LbbdbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:48:32 INFO - Running setup.py (path:/tmp/pip-hKKDup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:48:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:48:32 INFO - Running setup.py install for manifestparser 00:48:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Running setup.py install for mozcrash 00:48:32 INFO - Running setup.py install for mozdebug 00:48:32 INFO - Running setup.py install for mozdevice 00:48:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Running setup.py install for mozfile 00:48:32 INFO - Running setup.py install for mozhttpd 00:48:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Running setup.py install for mozinfo 00:48:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Running setup.py install for mozInstall 00:48:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:48:32 INFO - Running setup.py install for mozleak 00:48:33 INFO - Running setup.py install for mozlog 00:48:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:48:33 INFO - Running setup.py install for moznetwork 00:48:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:48:33 INFO - Running setup.py install for mozprocess 00:48:33 INFO - Running setup.py install for mozprofile 00:48:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:48:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:48:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:48:33 INFO - Running setup.py install for mozrunner 00:48:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:48:33 INFO - Running setup.py install for mozscreenshot 00:48:33 INFO - Running setup.py install for moztest 00:48:33 INFO - Running setup.py install for mozversion 00:48:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:48:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:48:33 INFO - Cleaning up... 00:48:33 INFO - Return code: 0 00:48:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48: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')]} 00:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:33 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 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:33 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 00:48:33 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 00:48:33 INFO - Using env: {'DISPLAY': ':0', 00:48:33 INFO - 'HOME': '/home/cltbld', 00:48:33 INFO - 'LANG': 'en_US.UTF-8', 00:48:33 INFO - 'LANGUAGE': 'en_US:en', 00:48:33 INFO - 'LOGNAME': 'cltbld', 00:48:33 INFO - 'MAIL': '/var/mail/cltbld', 00:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:33 INFO - 'MOZ_NO_REMOTE': '1', 00:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:33 INFO - 'NO_EM_RESTART': '1', 00:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:33 INFO - 'PWD': '/builds/slave/test', 00:48:33 INFO - 'SHELL': '/bin/bash', 00:48:33 INFO - 'SHLVL': '1', 00:48:33 INFO - 'TERM': 'linux', 00:48:33 INFO - 'TMOUT': '86400', 00:48:33 INFO - 'USER': 'cltbld', 00:48:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:33 INFO - '_': '/tools/buildbot/bin/python'} 00:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:48:34 INFO - Running setup.py (path:/tmp/pip-6RJWqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:48:34 INFO - Running setup.py (path:/tmp/pip-H9XycZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:48:34 INFO - Running setup.py (path:/tmp/pip-7LLSG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:48:34 INFO - Running setup.py (path:/tmp/pip-fzWSVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:48:34 INFO - Running setup.py (path:/tmp/pip-NLueKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:48:34 INFO - Running setup.py (path:/tmp/pip-6GcpXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:48:34 INFO - Running setup.py (path:/tmp/pip-3QJbrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:48:34 INFO - Running setup.py (path:/tmp/pip-zu8FKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:48:34 INFO - Running setup.py (path:/tmp/pip-GvuELI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:48:34 INFO - Running setup.py (path:/tmp/pip-KTk7Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:48:34 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)) 00:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:48:34 INFO - Running setup.py (path:/tmp/pip-ZwTQ8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:48:35 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)) 00:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:48:35 INFO - Running setup.py (path:/tmp/pip-QhRpPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:48:35 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)) 00:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:48:35 INFO - Running setup.py (path:/tmp/pip-KkBLLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:48:35 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)) 00:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:48:35 INFO - Running setup.py (path:/tmp/pip-1VKCWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:48:35 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)) 00:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:35 INFO - Running setup.py (path:/tmp/pip-YtS6T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:35 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)) 00:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:48:35 INFO - Running setup.py (path:/tmp/pip-zwQDGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:48:35 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)) 00:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:48:35 INFO - Running setup.py (path:/tmp/pip-7iknNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:48:35 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)) 00:48:35 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)) 00:48:35 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)) 00:48:35 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)) 00:48:35 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)) 00:48:35 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)) 00:48:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:48:35 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 00:48:35 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 00:48:35 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 00:48:35 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 00:48:35 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 00:48:35 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 00:48:37 INFO - Downloading blessings-1.6.tar.gz 00:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:48:37 INFO - Installing collected packages: blessings 00:48:37 INFO - Running setup.py install for blessings 00:48:37 INFO - Successfully installed blessings 00:48:37 INFO - Cleaning up... 00:48:37 INFO - Return code: 0 00:48:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:48:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:48:37 INFO - Reading from file tmpfile_stdout 00:48:37 INFO - Current package versions: 00:48:37 INFO - argparse == 1.2.1 00:48:37 INFO - blessings == 1.6 00:48:37 INFO - blobuploader == 1.2.4 00:48:37 INFO - docopt == 0.6.1 00:48:37 INFO - functools32 == 3.2.3-2 00:48:37 INFO - jsonschema == 2.5.1 00:48:37 INFO - manifestparser == 1.1 00:48:37 INFO - mozInstall == 1.12 00:48:37 INFO - mozcrash == 0.17 00:48:37 INFO - mozdebug == 0.1 00:48:37 INFO - mozdevice == 0.48 00:48:37 INFO - mozfile == 1.2 00:48:37 INFO - mozhttpd == 0.7 00:48:37 INFO - mozinfo == 0.9 00:48:37 INFO - mozleak == 0.1 00:48:37 INFO - mozlog == 3.3 00:48:37 INFO - moznetwork == 0.27 00:48:37 INFO - mozprocess == 0.23 00:48:37 INFO - mozprofile == 0.28 00:48:37 INFO - mozrunner == 6.12 00:48:37 INFO - mozscreenshot == 0.1 00:48:37 INFO - mozsystemmonitor == 0.3 00:48:37 INFO - moztest == 0.7 00:48:37 INFO - mozversion == 1.4 00:48:37 INFO - psutil == 3.1.1 00:48:37 INFO - requests == 1.2.3 00:48:37 INFO - wsgiref == 0.1.2 00:48:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:37 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 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:37 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 00:48:37 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 00:48:37 INFO - Using env: {'DISPLAY': ':0', 00:48:37 INFO - 'HOME': '/home/cltbld', 00:48:37 INFO - 'LANG': 'en_US.UTF-8', 00:48:37 INFO - 'LANGUAGE': 'en_US:en', 00:48:37 INFO - 'LOGNAME': 'cltbld', 00:48:37 INFO - 'MAIL': '/var/mail/cltbld', 00:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:37 INFO - 'MOZ_NO_REMOTE': '1', 00:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:37 INFO - 'NO_EM_RESTART': '1', 00:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:37 INFO - 'PWD': '/builds/slave/test', 00:48:37 INFO - 'SHELL': '/bin/bash', 00:48:37 INFO - 'SHLVL': '1', 00:48:37 INFO - 'TERM': 'linux', 00:48:37 INFO - 'TMOUT': '86400', 00:48:37 INFO - 'USER': 'cltbld', 00:48:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:37 INFO - '_': '/tools/buildbot/bin/python'} 00:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 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)) 00:48:38 INFO - Cleaning up... 00:48:38 INFO - Return code: 0 00:48:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1815180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', '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 00:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:48:38 INFO - Using env: {'DISPLAY': ':0', 00:48:38 INFO - 'HOME': '/home/cltbld', 00:48:38 INFO - 'LANG': 'en_US.UTF-8', 00:48:38 INFO - 'LANGUAGE': 'en_US:en', 00:48:38 INFO - 'LOGNAME': 'cltbld', 00:48:38 INFO - 'MAIL': '/var/mail/cltbld', 00:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:38 INFO - 'MOZ_NO_REMOTE': '1', 00:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:38 INFO - 'NO_EM_RESTART': '1', 00:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:38 INFO - 'PWD': '/builds/slave/test', 00:48:38 INFO - 'SHELL': '/bin/bash', 00:48:38 INFO - 'SHLVL': '1', 00:48:38 INFO - 'TERM': 'linux', 00:48:38 INFO - 'TMOUT': '86400', 00:48:38 INFO - 'USER': 'cltbld', 00:48:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:38 INFO - '_': '/tools/buildbot/bin/python'} 00:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:48:38 INFO - Cleaning up... 00:48:38 INFO - Return code: 0 00:48:38 INFO - Running post-action listener: _resource_record_post_action 00:48:38 INFO - Running post-action listener: _start_resource_monitoring 00:48:38 INFO - Starting resource monitoring. 00:48:38 INFO - [mozharness: 2016-08-01 07:48:38.417700Z] Finished create-virtualenv step (success) 00:48:38 INFO - [mozharness: 2016-08-01 07:48:38.418135Z] Running install step. 00:48:38 INFO - Running pre-action listener: _resource_record_pre_action 00:48:38 INFO - Running main action method: install 00:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:48:38 INFO - Reading from file tmpfile_stdout 00:48:38 INFO - Detecting whether we're running mozinstall >=1.0... 00:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:48:38 INFO - Reading from file tmpfile_stdout 00:48:38 INFO - Output received: 00:48:38 INFO - Usage: mozinstall [options] installer 00:48:38 INFO - Options: 00:48:38 INFO - -h, --help show this help message and exit 00:48:38 INFO - -d DEST, --destination=DEST 00:48:38 INFO - Directory to install application into. [default: 00:48:38 INFO - "/builds/slave/test"] 00:48:38 INFO - --app=APP Application being installed. [default: firefox] 00:48:38 INFO - mkdir: /builds/slave/test/build/application 00:48:38 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'] 00:48:38 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 00:48:54 INFO - Reading from file tmpfile_stdout 00:48:54 INFO - Output received: 00:48:54 INFO - /builds/slave/test/build/application/firefox/firefox 00:48:54 INFO - Running post-action listener: _resource_record_post_action 00:48:54 INFO - [mozharness: 2016-08-01 07:48:54.740841Z] Finished install step (success) 00:48:54 INFO - [mozharness: 2016-08-01 07:48:54.741051Z] Running run-tests step. 00:48:54 INFO - Running pre-action listener: _resource_record_pre_action 00:48:54 INFO - Running main action method: run_tests 00:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:48:54 INFO - Python 2.7.3 00:48:54 INFO - Return code: 0 00:48:54 INFO - grabbing minidump binary from tooltool 00:48: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')]} 00:48:54 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 0x18133b0>, '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 0x18142b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1814740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:48:54 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 00:48:54 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 00:48:54 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 00:48:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:48:54 INFO - Return code: 0 00:48:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:48:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:48:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:48:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:48:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:48:54 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/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:48:54 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/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:48:54 INFO - Using env: {'DISPLAY': ':0', 00:48:54 INFO - 'HOME': '/home/cltbld', 00:48:54 INFO - 'LANG': 'en_US.UTF-8', 00:48:54 INFO - 'LANGUAGE': 'en_US:en', 00:48:54 INFO - 'LOGNAME': 'cltbld', 00:48:54 INFO - 'MAIL': '/var/mail/cltbld', 00:48:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:48:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:54 INFO - 'MOZ_NO_REMOTE': '1', 00:48:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:54 INFO - 'NO_EM_RESTART': '1', 00:48:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:54 INFO - 'PWD': '/builds/slave/test', 00:48:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:48:54 INFO - 'SHELL': '/bin/bash', 00:48:54 INFO - 'SHLVL': '1', 00:48:54 INFO - 'TERM': 'linux', 00:48:54 INFO - 'TMOUT': '86400', 00:48:54 INFO - 'USER': 'cltbld', 00:48:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470036872.600807-431168425', 00:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:54 INFO - '_': '/tools/buildbot/bin/python'} 00:48:54 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/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:48:55 INFO - mozversion application_buildid: 20160731232923 00:48:55 INFO - mozversion application_changeset: 6c5e03c243216f5748c81297a14952e6fe9fc300 00:48:55 INFO - mozversion application_display_name: Nightly 00:48:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:48:55 INFO - mozversion application_name: Firefox 00:48:55 INFO - mozversion application_remotingname: firefox 00:48:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:48:55 INFO - mozversion application_vendor: Mozilla 00:48:55 INFO - mozversion application_version: 50.0a1 00:48:55 INFO - mozversion platform_buildid: 20160731232923 00:48:55 INFO - mozversion platform_changeset: 6c5e03c243216f5748c81297a14952e6fe9fc300 00:48:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:48:55 INFO - mozversion platform_version: 50.0a1 00:48:55 INFO - using testdate: 1470037735 00:48:55 INFO - actual date: 1470037735 00:48:55 INFO - starting webserver on 'localhost:58648' 00:48:55 INFO - SUITE-START | Running 2 tests 00:48:55 INFO - TEST-START | dromaeo_css 00:48:55 INFO - operating with platform_type : linux_ 00:48:55 INFO - Initialising browser for dromaeo_css test... 00:48:55 INFO - TEST-INFO | started process 13712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWo0ZQ/profile http://localhost:58648/getInfo.html) 00:48:59 INFO - PROCESS | 13712 | __metrics Screen width/height:1600/1200 00:48:59 INFO - PROCESS | 13712 | colorDepth:24 00:48:59 INFO - PROCESS | 13712 | Browser inner width/height: 1024/697 00:48:59 INFO - PROCESS | 13712 | __metrics 00:49:00 INFO - PROCESS | 13712 | 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" 00:49:00 INFO - PROCESS | 13712 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:49:01 INFO - PROCESS | 13712 | console.error: PushService: 00:49:01 INFO - PROCESS | 13712 | stateChangeProcessEnqueue: Error transitioning state 00:49:01 INFO - PROCESS | 13712 | UnknownError 00:49:02 INFO - TEST-INFO | 13712: exit 0 00:49:02 INFO - Browser initialized. 00:49:02 INFO - Running cycle 1/1 for dromaeo_css test... 00:49:02 INFO - TEST-INFO | started process 13793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWo0ZQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:49:14 INFO - PROCESS | 13793 | RSS: Main: 157077504 00:49:14 INFO - PROCESS | 13793 | 00:50:04 INFO - PROCESS | 13793 | 1470037804924 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] 00:52:18 INFO - PROCESS | 13793 | Cycle 1(1): loaded http://localhost:58648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58648/tests/dromaeo/cssquery-ext.html) 00:52:19 INFO - PROCESS | 13793 | RSS: Main: 270614528 00:52:19 INFO - PROCESS | 13793 | 00:55:22 INFO - PROCESS | 13793 | Cycle 1(1): loaded http://localhost:58648/tests/dromaeo/cssquery-ext.html (next: http://localhost:58648/tests/dromaeo/cssquery-jquery.html) 00:55:22 INFO - PROCESS | 13793 | RSS: Main: 237092864 00:55:22 INFO - PROCESS | 13793 | 00:58:25 INFO - PROCESS | 13793 | Cycle 1(1): loaded http://localhost:58648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58648/tests/dromaeo/cssquery-mootools.html) 00:58:25 INFO - PROCESS | 13793 | RSS: Main: 215457792 00:58:25 INFO - PROCESS | 13793 | 01:01:28 INFO - PROCESS | 13793 | Cycle 1(1): loaded http://localhost:58648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58648/tests/dromaeo/cssquery-prototype.html) 01:01:28 INFO - PROCESS | 13793 | RSS: Main: 190648320 01:01:28 INFO - PROCESS | 13793 | 01:04:31 INFO - PROCESS | 13793 | Cycle 1(1): loaded http://localhost:58648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58648/tests/dromaeo/cssquery-yui.html) 01:04:32 INFO - PROCESS | 13793 | RSS: Main: 189808640 01:04:32 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | Cycle 1(1): loaded http://localhost:58648/tests/dromaeo/cssquery-yui.html (next: http://localhost:58648/tests/dromaeo/cssquery-dojo.html) 01:07:35 INFO - PROCESS | 13793 | RSS: Main: 282116096 01:07:35 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | __start_tp_report 01:07:35 INFO - PROCESS | 13793 | _x_x_mozilla_page_load 01:07:35 INFO - PROCESS | 13793 | _x_x_mozilla_page_load_details 01:07:35 INFO - PROCESS | 13793 | |i|pagename|runs| 01:07:35 INFO - PROCESS | 13793 | |0;dojo.html;2638.947221055579;2652.1910817200746;2681.7184195659447;2693.070890542763;2698.9055383061586;4585.220512512872;4656.278276867091;4768.4993075727025;4779.474257831635;4787.5212478752155;4699.67102302839;4720.716756994582;4773.618110551156;4786;4867.805287788484;4357.455318085247;4360.97819510902;4376.343548467724;4382.649388048964;4492.191405547001;4432.623227025707;4439.822407103712;4440.53374395687;4449.221386257392;4468.463784345883;4279.593438623326;4319.69762116652;4330.307150855848;4343.109662519176;4345.891352716208;4332.1119170569955;4340.435743353375;4354.08564201518;4387.6709246806295;4403.427554417937;4335.479742430897;4387.056782791683;4403.22943484892;4404.339349097661;4452.30989196675;4585.082983403299;4775.307580400822;4788.569028787391;4833.854984350475;4836.298736683197;5020.573251273646;5088.465711100355;5093.923591146136;5103.642745007851;5153.613478989091;5141.974290128563;5171.172612382001;5177.197534382177;5185.662931909414;5190.92213616796;4584.679072464895;4662.813487460531;4785.066911952171;4836.927446088312;4850.369451971221;4944.579710724557;5179.48205179479;5218.060749065129;5218.217267409843;5235.267062611238;4955.281484184773;5007.4241462231585;5008.474110218374;5008.774605142778;5016.54851063406;4894.804207831647;4967.155583550732;5095.108356037678;5097.413797413345;5109;4963.503649635008;4995.875103122451;4996.725180115129;5016.046951079284;5025.070361983045;4970.279309500174;4970.925436118461;4984.102861484895;4993.275974983607;5023.271625614266;4206.20082184384;4230.915381692349;4301.526832048472;4303.397524346594;4340.696151269444;3687.6865466435115;3708;3749.9500139960855;3761.6426439488205;3764.604716504782;4385.407969924083;4388.05656783793;4391.538888416734;4394;4434.157510073076;5045.5459008689395;5048.949510504922;5049.596032317406;5050.4697006814495;5086.821961231339;4280.464941882265;4382.255016647177;4394.296912494049;4428.31361139024;4451.221036318631;4673.719576825401;4675.6727029108315;4677.812887484531;4709.646776491777;4726.550977657117;4843.515648435128;4871.732054737024;4876.146674332049;4880.80476780939;4912.140375434285;4955.132851750857;5018.598512118949;5018.899622007466;5157.226416037624;5211.374635043668;4785.9760701197665;4790.377250957354;4798.184308667465;4809.254565542346;4816.95183048165;4980.402351717817;5027.798888044437;5047.167217409086;5053.67151135175;5062.088824011713;5043.672161309503;5046.091703493406;5046.621503387188;5067.214581739836;5103.617228707936;4808.903821923472;4877.756112194447;4913.63147763912;4925.211966085552;4977.900441991213;4891.095147397743;4891.315215869852;4950.77721502526;4967.652264341606;5027.245913113063;4889.608831293417;4890.584300334369;4935.309056731989;4936.086823937583;4946.480619534897;4794.568488836021;4932.53140951609;4987.827860452718;4991.700497970133;5001.649884508195;4803.759812009455;4858.8299409521915;4873.878153046202;4874.098291816025;4892.0705066037335 01:07:35 INFO - PROCESS | 13793 | |1;ext.html;566.4420545762424;574.4370516893447;578.167438888001;583.5914859598282;588.0972706894916;29036.41927161458;29584.556231656516;31905.840470797673;42780.786096069474;44154.55845441553;41115.79442102785;41458.58541414585;41577.16845663093;41587.58412415883;41592;7707.922920770777;7846.254605812439;7849.529028258295;7851.921480785176;7855.5286682799215;7759.728409505668;7831.686732530692;7848.921510784905;7850.2542258485355;7852.097008843999;7868.449208555404;7911.129775724666;7915;7918.287354138127;7919.485233459806;7822.9608851955945;7833.099193592753;7834.56909869957;7840;7871.212878712112;7669.156392796788;7724.420668449832;7731.574763388011;7732.342750866183;7734.265244801735;39234.41148382777;39581;39614;39632.603673963466;39661.80169099136;3038.453078445879;3047.43622429849;3192.696693814107;3424.5548078749853;3731.067233191702;30362.392752145053;30446.695533044607;30730;31769.6823031769;31824.522632160537;3408.233147541808;3481.582210134775;3487.2851065531504;3519.102628829632;3618.3848745713294;261208;267312;267732;268362;268428;56380.718096409255;56430.51049129321;56585.7170714152;56785;56811;33387.49918751221;33984.830075849466;34247.657523424445;36142.28932830048;58994.70502647545;14838.258087095603;14867;14932.402703891723;14958.401663933539;15013.399464021317;11636.592719254786;11707.121965852595;11707.76584468306;11721.589744358907;11724.824127638092;18684.159212835453;18778.718319225223;18795.248190072245;18795.248190072518;18795.55657764482;6574.572652777554;6654.800355989328;6661.300563440769;6891.241963384024;6897.172339319314;778.723553138639;863.4646519158163;871.2376670413388;897.0132853860831;980.5146452506056;27673.72326276752;27959.58060629092;28624.710943133417;28813.711862881522;28981;896.8878890138733;900.8513595256841;917.2111983694018;937.0535758883441;957.6791774755395;14472.34874430632;15117.924410377878;15186.804451510203;15315.770263446057;15369;385175;386485;387119;387754;387804;50213.24680129801;50426.74786626043;50664.24003639948;50690;50961.49038509642;1059.0997651995897;1168.6669299249672;1180.415694231361;1198.922070065443;1211.9878801211876;27785.166445006682;28671.42657146887;29542;29889.5516567256;29997.850010749808;43262.78368608137;43734.12531749411;43836.561634383244;43866.342004869315;43922.34116488319;289863;291424;292470;292711;292766;23785.405364866016;24947.376315592257;25819.870900645376;25977.350566235997;25992.480150396506;42241.57758422499;42618.78690606651;42952.78523607362;43307.566924331615;43788.562114379725;34801.47797782985;35347.82326088456;35424.645753542136;35933.1016724584;36193;35933.281334372645;36140.27719445649;36413;36512.81743591265;36904;34865.651343487254;35026.474602880466;35867;35966.10084747902;36060;31402;32749.672503275615;33201.33597328088;33239.66760332366;33622.83188584042;25262.494750104528;25493.617595735708;25515;25551.488970220118;25768.484630307663 01:07:35 INFO - PROCESS | 13793 | |2;jquery.html;340.4994657852955;366.4228839577665;366.57111179919485;367.31495760406847;386.14468951272926;12912.935435322823;13546.39041243144;14774.70450590989;17042.403515876947;17069.658606827856;16461.884528867784;16608.33566657335;16948.915255423704;16949.152542372893;17075.316987320522;4922.187839006559;5106.821261255856;5130.640855140123;5131.4098878629065;5132.127538318495;3697.2605478904325;5654.123610840326;5880.353161152269;5953.732082056296;6039;5101.7194054327;6009.098635204732;6010.12853136295;6019.759209631631;6020.458158765732;5310.70791106489;5452.073147564924;5455.345358556999;5455.972720136394;5456.727163641802;4611.262198048296;4871.098846713334;5267.789288428458;5284.837335786159;5286.154215325568;11980.70048248792;12160.51357945681;12204.450799714034;12278.570250041295;13379.464821407131;1827.4974382044911;1883.5479484923658;1928.421473557941;1941.553442708171;2036.7963203679662;8903.888946708541;8935.374523783337;8953.731388058368;9433.386829856106;9562.28282878787;1667.1414221675846;1667.7998640163257;1692.7376256680234;1729.2218501674172;1736.2013473802067;64114.67942660257;64232;65882.3411765881;68190;71654.64172679155;9652;9749.707508774749;9827.4103553787;9990.600375985025;10011.899881001096;13184.934075329562;13192.538261160813;13218;13226.272555009567;13250.602481925558;6754.966225168842;7072.469564782662;7122.608256545836;7170.39051680613;7204.3155900189395;6728.360805723449;6810.353016463428;6925.099737034153;6929.826754331182;6945.722171113099;4098.036892206787;4175.248455278079;4228.788560571959;4229.555896630809;4414.227510185705;1701.829817018313;1736.8263173682783;1786.2944137065786;1812.8005919348861;1816.8728189026642;809.1786836361098;814.3932770086324;819.663937785505;848.295914391054;855.0543378062515;16489.09309987962;17218.827811721974;17658.5585360367;17676.646467070586;18000.639987200444;833.083608031173;845.5180547088223;848.0798333807887;861.4960248254841;877.2981614708208;7936.4047696423;9494.715158545254;9887.357321774061;9900.257480688833;10033.799324013478;286966;291610;294003;397221;397387;48423.5157648426;49274.50725492699;57543.71228143916;87222;89433.55283223542;899.2985471332371;901.8962819275736;920.7836158502746;926.1479438916214;929.2565947242314;15540.222988850739;15960.361585536448;16166.757498637295;16349.591260218589;16720.41478548245;27344.042958496357;31292.374152516368;39567;39672.80163599279;40013.599864000986;55354;55708.442915570326;56394.7180264096;57411.71294143503;57894.710526447096;5534.584906131976;6323.430891219812;6567.2447668516825;6993.720251189896;7168.781307177896;10320.329178603366;11692.532298707956;11790.646280611596;11976.76046479083;12040.879591203975;9979.503074538878;10145.492725363554;10310.948445258025;10343.63797267092;10730;10466.372017678963;10531.420771857622;10550.947245264031;10620.575176992834;10782.245242832927;10428.113610343205;10464.63373781914;10704.036636702735;10794.406307653155;10870.021698047214;6915.619640919797;6972.442204623517;7056;7065.470089743392;7229.674664640209;7885.842283154419;9508.572114255014;10472.842907356244;10599.576016959236;10877.564897404016 01:07:35 INFO - PROCESS | 13793 | |3;mootools.html;1220.371508673033;1348.6763176837562;1394.6861956059886;1431.6134643646217;1672.7490876368543;6235.781747638834;6884.208316043657;7191.856162876739;7203.6038017908995;7501.0998680158455;7283.7086516539275;7317.414606831454;7334.669939852706;7340.119185697724;7344.596047217415;2173.07644251193;2191.4740462289014;2193.517426166241;2193.967090493644;2198.604251234785;2105.9365020664545;2143.399848042543;2152.7524334701475;2156.35309407178;2158.363282831561;2142.1752625239237;2153.8707677539396;2165.675148727688;2169.739631244253;2176.5102851858364;2087.290321290761;2093.6859471079306;2096.088201632287;2096.3501314592527;2099.5066159452517;2057.0434747842323;2109.8523103382768;2114.06980928391;2116;2117.1743020222125;7305.598192099433;7341.449391295674;7348.301911318416;7393.07586551681;7409.88885166723;4454.398656181406;4557.817687292504;4563.133004729124;4578.221702310615;4604.217283061887;2910.0833237530323;2983.8508074596402;3051.8474076296097;3053.4961731314306;3055.251463391461;938.1603464898946;940.2431043010374;953.1993125774313;957.2533423929347;967.5404183013083;9896.95051524745;9936.652217172437;9967.950160249226;9989.75025624358;9992.400455972593;3857.61423857612;3906.3554513504955;3983.6813054956115;4053.7162398631813;4060.9390859136547;8012.679492820338;8060.919390806134;8063.354931605458;8067.1529489402765;8077.071136819223;4467.6649251305635;4470.240059189946;4470.798814053375;4472.2620767573635;4476.395686582335;3502.299540091941;3942;4141.8964525887095;4177.997280652621;4182.9581704182565;3490.5462289902152;3558.092686365012;3698.519192504957;3711.2206436648607;3714;1163.959261425846;1191.684203686024;1197.53900241705;1209.3832145605804;1210.189173253922;790.9644066017044;793.1275596843541;883.8718385834018;885.5085427587751;903.1239697493552;5092.567131793839;5186.92219616706;5203.739813009334;5223.085959956992;5302.2576839241765;848.3171047306977;855.3542075732782;905.8777065096259;926.2589928057527;954.6086104697041;3571.321448924696;3639.162992511684;3741.8316175772156;3769.566499852552;3789.8673546426294;8680.8697869532;8786.472811631322;8892.377533572588;9077.818443631091;9110.681126160685;8907.421017633833;9064.50145242018;9078.409903356262;9083.318751093562;9105.271578273721;6998.4751143664425;7121.359077683033;7183.856322873513;7185.568865868065;7214.855702885913;5348;5356.3572371315695;5408.891822163613;5474.972625137008;5641.746121424628;8565.700200492953;8626.482411055356;8636.956815215884;8710.738677839676;8730.039695633348;8410.789730256793;8596.613152408281;8757.562121893752;8770.736877893672;8800.47197168172;6106.297775755667;6964.4080253179045;7089.539179953286;7220.74727384539;7233.638318083969;7074.398676112588;7349.30181632744;7353;7358.595277259588;7362.705491780269;6406.423421892052;6569.080328754074;6596.868062638624;6662.666866656745;6775.86448271022;6496.123023391781;6536.738530458919;6543.789398961208;6554.246261679968;6577.50668699859;6034.969825150846;6170.228721409824;6181.5981961174175;6195.845103872439;6196.411340922605;4385.561443855589;4446.73319600825;4487.147441986012;4595.540445955377;4619.584237418649;4553.408056952575;4687.460941991714;4740.099381117577;4811.522066136013;4915.877103072309 01:07:35 INFO - PROCESS | 13793 | |4;prototype.html;292.8023584080745;294.26580681200403;299.38177663125657;299.93551386451907;302.6504387432515;4717.4290011943485;4777.307290442888;4781.5218478152165;4782.282657601361;4801.567858892699;4692.389989301395;4710.362197169579;4715.764211789406;4745.644076694253;4756.619470442365;3543.149644085414;3649.7627654202524;3681.153334733013;3723.3484140275477;3728.5152930119184;3730.2725968436166;3735.6637902588764;3738.1589142442867;3748.700103991674;3752.6997840172858;3708.128589781399;3715.2012317351764;3716.684081853046;3717.814109294538;3723.6276372362818;3564.6078931317534;3624.1845584743355;3723.478712980185;3723.888283351504;3745.8501659933568;3323.8171900545462;3327.5674162358982;3328.417526932777;3329.417351963397;3330.5670262865674;4625.190591646448;4629.305604159369;4632.907341853144;4639.979204574988;4641.489436162019;4127.525334586501;4180.47744031996;4215.810288536993;4246.5541118182455;4251.957480425187;4859.1496488114435;4875.463698993108;4919.655624106314;4931.5315045070665;4931.580815630676;3524.4537096750046;3533.522974398449;3539;3550.218951830593;3580.5703315602036;5002.299678045113;5189.195674670432;5235.842924712265;5244.685318880841;5271.235670827708;3687.225682606629;3716.1638631307737;3731.3470142724914;3731.533558305212;3741.4574886641285;3785.050698890074;3796.4115562087923;3796.886093417202;3803.1633040730994;3803.459598862465;4288.785560721952;4298.699091063658;4301.376300436419;4305.56944305567;4315.28797748368;4722.173619616553;4955.752212389366;4968.453470118284;4978.27814966835;5001.799928002839;1240.7406482420351;1250.0811903251104;1250.1748845761936;1250.9624711258678;1254.1659796235401;801.9077806052262;820.5733018830175;823.9382046346548;829.672279449614;840.5881118252013;4240;4264.168487144977;4267.8079486423185;4416.889577760518;4467.30756732707;5109.131447653907;5130.9230361544605;5134.897302053938;5135.871603209875;5139.8458046258675;4362.8691139265875;4459.687821852504;4462.107578484316;4464.549021568004;4482.618977386894;2704.418550011757;2708.485387776316;2715.6198132261497;2717.8505182215167;2723.1966569861543;4862.95137048632;4869.707817530889;4870.561649451566;4870.780814863339;4907.803687852446;5069.96229159511;5153.433122356538;5215.29593504872;5237.240600112962;5238.60710446718;4831.637627177905;4842.370491836039;4852.4662287148385;4859.514048595112;4862.0584546349655;5056.64603477753;5081.4918508148885;5096.51583099605;5110.565601923878;5124.461931497139;4783.402074740658;4989;5016;5032.723200223876;5041.521055499722;4805.255185446262;4836.637252206169;4840.7337596432535;4842.370491836039;4843.515648435269;3629;3645.5078564393466;3646.234290798962;3668.4313931340685;3669.889903302905;4868.853934381833;5113.079645663816;5126.74366281677;5130.358705161855;5147.253648221062;4934;4936.827211047596;4939.357883475125;4939.975300123477;4948.851534453972;4866.80532778699;4910.189818679878;4955.5044495550155;4972.65191436596;4988.176950803222;4657.93013104797;4839.2983017462975;4894.216925291937;4913.975430122827;4914.680545764514;4696.342512048248;4807.471178170328;4944.258361245842;4944.456109827845;4996.500349964975;4834.927476087932;4836.95163048365;4838.540338667821;4838.612910967044;4859.878503037311 01:07:35 INFO - PROCESS | 13793 | |5;yui.html;659.5679829711539;673.562184580023;685.1709431587778;731.2358585278383;749.7338444852079;12982.805257921127;14129.576112716635;14135.363908624111;14161.433542658282;14168.929155354223;12687.175333603309;12756.872431275684;12792.424340904658;12797.808032879491;12803.679908002305;605.0500713879211;717.7057406463351;742.153944503264;748.5658318175459;754.2457542457543;751.8496300739846;761.2653789093524;762.1806557950225;762.3443838299058;762.6491813765674;806.9556174410405;807.3662175192475;807.4912804932884;808.2160304504621;808.7735434078468;638.8977763557808;778.2101167315179;804.7947773317795;805.6414895371591;806.5684858600679;591.1959734760723;591.630231105559;592.1680039544403;592.2153147080093;592.3543337761861;12943.805842912363;13017.869821301856;13020.348982550835;13046.673833154247;13051.86948130516;12405.689857753629;12806.103572749911;12936.741265174738;13263.801042984363;13532.797008044887;11554.53781848725;11604;11810.350430726307;11844.644660660195;11862.644120676394;4167.083241686824;4176.540580536139;4223.72545784523;4228.302330115527;4233.682473814476;64719.352806471805;65030.049098526644;65905;65958.34041659618;66816.6659166701;10198.388096714221;10317.9484102579;10320.741981450374;10376.533056012497;10805.459727013618;19488.70766938497;19514.414567562995;19554.902225488782;19624.41126766199;19643.116059777345;6687.699053542602;6781.559198652072;6783.457323414115;6791.660416979132;6818.113645226089;3667.8166091695844;3677.981610091986;3699.315626609086;3791.0901383668274;3807.7144214184045;2738.7945904057274;2808.648918885139;2825.39254060378;2836.773058155343;2838.0634390651035;472.2208356212277;481.91084649339984;485.13887849068186;487.33965476778457;494.56231235356967;474.5136235358785;490.24991762603275;508.4204007431531;542.7015141672065;604.7943699142313;8035;8150.836983260301;8199.95900020496;8318.41771076031;8365.456245344034;514.6911852888237;521.5254118751917;535.5447869311055;585.5023230254335;622.9657368844667;3642.1987162824134;3693.6675699187203;3996.160806230724;4131;4224.429701990253;60223.698881506185;89193.55403222943;99582;105135;105563.4721826386;88028.55985720031;88052;88180.55909720411;89586.55206724055;90481.54759226294;78316.21683783203;78417.60791196008;79784;80304.59847700724;80414.59792700999;7063.929360706327;7099.07711997437;7184.425245980414;7193.4604904631315;7216.494845360774;35113.648863511036;44006;44032.89917752082;44351;45884.54115458803;58297.12554311604;64405.35594644181;65578.34421655913;67614.66192669005;70170.29829701637;9973.551190196604;10106;10326.277160598986;10358.274920755475;10388.792224155626;11401.429928503376;11460.885391146316;11826.586069487526;11962.401879906143;12359.75280494403;10524.263301568817;10635.840462392916;11038.573898527344;11111.444427778417;11217.66347009591;10565.313254638424;10570.2072344576;10740.946295268786;11093.445327733742;11244;10097.141742951637;10279.924930798521;10318.587256509656;10470.952904709467;10529.157667386744;7590.240975902366;7714.614269286401;7756.418268629988;7838.098618658927;7914.010748656418;8446.450980686235;8827.911720882708;8876.51179185151;8915.98456676272;8957.238634716123 01:07:35 INFO - PROCESS | 13793 | __end_tp_report 01:07:35 INFO - PROCESS | 13793 | __start_cc_report 01:07:35 INFO - PROCESS | 13793 | _x_x_mozilla_cycle_collect,1113 01:07:35 INFO - PROCESS | 13793 | __end_cc_report 01:07:35 INFO - PROCESS | 13793 | __startTimestamp1470038855459__endTimestamp 01:07:35 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | ------- Summary: start ------- 01:07:35 INFO - PROCESS | 13793 | Number of tests: 6 01:07:35 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | [#0] dojo.html Cycles:165 Average:4696.75 Median:4850.37 stddev:486.37 (10.0%) stddev-sans-first:460.30 01:07:35 INFO - PROCESS | 13793 | Values: 2638.9 2652.2 2681.7 2693.1 2698.9 4585.2 4656.3 4768.5 4779.5 4787.5 4699.7 4720.7 4773.6 4786.0 4867.8 4357.5 4361.0 4376.3 4382.6 4492.2 4432.6 4439.8 4440.5 4449.2 4468.5 4279.6 4319.7 4330.3 4343.1 4345.9 4332.1 4340.4 4354.1 4387.7 4403.4 4335.5 4387.1 4403.2 4404.3 4452.3 4585.1 4775.3 4788.6 4833.9 4836.3 5020.6 5088.5 5093.9 5103.6 5153.6 5142.0 5171.2 5177.2 5185.7 5190.9 4584.7 4662.8 4785.1 4836.9 4850.4 4944.6 5179.5 5218.1 5218.2 5235.3 4955.3 5007.4 5008.5 5008.8 5016.5 4894.8 4967.2 5095.1 5097.4 5109.0 4963.5 4995.9 4996.7 5016.0 5025.1 4970.3 4970.9 4984.1 4993.3 5023.3 4206.2 4230.9 4301.5 4303.4 4340.7 3687.7 3708.0 3750.0 3761.6 3764.6 4385.4 4388.1 4391.5 4394.0 4434.2 5045.5 5048.9 5049.6 5050.5 5086.8 4280.5 4382.3 4394.3 4428.3 4451.2 4673.7 4675.7 4677.8 4709.6 4726.6 4843.5 4871.7 4876.1 4880.8 4912.1 4955.1 5018.6 5018.9 5157.2 5211.4 4786.0 4790.4 4798.2 4809.3 4817.0 4980.4 5027.8 5047.2 5053.7 5062.1 5043.7 5046.1 5046.6 5067.2 5103.6 4808.9 4877.8 4913.6 4925.2 4977.9 4891.1 4891.3 4950.8 4967.7 5027.2 4889.6 4890.6 4935.3 4936.1 4946.5 4794.6 4932.5 4987.8 4991.7 5001.6 4803.8 4858.8 4873.9 4874.1 4892.1 01:07:35 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | [#1] ext.html Cycles:180 Average:46986.07 Median:19880.34 stddev:83961.26 (422.3%) stddev-sans-first:84124.45 01:07:35 INFO - PROCESS | 13793 | Values: 566.4 574.4 578.2 583.6 588.1 29036.4 29584.6 31905.8 42780.8 44154.6 41115.8 41458.6 41577.2 41587.6 41592.0 7707.9 7846.3 7849.5 7851.9 7855.5 7759.7 7831.7 7848.9 7850.3 7852.1 7868.4 7911.1 7915.0 7918.3 7919.5 7823.0 7833.1 7834.6 7840.0 7871.2 7669.2 7724.4 7731.6 7732.3 7734.3 39234.4 39581.0 39614.0 39632.6 39661.8 3038.5 3047.4 3192.7 3424.6 3731.1 30362.4 30446.7 30730.0 31769.7 31824.5 3408.2 3481.6 3487.3 3519.1 3618.4 261208.0 267312.0 267732.0 268362.0 268428.0 56380.7 56430.5 56585.7 56785.0 56811.0 33387.5 33984.8 34247.7 36142.3 58994.7 14838.3 14867.0 14932.4 14958.4 15013.4 11636.6 11707.1 11707.8 11721.6 11724.8 18684.2 18778.7 18795.2 18795.2 18795.6 6574.6 6654.8 6661.3 6891.2 6897.2 778.7 863.5 871.2 897.0 980.5 27673.7 27959.6 28624.7 28813.7 28981.0 896.9 900.9 917.2 937.1 957.7 14472.3 15117.9 15186.8 15315.8 15369.0 385175.0 386485.0 387119.0 387754.0 387804.0 50213.2 50426.7 50664.2 50690.0 50961.5 1059.1 1168.7 1180.4 1198.9 1212.0 27785.2 28671.4 29542.0 29889.6 29997.9 43262.8 43734.1 43836.6 43866.3 43922.3 289863.0 291424.0 292470.0 292711.0 292766.0 23785.4 24947.4 25819.9 25977.4 25992.5 42241.6 42618.8 42952.8 43307.6 43788.6 34801.5 35347.8 35424.6 35933.1 36193.0 35933.3 36140.3 36413.0 36512.8 36904.0 34865.7 35026.5 35867.0 35966.1 36060.0 31402.0 32749.7 33201.3 33239.7 33622.8 25262.5 25493.6 25515.0 25551.5 25768.5 01:07:35 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | [#2] jquery.html Cycles:180 Average:22171.66 Median:26517.39 stddev:56061.88 (211.4%) stddev-sans-first:56195.18 01:07:35 INFO - PROCESS | 13793 | Values: 340.5 366.4 366.6 367.3 386.1 12912.9 13546.4 14774.7 17042.4 17069.7 16461.9 16608.3 16948.9 16949.2 17075.3 4922.2 5106.8 5130.6 5131.4 5132.1 3697.3 5654.1 5880.4 5953.7 6039.0 5101.7 6009.1 6010.1 6019.8 6020.5 5310.7 5452.1 5455.3 5456.0 5456.7 4611.3 4871.1 5267.8 5284.8 5286.2 11980.7 12160.5 12204.5 12278.6 13379.5 1827.5 1883.5 1928.4 1941.6 2036.8 8903.9 8935.4 8953.7 9433.4 9562.3 1667.1 1667.8 1692.7 1729.2 1736.2 64114.7 64232.0 65882.3 68190.0 71654.6 9652.0 9749.7 9827.4 9990.6 10011.9 13184.9 13192.5 13218.0 13226.3 13250.6 6755.0 7072.5 7122.6 7170.4 7204.3 6728.4 6810.4 6925.1 6929.8 6945.7 4098.0 4175.2 4228.8 4229.6 4414.2 1701.8 1736.8 1786.3 1812.8 1816.9 809.2 814.4 819.7 848.3 855.1 16489.1 17218.8 17658.6 17676.6 18000.6 833.1 845.5 848.1 861.5 877.3 7936.4 9494.7 9887.4 9900.3 10033.8 286966.0 291610.0 294003.0 397221.0 397387.0 48423.5 49274.5 57543.7 87222.0 89433.6 899.3 901.9 920.8 926.1 929.3 15540.2 15960.4 16166.8 16349.6 16720.4 27344.0 31292.4 39567.0 39672.8 40013.6 55354.0 55708.4 56394.7 57411.7 57894.7 5534.6 6323.4 6567.2 6993.7 7168.8 10320.3 11692.5 11790.6 11976.8 12040.9 9979.5 10145.5 10310.9 10343.6 10730.0 10466.4 10531.4 10550.9 10620.6 10782.2 10428.1 10464.6 10704.0 10794.4 10870.0 6915.6 6972.4 7056.0 7065.5 7229.7 7885.8 9508.6 10472.8 10599.6 10877.6 01:07:35 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | [#3] mootools.html Cycles:180 Average:4968.67 Median:6070.63 stddev:2680.00 (44.1%) stddev-sans-first:2672.71 01:07:35 INFO - PROCESS | 13793 | Values: 1220.4 1348.7 1394.7 1431.6 1672.7 6235.8 6884.2 7191.9 7203.6 7501.1 7283.7 7317.4 7334.7 7340.1 7344.6 2173.1 2191.5 2193.5 2194.0 2198.6 2105.9 2143.4 2152.8 2156.4 2158.4 2142.2 2153.9 2165.7 2169.7 2176.5 2087.3 2093.7 2096.1 2096.4 2099.5 2057.0 2109.9 2114.1 2116.0 2117.2 7305.6 7341.4 7348.3 7393.1 7409.9 4454.4 4557.8 4563.1 4578.2 4604.2 2910.1 2983.9 3051.8 3053.5 3055.3 938.2 940.2 953.2 957.3 967.5 9897.0 9936.7 9968.0 9989.8 9992.4 3857.6 3906.4 3983.7 4053.7 4060.9 8012.7 8060.9 8063.4 8067.2 8077.1 4467.7 4470.2 4470.8 4472.3 4476.4 3502.3 3942.0 4141.9 4178.0 4183.0 3490.5 3558.1 3698.5 3711.2 3714.0 1164.0 1191.7 1197.5 1209.4 1210.2 791.0 793.1 883.9 885.5 903.1 5092.6 5186.9 5203.7 5223.1 5302.3 848.3 855.4 905.9 926.3 954.6 3571.3 3639.2 3741.8 3769.6 3789.9 8680.9 8786.5 8892.4 9077.8 9110.7 8907.4 9064.5 9078.4 9083.3 9105.3 6998.5 7121.4 7183.9 7185.6 7214.9 5348.0 5356.4 5408.9 5475.0 5641.7 8565.7 8626.5 8637.0 8710.7 8730.0 8410.8 8596.6 8757.6 8770.7 8800.5 6106.3 6964.4 7089.5 7220.7 7233.6 7074.4 7349.3 7353.0 7358.6 7362.7 6406.4 6569.1 6596.9 6662.7 6775.9 6496.1 6536.7 6543.8 6554.2 6577.5 6035.0 6170.2 6181.6 6195.8 6196.4 4385.6 4446.7 4487.1 4595.5 4619.6 4553.4 4687.5 4740.1 4811.5 4915.9 01:07:35 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | [#4] prototype.html Cycles:180 Average:4133.81 Median:4719.80 stddev:1192.39 (25.3%) stddev-sans-first:1160.36 01:07:35 INFO - PROCESS | 13793 | Values: 292.8 294.3 299.4 299.9 302.7 4717.4 4777.3 4781.5 4782.3 4801.6 4692.4 4710.4 4715.8 4745.6 4756.6 3543.1 3649.8 3681.2 3723.3 3728.5 3730.3 3735.7 3738.2 3748.7 3752.7 3708.1 3715.2 3716.7 3717.8 3723.6 3564.6 3624.2 3723.5 3723.9 3745.9 3323.8 3327.6 3328.4 3329.4 3330.6 4625.2 4629.3 4632.9 4640.0 4641.5 4127.5 4180.5 4215.8 4246.6 4252.0 4859.1 4875.5 4919.7 4931.5 4931.6 3524.5 3533.5 3539.0 3550.2 3580.6 5002.3 5189.2 5235.8 5244.7 5271.2 3687.2 3716.2 3731.3 3731.5 3741.5 3785.1 3796.4 3796.9 3803.2 3803.5 4288.8 4298.7 4301.4 4305.6 4315.3 4722.2 4955.8 4968.5 4978.3 5001.8 1240.7 1250.1 1250.2 1251.0 1254.2 801.9 820.6 823.9 829.7 840.6 4240.0 4264.2 4267.8 4416.9 4467.3 5109.1 5130.9 5134.9 5135.9 5139.8 4362.9 4459.7 4462.1 4464.5 4482.6 2704.4 2708.5 2715.6 2717.9 2723.2 4863.0 4869.7 4870.6 4870.8 4907.8 5070.0 5153.4 5215.3 5237.2 5238.6 4831.6 4842.4 4852.5 4859.5 4862.1 5056.6 5081.5 5096.5 5110.6 5124.5 4783.4 4989.0 5016.0 5032.7 5041.5 4805.3 4836.6 4840.7 4842.4 4843.5 3629.0 3645.5 3646.2 3668.4 3669.9 4868.9 5113.1 5126.7 5130.4 5147.3 4934.0 4936.8 4939.4 4940.0 4948.9 4866.8 4910.2 4955.5 4972.7 4988.2 4657.9 4839.3 4894.2 4914.0 4914.7 4696.3 4807.5 4944.3 4944.5 4996.5 4834.9 4837.0 4838.5 4838.6 4859.9 01:07:35 INFO - PROCESS | 13793 | 01:07:35 INFO - PROCESS | 13793 | [#5] yui.html Cycles:180 Average:17823.16 Median:488.79 stddev:26003.34 (5319.9%) stddev-sans-first:26044.35 01:07:35 INFO - PROCESS | 13793 | Values: 659.6 673.6 685.2 731.2 749.7 12982.8 14129.6 14135.4 14161.4 14168.9 12687.2 12756.9 12792.4 12797.8 12803.7 605.1 717.7 742.2 748.6 754.2 751.8 761.3 762.2 762.3 762.6 807.0 807.4 807.5 808.2 808.8 638.9 778.2 804.8 805.6 806.6 591.2 591.6 592.2 592.2 592.4 12943.8 13017.9 13020.3 13046.7 13051.9 12405.7 12806.1 12936.7 13263.8 13532.8 11554.5 11604.0 11810.4 11844.6 11862.6 4167.1 4176.5 4223.7 4228.3 4233.7 64719.4 65030.0 65905.0 65958.3 66816.7 10198.4 10317.9 10320.7 10376.5 10805.5 19488.7 19514.4 19554.9 19624.4 19643.1 6687.7 6781.6 6783.5 6791.7 6818.1 3667.8 3678.0 3699.3 3791.1 3807.7 2738.8 2808.6 2825.4 2836.8 2838.1 472.2 481.9 485.1 487.3 494.6 474.5 490.2 508.4 542.7 604.8 8035.0 8150.8 8200.0 8318.4 8365.5 514.7 521.5 535.5 585.5 623.0 3642.2 3693.7 3996.2 4131.0 4224.4 60223.7 89193.6 99582.0 105135.0 105563.5 88028.6 88052.0 88180.6 89586.6 90481.5 78316.2 78417.6 79784.0 80304.6 80414.6 7063.9 7099.1 7184.4 7193.5 7216.5 35113.6 44006.0 44032.9 44351.0 45884.5 58297.1 64405.4 65578.3 67614.7 70170.3 9973.6 10106.0 10326.3 10358.3 10388.8 11401.4 11460.9 11826.6 11962.4 12359.8 10524.3 10635.8 11038.6 11111.4 11217.7 10565.3 10570.2 10740.9 11093.4 11244.0 10097.1 10279.9 10318.6 10471.0 10529.2 7590.2 7714.6 7756.4 7838.1 7914.0 8446.5 8827.9 8876.5 8916.0 8957.2 01:07:35 INFO - PROCESS | 13793 | -------- Summary: end -------- 01:07:35 INFO - PROCESS | 13793 | 01:07:36 INFO - TEST-INFO | 13793: exit 0 01:07:36 INFO - TEST-OK | dromaeo_css | took 1121331ms 01:07:36 INFO - TEST-START | kraken 01:07:36 INFO - operating with platform_type : linux_ 01:07:36 INFO - Initialising browser for kraken test... 01:07:36 INFO - TEST-INFO | started process 13981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfrudJ0/profile http://localhost:58648/getInfo.html) 01:07:41 INFO - PROCESS | 13981 | __metrics Screen width/height:1600/1200 01:07:41 INFO - PROCESS | 13981 | colorDepth:24 01:07:41 INFO - PROCESS | 13981 | Browser inner width/height: 1024/697 01:07:41 INFO - PROCESS | 13981 | __metrics 01:07:42 INFO - PROCESS | 13981 | 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" 01:07:42 INFO - PROCESS | 13981 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:07:43 INFO - TEST-INFO | 13981: exit 0 01:07:43 INFO - Browser initialized. 01:07:43 INFO - Running cycle 1/1 for kraken test... 01:07:43 INFO - TEST-INFO | started process 14061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfrudJ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:07:55 INFO - PROCESS | 14061 | RSS: Main: 158203904 01:07:55 INFO - PROCESS | 14061 | 01:07:58 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58648/tests/kraken/driver.html?testName=audio-beat-detection) 01:07:59 INFO - PROCESS | 14061 | RSS: Main: 214003712 01:07:59 INFO - PROCESS | 14061 | 01:08:01 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58648/tests/kraken/driver.html?testName=audio-dft) 01:08:02 INFO - PROCESS | 14061 | RSS: Main: 191565824 01:08:02 INFO - PROCESS | 14061 | 01:08:05 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58648/tests/kraken/driver.html?testName=audio-fft) 01:08:06 INFO - PROCESS | 14061 | RSS: Main: 270307328 01:08:06 INFO - PROCESS | 14061 | 01:08:08 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58648/tests/kraken/driver.html?testName=audio-oscillator) 01:08:09 INFO - PROCESS | 14061 | RSS: Main: 180674560 01:08:09 INFO - PROCESS | 14061 | 01:08:11 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:08:11 INFO - PROCESS | 14061 | RSS: Main: 185397248 01:08:11 INFO - PROCESS | 14061 | 01:08:15 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58648/tests/kraken/driver.html?testName=imaging-darkroom) 01:08:15 INFO - PROCESS | 14061 | RSS: Main: 222126080 01:08:15 INFO - PROCESS | 14061 | 01:08:19 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58648/tests/kraken/driver.html?testName=imaging-desaturate) 01:08:19 INFO - PROCESS | 14061 | RSS: Main: 215928832 01:08:19 INFO - PROCESS | 14061 | 01:08:22 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58648/tests/kraken/driver.html?testName=json-parse-financial) 01:08:23 INFO - PROCESS | 14061 | RSS: Main: 218759168 01:08:23 INFO - PROCESS | 14061 | 01:08:25 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:08:25 INFO - PROCESS | 14061 | RSS: Main: 184684544 01:08:25 INFO - PROCESS | 14061 | 01:08:27 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58648/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:08:28 INFO - PROCESS | 14061 | RSS: Main: 189616128 01:08:28 INFO - PROCESS | 14061 | 01:08:30 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:08:30 INFO - PROCESS | 14061 | RSS: Main: 194551808 01:08:30 INFO - PROCESS | 14061 | 01:08:33 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:08:34 INFO - PROCESS | 14061 | RSS: Main: 189374464 01:08:34 INFO - PROCESS | 14061 | 01:08:37 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:08:37 INFO - PROCESS | 14061 | RSS: Main: 192663552 01:08:37 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | Cycle 1(1): loaded http://localhost:58648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58648/tests/kraken/driver.html?testName=ai-astar) 01:08:39 INFO - PROCESS | 14061 | RSS: Main: 244432896 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | __start_tp_report 01:08:39 INFO - PROCESS | 14061 | _x_x_mozilla_page_load 01:08:39 INFO - PROCESS | 14061 | _x_x_mozilla_page_load_details 01:08:39 INFO - PROCESS | 14061 | |i|pagename|runs| 01:08:39 INFO - PROCESS | 14061 | |0;ai-astar;105;115;115;114;113;115;115;113;115;115 01:08:39 INFO - PROCESS | 14061 | |1;audio-beat-detection;148;124;123;174;123;124;150;123;166;122 01:08:39 INFO - PROCESS | 14061 | |2;audio-dft;162;161;160;162;162;162;161;162;161;161 01:08:39 INFO - PROCESS | 14061 | |3;audio-fft;75;77;77;122;76;76;77;75;97;75 01:08:39 INFO - PROCESS | 14061 | |4;audio-oscillator;85;85;126;85;85;85;120;85;85;129 01:08:39 INFO - PROCESS | 14061 | |5;imaging-gaussian-blur;117;117;116;116;119;118;117;117;117;117 01:08:39 INFO - PROCESS | 14061 | |6;imaging-darkroom;147;146;147;147;146;146;147;148;147;147 01:08:39 INFO - PROCESS | 14061 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 01:08:39 INFO - PROCESS | 14061 | |8;json-parse-financial;64;63;63;62;63;62;62;64;64;62 01:08:39 INFO - PROCESS | 14061 | |9;json-stringify-tinderbox;65;66;65;66;66;66;66;67;75;66 01:08:39 INFO - PROCESS | 14061 | |10;stanford-crypto-aes;82;79;79;82;81;80;81;80;80;79 01:08:39 INFO - PROCESS | 14061 | |11;stanford-crypto-ccm;141;128;138;140;127;129;127;129;170;140 01:08:39 INFO - PROCESS | 14061 | |12;stanford-crypto-pbkdf2;167;168;164;173;162;167;164;164;166;167 01:08:39 INFO - PROCESS | 14061 | |13;stanford-crypto-sha256-iterative;68;68;68;66;67;68;68;70;67;66 01:08:39 INFO - PROCESS | 14061 | __end_tp_report 01:08:39 INFO - PROCESS | 14061 | __start_cc_report 01:08:39 INFO - PROCESS | 14061 | _x_x_mozilla_cycle_collect,1915 01:08:39 INFO - PROCESS | 14061 | __end_cc_report 01:08:39 INFO - PROCESS | 14061 | __startTimestamp1470038919816__endTimestamp 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | ------- Summary: start ------- 01:08:39 INFO - PROCESS | 14061 | Number of tests: 14 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.10 (2.7%) stddev-sans-first:0.88 01:08:39 INFO - PROCESS | 14061 | Values: 105.0 115.0 115.0 114.0 113.0 115.0 115.0 113.0 115.0 115.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:136.00 stddev:20.13 (14.8%) stddev-sans-first:21.00 01:08:39 INFO - PROCESS | 14061 | Values: 148.0 124.0 123.0 174.0 123.0 124.0 150.0 123.0 166.0 122.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 01:08:39 INFO - PROCESS | 14061 | Values: 162.0 161.0 160.0 162.0 162.0 162.0 161.0 162.0 161.0 161.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.50 stddev:15.33 (20.0%) stddev-sans-first:16.00 01:08:39 INFO - PROCESS | 14061 | Values: 75.0 77.0 77.0 122.0 76.0 76.0 77.0 75.0 97.0 75.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.00 stddev:19.44 (22.9%) stddev-sans-first:20.13 01:08:39 INFO - PROCESS | 14061 | Values: 85.0 85.0 126.0 85.0 85.0 85.0 120.0 85.0 85.0 129.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 01:08:39 INFO - PROCESS | 14061 | Values: 117.0 117.0 116.0 116.0 119.0 118.0 117.0 117.0 117.0 117.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 01:08:39 INFO - PROCESS | 14061 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 148.0 147.0 147.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:08:39 INFO - PROCESS | 14061 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 01:08:39 INFO - PROCESS | 14061 | Values: 64.0 63.0 63.0 62.0 63.0 62.0 62.0 64.0 64.0 62.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.00 stddev:2.94 (4.4%) stddev-sans-first:3.04 01:08:39 INFO - PROCESS | 14061 | Values: 65.0 66.0 65.0 66.0 66.0 66.0 66.0 67.0 75.0 66.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:1.16 (1.4%) stddev-sans-first:1.05 01:08:39 INFO - PROCESS | 14061 | Values: 82.0 79.0 79.0 82.0 81.0 80.0 81.0 80.0 80.0 79.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:139.00 stddev:13.05 (9.4%) stddev-sans-first:13.76 01:08:39 INFO - PROCESS | 14061 | Values: 141.0 128.0 138.0 140.0 127.0 129.0 127.0 129.0 170.0 140.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:167.00 stddev:3.05 (1.8%) stddev-sans-first:3.22 01:08:39 INFO - PROCESS | 14061 | Values: 167.0 168.0 164.0 173.0 162.0 167.0 164.0 164.0 166.0 167.0 01:08:39 INFO - PROCESS | 14061 | 01:08:39 INFO - PROCESS | 14061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.24 01:08:39 INFO - PROCESS | 14061 | Values: 68.0 68.0 68.0 66.0 67.0 68.0 68.0 70.0 67.0 66.0 01:08:39 INFO - PROCESS | 14061 | -------- Summary: end -------- 01:08:39 INFO - PROCESS | 14061 | 01:08:41 INFO - TEST-INFO | 14061: exit 0 01:08:41 INFO - TEST-OK | kraken | took 65001ms 01:08:41 INFO - SUITE-END | took 1186s 01:08:41 INFO - Completed test suite (00:19:46) 01:08:41 INFO - javascript benchmark 01:08:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2638.947221055579, 2652.1910817200746, 2681.7184195659447, 2693.070890542763, 2698.9055383061586, 4585.220512512872, 4656.278276867091, 4768.4993075727025, 4779.474257831635, 4787.5212478752155, 4699.67102302839, 4720.716756994582, 4773.618110551156, 4786.0, 4867.805287788484, 4357.455318085247, 4360.97819510902, 4376.343548467724, 4382.649388048964, 4492.191405547001, 4432.623227025707, 4439.822407103712, 4440.53374395687, 4449.221386257392, 4468.463784345883, 4279.593438623326, 4319.69762116652, 4330.307150855848, 4343.109662519176, 4345.891352716208, 4332.1119170569955, 4340.435743353375, 4354.08564201518, 4387.6709246806295, 4403.427554417937, 4335.479742430897, 4387.056782791683, 4403.22943484892, 4404.339349097661, 4452.30989196675, 4585.082983403299, 4775.307580400822, 4788.569028787391, 4833.854984350475, 4836.298736683197, 5020.573251273646, 5088.465711100355, 5093.923591146136, 5103.642745007851, 5153.613478989091, 5141.974290128563, 5171.172612382001, 5177.197534382177, 5185.662931909414, 5190.92213616796, 4584.679072464895, 4662.813487460531, 4785.066911952171, 4836.927446088312, 4850.369451971221, 4944.579710724557, 5179.48205179479, 5218.060749065129, 5218.217267409843, 5235.267062611238, 4955.281484184773, 5007.4241462231585, 5008.474110218374, 5008.774605142778, 5016.54851063406, 4894.804207831647, 4967.155583550732, 5095.108356037678, 5097.413797413345, 5109.0, 4963.503649635008, 4995.875103122451, 4996.725180115129, 5016.046951079284, 5025.070361983045, 4970.279309500174, 4970.925436118461, 4984.102861484895, 4993.275974983607, 5023.271625614266, 4206.20082184384, 4230.915381692349, 4301.526832048472, 4303.397524346594, 4340.696151269444, 3687.6865466435115, 3708.0, 3749.9500139960855, 3761.6426439488205, 3764.604716504782, 4385.407969924083, 4388.05656783793, 4391.538888416734, 4394.0, 4434.157510073076, 5045.5459008689395, 5048.949510504922, 5049.596032317406, 5050.4697006814495, 5086.821961231339, 4280.464941882265, 4382.255016647177, 4394.296912494049, 4428.31361139024, 4451.221036318631, 4673.719576825401, 4675.6727029108315, 4677.812887484531, 4709.646776491777, 4726.550977657117, 4843.515648435128, 4871.732054737024, 4876.146674332049, 4880.80476780939, 4912.140375434285, 4955.132851750857, 5018.598512118949, 5018.899622007466, 5157.226416037624, 5211.374635043668, 4785.9760701197665, 4790.377250957354, 4798.184308667465, 4809.254565542346, 4816.95183048165, 4980.402351717817, 5027.798888044437, 5047.167217409086, 5053.67151135175, 5062.088824011713, 5043.672161309503, 5046.091703493406, 5046.621503387188, 5067.214581739836, 5103.617228707936, 4808.903821923472, 4877.756112194447, 4913.63147763912, 4925.211966085552, 4977.900441991213, 4891.095147397743, 4891.315215869852, 4950.77721502526, 4967.652264341606, 5027.245913113063, 4889.608831293417, 4890.584300334369, 4935.309056731989, 4936.086823937583, 4946.480619534897, 4794.568488836021, 4932.53140951609, 4987.827860452718, 4991.700497970133, 5001.649884508195, 4803.759812009455, 4858.8299409521915, 4873.878153046202, 4874.098291816025, 4892.0705066037335], "value": 4666.082872773445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4420545762424, 574.4370516893447, 578.167438888001, 583.5914859598282, 588.0972706894916, 29036.41927161458, 29584.556231656516, 31905.840470797673, 42780.786096069474, 44154.55845441553, 41115.79442102785, 41458.58541414585, 41577.16845663093, 41587.58412415883, 41592.0, 7707.922920770777, 7846.254605812439, 7849.529028258295, 7851.921480785176, 7855.5286682799215, 7759.728409505668, 7831.686732530692, 7848.921510784905, 7850.2542258485355, 7852.097008843999, 7868.449208555404, 7911.129775724666, 7915.0, 7918.287354138127, 7919.485233459806, 7822.9608851955945, 7833.099193592753, 7834.56909869957, 7840.0, 7871.212878712112, 7669.156392796788, 7724.420668449832, 7731.574763388011, 7732.342750866183, 7734.265244801735, 39234.41148382777, 39581.0, 39614.0, 39632.603673963466, 39661.80169099136, 3038.453078445879, 3047.43622429849, 3192.696693814107, 3424.5548078749853, 3731.067233191702, 30362.392752145053, 30446.695533044607, 30730.0, 31769.6823031769, 31824.522632160537, 3408.233147541808, 3481.582210134775, 3487.2851065531504, 3519.102628829632, 3618.3848745713294, 261208.0, 267312.0, 267732.0, 268362.0, 268428.0, 56380.718096409255, 56430.51049129321, 56585.7170714152, 56785.0, 56811.0, 33387.49918751221, 33984.830075849466, 34247.657523424445, 36142.28932830048, 58994.70502647545, 14838.258087095603, 14867.0, 14932.402703891723, 14958.401663933539, 15013.399464021317, 11636.592719254786, 11707.121965852595, 11707.76584468306, 11721.589744358907, 11724.824127638092, 18684.159212835453, 18778.718319225223, 18795.248190072245, 18795.248190072518, 18795.55657764482, 6574.572652777554, 6654.800355989328, 6661.300563440769, 6891.241963384024, 6897.172339319314, 778.723553138639, 863.4646519158163, 871.2376670413388, 897.0132853860831, 980.5146452506056, 27673.72326276752, 27959.58060629092, 28624.710943133417, 28813.711862881522, 28981.0, 896.8878890138733, 900.8513595256841, 917.2111983694018, 937.0535758883441, 957.6791774755395, 14472.34874430632, 15117.924410377878, 15186.804451510203, 15315.770263446057, 15369.0, 385175.0, 386485.0, 387119.0, 387754.0, 387804.0, 50213.24680129801, 50426.74786626043, 50664.24003639948, 50690.0, 50961.49038509642, 1059.0997651995897, 1168.6669299249672, 1180.415694231361, 1198.922070065443, 1211.9878801211876, 27785.166445006682, 28671.42657146887, 29542.0, 29889.5516567256, 29997.850010749808, 43262.78368608137, 43734.12531749411, 43836.561634383244, 43866.342004869315, 43922.34116488319, 289863.0, 291424.0, 292470.0, 292711.0, 292766.0, 23785.405364866016, 24947.376315592257, 25819.870900645376, 25977.350566235997, 25992.480150396506, 42241.57758422499, 42618.78690606651, 42952.78523607362, 43307.566924331615, 43788.562114379725, 34801.47797782985, 35347.82326088456, 35424.645753542136, 35933.1016724584, 36193.0, 35933.281334372645, 36140.27719445649, 36413.0, 36512.81743591265, 36904.0, 34865.651343487254, 35026.474602880466, 35867.0, 35966.10084747902, 36060.0, 31402.0, 32749.672503275615, 33201.33597328088, 33239.66760332366, 33622.83188584042, 25262.494750104528, 25493.617595735708, 25515.0, 25551.488970220118, 25768.484630307663], "value": 17509.245570446343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.4994657852955, 366.4228839577665, 366.57111179919485, 367.31495760406847, 386.14468951272926, 12912.935435322823, 13546.39041243144, 14774.70450590989, 17042.403515876947, 17069.658606827856, 16461.884528867784, 16608.33566657335, 16948.915255423704, 16949.152542372893, 17075.316987320522, 4922.187839006559, 5106.821261255856, 5130.640855140123, 5131.4098878629065, 5132.127538318495, 3697.2605478904325, 5654.123610840326, 5880.353161152269, 5953.732082056296, 6039.0, 5101.7194054327, 6009.098635204732, 6010.12853136295, 6019.759209631631, 6020.458158765732, 5310.70791106489, 5452.073147564924, 5455.345358556999, 5455.972720136394, 5456.727163641802, 4611.262198048296, 4871.098846713334, 5267.789288428458, 5284.837335786159, 5286.154215325568, 11980.70048248792, 12160.51357945681, 12204.450799714034, 12278.570250041295, 13379.464821407131, 1827.4974382044911, 1883.5479484923658, 1928.421473557941, 1941.553442708171, 2036.7963203679662, 8903.888946708541, 8935.374523783337, 8953.731388058368, 9433.386829856106, 9562.28282878787, 1667.1414221675846, 1667.7998640163257, 1692.7376256680234, 1729.2218501674172, 1736.2013473802067, 64114.67942660257, 64232.0, 65882.3411765881, 68190.0, 71654.64172679155, 9652.0, 9749.707508774749, 9827.4103553787, 9990.600375985025, 10011.899881001096, 13184.934075329562, 13192.538261160813, 13218.0, 13226.272555009567, 13250.602481925558, 6754.966225168842, 7072.469564782662, 7122.608256545836, 7170.39051680613, 7204.3155900189395, 6728.360805723449, 6810.353016463428, 6925.099737034153, 6929.826754331182, 6945.722171113099, 4098.036892206787, 4175.248455278079, 4228.788560571959, 4229.555896630809, 4414.227510185705, 1701.829817018313, 1736.8263173682783, 1786.2944137065786, 1812.8005919348861, 1816.8728189026642, 809.1786836361098, 814.3932770086324, 819.663937785505, 848.295914391054, 855.0543378062515, 16489.09309987962, 17218.827811721974, 17658.5585360367, 17676.646467070586, 18000.639987200444, 833.083608031173, 845.5180547088223, 848.0798333807887, 861.4960248254841, 877.2981614708208, 7936.4047696423, 9494.715158545254, 9887.357321774061, 9900.257480688833, 10033.799324013478, 286966.0, 291610.0, 294003.0, 397221.0, 397387.0, 48423.5157648426, 49274.50725492699, 57543.71228143916, 87222.0, 89433.55283223542, 899.2985471332371, 901.8962819275736, 920.7836158502746, 926.1479438916214, 929.2565947242314, 15540.222988850739, 15960.361585536448, 16166.757498637295, 16349.591260218589, 16720.41478548245, 27344.042958496357, 31292.374152516368, 39567.0, 39672.80163599279, 40013.599864000986, 55354.0, 55708.442915570326, 56394.7180264096, 57411.71294143503, 57894.710526447096, 5534.584906131976, 6323.430891219812, 6567.2447668516825, 6993.720251189896, 7168.781307177896, 10320.329178603366, 11692.532298707956, 11790.646280611596, 11976.76046479083, 12040.879591203975, 9979.503074538878, 10145.492725363554, 10310.948445258025, 10343.63797267092, 10730.0, 10466.372017678963, 10531.420771857622, 10550.947245264031, 10620.575176992834, 10782.245242832927, 10428.113610343205, 10464.63373781914, 10704.036636702735, 10794.406307653155, 10870.021698047214, 6915.619640919797, 6972.442204623517, 7056.0, 7065.470089743392, 7229.674664640209, 7885.842283154419, 9508.572114255014, 10472.842907356244, 10599.576016959236, 10877.564897404016], "value": 7920.159408306425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1220.371508673033, 1348.6763176837562, 1394.6861956059886, 1431.6134643646217, 1672.7490876368543, 6235.781747638834, 6884.208316043657, 7191.856162876739, 7203.6038017908995, 7501.0998680158455, 7283.7086516539275, 7317.414606831454, 7334.669939852706, 7340.119185697724, 7344.596047217415, 2173.07644251193, 2191.4740462289014, 2193.517426166241, 2193.967090493644, 2198.604251234785, 2105.9365020664545, 2143.399848042543, 2152.7524334701475, 2156.35309407178, 2158.363282831561, 2142.1752625239237, 2153.8707677539396, 2165.675148727688, 2169.739631244253, 2176.5102851858364, 2087.290321290761, 2093.6859471079306, 2096.088201632287, 2096.3501314592527, 2099.5066159452517, 2057.0434747842323, 2109.8523103382768, 2114.06980928391, 2116.0, 2117.1743020222125, 7305.598192099433, 7341.449391295674, 7348.301911318416, 7393.07586551681, 7409.88885166723, 4454.398656181406, 4557.817687292504, 4563.133004729124, 4578.221702310615, 4604.217283061887, 2910.0833237530323, 2983.8508074596402, 3051.8474076296097, 3053.4961731314306, 3055.251463391461, 938.1603464898946, 940.2431043010374, 953.1993125774313, 957.2533423929347, 967.5404183013083, 9896.95051524745, 9936.652217172437, 9967.950160249226, 9989.75025624358, 9992.400455972593, 3857.61423857612, 3906.3554513504955, 3983.6813054956115, 4053.7162398631813, 4060.9390859136547, 8012.679492820338, 8060.919390806134, 8063.354931605458, 8067.1529489402765, 8077.071136819223, 4467.6649251305635, 4470.240059189946, 4470.798814053375, 4472.2620767573635, 4476.395686582335, 3502.299540091941, 3942.0, 4141.8964525887095, 4177.997280652621, 4182.9581704182565, 3490.5462289902152, 3558.092686365012, 3698.519192504957, 3711.2206436648607, 3714.0, 1163.959261425846, 1191.684203686024, 1197.53900241705, 1209.3832145605804, 1210.189173253922, 790.9644066017044, 793.1275596843541, 883.8718385834018, 885.5085427587751, 903.1239697493552, 5092.567131793839, 5186.92219616706, 5203.739813009334, 5223.085959956992, 5302.2576839241765, 848.3171047306977, 855.3542075732782, 905.8777065096259, 926.2589928057527, 954.6086104697041, 3571.321448924696, 3639.162992511684, 3741.8316175772156, 3769.566499852552, 3789.8673546426294, 8680.8697869532, 8786.472811631322, 8892.377533572588, 9077.818443631091, 9110.681126160685, 8907.421017633833, 9064.50145242018, 9078.409903356262, 9083.318751093562, 9105.271578273721, 6998.4751143664425, 7121.359077683033, 7183.856322873513, 7185.568865868065, 7214.855702885913, 5348.0, 5356.3572371315695, 5408.891822163613, 5474.972625137008, 5641.746121424628, 8565.700200492953, 8626.482411055356, 8636.956815215884, 8710.738677839676, 8730.039695633348, 8410.789730256793, 8596.613152408281, 8757.562121893752, 8770.736877893672, 8800.47197168172, 6106.297775755667, 6964.4080253179045, 7089.539179953286, 7220.74727384539, 7233.638318083969, 7074.398676112588, 7349.30181632744, 7353.0, 7358.595277259588, 7362.705491780269, 6406.423421892052, 6569.080328754074, 6596.868062638624, 6662.666866656745, 6775.86448271022, 6496.123023391781, 6536.738530458919, 6543.789398961208, 6554.246261679968, 6577.50668699859, 6034.969825150846, 6170.228721409824, 6181.5981961174175, 6195.845103872439, 6196.411340922605, 4385.561443855589, 4446.73319600825, 4487.147441986012, 4595.540445955377, 4619.584237418649, 4553.408056952575, 4687.460941991714, 4740.099381117577, 4811.522066136013, 4915.877103072309], "value": 4053.9631984624225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.8023584080745, 294.26580681200403, 299.38177663125657, 299.93551386451907, 302.6504387432515, 4717.4290011943485, 4777.307290442888, 4781.5218478152165, 4782.282657601361, 4801.567858892699, 4692.389989301395, 4710.362197169579, 4715.764211789406, 4745.644076694253, 4756.619470442365, 3543.149644085414, 3649.7627654202524, 3681.153334733013, 3723.3484140275477, 3728.5152930119184, 3730.2725968436166, 3735.6637902588764, 3738.1589142442867, 3748.700103991674, 3752.6997840172858, 3708.128589781399, 3715.2012317351764, 3716.684081853046, 3717.814109294538, 3723.6276372362818, 3564.6078931317534, 3624.1845584743355, 3723.478712980185, 3723.888283351504, 3745.8501659933568, 3323.8171900545462, 3327.5674162358982, 3328.417526932777, 3329.417351963397, 3330.5670262865674, 4625.190591646448, 4629.305604159369, 4632.907341853144, 4639.979204574988, 4641.489436162019, 4127.525334586501, 4180.47744031996, 4215.810288536993, 4246.5541118182455, 4251.957480425187, 4859.1496488114435, 4875.463698993108, 4919.655624106314, 4931.5315045070665, 4931.580815630676, 3524.4537096750046, 3533.522974398449, 3539.0, 3550.218951830593, 3580.5703315602036, 5002.299678045113, 5189.195674670432, 5235.842924712265, 5244.685318880841, 5271.235670827708, 3687.225682606629, 3716.1638631307737, 3731.3470142724914, 3731.533558305212, 3741.4574886641285, 3785.050698890074, 3796.4115562087923, 3796.886093417202, 3803.1633040730994, 3803.459598862465, 4288.785560721952, 4298.699091063658, 4301.376300436419, 4305.56944305567, 4315.28797748368, 4722.173619616553, 4955.752212389366, 4968.453470118284, 4978.27814966835, 5001.799928002839, 1240.7406482420351, 1250.0811903251104, 1250.1748845761936, 1250.9624711258678, 1254.1659796235401, 801.9077806052262, 820.5733018830175, 823.9382046346548, 829.672279449614, 840.5881118252013, 4240.0, 4264.168487144977, 4267.8079486423185, 4416.889577760518, 4467.30756732707, 5109.131447653907, 5130.9230361544605, 5134.897302053938, 5135.871603209875, 5139.8458046258675, 4362.8691139265875, 4459.687821852504, 4462.107578484316, 4464.549021568004, 4482.618977386894, 2704.418550011757, 2708.485387776316, 2715.6198132261497, 2717.8505182215167, 2723.1966569861543, 4862.95137048632, 4869.707817530889, 4870.561649451566, 4870.780814863339, 4907.803687852446, 5069.96229159511, 5153.433122356538, 5215.29593504872, 5237.240600112962, 5238.60710446718, 4831.637627177905, 4842.370491836039, 4852.4662287148385, 4859.514048595112, 4862.0584546349655, 5056.64603477753, 5081.4918508148885, 5096.51583099605, 5110.565601923878, 5124.461931497139, 4783.402074740658, 4989.0, 5016.0, 5032.723200223876, 5041.521055499722, 4805.255185446262, 4836.637252206169, 4840.7337596432535, 4842.370491836039, 4843.515648435269, 3629.0, 3645.5078564393466, 3646.234290798962, 3668.4313931340685, 3669.889903302905, 4868.853934381833, 5113.079645663816, 5126.74366281677, 5130.358705161855, 5147.253648221062, 4934.0, 4936.827211047596, 4939.357883475125, 4939.975300123477, 4948.851534453972, 4866.80532778699, 4910.189818679878, 4955.5044495550155, 4972.65191436596, 4988.176950803222, 4657.93013104797, 4839.2983017462975, 4894.216925291937, 4913.975430122827, 4914.680545764514, 4696.342512048248, 4807.471178170328, 4944.258361245842, 4944.456109827845, 4996.500349964975, 4834.927476087932, 4836.95163048365, 4838.540338667821, 4838.612910967044, 4859.878503037311], "value": 3752.4003341961106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.5679829711539, 673.562184580023, 685.1709431587778, 731.2358585278383, 749.7338444852079, 12982.805257921127, 14129.576112716635, 14135.363908624111, 14161.433542658282, 14168.929155354223, 12687.175333603309, 12756.872431275684, 12792.424340904658, 12797.808032879491, 12803.679908002305, 605.0500713879211, 717.7057406463351, 742.153944503264, 748.5658318175459, 754.2457542457543, 751.8496300739846, 761.2653789093524, 762.1806557950225, 762.3443838299058, 762.6491813765674, 806.9556174410405, 807.3662175192475, 807.4912804932884, 808.2160304504621, 808.7735434078468, 638.8977763557808, 778.2101167315179, 804.7947773317795, 805.6414895371591, 806.5684858600679, 591.1959734760723, 591.630231105559, 592.1680039544403, 592.2153147080093, 592.3543337761861, 12943.805842912363, 13017.869821301856, 13020.348982550835, 13046.673833154247, 13051.86948130516, 12405.689857753629, 12806.103572749911, 12936.741265174738, 13263.801042984363, 13532.797008044887, 11554.53781848725, 11604.0, 11810.350430726307, 11844.644660660195, 11862.644120676394, 4167.083241686824, 4176.540580536139, 4223.72545784523, 4228.302330115527, 4233.682473814476, 64719.352806471805, 65030.049098526644, 65905.0, 65958.34041659618, 66816.6659166701, 10198.388096714221, 10317.9484102579, 10320.741981450374, 10376.533056012497, 10805.459727013618, 19488.70766938497, 19514.414567562995, 19554.902225488782, 19624.41126766199, 19643.116059777345, 6687.699053542602, 6781.559198652072, 6783.457323414115, 6791.660416979132, 6818.113645226089, 3667.8166091695844, 3677.981610091986, 3699.315626609086, 3791.0901383668274, 3807.7144214184045, 2738.7945904057274, 2808.648918885139, 2825.39254060378, 2836.773058155343, 2838.0634390651035, 472.2208356212277, 481.91084649339984, 485.13887849068186, 487.33965476778457, 494.56231235356967, 474.5136235358785, 490.24991762603275, 508.4204007431531, 542.7015141672065, 604.7943699142313, 8035.0, 8150.836983260301, 8199.95900020496, 8318.41771076031, 8365.456245344034, 514.6911852888237, 521.5254118751917, 535.5447869311055, 585.5023230254335, 622.9657368844667, 3642.1987162824134, 3693.6675699187203, 3996.160806230724, 4131.0, 4224.429701990253, 60223.698881506185, 89193.55403222943, 99582.0, 105135.0, 105563.4721826386, 88028.55985720031, 88052.0, 88180.55909720411, 89586.55206724055, 90481.54759226294, 78316.21683783203, 78417.60791196008, 79784.0, 80304.59847700724, 80414.59792700999, 7063.929360706327, 7099.07711997437, 7184.425245980414, 7193.4604904631315, 7216.494845360774, 35113.648863511036, 44006.0, 44032.89917752082, 44351.0, 45884.54115458803, 58297.12554311604, 64405.35594644181, 65578.34421655913, 67614.66192669005, 70170.29829701637, 9973.551190196604, 10106.0, 10326.277160598986, 10358.274920755475, 10388.792224155626, 11401.429928503376, 11460.885391146316, 11826.586069487526, 11962.401879906143, 12359.75280494403, 10524.263301568817, 10635.840462392916, 11038.573898527344, 11111.444427778417, 11217.66347009591, 10565.313254638424, 10570.2072344576, 10740.946295268786, 11093.445327733742, 11244.0, 10097.141742951637, 10279.924930798521, 10318.587256509656, 10470.952904709467, 10529.157667386744, 7590.240975902366, 7714.614269286401, 7756.418268629988, 7838.098618658927, 7914.010748656418, 8446.450980686235, 8827.911720882708, 8876.51179185151, 8915.98456676272, 8957.238634716123], "value": 6419.920636593807, "unit": "score"}], "name": "dromaeo_css", "value": 6311.323797249639, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 114.0, 113.0, 115.0, 115.0, 113.0, 115.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 123.0, 174.0, 123.0, 124.0, 150.0, 123.0, 166.0, 122.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 122.0, 76.0, 76.0, 77.0, 75.0, 97.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 126.0, 85.0, 85.0, 85.0, 120.0, 85.0, 85.0, 129.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 64.0, 64.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 75.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 82.0, 81.0, 80.0, 81.0, 80.0, 80.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 128.0, 138.0, 140.0, 127.0, 129.0, 127.0, 129.0, 170.0, 140.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 164.0, 173.0, 162.0, 167.0, 164.0, 164.0, 166.0, 167.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 66.0, 67.0, 68.0, 68.0, 70.0, 67.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1532.0, "alertThreshold": 2.0}]} 01:08:41 INFO - Return code: 0 01:08:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:08:41 INFO - # TBPL SUCCESS # 01:08:41 INFO - Running post-action listener: _resource_record_post_action 01:08:41 INFO - [mozharness: 2016-08-01 08:08:41.623851Z] Finished run-tests step (success) 01:08:41 INFO - Running post-run listener: _resource_record_post_run 01:08:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530657280; Read time: 12; Write time: 1085808 01:08:41 INFO - TinderboxPrint: CPU usage
13.1% 01:08:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:08:41 INFO - TinderboxPrint: I/O write bytes / time
530,657,280 / 1,085,808 01:08:41 INFO - TinderboxPrint: CPU idle
8,346.3 (86.9%) 01:08:41 INFO - TinderboxPrint: CPU user
1,199.9 (12.5%) 01:08:41 INFO - TinderboxPrint: Swap in / out
0 / 0 01:08:41 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 236888064; Read time: 0; Write time: 660604 01:08:41 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293769216; Read time: 0; Write time: 425204 01:08:42 INFO - Running post-run listener: _upload_blobber_files 01:08:42 INFO - Blob upload gear active. 01:08:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:08:42 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 01:08:42 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'] 01:08:42 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 01:08:42 INFO - (blobuploader) - INFO - Open directory for files ... 01:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:08:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:08:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:08:48 INFO - (blobuploader) - INFO - Done attempting. 01:08:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:08:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:08:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:08:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:08:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:08:49 INFO - (blobuploader) - INFO - Done attempting. 01:08:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:08:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:08:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:08:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:08:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:08:49 INFO - (blobuploader) - INFO - Done attempting. 01:08:49 INFO - (blobuploader) - INFO - Iteration through files over. 01:08:49 INFO - Return code: 0 01:08:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:08:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:08:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/202a51291cf53aace514b32224b7030a2db2ce5dfd8df2a12911a3e8dd802f9f801f0b07619d90c4203ebff67e2f4637acf0e44f9ea988dad0c3b2d26cfcf5e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c84d26681cce76ab8c5e41846c3a898a68c2ce05c1c900e41623f7ab13c2aabdde6e8daca65726c864a764e12615770cf865dd2ad76da100eff159b1ce74cc8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79a3f0a2e047d88462e0e076eed365a750df718423312205933b203552416ffe35824d85b4780bcbc55a05cb7b3f8184781a53380a4305575f98ebf58e06a08a"} 01:08:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:08:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:08:49 INFO - Contents: 01:08:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/202a51291cf53aace514b32224b7030a2db2ce5dfd8df2a12911a3e8dd802f9f801f0b07619d90c4203ebff67e2f4637acf0e44f9ea988dad0c3b2d26cfcf5e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c84d26681cce76ab8c5e41846c3a898a68c2ce05c1c900e41623f7ab13c2aabdde6e8daca65726c864a764e12615770cf865dd2ad76da100eff159b1ce74cc8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79a3f0a2e047d88462e0e076eed365a750df718423312205933b203552416ffe35824d85b4780bcbc55a05cb7b3f8184781a53380a4305575f98ebf58e06a08a"} 01:08:49 INFO - Running post-run listener: copy_logs_to_upload_dir 01:08:49 INFO - Copying logs to upload dir... 01:08:49 INFO - mkdir: /builds/slave/test/build/upload/logs 01:08:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.403911 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-01 01:08:50.033071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 01:08:50.036733) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470036872.600807-431168425 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/202a51291cf53aace514b32224b7030a2db2ce5dfd8df2a12911a3e8dd802f9f801f0b07619d90c4203ebff67e2f4637acf0e44f9ea988dad0c3b2d26cfcf5e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c84d26681cce76ab8c5e41846c3a898a68c2ce05c1c900e41623f7ab13c2aabdde6e8daca65726c864a764e12615770cf865dd2ad76da100eff159b1ce74cc8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79a3f0a2e047d88462e0e076eed365a750df718423312205933b203552416ffe35824d85b4780bcbc55a05cb7b3f8184781a53380a4305575f98ebf58e06a08a"} build_url:https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/a99FpB0lTz6t7MBuDr3jIg/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/202a51291cf53aace514b32224b7030a2db2ce5dfd8df2a12911a3e8dd802f9f801f0b07619d90c4203ebff67e2f4637acf0e44f9ea988dad0c3b2d26cfcf5e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c84d26681cce76ab8c5e41846c3a898a68c2ce05c1c900e41623f7ab13c2aabdde6e8daca65726c864a764e12615770cf865dd2ad76da100eff159b1ce74cc8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79a3f0a2e047d88462e0e076eed365a750df718423312205933b203552416ffe35824d85b4780bcbc55a05cb7b3f8184781a53380a4305575f98ebf58e06a08a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 01:08:50.063705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:08:50.064224) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470036872.600807-431168425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:08:50.147378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 01:08:50.147689) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 01:08:50.148071) ========= ========= Total master_lag: 0.18 =========