builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1469442837.87 results: success (0) buildid: 20160725003007 builduid: a9650385bb4b4eb0afa235298df8e1d7 revision: 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:57.872978) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:57.873396) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:57.873668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:57.892109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:57.892418) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 03:33:59-- 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% 46.2M=0s 2016-07-25 03:33:59 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112950 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.019125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.019447) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020673 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.070142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.070505) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 --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 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 --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=3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 03:34:00,014 truncating revision to first 12 chars 2016-07-25 03:34:00,015 Setting DEBUG logging. 2016-07-25 03:34:00,015 attempt 1/10 2016-07-25 03:34:00,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/05b9ca6b58ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 03:34:00,311 unpacking tar archive at: autoland-05b9ca6b58ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652505 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.738915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.739181) ========= script_repo_revision: 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.739550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.739813) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 03:33:58.756435) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-25 03:33:58.756699) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:00 INFO - MultiFileLogger online at 20160725 03:34:00 in /builds/slave/test 03:34:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:34:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:00 INFO - {'append_to_log': False, 03:34:00 INFO - 'base_work_dir': '/builds/slave/test', 03:34:00 INFO - 'blob_upload_branch': 'Autoland', 03:34:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:00 INFO - 'branch': 'Autoland', 03:34:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:00 INFO - 'config_files': ('talos/linux_config.py',), 03:34:00 INFO - 'default_actions': ('clobber', 03:34:00 INFO - 'read-buildbot-config', 03:34:00 INFO - 'download-and-extract', 03:34:00 INFO - 'populate-webroot', 03:34:00 INFO - 'create-virtualenv', 03:34:00 INFO - 'install', 03:34:00 INFO - 'run-tests'), 03:34:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:00 INFO - 'download_minidump_stackwalk': True, 03:34:00 INFO - 'download_symbols': 'ondemand', 03:34:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:00 INFO - 'installer_path': 'installer.exe', 03:34:00 INFO - 'log_level': 'info', 03:34:00 INFO - 'log_name': 'talos', 03:34:00 INFO - 'log_to_console': True, 03:34:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:00 INFO - 'opt_config_files': (), 03:34:00 INFO - 'pip_index': False, 03:34:00 INFO - 'sps_profile': False, 03:34:00 INFO - 'sps_profile_interval': 0, 03:34:00 INFO - 'suite': 'dromaeojs', 03:34:00 INFO - 'system_bits': '32', 03:34:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:00 INFO - 'title': 'talos-linux64-ix-059', 03:34:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:00 INFO - 'use_talos_json': True, 03:34:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:00 INFO - 'work_dir': 'build'} 03:34:00 INFO - [mozharness: 2016-07-25 10:34:00.790778Z] Running clobber step. 03:34:00 INFO - Running pre-action listener: _resource_record_pre_action 03:34:00 INFO - Running main action method: clobber 03:34:00 INFO - rmtree: /builds/slave/test/build 03:34:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:01 INFO - Running post-action listener: _resource_record_post_action 03:34:01 INFO - [mozharness: 2016-07-25 10:34:01.260375Z] Finished clobber step (success) 03:34:01 INFO - [mozharness: 2016-07-25 10:34:01.260476Z] Running read-buildbot-config step. 03:34:01 INFO - Running pre-action listener: _resource_record_pre_action 03:34:01 INFO - Running main action method: read_buildbot_config 03:34:01 INFO - Using buildbot properties: 03:34:01 INFO - { 03:34:01 INFO - "project": "", 03:34:01 INFO - "product": "firefox", 03:34:01 INFO - "script_repo_revision": "production", 03:34:01 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:34:01 INFO - "repository": "", 03:34:01 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 03:34:01 INFO - "buildid": "20160725003007", 03:34:01 INFO - "pgo_build": "True", 03:34:01 INFO - "basedir": "/builds/slave/test", 03:34:01 INFO - "buildnumber": 43, 03:34:01 INFO - "slavename": "talos-linux64-ix-059", 03:34:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:34:01 INFO - "platform": "ubuntu64_hw", 03:34:01 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 03:34:01 INFO - "branch": "autoland", 03:34:01 INFO - "repo_path": "integration/autoland", 03:34:01 INFO - "revision": "05b9ca6b58ec97e6e73941831fe7a881cb70bcd3", 03:34:01 INFO - "stage_platform": "linux64-pgo", 03:34:01 INFO - "builduid": "a9650385bb4b4eb0afa235298df8e1d7", 03:34:01 INFO - "slavebuilddir": "test" 03:34:01 INFO - } 03:34:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:34:01 INFO - Running post-action listener: _resource_record_post_action 03:34:01 INFO - [mozharness: 2016-07-25 10:34:01.263290Z] Finished read-buildbot-config step (success) 03:34:01 INFO - [mozharness: 2016-07-25 10:34:01.263378Z] Running download-and-extract step. 03:34:01 INFO - Running pre-action listener: _resource_record_pre_action 03:34:01 INFO - Running main action method: download_and_extract 03:34:01 INFO - mkdir: /builds/slave/test/build/tests 03:34: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')]} 03:34:01 INFO - https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:02 INFO - Downloaded 1361 bytes. 03:34:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:34:02 INFO - Using the following test package requirements: 03:34:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:34:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:34:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:34:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:34:02 INFO - u'jsshell-linux-x86_64.zip'], 03:34:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:34:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:34:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:34:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:34:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:34:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:34:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:34:02 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')]} 03:34:02 INFO - https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:34:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:34:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:05 INFO - Downloaded 24309270 bytes. 03:34:05 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'] 03:34:05 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 03:34:06 INFO - Return code: 0 03:34:06 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 03:34:06 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')]} 03:34:06 INFO - https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:34:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:34:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:25 INFO - Downloaded 24309270 bytes. 03:34:25 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'] 03:34:25 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 03:34:27 INFO - Return code: 0 03:34: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')]} 03:34:27 INFO - https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:34:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:34:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:34:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:28 INFO - Downloaded 14403248 bytes. 03:34:28 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'] 03:34:28 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 03:34:28 INFO - Return code: 0 03:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:28 INFO - https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:34:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:34:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:34:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MWoaZCadQC-SghJFFdzRSg/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 03:34:30 INFO - Downloaded 60863029 bytes. 03:34:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:34:30 INFO - mkdir: /builds/slave/test/properties 03:34:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:30 INFO - Contents: 03:34:30 INFO - build_url:https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:34:31 INFO - Running post-action listener: _resource_record_post_action 03:34:31 INFO - Running post-action listener: set_extra_try_arguments 03:34:31 INFO - [mozharness: 2016-07-25 10:34:31.127268Z] Finished download-and-extract step (success) 03:34:31 INFO - [mozharness: 2016-07-25 10:34:31.127499Z] Running populate-webroot step. 03:34:31 INFO - Running pre-action listener: _resource_record_pre_action 03:34:31 INFO - Running main action method: populate_webroot 03:34:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:34:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:34:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:34:31 INFO - '--tppagecycles', 03:34:31 INFO - '7'], 03:34:31 INFO - 'tests': ['tsvgm']}}, 03:34:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:34:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:34:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:31 INFO - 'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:31 INFO - 'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['damp', 'tps']}, 03:34:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:31 INFO - 'tests': ['damp', 'tps']}, 03:34:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['dromaeo_dom']}, 03:34:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['basic_compositor_video']}, 03:34:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:34:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['a11yr', 03:34:31 INFO - 'ts_paint', 03:34:31 INFO - 'tpaint', 03:34:31 INFO - 'sessionrestore', 03:34:31 INFO - 'sessionrestore_no_auto_restore', 03:34:31 INFO - 'tabpaint']}, 03:34:31 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:31 INFO - 'ts_paint', 03:34:31 INFO - 'tpaint', 03:34:31 INFO - 'sessionrestore', 03:34:31 INFO - 'sessionrestore_no_auto_restore', 03:34:31 INFO - 'tabpaint']}, 03:34:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:34:31 INFO - 'ts_paint', 03:34:31 INFO - 'tpaint', 03:34:31 INFO - 'sessionrestore', 03:34:31 INFO - 'sessionrestore_no_auto_restore', 03:34:31 INFO - 'tabpaint']}, 03:34:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:34:31 INFO - 'ts_paint', 03:34:31 INFO - 'tpaint', 03:34:31 INFO - 'sessionrestore', 03:34:31 INFO - 'sessionrestore_no_auto_restore', 03:34:31 INFO - 'tabpaint']}, 03:34:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['a11yr', 03:34:31 INFO - 'ts_paint', 03:34:31 INFO - 'tpaint', 03:34:31 INFO - 'sessionrestore', 03:34:31 INFO - 'sessionrestore_no_auto_restore', 03:34:31 INFO - 'tabpaint']}, 03:34:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['a11yr', 03:34:31 INFO - 'ts_paint', 03:34:31 INFO - 'tpaint', 03:34:31 INFO - 'sessionrestore', 03:34:31 INFO - 'sessionrestore_no_auto_restore', 03:34:31 INFO - 'tabpaint']}, 03:34:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['tsvgx', 03:34:31 INFO - 'tsvgr_opacity', 03:34:31 INFO - 'tart', 03:34:31 INFO - 'tscrollx', 03:34:31 INFO - 'cart']}, 03:34:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:31 INFO - 'tsvgr_opacity', 03:34:31 INFO - 'tart', 03:34:31 INFO - 'tscrollx', 03:34:31 INFO - 'cart']}, 03:34:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:31 INFO - 'talos_options': ['--disable-e10s'], 03:34:31 INFO - 'tests': ['tp5o']}, 03:34:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:31 INFO - 'tests': ['tp5o']}, 03:34:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:31 INFO - 'talos_options': ['--disable-e10s', 03:34:31 INFO - '--xperf_path', 03:34:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:31 INFO - 'tests': ['tp5n']}, 03:34:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:31 INFO - 'talos_options': ['--xperf_path', 03:34:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:31 INFO - 'tests': ['tp5n']}}, 03:34:31 INFO - 'talos.zip': {'path': '', 03:34:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:34:31 INFO - Running post-action listener: _resource_record_post_action 03:34:31 INFO - [mozharness: 2016-07-25 10:34:31.147484Z] Finished populate-webroot step (success) 03:34:31 INFO - [mozharness: 2016-07-25 10:34:31.147573Z] Running create-virtualenv step. 03:34:31 INFO - Running pre-action listener: _resource_record_pre_action 03:34:31 INFO - Running main action method: create_virtualenv 03:34:31 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:31 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 03:34:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:31 INFO - Using real prefix '/usr' 03:34:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:33 INFO - Installing pip.................done. 03:34:33 INFO - Return code: 0 03:34:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:33 INFO - Using env: {'DISPLAY': ':0', 03:34:33 INFO - 'HOME': '/home/cltbld', 03:34:33 INFO - 'LANG': 'en_US.UTF-8', 03:34:33 INFO - 'LANGUAGE': 'en_US:en', 03:34:33 INFO - 'LOGNAME': 'cltbld', 03:34:33 INFO - 'MAIL': '/var/mail/cltbld', 03:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:33 INFO - 'MOZ_NO_REMOTE': '1', 03:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:33 INFO - 'NO_EM_RESTART': '1', 03:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:33 INFO - 'PWD': '/builds/slave/test', 03:34:33 INFO - 'SHELL': '/bin/bash', 03:34:33 INFO - 'SHLVL': '1', 03:34:33 INFO - 'TERM': 'linux', 03:34:33 INFO - 'TMOUT': '86400', 03:34:33 INFO - 'USER': 'cltbld', 03:34:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:33 INFO - '_': '/tools/buildbot/bin/python'} 03:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:34:33 INFO - Cleaning up... 03:34:33 INFO - Return code: 0 03:34:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:33 INFO - Using env: {'DISPLAY': ':0', 03:34:33 INFO - 'HOME': '/home/cltbld', 03:34:33 INFO - 'LANG': 'en_US.UTF-8', 03:34:33 INFO - 'LANGUAGE': 'en_US:en', 03:34:33 INFO - 'LOGNAME': 'cltbld', 03:34:33 INFO - 'MAIL': '/var/mail/cltbld', 03:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:33 INFO - 'MOZ_NO_REMOTE': '1', 03:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:33 INFO - 'NO_EM_RESTART': '1', 03:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:33 INFO - 'PWD': '/builds/slave/test', 03:34:33 INFO - 'SHELL': '/bin/bash', 03:34:33 INFO - 'SHLVL': '1', 03:34:33 INFO - 'TERM': 'linux', 03:34:33 INFO - 'TMOUT': '86400', 03:34:33 INFO - 'USER': 'cltbld', 03:34:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:33 INFO - '_': '/tools/buildbot/bin/python'} 03:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:34 INFO - Downloading/unpacking psutil>=3.1.1 03:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:36 INFO - Installing collected packages: psutil 03:34:36 INFO - Running setup.py install for psutil 03:34:36 INFO - building 'psutil._psutil_linux' extension 03:34:36 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 03:34:36 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 03:34:36 INFO - building 'psutil._psutil_posix' extension 03:34:36 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 03:34:36 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 03:34:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:36 INFO - Successfully installed psutil 03:34:36 INFO - Cleaning up... 03:34:36 INFO - Return code: 0 03:34:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:34:36 INFO - Using env: {'DISPLAY': ':0', 03:34:36 INFO - 'HOME': '/home/cltbld', 03:34:36 INFO - 'LANG': 'en_US.UTF-8', 03:34:36 INFO - 'LANGUAGE': 'en_US:en', 03:34:36 INFO - 'LOGNAME': 'cltbld', 03:34:36 INFO - 'MAIL': '/var/mail/cltbld', 03:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:36 INFO - 'MOZ_NO_REMOTE': '1', 03:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:36 INFO - 'NO_EM_RESTART': '1', 03:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:36 INFO - 'PWD': '/builds/slave/test', 03:34:36 INFO - 'SHELL': '/bin/bash', 03:34:36 INFO - 'SHLVL': '1', 03:34:36 INFO - 'TERM': 'linux', 03:34:36 INFO - 'TMOUT': '86400', 03:34:36 INFO - 'USER': 'cltbld', 03:34:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:36 INFO - '_': '/tools/buildbot/bin/python'} 03:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:38 INFO - Installing collected packages: mozsystemmonitor 03:34:38 INFO - Running setup.py install for mozsystemmonitor 03:34:38 INFO - Successfully installed mozsystemmonitor 03:34:38 INFO - Cleaning up... 03:34:39 INFO - Return code: 0 03:34:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:39 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')]} 03:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:39 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')]} 03:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:39 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 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:39 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 03:34:39 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 03:34:39 INFO - Using env: {'DISPLAY': ':0', 03:34:39 INFO - 'HOME': '/home/cltbld', 03:34:39 INFO - 'LANG': 'en_US.UTF-8', 03:34:39 INFO - 'LANGUAGE': 'en_US:en', 03:34:39 INFO - 'LOGNAME': 'cltbld', 03:34:39 INFO - 'MAIL': '/var/mail/cltbld', 03:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:39 INFO - 'MOZ_NO_REMOTE': '1', 03:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:39 INFO - 'NO_EM_RESTART': '1', 03:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:39 INFO - 'PWD': '/builds/slave/test', 03:34:39 INFO - 'SHELL': '/bin/bash', 03:34:39 INFO - 'SHLVL': '1', 03:34:39 INFO - 'TERM': 'linux', 03:34:39 INFO - 'TMOUT': '86400', 03:34:39 INFO - 'USER': 'cltbld', 03:34:39 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:39 INFO - '_': '/tools/buildbot/bin/python'} 03:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:39 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 03:34:39 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 03:34:39 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 03:34:39 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 03:34:39 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 03:34:39 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 03:34:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:41 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 03:34:41 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 03:34:41 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 03:34:41 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 03:34:41 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 03:34:41 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 03:34:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:41 INFO - warning: no files found matching '*.txt' 03:34:41 INFO - no previously-included directories found matching 'build' 03:34:41 INFO - no previously-included directories found matching 'dist' 03:34:41 INFO - no previously-included directories found matching '.git*' 03:34:41 INFO - Installing collected packages: jsonschema, functools32 03:34:41 INFO - Running setup.py install for functools32 03:34:41 INFO - warning: no files found matching '*.txt' 03:34:41 INFO - no previously-included directories found matching 'build' 03:34:41 INFO - no previously-included directories found matching 'dist' 03:34:41 INFO - no previously-included directories found matching '.git*' 03:34:41 INFO - Successfully installed jsonschema functools32 03:34:41 INFO - Cleaning up... 03:34:41 INFO - Return code: 0 03:34:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:41 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 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:41 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 03:34:41 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 03:34:41 INFO - Using env: {'DISPLAY': ':0', 03:34:41 INFO - 'HOME': '/home/cltbld', 03:34:41 INFO - 'LANG': 'en_US.UTF-8', 03:34:41 INFO - 'LANGUAGE': 'en_US:en', 03:34:41 INFO - 'LOGNAME': 'cltbld', 03:34:41 INFO - 'MAIL': '/var/mail/cltbld', 03:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:41 INFO - 'MOZ_NO_REMOTE': '1', 03:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:41 INFO - 'NO_EM_RESTART': '1', 03:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:41 INFO - 'PWD': '/builds/slave/test', 03:34:41 INFO - 'SHELL': '/bin/bash', 03:34:41 INFO - 'SHLVL': '1', 03:34:41 INFO - 'TERM': 'linux', 03:34:41 INFO - 'TMOUT': '86400', 03:34:41 INFO - 'USER': 'cltbld', 03:34:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:41 INFO - '_': '/tools/buildbot/bin/python'} 03:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:41 INFO - Cleaning up... 03:34:41 INFO - Return code: 0 03:34:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:41 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 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:41 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 03:34:41 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 03:34:41 INFO - Using env: {'DISPLAY': ':0', 03:34:41 INFO - 'HOME': '/home/cltbld', 03:34:41 INFO - 'LANG': 'en_US.UTF-8', 03:34:41 INFO - 'LANGUAGE': 'en_US:en', 03:34:41 INFO - 'LOGNAME': 'cltbld', 03:34:41 INFO - 'MAIL': '/var/mail/cltbld', 03:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:41 INFO - 'MOZ_NO_REMOTE': '1', 03:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:41 INFO - 'NO_EM_RESTART': '1', 03:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:41 INFO - 'PWD': '/builds/slave/test', 03:34:41 INFO - 'SHELL': '/bin/bash', 03:34:41 INFO - 'SHLVL': '1', 03:34:41 INFO - 'TERM': 'linux', 03:34:41 INFO - 'TMOUT': '86400', 03:34:41 INFO - 'USER': 'cltbld', 03:34:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:41 INFO - '_': '/tools/buildbot/bin/python'} 03:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:43 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 03:34:43 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 03:34:43 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 03:34:43 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 03:34:43 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 03:34:43 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 03:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:44 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 03:34:44 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 03:34:44 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 03:34:44 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 03:34:44 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 03:34:44 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 03:34:44 INFO - Downloading docopt-0.6.1.tar.gz 03:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:44 INFO - Running setup.py install for blobuploader 03:34:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:44 INFO - Running setup.py install for requests 03:34:45 INFO - Running setup.py install for docopt 03:34:45 INFO - Successfully installed blobuploader requests docopt 03:34:45 INFO - Cleaning up... 03:34:45 INFO - Return code: 0 03:34:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:45 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')]} 03:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:45 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')]} 03:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:45 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 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:45 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 03:34:45 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 03:34:45 INFO - Using env: {'DISPLAY': ':0', 03:34:45 INFO - 'HOME': '/home/cltbld', 03:34:45 INFO - 'LANG': 'en_US.UTF-8', 03:34:45 INFO - 'LANGUAGE': 'en_US:en', 03:34:45 INFO - 'LOGNAME': 'cltbld', 03:34:45 INFO - 'MAIL': '/var/mail/cltbld', 03:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:45 INFO - 'MOZ_NO_REMOTE': '1', 03:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:45 INFO - 'NO_EM_RESTART': '1', 03:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:45 INFO - 'PWD': '/builds/slave/test', 03:34:45 INFO - 'SHELL': '/bin/bash', 03:34:45 INFO - 'SHLVL': '1', 03:34:45 INFO - 'TERM': 'linux', 03:34:45 INFO - 'TMOUT': '86400', 03:34:45 INFO - 'USER': 'cltbld', 03:34:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:45 INFO - '_': '/tools/buildbot/bin/python'} 03:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:45 INFO - Running setup.py (path:/tmp/pip-Mtt9hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:45 INFO - Running setup.py (path:/tmp/pip-6EEHjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:45 INFO - Running setup.py (path:/tmp/pip-4QYpyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:45 INFO - Running setup.py (path:/tmp/pip-SpH0tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:45 INFO - Running setup.py (path:/tmp/pip-4XHVeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:45 INFO - Running setup.py (path:/tmp/pip-mcuyg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:45 INFO - Running setup.py (path:/tmp/pip-zgW3wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:46 INFO - Running setup.py (path:/tmp/pip-NZR9Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:46 INFO - Running setup.py (path:/tmp/pip-K901hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:46 INFO - Running setup.py (path:/tmp/pip-lyijBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:46 INFO - Running setup.py (path:/tmp/pip-F9vRzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:46 INFO - Running setup.py (path:/tmp/pip-ZC2WGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:46 INFO - Running setup.py (path:/tmp/pip-3Wtoq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:46 INFO - Running setup.py (path:/tmp/pip-JDZ911-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:46 INFO - Running setup.py (path:/tmp/pip-JTPFy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:46 INFO - Running setup.py (path:/tmp/pip-fgy8AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:46 INFO - Running setup.py (path:/tmp/pip-7KE8ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:46 INFO - Running setup.py install for manifestparser 03:34:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:46 INFO - Running setup.py install for mozcrash 03:34:46 INFO - Running setup.py install for mozdebug 03:34:47 INFO - Running setup.py install for mozdevice 03:34:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Running setup.py install for mozfile 03:34:47 INFO - Running setup.py install for mozhttpd 03:34:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Running setup.py install for mozinfo 03:34:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Running setup.py install for mozInstall 03:34:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Running setup.py install for mozleak 03:34:47 INFO - Running setup.py install for mozlog 03:34:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Running setup.py install for moznetwork 03:34:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:47 INFO - Running setup.py install for mozprocess 03:34:47 INFO - Running setup.py install for mozprofile 03:34:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Running setup.py install for mozrunner 03:34:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Running setup.py install for mozscreenshot 03:34:48 INFO - Running setup.py install for moztest 03:34:48 INFO - Running setup.py install for mozversion 03:34:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:48 INFO - Cleaning up... 03:34:48 INFO - Return code: 0 03:34:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:48 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 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:48 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 03:34:48 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 03:34:48 INFO - Using env: {'DISPLAY': ':0', 03:34:48 INFO - 'HOME': '/home/cltbld', 03:34:48 INFO - 'LANG': 'en_US.UTF-8', 03:34:48 INFO - 'LANGUAGE': 'en_US:en', 03:34:48 INFO - 'LOGNAME': 'cltbld', 03:34:48 INFO - 'MAIL': '/var/mail/cltbld', 03:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:48 INFO - 'MOZ_NO_REMOTE': '1', 03:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:48 INFO - 'NO_EM_RESTART': '1', 03:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:48 INFO - 'PWD': '/builds/slave/test', 03:34:48 INFO - 'SHELL': '/bin/bash', 03:34:48 INFO - 'SHLVL': '1', 03:34:48 INFO - 'TERM': 'linux', 03:34:48 INFO - 'TMOUT': '86400', 03:34:48 INFO - 'USER': 'cltbld', 03:34:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:48 INFO - '_': '/tools/buildbot/bin/python'} 03:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:48 INFO - Running setup.py (path:/tmp/pip-HON90M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:48 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)) 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:48 INFO - Running setup.py (path:/tmp/pip-KhMVdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:48 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)) 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:48 INFO - Running setup.py (path:/tmp/pip-Y65SWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:48 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)) 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:48 INFO - Running setup.py (path:/tmp/pip-RSxq4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:49 INFO - Running setup.py (path:/tmp/pip-OhDX5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:49 INFO - Running setup.py (path:/tmp/pip-btGY2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:49 INFO - Running setup.py (path:/tmp/pip-JASecd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:49 INFO - Running setup.py (path:/tmp/pip-dEVq2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:49 INFO - Running setup.py (path:/tmp/pip-14Z5iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:49 INFO - Running setup.py (path:/tmp/pip-xkYtoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:49 INFO - Running setup.py (path:/tmp/pip-yXGC6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:49 INFO - Running setup.py (path:/tmp/pip-Qy7MQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:49 INFO - Running setup.py (path:/tmp/pip-tmDInL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:49 INFO - Running setup.py (path:/tmp/pip-KxqKS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:49 INFO - Running setup.py (path:/tmp/pip-avOFQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:49 INFO - Running setup.py (path:/tmp/pip-9lhDUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:49 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)) 03:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:49 INFO - Running setup.py (path:/tmp/pip-tUXjID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:49 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)) 03:34:49 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)) 03:34:49 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)) 03:34:49 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)) 03:34:49 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)) 03:34:49 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)) 03:34:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:51 INFO - Downloading blessings-1.6.tar.gz 03:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:51 INFO - Installing collected packages: blessings 03:34:51 INFO - Running setup.py install for blessings 03:34:52 INFO - Successfully installed blessings 03:34:52 INFO - Cleaning up... 03:34:52 INFO - Return code: 0 03:34:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:52 INFO - Reading from file tmpfile_stdout 03:34:52 INFO - Current package versions: 03:34:52 INFO - argparse == 1.2.1 03:34:52 INFO - blessings == 1.6 03:34:52 INFO - blobuploader == 1.2.4 03:34:52 INFO - docopt == 0.6.1 03:34:52 INFO - functools32 == 3.2.3-2 03:34:52 INFO - jsonschema == 2.5.1 03:34:52 INFO - manifestparser == 1.1 03:34:52 INFO - mozInstall == 1.12 03:34:52 INFO - mozcrash == 0.17 03:34:52 INFO - mozdebug == 0.1 03:34:52 INFO - mozdevice == 0.48 03:34:52 INFO - mozfile == 1.2 03:34:52 INFO - mozhttpd == 0.7 03:34:52 INFO - mozinfo == 0.9 03:34:52 INFO - mozleak == 0.1 03:34:52 INFO - mozlog == 3.3 03:34:52 INFO - moznetwork == 0.27 03:34:52 INFO - mozprocess == 0.23 03:34:52 INFO - mozprofile == 0.28 03:34:52 INFO - mozrunner == 6.12 03:34:52 INFO - mozscreenshot == 0.1 03:34:52 INFO - mozsystemmonitor == 0.3 03:34:52 INFO - moztest == 0.7 03:34:52 INFO - mozversion == 1.4 03:34:52 INFO - psutil == 3.1.1 03:34:52 INFO - requests == 1.2.3 03:34:52 INFO - wsgiref == 0.1.2 03:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:52 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 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:52 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 03:34:52 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 03:34:52 INFO - Using env: {'DISPLAY': ':0', 03:34:52 INFO - 'HOME': '/home/cltbld', 03:34:52 INFO - 'LANG': 'en_US.UTF-8', 03:34:52 INFO - 'LANGUAGE': 'en_US:en', 03:34:52 INFO - 'LOGNAME': 'cltbld', 03:34:52 INFO - 'MAIL': '/var/mail/cltbld', 03:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:52 INFO - 'MOZ_NO_REMOTE': '1', 03:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:52 INFO - 'NO_EM_RESTART': '1', 03:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:52 INFO - 'PWD': '/builds/slave/test', 03:34:52 INFO - 'SHELL': '/bin/bash', 03:34:52 INFO - 'SHLVL': '1', 03:34:52 INFO - 'TERM': 'linux', 03:34:52 INFO - 'TMOUT': '86400', 03:34:52 INFO - 'USER': 'cltbld', 03:34:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:52 INFO - '_': '/tools/buildbot/bin/python'} 03:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 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)) 03:34:52 INFO - Cleaning up... 03:34:52 INFO - Return code: 0 03:34:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:52 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 0xf51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1212180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', '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 03:34:52 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 03:34:52 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 03:34:52 INFO - Using env: {'DISPLAY': ':0', 03:34:52 INFO - 'HOME': '/home/cltbld', 03:34:52 INFO - 'LANG': 'en_US.UTF-8', 03:34:52 INFO - 'LANGUAGE': 'en_US:en', 03:34:52 INFO - 'LOGNAME': 'cltbld', 03:34:52 INFO - 'MAIL': '/var/mail/cltbld', 03:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:52 INFO - 'MOZ_NO_REMOTE': '1', 03:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:52 INFO - 'NO_EM_RESTART': '1', 03:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:52 INFO - 'PWD': '/builds/slave/test', 03:34:52 INFO - 'SHELL': '/bin/bash', 03:34:52 INFO - 'SHLVL': '1', 03:34:52 INFO - 'TERM': 'linux', 03:34:52 INFO - 'TMOUT': '86400', 03:34:52 INFO - 'USER': 'cltbld', 03:34:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:52 INFO - '_': '/tools/buildbot/bin/python'} 03:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:52 INFO - Cleaning up... 03:34:52 INFO - Return code: 0 03:34:52 INFO - Running post-action listener: _resource_record_post_action 03:34:52 INFO - Running post-action listener: _start_resource_monitoring 03:34:52 INFO - Starting resource monitoring. 03:34:52 INFO - [mozharness: 2016-07-25 10:34:52.827094Z] Finished create-virtualenv step (success) 03:34:52 INFO - [mozharness: 2016-07-25 10:34:52.827581Z] Running install step. 03:34:52 INFO - Running pre-action listener: _resource_record_pre_action 03:34:52 INFO - Running main action method: install 03:34:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:53 INFO - Reading from file tmpfile_stdout 03:34:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:53 INFO - Reading from file tmpfile_stdout 03:34:53 INFO - Output received: 03:34:53 INFO - Usage: mozinstall [options] installer 03:34:53 INFO - Options: 03:34:53 INFO - -h, --help show this help message and exit 03:34:53 INFO - -d DEST, --destination=DEST 03:34:53 INFO - Directory to install application into. [default: 03:34:53 INFO - "/builds/slave/test"] 03:34:53 INFO - --app=APP Application being installed. [default: firefox] 03:34:53 INFO - mkdir: /builds/slave/test/build/application 03:34:53 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'] 03:34:53 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 03:35:10 INFO - Reading from file tmpfile_stdout 03:35:10 INFO - Output received: 03:35:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:10 INFO - Running post-action listener: _resource_record_post_action 03:35:10 INFO - [mozharness: 2016-07-25 10:35:10.352527Z] Finished install step (success) 03:35:10 INFO - [mozharness: 2016-07-25 10:35:10.352804Z] Running run-tests step. 03:35:10 INFO - Running pre-action listener: _resource_record_pre_action 03:35:10 INFO - Running main action method: run_tests 03:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:10 INFO - Python 2.7.3 03:35:10 INFO - Return code: 0 03:35:10 INFO - grabbing minidump binary from tooltool 03:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:10 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 0x12103b0>, '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 0x12112b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1211740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:10 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 03:35:10 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 03:35:10 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 03:35:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:10 INFO - Return code: 0 03:35:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 03:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 03:35:10 INFO - Using env: {'DISPLAY': ':0', 03:35:10 INFO - 'HOME': '/home/cltbld', 03:35:10 INFO - 'LANG': 'en_US.UTF-8', 03:35:10 INFO - 'LANGUAGE': 'en_US:en', 03:35:10 INFO - 'LOGNAME': 'cltbld', 03:35:10 INFO - 'MAIL': '/var/mail/cltbld', 03:35:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:10 INFO - 'MOZ_NO_REMOTE': '1', 03:35:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:10 INFO - 'NO_EM_RESTART': '1', 03:35:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:10 INFO - 'PWD': '/builds/slave/test', 03:35:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:10 INFO - 'SHELL': '/bin/bash', 03:35:10 INFO - 'SHLVL': '1', 03:35:10 INFO - 'TERM': 'linux', 03:35:10 INFO - 'TMOUT': '86400', 03:35:10 INFO - 'USER': 'cltbld', 03:35:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479', 03:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:10 INFO - '_': '/tools/buildbot/bin/python'} 03:35:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 03:35:10 INFO - mozversion application_buildid: 20160725003007 03:35:10 INFO - mozversion application_changeset: 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 03:35:10 INFO - mozversion application_display_name: Nightly 03:35:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:10 INFO - mozversion application_name: Firefox 03:35:10 INFO - mozversion application_remotingname: firefox 03:35:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:35:10 INFO - mozversion application_vendor: Mozilla 03:35:10 INFO - mozversion application_version: 50.0a1 03:35:10 INFO - mozversion platform_buildid: 20160725003007 03:35:10 INFO - mozversion platform_changeset: 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 03:35:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:35:10 INFO - mozversion platform_version: 50.0a1 03:35:10 INFO - using testdate: 1469442910 03:35:10 INFO - actual date: 1469442910 03:35:10 INFO - starting webserver on 'localhost:42928' 03:35:10 INFO - SUITE-START | Running 2 tests 03:35:10 INFO - TEST-START | dromaeo_css 03:35:10 INFO - operating with platform_type : linux_ 03:35:10 INFO - Initialising browser for dromaeo_css test... 03:35:10 INFO - TEST-INFO | started process 22916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFyY0_1/profile http://localhost:42928/getInfo.html) 03:35:13 INFO - PROCESS | 22916 | JavaScript error: , line 0: uncaught exception: undefined 03:35:14 INFO - PROCESS | 22916 | __metrics Screen width/height:1600/1200 03:35:14 INFO - PROCESS | 22916 | colorDepth:24 03:35:14 INFO - PROCESS | 22916 | Browser inner width/height: 1024/697 03:35:14 INFO - PROCESS | 22916 | __metrics 03:35:15 INFO - PROCESS | 22916 | 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" 03:35:15 INFO - PROCESS | 22916 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:16 INFO - TEST-INFO | 22916: exit 0 03:35:16 INFO - Browser initialized. 03:35:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:16 INFO - TEST-INFO | started process 22999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFyY0_1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:27 INFO - PROCESS | 22999 | RSS: Main: 157835264 03:35:27 INFO - PROCESS | 22999 | 03:36:19 INFO - PROCESS | 22999 | 1469442979498 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] 03:38:27 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:42928/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42928/tests/dromaeo/cssquery-ext.html) 03:38:28 INFO - PROCESS | 22999 | RSS: Main: 265084928 03:38:28 INFO - PROCESS | 22999 | 03:41:30 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:42928/tests/dromaeo/cssquery-ext.html (next: http://localhost:42928/tests/dromaeo/cssquery-jquery.html) 03:41:31 INFO - PROCESS | 22999 | RSS: Main: 243720192 03:41:31 INFO - PROCESS | 22999 | 03:44:33 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:42928/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42928/tests/dromaeo/cssquery-mootools.html) 03:44:33 INFO - PROCESS | 22999 | RSS: Main: 229011456 03:44:33 INFO - PROCESS | 22999 | 03:47:35 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:42928/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42928/tests/dromaeo/cssquery-prototype.html) 03:47:36 INFO - PROCESS | 22999 | RSS: Main: 237879296 03:47:36 INFO - PROCESS | 22999 | 03:50:38 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:42928/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42928/tests/dromaeo/cssquery-yui.html) 03:50:39 INFO - PROCESS | 22999 | RSS: Main: 182833152 03:50:39 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | Cycle 1(1): loaded http://localhost:42928/tests/dromaeo/cssquery-yui.html (next: http://localhost:42928/tests/dromaeo/cssquery-dojo.html) 03:53:42 INFO - PROCESS | 22999 | RSS: Main: 267579392 03:53:42 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | __start_tp_report 03:53:42 INFO - PROCESS | 22999 | _x_x_mozilla_page_load 03:53:42 INFO - PROCESS | 22999 | _x_x_mozilla_page_load_details 03:53:42 INFO - PROCESS | 22999 | |i|pagename|runs| 03:53:42 INFO - PROCESS | 22999 | |0;dojo.html;2998.505246634305;3038.9696103038964;3060.6939306069394;3078.30738083931;3108.8445577721122;5052.949470505294;5136.33227680402;5173.870653233671;5262.00021995821;5293.52358287754;5139.537441630253;5146.665466744659;5165.63840531163;5187.896242075156;5215.400228973669;4629.583337499616;4719.4100737407825;4723.126221648989;4732.100900828848;4895.55939965403;4848.563629273364;4874.366332376804;4875.561199492045;4885.682430642015;4905.043516514281;4664.930026049612;4675;4705.1530724469585;4720.362751028619;4726.503717109723;4690.695104818176;4698.741569213692;4716.2454007359;4812.133815913135;4819.397575303087;4722.220833562458;4724.669273150881;4735.857924262277;4745.477997420281;4784.617230621577;5130.461301563357;5132.178851383798;5212.478752124795;5219.556337711299;5249.212618107276;5546.528545073674;5588.888222235532;5639.718014099279;5640.407757185519;5643.68959707216;5572.86067848307;5637.746301416446;5654.773809047674;5658.801941932013;5661.801836935729;5031.84904452867;5170.741462926876;5221.425643179247;5282.022825777205;5286.841394758163;5764.913526297109;5779.624324418899;5792.4497172768515;5794.130880367894;5800.187973683687;5588.580856435784;5590.217369568264;5592.440755924456;5592.5805564582815;5596;5425.511703946664;5515.917261241085;5523.806666766724;5657.632253903483;5659.236003139606;5591.804286849941;5602.663840169522;5606.85982850432;5637.830865074055;5653.349864765522;5557.833265002057;5600.719964001783;5602.859928501739;5611;5616.466435688603;4158.334666453414;4245.57544245573;4269.295566231537;4300.09697963425;4327.6105150536605;3831.540215174197;3837.9040523987123;3846.211526637089;3869.4195870619633;3897.162110146332;5321.600879933943;5322.121849894801;5324.387695414999;5327.280817089643;5376.7042812644895;5455.072637651609;5488.835334939959;5507.7246137692955;5575.60970732053;5604.719764011783;5190.169572868323;5212.5569326607665;5246.658967167122;5248.737563121905;5252.422233554306;4805.327254184417;4818.469968303484;4819.759012049383;4822.132016237041;4860.3681521401995;5581.274434323512;5624.71876406178;5681.0910254359105;5737.053386191232;5738.77044918207;5520.1167813149705;5524.806631767869;5528.170774383874;5567.972160139173;5570.610057296112;5707.514861236841;5712.285964254468;5716.571257155647;5717.17101020358;5720.771169153354;5383.434739352311;5455.399906010256;5460.071787796163;5460.6177567569885;5473.945260547343;5627.8874422512135;5636.605437619327;5636.661800291831;5669.3480249770155;5689.91891540606;5456.699881506555;5457.836264912059;5466.808661696821;5476.424975377528;5492.670439773627;5186.481351864783;5305.389880163831;5344.171653393731;5456.945430545644;5516.503514683698;5360.463953604608;5361.946380536145;5365.275687782099;5402.162664786964;5404.351477822529;5439.700816455133;5445.50990410865;5488.231647569423;5493.313335833021;5498.477644623755;5231.42454330031;5277.313949186735;5346.064438723286;5351.090314646442;5358.812441564526 03:53:42 INFO - PROCESS | 22999 | |1;ext.html;599.2629066248514;607.4138456389585;640.433216603306;646.5474168082344;656.1240743607284;43363;44735.328970065435;44857.77571112148;44977;47921.52078479214;46123;46399.76800116003;46762.76618616911;46796.76601616995;46807.29789053167;8972.10278972104;9120.908790912106;9121.543922803867;9122.863157052616;9123.178913897747;8874;8983.775405614846;8991.910080899206;8995.055519170492;8998.640054397816;9022.09779022099;9034.277257819358;9052;9059.95470022649;9060.637574497012;8962.327825413087;8971.058038905887;9007.774805629846;9016.504092274923;9018.368714189977;8769.035406105324;8847.955760221157;8849.867251991225;8852.114788521161;8861.512616806072;43924;44244.11511769779;44305.77847110776;44326.55673443257;44342.77828610869;3530.0821786335737;3777;3823.713221508398;4120.21715873983;4265.7014009019385;33049.17377065569;33943.83028084844;34007.4898876517;34110.658893411;34820;4360.520342762294;4379.309150122987;4468.151051300242;4509.278515437547;4530.75080870552;360556;362939.2971245994;363619;363677;364599.9999999973;32824.50763238553;33628.66371336304;33706;59145.11282330768;59534.40465595375;34658.133546661535;34832.651673483444;34860.47709284363;34876.12809679778;34884.651153488645;15067.4726384576;15213.61965950838;15227.771583426258;15249.085054896741;15261.771073433907;12604.432800523999;12678.80981785274;12679.049071319689;12680.302583358003;12746.171498852545;8248.711295104762;8260.876086858701;8275.62759675816;8331.29184019353;8356.582170891432;3190.6649801770945;3212.9357412852078;3218.4045951499047;3248.871988847309;3305.2563173285816;986.8667729856521;1063.9041786959444;1072.1851392941421;1076.617800680747;1119.0320372877402;33532;34154.82922585371;34167.82916085453;34253;34273.82863085669;1103.2442776697987;1103.7682086761708;1107.291333546531;1110.3337997201777;1178.298912147271;17258.82741172572;17444.825551744572;17587.648247034987;17641.470755877344;17712.822871771376;592761.1085833716;595639;595684;597940;600659;60360;60939;61043.69478152581;61149;61154.388456114866;1249.5314257153568;1367.5760514240617;1386.0990356268505;1401.0262867307326;1404.789281607767;32383.51424728584;34286.65713342935;34366.48450273298;34592.13519661928;34878.47682284717;50945.49054509407;51660.48339516707;51831.222531661304;51856.740716296175;51865.7406712964;442163;442565;444954;445065;445445;24993.500129996934;26045.869770651025;27066.864665676545;27676.308092297048;27946;47608.76195619;48406.27390589214;48549.5145048545;48708.5129148704;48815.75592122017;41436;41678.37482437827;41955;42018;43874.561254388325;42017.57982420137;42064.369034463896;42383;43051.13897722091;43305.56694433141;41584.584154158074;42298;42911;43294.78352608217;43353;35602.8219858899;37457;37740.81129594444;38035.809820950715;38720.612793872824;28843.711562884102;29107.272318192216;29276.121716348545;29326.41347173002;29346.559801602565 03:53:42 INFO - PROCESS | 22999 | |2;jquery.html;384.73645552796336;391.4636947382087;395.81001119462655;402.81671839313117;416.23412920226775;14613.488527901525;18589.163487643054;18914.243430262806;20281.391558253257;20311.1875524979;18328.450146495594;19339.903300483515;19563.902180489076;19696.310629127984;19746.70379944302;5570.693611851347;5634.0703783875615;5770.971145144268;5818.06910894257;5904.852378690545;5834.329052159013;5853.678047707374;5866.384029676887;5868.6478811271245;5872.823815285548;6445.709943052574;6475.676216189196;6478.416942475176;6489.1239682642945;6498.44763195129;5819.359870414293;5888.646681199141;6093.756249750027;6466.773662921799;6484.740610375603;5705.286839145107;5714.7428365723645;5717.656940583578;5721.427857214246;5723.484886360206;12261.448234829453;12505.74988500225;12549.560765373168;12597.74804503914;18246.631502637356;2276.8064714499287;2276.84062115652;2332.3702600297993;2338.649202619604;2406.566817972764;9797.412155270635;10074.89925100747;10389.324693894949;12375;14156.787648185285;1850;1887.2639670528504;1893.1102381880494;1938.9903050484797;1944.3583617406364;84880.57559712161;85518.14481855163;87638.56180719119;87871.56064219637;89124.55437722834;10328.896711032794;10432.165426765841;10466.529006194587;10641.787164256826;10914.836277455845;12683.175593586388;13426.597202083953;14632.341544630517;14639.634009149857;14653.487127950471;7264.636768161571;7365.226651201547;7539.660715267826;7591.051118610174;7656.3874890008665;7189.173245076779;7190.316919892602;7325.2674732527385;7354.154272258758;7383.224761399975;4429.379886815848;4463.687541872037;4529.365888775574;4597.747123908151;4625.722456652612;1795.4882858385297;1866.0856180471471;1890.1777726688933;1903.200655724599;1929.3150931419143;908.2733812949614;954.5275088831073;999.645125980281;1015.1117771949545;1099.8075336816025;18782.342618008304;19629.90185049094;20106;20234.69647955282;20322.390328290174;968.9903100969041;982.7199248214224;1010.1211945607222;1053.441675911768;1057.7620035491952;10344.500047493071;10996.615118470816;11296.71758206035;11371.943140284411;11386.601468948547;487028;489293;490348;493831;498269;93707;93739;94555;94605;96538.51730741301;998.1814911772423;1002.2332915319786;1004.2869562610482;1008.2690049713899;1008.7326858382535;17246.568835779206;17318.134093295033;17913.28346866163;17938.103094844944;18291.908540457214;41874.37188442237;43323.783381082896;43490.782546087066;43943.56056439522;44096;59038.70480647569;59843.40156598378;59942.400575993684;61056;61412.69293653503;7313.707451702086;7315.963420182865;7550.395968322631;8071.596420179085;8262.876056859031;9324.393914395543;12598.118131730691;12898;13049.28228947417;13278.53525126616;11653.88346116528;11663.066954643438;11699.181057325906;11842.526298947945;12266.570670026505;11558.07535397183;11607.36159511235;11638.185327027028;12012.699682508008;12291.385430728249;11604.6518604442;11759.647210583697;11766.87863752992;11846.52613895469;12109.69725756828;6873.931260687329;7242.710291588488;7313.817154570966;7496.400287977058;7908.932294140448;10134.746631334276;11704.473298701749;11841.763164736829;12208.75582488363;12279.815802762787 03:53:42 INFO - PROCESS | 22999 | |3;mootools.html;1329.3884812986025;1438.7266419380314;1479.933402996865;1596.3056070609287;1770.4600096970428;8328.167183281668;8633.525156116419;8729.956350218255;8988.101189881025;8990.37067405282;8822.059146987669;8902.065283145273;8902.599383027764;8916.242119419858;8928.776780580472;2342.1099982006813;2370.668106465096;2371.027878569787;2371.905123795046;2372.383180373107;2370.0756704885107;2381.880905954695;2416.8549887006834;2422.2975337152293;2425.575524283252;2320.466292752668;2322.6167682332393;2335.8481698689616;2340.8010319122895;2351.2358483492935;2244.124791331374;2254.4589298568226;2282.9315120546325;2283.4633861042644;2284.680144779724;2254;2272.8522646027955;2277.0436416704856;2277.943051423711;2279.5213005268915;8618.698345557876;8888.822223555557;8941.329400294939;8942.86585701215;8947.910520894773;5049.924251136236;5205.6356055075785;5268.81559145428;5276.1030624793875;5277.23480095384;3351.9664803351898;3383.6785505377197;3392.423288041039;3393.745469089828;3421.4354631485776;1138.846255755479;1143.1826244235328;1156.1444531046964;1165.2309475746051;1182.0543565147934;11805.822912656316;11971.04231661465;12010.219335743148;12018.39908004605;12026.398680065962;4395.164918665443;4598.402207712976;4623.751587071539;4765.166095933268;4765.737884416321;10171.288009839389;10185.490725463696;10185.592576296865;10188.796224075477;10196.082352588155;5216.347956505437;5252.947470525322;5255.343082114736;5255.710935898563;5262.052830490472;4248.91502169961;4369.563043695669;4508.301213311942;4790.616750659939;4799.904001920012;4065.28857449951;4134.713543849975;4146.688998325138;4154.023804405962;4214.831406743757;1268.9682757931125;1291.3672300572653;1295.106376600143;1300.5253082624774;1302.1340808362334;851.3019324154258;951.5955718819474;997.3517213811081;1004.1715584642699;1005.8239808033711;5864.589478736448;5917.408259174134;5976.252968378953;6086.695665216722;6223.657698826608;446.9843555475543;451.97288162710345;452.9297958816389;460.62459095836783;462.4750907719762;4113.547509773923;4255.8084886180195;4300.978495107567;4313.956860431418;4316.2446571849805;10732.463376831127;11169.944150279196;11181.385023823768;11186;11205.775884482428;11110.333379997226;11110.61112861046;11126.666200014013;11132.777344453065;11133;7859.764207073797;8098.959505202436;8107.1892810718455;8357.749267521984;8359.749207523906;6201.410865967726;6208.0998255253635;6226.1905952225925;6281.748730050929;6585.3085426029575;10006.799864002534;10207.132393746615;10329.225308101772;10335.431551264752;10564.683059508227;9578.23374130054;9966.152877005246;10597;10653.840192397276;10672.733181670521;8408.327333813158;8681.392302539014;8702;8806.075362086889;8817.470951742916;8708.869366959374;8772.166644168794;8804.823903521765;8824.955875220583;8828.51443170606;7813.687452502064;7826.41301902371;7852.450328476952;7922.7227047053075;7993.240642138988;7520.962395187989;7561.470697051153;7576.740703768405;7768.7669369918995;7925.682972681028;7160.928390716234;7274.8908766367485;7284.344409003215;7286.6720997556295;7293.708251669874;5332.173513105475;5443.265159203615;5478.397376288684;5499.202615620793;5732.828015159552;5435.701036442875;5455.8363249102595;5497.285352904097;5518.889622207614;5609.747561359667 03:53:42 INFO - PROCESS | 22999 | |4;prototype.html;307.0680484728847;319.10013761193443;331.08290036598606;333.644668428124;341.56962227593226;5251.894962100756;5318.627696061272;5332.586864480915;5333.466653334669;5348.625596208257;4979.531038343688;5034.1945288753805;5103.540681338679;5126.205438157082;5245.160774276116;3953.2686453006213;3975.085730282037;4066.32905570582;4114.670826333886;4123.422720819072;4086.2031903778775;4086.795660216992;4103;4134.524529679095;4139.4204811326435;3875.457435958968;4002.5196976362877;4047.8583249586272;4056.5132184137797;4111.239420707164;4041.7777022263763;4044;4051.372037334218;4062.2484840304637;4062.9796851015703;3548.2193917338145;3566.6789988901123;3570.5001299818045;3571.9818302659173;3574.749767516275;4876.439869068732;5117.46266642001;5130.9230361544605;5136.666116702402;5138.203578445347;4548.863534093983;4615.930761038587;4625.699329543569;4661.160991021615;4675.275332323496;5375.247465354853;5376.569874410038;5382.596305277119;5399.460053994609;5404.51359377654;3850.8074596270076;3895.2988462076814;3899.395593682984;3934.8032598370255;3940.4286378474962;5601.271834661508;5626.677730733274;5641;5642.57680673947;5653.293338332708;3995.800209989489;3999.5000624921886;3999.7600143991453;4000.5399379071196;4005.118873847749;4068.6745060395688;4070.8778736637946;4084.6732261419015;4087.5912408758886;4097.13960068383;4418.955810441918;4578.381918441034;4593.19619066662;4605.194091034123;4705.3649956024055;5420.593455490854;5434.3207099112615;5438.401775804658;5479.808206712746;5485;1310.9250414660078;1359.422245545639;1375.312343828086;1377.4490203918513;1383.3567391163158;932.4591736792644;941.8963913969458;949.1173208915775;953.6042542344987;961.6393852305386;5305.124654432053;5308.46915308466;5321.574274058066;5349.973250133725;5353.598480114007;5570.161846590616;5601.915971260434;5625.8312250631725;5632.493075623213;5642.125470552071;5154.768035438415;5388.137897936312;5398.78404863801;5408.513233808976;5423;2981.329200929817;2992.6558445779015;2995.221242476972;3011.3525591997386;3015.1557563882147;5645.379008309083;5745.827625171251;5796.913046304308;5827.708614569255;5849.444302791228;5669.829905102853;5669.914951275734;5674.836658485001;5684.54523638108;5705.5435565154685;5688.544916406595;5725.456081672234;5748.45389687979;5753.453421924911;5761.193432919395;5382.519807053091;5562.7774889005605;5596.1605759136455;5601.599600099975;5622.437756224344;5467.6719396836315;5515.420880807457;5549.694766787866;5564.693941833238;5603.859903502445;5447.809326673548;5711.457411545896;5791.8552036199435;5797.101449275369;5805.680687562224;3972.364421692631;3981.5023122109737;3995.940060899031;3998.7600743955454;3999.5600483947323;5588.552915766648;5597.488678056983;5598.832035038955;5620;5641;5323.387810401853;5431.646942948696;5473.698946557977;5492.148716948879;5526.723663816712;5413.512783849473;5468.152436372368;5480.369757477941;5487.039768040497;5498.1752737089755;5217;5233.502817232356;5392.191171324333;5421.024215641222;5461.023742060507;5486.835394938158;5492.505674489155;5523.6685798852195;5529.972350138223;5540.506771952557;5394.703291319015;5412.404635490172;5417;5422.186671999231;5429.592780541396 03:53:42 INFO - PROCESS | 22999 | |5;yui.html;762.0550517358475;762.6682393158973;789.218673513222;831.8336332733455;887.1261807119988;14629.341679624416;15278.236088195601;15279.92360038201;15334.46329378472;15350.53948381549;13217.405216765244;13266.867331326685;13268.867311326883;13280.535181268657;13287;655.6459511863588;793.6150966781106;817.5094943034162;819.8073452738602;823.3618945317367;811.9553424561647;812.7033632724073;812.7764864662236;814.5764202614637;814.8288859339546;704.1339152842007;858.120426562775;871.6077765005741;872.5549969515529;874.5277550122926;837.526797359493;858.7853036740814;860.711661593367;860.9612567434481;867.3104881619128;634.6382561939696;635.9141515895341;635.9141515895387;636.5257882877286;636.7293900092442;13616.523421680293;13618.455261789517;13626.727465450735;13642.249676267802;13643.727125457435;14450.205238711867;15483.690326193526;15658.295376708076;15825.60435989098;16113;13181.60455186346;13184;13196.340182990813;13367.732645347136;13383.397747101306;4661.696989695659;4671.6262698984;4693.671442998992;4806.663533552653;4898.21628539432;64355.356446435406;66334.66832665805;67061.66469167623;75238;75605;11412.714682132848;11470.369129697947;11528.423578821194;11540.134489913291;11779.88220117788;22850.42873928165;22873;22913.88543057274;22922.65616015761;23028.539429211658;9108.407953483002;9111.95444022789;9123.635054597875;9322.906770932339;9624.855627165598;4711.693739906964;4766.213574760195;4839.685420447659;4947.6536642434685;5165.302684137669;3739.513863197767;3864.2078373933277;3871.4192871069004;3871.8838434847;3874.4188371744463;673.6160388578561;699.5243234600521;700.8878579427369;713.7715930902166;716.2515171645642;640.5068097564849;685.7428464325877;731.1043971135423;737.133867705444;740.3521918321469;10087.949560252151;10191.592336306612;10201.504419919873;10296;10330.328528645614;711.9359257666835;731.6890321613294;740.7703611880335;744.3301029073768;760.3878877503552;4564.863054108316;4724.740139292372;4862.975685121552;4880.487548807395;4882.780274887638;72343;72427.2757272431;72552.63723681348;72656.63671681608;95865;78706.60646696844;92207;93361;93454;95347.52326238324;25334.36664083376;25983;27171.282871713065;55029.72485137549;71207.64396177986;9428.340016198801;9860.802783944424;10394.16846652251;10470.319429237075;10562.577496900038;50777.49222507728;51366.74316628542;52146;52556.21165682442;53451;65602.34397655963;73703.6314818444;75547.62226188833;75963.62018189873;77925;13305.80041299362;13452.192868427926;13594.592162235149;13628.795568066686;13852.653683657989;15195.77206341928;15304;15350.385984560493;15693;15764;12703.80944285855;13100.868991309964;13947;14869.405223790927;15150.393984240507;13841.238731869844;13975.207845870787;14490.492832750802;14517.056391334529;14927.477538286108;13443.538722106056;13948.860511394756;14109.365078571283;14420.85579144195;14746.778798317819;11150.776984460103;11154.219204655596;11196.496157672762;11433.256838305484;11492.310461372344;12174.57388991381;12251.632451026484;12397.380130993595;12585.685357865761;12623.242605443336 03:53:42 INFO - PROCESS | 22999 | __end_tp_report 03:53:42 INFO - PROCESS | 22999 | __start_cc_report 03:53:42 INFO - PROCESS | 22999 | _x_x_mozilla_cycle_collect,921 03:53:42 INFO - PROCESS | 22999 | __end_cc_report 03:53:42 INFO - PROCESS | 22999 | __startTimestamp1469444022457__endTimestamp 03:53:42 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | ------- Summary: start ------- 03:53:42 INFO - PROCESS | 22999 | Number of tests: 6 03:53:42 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | [#0] dojo.html Cycles:165 Average:5183.74 Median:5360.46 stddev:579.22 (10.8%) stddev-sans-first:555.05 03:53:42 INFO - PROCESS | 22999 | Values: 2998.5 3039.0 3060.7 3078.3 3108.8 5052.9 5136.3 5173.9 5262.0 5293.5 5139.5 5146.7 5165.6 5187.9 5215.4 4629.6 4719.4 4723.1 4732.1 4895.6 4848.6 4874.4 4875.6 4885.7 4905.0 4664.9 4675.0 4705.2 4720.4 4726.5 4690.7 4698.7 4716.2 4812.1 4819.4 4722.2 4724.7 4735.9 4745.5 4784.6 5130.5 5132.2 5212.5 5219.6 5249.2 5546.5 5588.9 5639.7 5640.4 5643.7 5572.9 5637.7 5654.8 5658.8 5661.8 5031.8 5170.7 5221.4 5282.0 5286.8 5764.9 5779.6 5792.4 5794.1 5800.2 5588.6 5590.2 5592.4 5592.6 5596.0 5425.5 5515.9 5523.8 5657.6 5659.2 5591.8 5602.7 5606.9 5637.8 5653.3 5557.8 5600.7 5602.9 5611.0 5616.5 4158.3 4245.6 4269.3 4300.1 4327.6 3831.5 3837.9 3846.2 3869.4 3897.2 5321.6 5322.1 5324.4 5327.3 5376.7 5455.1 5488.8 5507.7 5575.6 5604.7 5190.2 5212.6 5246.7 5248.7 5252.4 4805.3 4818.5 4819.8 4822.1 4860.4 5581.3 5624.7 5681.1 5737.1 5738.8 5520.1 5524.8 5528.2 5568.0 5570.6 5707.5 5712.3 5716.6 5717.2 5720.8 5383.4 5455.4 5460.1 5460.6 5473.9 5627.9 5636.6 5636.7 5669.3 5689.9 5456.7 5457.8 5466.8 5476.4 5492.7 5186.5 5305.4 5344.2 5456.9 5516.5 5360.5 5361.9 5365.3 5402.2 5404.4 5439.7 5445.5 5488.2 5493.3 5498.5 5231.4 5277.3 5346.1 5351.1 5358.8 03:53:42 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | [#1] ext.html Cycles:180 Average:61573.71 Median:23588.35 stddev:127245.28 (539.4%) stddev-sans-first:127519.88 03:53:42 INFO - PROCESS | 22999 | Values: 599.3 607.4 640.4 646.5 656.1 43363.0 44735.3 44857.8 44977.0 47921.5 46123.0 46399.8 46762.8 46796.8 46807.3 8972.1 9120.9 9121.5 9122.9 9123.2 8874.0 8983.8 8991.9 8995.1 8998.6 9022.1 9034.3 9052.0 9060.0 9060.6 8962.3 8971.1 9007.8 9016.5 9018.4 8769.0 8848.0 8849.9 8852.1 8861.5 43924.0 44244.1 44305.8 44326.6 44342.8 3530.1 3777.0 3823.7 4120.2 4265.7 33049.2 33943.8 34007.5 34110.7 34820.0 4360.5 4379.3 4468.2 4509.3 4530.8 360556.0 362939.3 363619.0 363677.0 364600.0 32824.5 33628.7 33706.0 59145.1 59534.4 34658.1 34832.7 34860.5 34876.1 34884.7 15067.5 15213.6 15227.8 15249.1 15261.8 12604.4 12678.8 12679.0 12680.3 12746.2 8248.7 8260.9 8275.6 8331.3 8356.6 3190.7 3212.9 3218.4 3248.9 3305.3 986.9 1063.9 1072.2 1076.6 1119.0 33532.0 34154.8 34167.8 34253.0 34273.8 1103.2 1103.8 1107.3 1110.3 1178.3 17258.8 17444.8 17587.6 17641.5 17712.8 592761.1 595639.0 595684.0 597940.0 600659.0 60360.0 60939.0 61043.7 61149.0 61154.4 1249.5 1367.6 1386.1 1401.0 1404.8 32383.5 34286.7 34366.5 34592.1 34878.5 50945.5 51660.5 51831.2 51856.7 51865.7 442163.0 442565.0 444954.0 445065.0 445445.0 24993.5 26045.9 27066.9 27676.3 27946.0 47608.8 48406.3 48549.5 48708.5 48815.8 41436.0 41678.4 41955.0 42018.0 43874.6 42017.6 42064.4 42383.0 43051.1 43305.6 41584.6 42298.0 42911.0 43294.8 43353.0 35602.8 37457.0 37740.8 38035.8 38720.6 28843.7 29107.3 29276.1 29326.4 29346.6 03:53:42 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | [#2] jquery.html Cycles:180 Average:29061.73 Median:2372.61 stddev:81330.15 (3427.9%) stddev-sans-first:81529.80 03:53:42 INFO - PROCESS | 22999 | Values: 384.7 391.5 395.8 402.8 416.2 14613.5 18589.2 18914.2 20281.4 20311.2 18328.5 19339.9 19563.9 19696.3 19746.7 5570.7 5634.1 5771.0 5818.1 5904.9 5834.3 5853.7 5866.4 5868.6 5872.8 6445.7 6475.7 6478.4 6489.1 6498.4 5819.4 5888.6 6093.8 6466.8 6484.7 5705.3 5714.7 5717.7 5721.4 5723.5 12261.4 12505.7 12549.6 12597.7 18246.6 2276.8 2276.8 2332.4 2338.6 2406.6 9797.4 10074.9 10389.3 12375.0 14156.8 1850.0 1887.3 1893.1 1939.0 1944.4 84880.6 85518.1 87638.6 87871.6 89124.6 10328.9 10432.2 10466.5 10641.8 10914.8 12683.2 13426.6 14632.3 14639.6 14653.5 7264.6 7365.2 7539.7 7591.1 7656.4 7189.2 7190.3 7325.3 7354.2 7383.2 4429.4 4463.7 4529.4 4597.7 4625.7 1795.5 1866.1 1890.2 1903.2 1929.3 908.3 954.5 999.6 1015.1 1099.8 18782.3 19629.9 20106.0 20234.7 20322.4 969.0 982.7 1010.1 1053.4 1057.8 10344.5 10996.6 11296.7 11371.9 11386.6 487028.0 489293.0 490348.0 493831.0 498269.0 93707.0 93739.0 94555.0 94605.0 96538.5 998.2 1002.2 1004.3 1008.3 1008.7 17246.6 17318.1 17913.3 17938.1 18291.9 41874.4 43323.8 43490.8 43943.6 44096.0 59038.7 59843.4 59942.4 61056.0 61412.7 7313.7 7316.0 7550.4 8071.6 8262.9 9324.4 12598.1 12898.0 13049.3 13278.5 11653.9 11663.1 11699.2 11842.5 12266.6 11558.1 11607.4 11638.2 12012.7 12291.4 11604.7 11759.6 11766.9 11846.5 12109.7 6873.9 7242.7 7313.8 7496.4 7908.9 10134.7 11704.5 11841.8 12208.8 12279.8 03:53:42 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | [#3] mootools.html Cycles:180 Average:5879.62 Median:452.45 stddev:3351.40 (740.7%) stddev-sans-first:3343.35 03:53:42 INFO - PROCESS | 22999 | Values: 1329.4 1438.7 1479.9 1596.3 1770.5 8328.2 8633.5 8730.0 8988.1 8990.4 8822.1 8902.1 8902.6 8916.2 8928.8 2342.1 2370.7 2371.0 2371.9 2372.4 2370.1 2381.9 2416.9 2422.3 2425.6 2320.5 2322.6 2335.8 2340.8 2351.2 2244.1 2254.5 2282.9 2283.5 2284.7 2254.0 2272.9 2277.0 2277.9 2279.5 8618.7 8888.8 8941.3 8942.9 8947.9 5049.9 5205.6 5268.8 5276.1 5277.2 3352.0 3383.7 3392.4 3393.7 3421.4 1138.8 1143.2 1156.1 1165.2 1182.1 11805.8 11971.0 12010.2 12018.4 12026.4 4395.2 4598.4 4623.8 4765.2 4765.7 10171.3 10185.5 10185.6 10188.8 10196.1 5216.3 5252.9 5255.3 5255.7 5262.1 4248.9 4369.6 4508.3 4790.6 4799.9 4065.3 4134.7 4146.7 4154.0 4214.8 1269.0 1291.4 1295.1 1300.5 1302.1 851.3 951.6 997.4 1004.2 1005.8 5864.6 5917.4 5976.3 6086.7 6223.7 447.0 452.0 452.9 460.6 462.5 4113.5 4255.8 4301.0 4314.0 4316.2 10732.5 11169.9 11181.4 11186.0 11205.8 11110.3 11110.6 11126.7 11132.8 11133.0 7859.8 8099.0 8107.2 8357.7 8359.7 6201.4 6208.1 6226.2 6281.7 6585.3 10006.8 10207.1 10329.2 10335.4 10564.7 9578.2 9966.2 10597.0 10653.8 10672.7 8408.3 8681.4 8702.0 8806.1 8817.5 8708.9 8772.2 8804.8 8825.0 8828.5 7813.7 7826.4 7852.5 7922.7 7993.2 7521.0 7561.5 7576.7 7768.8 7925.7 7160.9 7274.9 7284.3 7286.7 7293.7 5332.2 5443.3 5478.4 5499.2 5732.8 5435.7 5455.8 5497.3 5518.9 5609.7 03:53:42 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | [#4] prototype.html Cycles:180 Average:4601.96 Median:5341.05 stddev:1352.07 (25.3%) stddev-sans-first:1316.87 03:53:42 INFO - PROCESS | 22999 | Values: 307.1 319.1 331.1 333.6 341.6 5251.9 5318.6 5332.6 5333.5 5348.6 4979.5 5034.2 5103.5 5126.2 5245.2 3953.3 3975.1 4066.3 4114.7 4123.4 4086.2 4086.8 4103.0 4134.5 4139.4 3875.5 4002.5 4047.9 4056.5 4111.2 4041.8 4044.0 4051.4 4062.2 4063.0 3548.2 3566.7 3570.5 3572.0 3574.7 4876.4 5117.5 5130.9 5136.7 5138.2 4548.9 4615.9 4625.7 4661.2 4675.3 5375.2 5376.6 5382.6 5399.5 5404.5 3850.8 3895.3 3899.4 3934.8 3940.4 5601.3 5626.7 5641.0 5642.6 5653.3 3995.8 3999.5 3999.8 4000.5 4005.1 4068.7 4070.9 4084.7 4087.6 4097.1 4419.0 4578.4 4593.2 4605.2 4705.4 5420.6 5434.3 5438.4 5479.8 5485.0 1310.9 1359.4 1375.3 1377.4 1383.4 932.5 941.9 949.1 953.6 961.6 5305.1 5308.5 5321.6 5350.0 5353.6 5570.2 5601.9 5625.8 5632.5 5642.1 5154.8 5388.1 5398.8 5408.5 5423.0 2981.3 2992.7 2995.2 3011.4 3015.2 5645.4 5745.8 5796.9 5827.7 5849.4 5669.8 5669.9 5674.8 5684.5 5705.5 5688.5 5725.5 5748.5 5753.5 5761.2 5382.5 5562.8 5596.2 5601.6 5622.4 5467.7 5515.4 5549.7 5564.7 5603.9 5447.8 5711.5 5791.9 5797.1 5805.7 3972.4 3981.5 3995.9 3998.8 3999.6 5588.6 5597.5 5598.8 5620.0 5641.0 5323.4 5431.6 5473.7 5492.1 5526.7 5413.5 5468.2 5480.4 5487.0 5498.2 5217.0 5233.5 5392.2 5421.0 5461.0 5486.8 5492.5 5523.7 5530.0 5540.5 5394.7 5412.4 5417.0 5422.2 5429.6 03:53:42 INFO - PROCESS | 22999 | 03:53:42 INFO - PROCESS | 22999 | [#5] yui.html Cycles:180 Average:18318.76 Median:4718.22 stddev:24015.68 (509.0%) stddev-sans-first:24046.87 03:53:42 INFO - PROCESS | 22999 | Values: 762.1 762.7 789.2 831.8 887.1 14629.3 15278.2 15279.9 15334.5 15350.5 13217.4 13266.9 13268.9 13280.5 13287.0 655.6 793.6 817.5 819.8 823.4 812.0 812.7 812.8 814.6 814.8 704.1 858.1 871.6 872.6 874.5 837.5 858.8 860.7 861.0 867.3 634.6 635.9 635.9 636.5 636.7 13616.5 13618.5 13626.7 13642.2 13643.7 14450.2 15483.7 15658.3 15825.6 16113.0 13181.6 13184.0 13196.3 13367.7 13383.4 4661.7 4671.6 4693.7 4806.7 4898.2 64355.4 66334.7 67061.7 75238.0 75605.0 11412.7 11470.4 11528.4 11540.1 11779.9 22850.4 22873.0 22913.9 22922.7 23028.5 9108.4 9112.0 9123.6 9322.9 9624.9 4711.7 4766.2 4839.7 4947.7 5165.3 3739.5 3864.2 3871.4 3871.9 3874.4 673.6 699.5 700.9 713.8 716.3 640.5 685.7 731.1 737.1 740.4 10087.9 10191.6 10201.5 10296.0 10330.3 711.9 731.7 740.8 744.3 760.4 4564.9 4724.7 4863.0 4880.5 4882.8 72343.0 72427.3 72552.6 72656.6 95865.0 78706.6 92207.0 93361.0 93454.0 95347.5 25334.4 25983.0 27171.3 55029.7 71207.6 9428.3 9860.8 10394.2 10470.3 10562.6 50777.5 51366.7 52146.0 52556.2 53451.0 65602.3 73703.6 75547.6 75963.6 77925.0 13305.8 13452.2 13594.6 13628.8 13852.7 15195.8 15304.0 15350.4 15693.0 15764.0 12703.8 13100.9 13947.0 14869.4 15150.4 13841.2 13975.2 14490.5 14517.1 14927.5 13443.5 13948.9 14109.4 14420.9 14746.8 11150.8 11154.2 11196.5 11433.3 11492.3 12174.6 12251.6 12397.4 12585.7 12623.2 03:53:42 INFO - PROCESS | 22999 | -------- Summary: end -------- 03:53:42 INFO - PROCESS | 22999 | 03:53:43 INFO - TEST-INFO | 22999: exit 0 03:53:43 INFO - TEST-OK | dromaeo_css | took 1112559ms 03:53:43 INFO - TEST-START | kraken 03:53:43 INFO - operating with platform_type : linux_ 03:53:43 INFO - Initialising browser for kraken test... 03:53:43 INFO - TEST-INFO | started process 23184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnLRyBj/profile http://localhost:42928/getInfo.html) 03:53:46 INFO - PROCESS | 23184 | JavaScript error: , line 0: uncaught exception: undefined 03:53:46 INFO - PROCESS | 23184 | __metrics Screen width/height:1600/1200 03:53:46 INFO - PROCESS | 23184 | colorDepth:24 03:53:46 INFO - PROCESS | 23184 | Browser inner width/height: 1024/697 03:53:46 INFO - PROCESS | 23184 | __metrics 03:53:47 INFO - PROCESS | 23184 | 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" 03:53:47 INFO - PROCESS | 23184 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:48 INFO - TEST-INFO | 23184: exit 0 03:53:48 INFO - Browser initialized. 03:53:48 INFO - Running cycle 1/1 for kraken test... 03:53:48 INFO - TEST-INFO | started process 23269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnLRyBj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:00 INFO - PROCESS | 23269 | RSS: Main: 157331456 03:54:00 INFO - PROCESS | 23269 | 03:54:02 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42928/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:03 INFO - PROCESS | 23269 | RSS: Main: 213610496 03:54:03 INFO - PROCESS | 23269 | 03:54:06 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42928/tests/kraken/driver.html?testName=audio-dft) 03:54:07 INFO - PROCESS | 23269 | RSS: Main: 187994112 03:54:07 INFO - PROCESS | 23269 | 03:54:10 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42928/tests/kraken/driver.html?testName=audio-fft) 03:54:10 INFO - PROCESS | 23269 | RSS: Main: 271880192 03:54:10 INFO - PROCESS | 23269 | 03:54:12 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42928/tests/kraken/driver.html?testName=audio-oscillator) 03:54:13 INFO - PROCESS | 23269 | RSS: Main: 181039104 03:54:13 INFO - PROCESS | 23269 | 03:54:15 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42928/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:16 INFO - PROCESS | 23269 | RSS: Main: 185651200 03:54:16 INFO - PROCESS | 23269 | 03:54:19 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42928/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:19 INFO - PROCESS | 23269 | RSS: Main: 221396992 03:54:19 INFO - PROCESS | 23269 | 03:54:23 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42928/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:23 INFO - PROCESS | 23269 | RSS: Main: 221224960 03:54:23 INFO - PROCESS | 23269 | 03:54:26 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42928/tests/kraken/driver.html?testName=json-parse-financial) 03:54:27 INFO - PROCESS | 23269 | RSS: Main: 221040640 03:54:27 INFO - PROCESS | 23269 | 03:54:28 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42928/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:29 INFO - PROCESS | 23269 | RSS: Main: 184750080 03:54:29 INFO - PROCESS | 23269 | 03:54:31 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42928/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:31 INFO - PROCESS | 23269 | RSS: Main: 189222912 03:54:31 INFO - PROCESS | 23269 | 03:54:33 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42928/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:34 INFO - PROCESS | 23269 | RSS: Main: 195035136 03:54:34 INFO - PROCESS | 23269 | 03:54:36 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:37 INFO - PROCESS | 23269 | RSS: Main: 189300736 03:54:37 INFO - PROCESS | 23269 | 03:54:40 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:40 INFO - PROCESS | 23269 | RSS: Main: 193933312 03:54:40 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | Cycle 1(1): loaded http://localhost:42928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42928/tests/kraken/driver.html?testName=ai-astar) 03:54:42 INFO - PROCESS | 23269 | RSS: Main: 244658176 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | __start_tp_report 03:54:42 INFO - PROCESS | 23269 | _x_x_mozilla_page_load 03:54:42 INFO - PROCESS | 23269 | _x_x_mozilla_page_load_details 03:54:42 INFO - PROCESS | 23269 | |i|pagename|runs| 03:54:42 INFO - PROCESS | 23269 | |0;ai-astar;103;112;110;111;111;113;110;108;108;110 03:54:42 INFO - PROCESS | 23269 | |1;audio-beat-detection;142;120;122;174;117;122;148;117;167;119 03:54:42 INFO - PROCESS | 23269 | |2;audio-dft;163;160;159;161;161;160;162;162;162;160 03:54:42 INFO - PROCESS | 23269 | |3;audio-fft;75;76;74;112;75;75;75;75;101;76 03:54:42 INFO - PROCESS | 23269 | |4;audio-oscillator;84;83;112;84;83;85;123;82;88;140 03:54:42 INFO - PROCESS | 23269 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;117;117;116 03:54:42 INFO - PROCESS | 23269 | |6;imaging-darkroom;149;148;148;149;149;148;148;150;148;146 03:54:42 INFO - PROCESS | 23269 | |7;imaging-desaturate;95;96;96;95;96;96;95;95;95;95 03:54:42 INFO - PROCESS | 23269 | |8;json-parse-financial;53;51;52;54;53;53;53;52;52;53 03:54:42 INFO - PROCESS | 23269 | |9;json-stringify-tinderbox;64;64;64;63;64;63;64;65;65;65 03:54:42 INFO - PROCESS | 23269 | |10;stanford-crypto-aes;79;76;78;82;75;75;75;75;75;75 03:54:42 INFO - PROCESS | 23269 | |11;stanford-crypto-ccm;121;118;124;120;117;125;126;127;162;122 03:54:42 INFO - PROCESS | 23269 | |12;stanford-crypto-pbkdf2;160;157;159;156;157;155;157;160;160;158 03:54:42 INFO - PROCESS | 23269 | |13;stanford-crypto-sha256-iterative;64;62;63;62;63;63;62;62;70;62 03:54:42 INFO - PROCESS | 23269 | __end_tp_report 03:54:42 INFO - PROCESS | 23269 | __start_cc_report 03:54:42 INFO - PROCESS | 23269 | _x_x_mozilla_cycle_collect,1666 03:54:42 INFO - PROCESS | 23269 | __end_cc_report 03:54:42 INFO - PROCESS | 23269 | __startTimestamp1469444082721__endTimestamp 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | ------- Summary: start ------- 03:54:42 INFO - PROCESS | 23269 | Number of tests: 14 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.80 (2.5%) stddev-sans-first:1.66 03:54:42 INFO - PROCESS | 23269 | Values: 103.0 112.0 110.0 111.0 111.0 113.0 110.0 108.0 108.0 110.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:132.00 stddev:21.68 (16.4%) stddev-sans-first:22.84 03:54:42 INFO - PROCESS | 23269 | Values: 142.0 120.0 122.0 174.0 117.0 122.0 148.0 117.0 167.0 119.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.09 03:54:42 INFO - PROCESS | 23269 | Values: 163.0 160.0 159.0 161.0 161.0 160.0 162.0 162.0 162.0 160.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:13.49 (18.0%) stddev-sans-first:14.11 03:54:42 INFO - PROCESS | 23269 | Values: 75.0 76.0 74.0 112.0 75.0 75.0 75.0 75.0 101.0 76.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:83.50 stddev:20.89 (25.0%) stddev-sans-first:21.67 03:54:42 INFO - PROCESS | 23269 | Values: 84.0 83.0 112.0 84.0 83.0 85.0 123.0 82.0 88.0 140.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 03:54:42 INFO - PROCESS | 23269 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 03:54:42 INFO - PROCESS | 23269 | Values: 149.0 148.0 148.0 149.0 149.0 148.0 148.0 150.0 148.0 146.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:54:42 INFO - PROCESS | 23269 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.84 (1.6%) stddev-sans-first:0.88 03:54:42 INFO - PROCESS | 23269 | Values: 53.0 51.0 52.0 54.0 53.0 53.0 53.0 52.0 52.0 53.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 03:54:42 INFO - PROCESS | 23269 | Values: 64.0 64.0 64.0 63.0 64.0 63.0 64.0 65.0 65.0 65.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:75.50 stddev:2.42 (3.2%) stddev-sans-first:2.39 03:54:42 INFO - PROCESS | 23269 | Values: 79.0 76.0 78.0 82.0 75.0 75.0 75.0 75.0 75.0 75.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:124.50 stddev:13.01 (10.5%) stddev-sans-first:13.66 03:54:42 INFO - PROCESS | 23269 | Values: 121.0 118.0 124.0 120.0 117.0 125.0 126.0 127.0 162.0 122.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:158.50 stddev:1.79 (1.1%) stddev-sans-first:1.73 03:54:42 INFO - PROCESS | 23269 | Values: 160.0 157.0 159.0 156.0 157.0 155.0 157.0 160.0 160.0 158.0 03:54:42 INFO - PROCESS | 23269 | 03:54:42 INFO - PROCESS | 23269 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:2.45 (3.9%) stddev-sans-first:2.59 03:54:42 INFO - PROCESS | 23269 | Values: 64.0 62.0 63.0 62.0 63.0 63.0 62.0 62.0 70.0 62.0 03:54:42 INFO - PROCESS | 23269 | -------- Summary: end -------- 03:54:42 INFO - PROCESS | 23269 | 03:54:43 INFO - TEST-INFO | 23269: exit 0 03:54:43 INFO - TEST-OK | kraken | took 60493ms 03:54:43 INFO - SUITE-END | took 1173s 03:54:43 INFO - Completed test suite (00:19:33) 03:54:43 INFO - javascript benchmark 03:54:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2998.505246634305, 3038.9696103038964, 3060.6939306069394, 3078.30738083931, 3108.8445577721122, 5052.949470505294, 5136.33227680402, 5173.870653233671, 5262.00021995821, 5293.52358287754, 5139.537441630253, 5146.665466744659, 5165.63840531163, 5187.896242075156, 5215.400228973669, 4629.583337499616, 4719.4100737407825, 4723.126221648989, 4732.100900828848, 4895.55939965403, 4848.563629273364, 4874.366332376804, 4875.561199492045, 4885.682430642015, 4905.043516514281, 4664.930026049612, 4675.0, 4705.1530724469585, 4720.362751028619, 4726.503717109723, 4690.695104818176, 4698.741569213692, 4716.2454007359, 4812.133815913135, 4819.397575303087, 4722.220833562458, 4724.669273150881, 4735.857924262277, 4745.477997420281, 4784.617230621577, 5130.461301563357, 5132.178851383798, 5212.478752124795, 5219.556337711299, 5249.212618107276, 5546.528545073674, 5588.888222235532, 5639.718014099279, 5640.407757185519, 5643.68959707216, 5572.86067848307, 5637.746301416446, 5654.773809047674, 5658.801941932013, 5661.801836935729, 5031.84904452867, 5170.741462926876, 5221.425643179247, 5282.022825777205, 5286.841394758163, 5764.913526297109, 5779.624324418899, 5792.4497172768515, 5794.130880367894, 5800.187973683687, 5588.580856435784, 5590.217369568264, 5592.440755924456, 5592.5805564582815, 5596.0, 5425.511703946664, 5515.917261241085, 5523.806666766724, 5657.632253903483, 5659.236003139606, 5591.804286849941, 5602.663840169522, 5606.85982850432, 5637.830865074055, 5653.349864765522, 5557.833265002057, 5600.719964001783, 5602.859928501739, 5611.0, 5616.466435688603, 4158.334666453414, 4245.57544245573, 4269.295566231537, 4300.09697963425, 4327.6105150536605, 3831.540215174197, 3837.9040523987123, 3846.211526637089, 3869.4195870619633, 3897.162110146332, 5321.600879933943, 5322.121849894801, 5324.387695414999, 5327.280817089643, 5376.7042812644895, 5455.072637651609, 5488.835334939959, 5507.7246137692955, 5575.60970732053, 5604.719764011783, 5190.169572868323, 5212.5569326607665, 5246.658967167122, 5248.737563121905, 5252.422233554306, 4805.327254184417, 4818.469968303484, 4819.759012049383, 4822.132016237041, 4860.3681521401995, 5581.274434323512, 5624.71876406178, 5681.0910254359105, 5737.053386191232, 5738.77044918207, 5520.1167813149705, 5524.806631767869, 5528.170774383874, 5567.972160139173, 5570.610057296112, 5707.514861236841, 5712.285964254468, 5716.571257155647, 5717.17101020358, 5720.771169153354, 5383.434739352311, 5455.399906010256, 5460.071787796163, 5460.6177567569885, 5473.945260547343, 5627.8874422512135, 5636.605437619327, 5636.661800291831, 5669.3480249770155, 5689.91891540606, 5456.699881506555, 5457.836264912059, 5466.808661696821, 5476.424975377528, 5492.670439773627, 5186.481351864783, 5305.389880163831, 5344.171653393731, 5456.945430545644, 5516.503514683698, 5360.463953604608, 5361.946380536145, 5365.275687782099, 5402.162664786964, 5404.351477822529, 5439.700816455133, 5445.50990410865, 5488.231647569423, 5493.313335833021, 5498.477644623755, 5231.42454330031, 5277.313949186735, 5346.064438723286, 5351.090314646442, 5358.812441564526], "value": 5145.476369620486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2629066248514, 607.4138456389585, 640.433216603306, 646.5474168082344, 656.1240743607284, 43363.0, 44735.328970065435, 44857.77571112148, 44977.0, 47921.52078479214, 46123.0, 46399.76800116003, 46762.76618616911, 46796.76601616995, 46807.29789053167, 8972.10278972104, 9120.908790912106, 9121.543922803867, 9122.863157052616, 9123.178913897747, 8874.0, 8983.775405614846, 8991.910080899206, 8995.055519170492, 8998.640054397816, 9022.09779022099, 9034.277257819358, 9052.0, 9059.95470022649, 9060.637574497012, 8962.327825413087, 8971.058038905887, 9007.774805629846, 9016.504092274923, 9018.368714189977, 8769.035406105324, 8847.955760221157, 8849.867251991225, 8852.114788521161, 8861.512616806072, 43924.0, 44244.11511769779, 44305.77847110776, 44326.55673443257, 44342.77828610869, 3530.0821786335737, 3777.0, 3823.713221508398, 4120.21715873983, 4265.7014009019385, 33049.17377065569, 33943.83028084844, 34007.4898876517, 34110.658893411, 34820.0, 4360.520342762294, 4379.309150122987, 4468.151051300242, 4509.278515437547, 4530.75080870552, 360556.0, 362939.2971245994, 363619.0, 363677.0, 364599.9999999973, 32824.50763238553, 33628.66371336304, 33706.0, 59145.11282330768, 59534.40465595375, 34658.133546661535, 34832.651673483444, 34860.47709284363, 34876.12809679778, 34884.651153488645, 15067.4726384576, 15213.61965950838, 15227.771583426258, 15249.085054896741, 15261.771073433907, 12604.432800523999, 12678.80981785274, 12679.049071319689, 12680.302583358003, 12746.171498852545, 8248.711295104762, 8260.876086858701, 8275.62759675816, 8331.29184019353, 8356.582170891432, 3190.6649801770945, 3212.9357412852078, 3218.4045951499047, 3248.871988847309, 3305.2563173285816, 986.8667729856521, 1063.9041786959444, 1072.1851392941421, 1076.617800680747, 1119.0320372877402, 33532.0, 34154.82922585371, 34167.82916085453, 34253.0, 34273.82863085669, 1103.2442776697987, 1103.7682086761708, 1107.291333546531, 1110.3337997201777, 1178.298912147271, 17258.82741172572, 17444.825551744572, 17587.648247034987, 17641.470755877344, 17712.822871771376, 592761.1085833716, 595639.0, 595684.0, 597940.0, 600659.0, 60360.0, 60939.0, 61043.69478152581, 61149.0, 61154.388456114866, 1249.5314257153568, 1367.5760514240617, 1386.0990356268505, 1401.0262867307326, 1404.789281607767, 32383.51424728584, 34286.65713342935, 34366.48450273298, 34592.13519661928, 34878.47682284717, 50945.49054509407, 51660.48339516707, 51831.222531661304, 51856.740716296175, 51865.7406712964, 442163.0, 442565.0, 444954.0, 445065.0, 445445.0, 24993.500129996934, 26045.869770651025, 27066.864665676545, 27676.308092297048, 27946.0, 47608.76195619, 48406.27390589214, 48549.5145048545, 48708.5129148704, 48815.75592122017, 41436.0, 41678.37482437827, 41955.0, 42018.0, 43874.561254388325, 42017.57982420137, 42064.369034463896, 42383.0, 43051.13897722091, 43305.56694433141, 41584.584154158074, 42298.0, 42911.0, 43294.78352608217, 43353.0, 35602.8219858899, 37457.0, 37740.81129594444, 38035.809820950715, 38720.612793872824, 28843.711562884102, 29107.272318192216, 29276.121716348545, 29326.41347173002, 29346.559801602565], "value": 19253.213301672233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.73645552796336, 391.4636947382087, 395.81001119462655, 402.81671839313117, 416.23412920226775, 14613.488527901525, 18589.163487643054, 18914.243430262806, 20281.391558253257, 20311.1875524979, 18328.450146495594, 19339.903300483515, 19563.902180489076, 19696.310629127984, 19746.70379944302, 5570.693611851347, 5634.0703783875615, 5770.971145144268, 5818.06910894257, 5904.852378690545, 5834.329052159013, 5853.678047707374, 5866.384029676887, 5868.6478811271245, 5872.823815285548, 6445.709943052574, 6475.676216189196, 6478.416942475176, 6489.1239682642945, 6498.44763195129, 5819.359870414293, 5888.646681199141, 6093.756249750027, 6466.773662921799, 6484.740610375603, 5705.286839145107, 5714.7428365723645, 5717.656940583578, 5721.427857214246, 5723.484886360206, 12261.448234829453, 12505.74988500225, 12549.560765373168, 12597.74804503914, 18246.631502637356, 2276.8064714499287, 2276.84062115652, 2332.3702600297993, 2338.649202619604, 2406.566817972764, 9797.412155270635, 10074.89925100747, 10389.324693894949, 12375.0, 14156.787648185285, 1850.0, 1887.2639670528504, 1893.1102381880494, 1938.9903050484797, 1944.3583617406364, 84880.57559712161, 85518.14481855163, 87638.56180719119, 87871.56064219637, 89124.55437722834, 10328.896711032794, 10432.165426765841, 10466.529006194587, 10641.787164256826, 10914.836277455845, 12683.175593586388, 13426.597202083953, 14632.341544630517, 14639.634009149857, 14653.487127950471, 7264.636768161571, 7365.226651201547, 7539.660715267826, 7591.051118610174, 7656.3874890008665, 7189.173245076779, 7190.316919892602, 7325.2674732527385, 7354.154272258758, 7383.224761399975, 4429.379886815848, 4463.687541872037, 4529.365888775574, 4597.747123908151, 4625.722456652612, 1795.4882858385297, 1866.0856180471471, 1890.1777726688933, 1903.200655724599, 1929.3150931419143, 908.2733812949614, 954.5275088831073, 999.645125980281, 1015.1117771949545, 1099.8075336816025, 18782.342618008304, 19629.90185049094, 20106.0, 20234.69647955282, 20322.390328290174, 968.9903100969041, 982.7199248214224, 1010.1211945607222, 1053.441675911768, 1057.7620035491952, 10344.500047493071, 10996.615118470816, 11296.71758206035, 11371.943140284411, 11386.601468948547, 487028.0, 489293.0, 490348.0, 493831.0, 498269.0, 93707.0, 93739.0, 94555.0, 94605.0, 96538.51730741301, 998.1814911772423, 1002.2332915319786, 1004.2869562610482, 1008.2690049713899, 1008.7326858382535, 17246.568835779206, 17318.134093295033, 17913.28346866163, 17938.103094844944, 18291.908540457214, 41874.37188442237, 43323.783381082896, 43490.782546087066, 43943.56056439522, 44096.0, 59038.70480647569, 59843.40156598378, 59942.400575993684, 61056.0, 61412.69293653503, 7313.707451702086, 7315.963420182865, 7550.395968322631, 8071.596420179085, 8262.876056859031, 9324.393914395543, 12598.118131730691, 12898.0, 13049.28228947417, 13278.53525126616, 11653.88346116528, 11663.066954643438, 11699.181057325906, 11842.526298947945, 12266.570670026505, 11558.07535397183, 11607.36159511235, 11638.185327027028, 12012.699682508008, 12291.385430728249, 11604.6518604442, 11759.647210583697, 11766.87863752992, 11846.52613895469, 12109.69725756828, 6873.931260687329, 7242.710291588488, 7313.817154570966, 7496.400287977058, 7908.932294140448, 10134.746631334276, 11704.473298701749, 11841.763164736829, 12208.75582488363, 12279.815802762787], "value": 9061.59783310479, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.3884812986025, 1438.7266419380314, 1479.933402996865, 1596.3056070609287, 1770.4600096970428, 8328.167183281668, 8633.525156116419, 8729.956350218255, 8988.101189881025, 8990.37067405282, 8822.059146987669, 8902.065283145273, 8902.599383027764, 8916.242119419858, 8928.776780580472, 2342.1099982006813, 2370.668106465096, 2371.027878569787, 2371.905123795046, 2372.383180373107, 2370.0756704885107, 2381.880905954695, 2416.8549887006834, 2422.2975337152293, 2425.575524283252, 2320.466292752668, 2322.6167682332393, 2335.8481698689616, 2340.8010319122895, 2351.2358483492935, 2244.124791331374, 2254.4589298568226, 2282.9315120546325, 2283.4633861042644, 2284.680144779724, 2254.0, 2272.8522646027955, 2277.0436416704856, 2277.943051423711, 2279.5213005268915, 8618.698345557876, 8888.822223555557, 8941.329400294939, 8942.86585701215, 8947.910520894773, 5049.924251136236, 5205.6356055075785, 5268.81559145428, 5276.1030624793875, 5277.23480095384, 3351.9664803351898, 3383.6785505377197, 3392.423288041039, 3393.745469089828, 3421.4354631485776, 1138.846255755479, 1143.1826244235328, 1156.1444531046964, 1165.2309475746051, 1182.0543565147934, 11805.822912656316, 11971.04231661465, 12010.219335743148, 12018.39908004605, 12026.398680065962, 4395.164918665443, 4598.402207712976, 4623.751587071539, 4765.166095933268, 4765.737884416321, 10171.288009839389, 10185.490725463696, 10185.592576296865, 10188.796224075477, 10196.082352588155, 5216.347956505437, 5252.947470525322, 5255.343082114736, 5255.710935898563, 5262.052830490472, 4248.91502169961, 4369.563043695669, 4508.301213311942, 4790.616750659939, 4799.904001920012, 4065.28857449951, 4134.713543849975, 4146.688998325138, 4154.023804405962, 4214.831406743757, 1268.9682757931125, 1291.3672300572653, 1295.106376600143, 1300.5253082624774, 1302.1340808362334, 851.3019324154258, 951.5955718819474, 997.3517213811081, 1004.1715584642699, 1005.8239808033711, 5864.589478736448, 5917.408259174134, 5976.252968378953, 6086.695665216722, 6223.657698826608, 446.9843555475543, 451.97288162710345, 452.9297958816389, 460.62459095836783, 462.4750907719762, 4113.547509773923, 4255.8084886180195, 4300.978495107567, 4313.956860431418, 4316.2446571849805, 10732.463376831127, 11169.944150279196, 11181.385023823768, 11186.0, 11205.775884482428, 11110.333379997226, 11110.61112861046, 11126.666200014013, 11132.777344453065, 11133.0, 7859.764207073797, 8098.959505202436, 8107.1892810718455, 8357.749267521984, 8359.749207523906, 6201.410865967726, 6208.0998255253635, 6226.1905952225925, 6281.748730050929, 6585.3085426029575, 10006.799864002534, 10207.132393746615, 10329.225308101772, 10335.431551264752, 10564.683059508227, 9578.23374130054, 9966.152877005246, 10597.0, 10653.840192397276, 10672.733181670521, 8408.327333813158, 8681.392302539014, 8702.0, 8806.075362086889, 8817.470951742916, 8708.869366959374, 8772.166644168794, 8804.823903521765, 8824.955875220583, 8828.51443170606, 7813.687452502064, 7826.41301902371, 7852.450328476952, 7922.7227047053075, 7993.240642138988, 7520.962395187989, 7561.470697051153, 7576.740703768405, 7768.7669369918995, 7925.682972681028, 7160.928390716234, 7274.8908766367485, 7284.344409003215, 7286.6720997556295, 7293.708251669874, 5332.173513105475, 5443.265159203615, 5478.397376288684, 5499.202615620793, 5732.828015159552, 5435.701036442875, 5455.8363249102595, 5497.285352904097, 5518.889622207614, 5609.747561359667], "value": 4614.528959166446, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.0680484728847, 319.10013761193443, 331.08290036598606, 333.644668428124, 341.56962227593226, 5251.894962100756, 5318.627696061272, 5332.586864480915, 5333.466653334669, 5348.625596208257, 4979.531038343688, 5034.1945288753805, 5103.540681338679, 5126.205438157082, 5245.160774276116, 3953.2686453006213, 3975.085730282037, 4066.32905570582, 4114.670826333886, 4123.422720819072, 4086.2031903778775, 4086.795660216992, 4103.0, 4134.524529679095, 4139.4204811326435, 3875.457435958968, 4002.5196976362877, 4047.8583249586272, 4056.5132184137797, 4111.239420707164, 4041.7777022263763, 4044.0, 4051.372037334218, 4062.2484840304637, 4062.9796851015703, 3548.2193917338145, 3566.6789988901123, 3570.5001299818045, 3571.9818302659173, 3574.749767516275, 4876.439869068732, 5117.46266642001, 5130.9230361544605, 5136.666116702402, 5138.203578445347, 4548.863534093983, 4615.930761038587, 4625.699329543569, 4661.160991021615, 4675.275332323496, 5375.247465354853, 5376.569874410038, 5382.596305277119, 5399.460053994609, 5404.51359377654, 3850.8074596270076, 3895.2988462076814, 3899.395593682984, 3934.8032598370255, 3940.4286378474962, 5601.271834661508, 5626.677730733274, 5641.0, 5642.57680673947, 5653.293338332708, 3995.800209989489, 3999.5000624921886, 3999.7600143991453, 4000.5399379071196, 4005.118873847749, 4068.6745060395688, 4070.8778736637946, 4084.6732261419015, 4087.5912408758886, 4097.13960068383, 4418.955810441918, 4578.381918441034, 4593.19619066662, 4605.194091034123, 4705.3649956024055, 5420.593455490854, 5434.3207099112615, 5438.401775804658, 5479.808206712746, 5485.0, 1310.9250414660078, 1359.422245545639, 1375.312343828086, 1377.4490203918513, 1383.3567391163158, 932.4591736792644, 941.8963913969458, 949.1173208915775, 953.6042542344987, 961.6393852305386, 5305.124654432053, 5308.46915308466, 5321.574274058066, 5349.973250133725, 5353.598480114007, 5570.161846590616, 5601.915971260434, 5625.8312250631725, 5632.493075623213, 5642.125470552071, 5154.768035438415, 5388.137897936312, 5398.78404863801, 5408.513233808976, 5423.0, 2981.329200929817, 2992.6558445779015, 2995.221242476972, 3011.3525591997386, 3015.1557563882147, 5645.379008309083, 5745.827625171251, 5796.913046304308, 5827.708614569255, 5849.444302791228, 5669.829905102853, 5669.914951275734, 5674.836658485001, 5684.54523638108, 5705.5435565154685, 5688.544916406595, 5725.456081672234, 5748.45389687979, 5753.453421924911, 5761.193432919395, 5382.519807053091, 5562.7774889005605, 5596.1605759136455, 5601.599600099975, 5622.437756224344, 5467.6719396836315, 5515.420880807457, 5549.694766787866, 5564.693941833238, 5603.859903502445, 5447.809326673548, 5711.457411545896, 5791.8552036199435, 5797.101449275369, 5805.680687562224, 3972.364421692631, 3981.5023122109737, 3995.940060899031, 3998.7600743955454, 3999.5600483947323, 5588.552915766648, 5597.488678056983, 5598.832035038955, 5620.0, 5641.0, 5323.387810401853, 5431.646942948696, 5473.698946557977, 5492.148716948879, 5526.723663816712, 5413.512783849473, 5468.152436372368, 5480.369757477941, 5487.039768040497, 5498.1752737089755, 5217.0, 5233.502817232356, 5392.191171324333, 5421.024215641222, 5461.023742060507, 5486.835394938158, 5492.505674489155, 5523.6685798852195, 5529.972350138223, 5540.506771952557, 5394.703291319015, 5412.404635490172, 5417.0, 5422.186671999231, 5429.592780541396], "value": 4170.514607853723, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.0550517358475, 762.6682393158973, 789.218673513222, 831.8336332733455, 887.1261807119988, 14629.341679624416, 15278.236088195601, 15279.92360038201, 15334.46329378472, 15350.53948381549, 13217.405216765244, 13266.867331326685, 13268.867311326883, 13280.535181268657, 13287.0, 655.6459511863588, 793.6150966781106, 817.5094943034162, 819.8073452738602, 823.3618945317367, 811.9553424561647, 812.7033632724073, 812.7764864662236, 814.5764202614637, 814.8288859339546, 704.1339152842007, 858.120426562775, 871.6077765005741, 872.5549969515529, 874.5277550122926, 837.526797359493, 858.7853036740814, 860.711661593367, 860.9612567434481, 867.3104881619128, 634.6382561939696, 635.9141515895341, 635.9141515895387, 636.5257882877286, 636.7293900092442, 13616.523421680293, 13618.455261789517, 13626.727465450735, 13642.249676267802, 13643.727125457435, 14450.205238711867, 15483.690326193526, 15658.295376708076, 15825.60435989098, 16113.0, 13181.60455186346, 13184.0, 13196.340182990813, 13367.732645347136, 13383.397747101306, 4661.696989695659, 4671.6262698984, 4693.671442998992, 4806.663533552653, 4898.21628539432, 64355.356446435406, 66334.66832665805, 67061.66469167623, 75238.0, 75605.0, 11412.714682132848, 11470.369129697947, 11528.423578821194, 11540.134489913291, 11779.88220117788, 22850.42873928165, 22873.0, 22913.88543057274, 22922.65616015761, 23028.539429211658, 9108.407953483002, 9111.95444022789, 9123.635054597875, 9322.906770932339, 9624.855627165598, 4711.693739906964, 4766.213574760195, 4839.685420447659, 4947.6536642434685, 5165.302684137669, 3739.513863197767, 3864.2078373933277, 3871.4192871069004, 3871.8838434847, 3874.4188371744463, 673.6160388578561, 699.5243234600521, 700.8878579427369, 713.7715930902166, 716.2515171645642, 640.5068097564849, 685.7428464325877, 731.1043971135423, 737.133867705444, 740.3521918321469, 10087.949560252151, 10191.592336306612, 10201.504419919873, 10296.0, 10330.328528645614, 711.9359257666835, 731.6890321613294, 740.7703611880335, 744.3301029073768, 760.3878877503552, 4564.863054108316, 4724.740139292372, 4862.975685121552, 4880.487548807395, 4882.780274887638, 72343.0, 72427.2757272431, 72552.63723681348, 72656.63671681608, 95865.0, 78706.60646696844, 92207.0, 93361.0, 93454.0, 95347.52326238324, 25334.36664083376, 25983.0, 27171.282871713065, 55029.72485137549, 71207.64396177986, 9428.340016198801, 9860.802783944424, 10394.16846652251, 10470.319429237075, 10562.577496900038, 50777.49222507728, 51366.74316628542, 52146.0, 52556.21165682442, 53451.0, 65602.34397655963, 73703.6314818444, 75547.62226188833, 75963.62018189873, 77925.0, 13305.80041299362, 13452.192868427926, 13594.592162235149, 13628.795568066686, 13852.653683657989, 15195.77206341928, 15304.0, 15350.385984560493, 15693.0, 15764.0, 12703.80944285855, 13100.868991309964, 13947.0, 14869.405223790927, 15150.393984240507, 13841.238731869844, 13975.207845870787, 14490.492832750802, 14517.056391334529, 14927.477538286108, 13443.538722106056, 13948.860511394756, 14109.365078571283, 14420.85579144195, 14746.778798317819, 11150.776984460103, 11154.219204655596, 11196.496157672762, 11433.256838305484, 11492.310461372344, 12174.57388991381, 12251.632451026484, 12397.380130993595, 12585.685357865761, 12623.242605443336], "value": 7511.503486381975, "unit": "score"}], "name": "dromaeo_css", "value": 7115.471823733272, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 111.0, 111.0, 113.0, 110.0, 108.0, 108.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 120.0, 122.0, 174.0, 117.0, 122.0, 148.0, 117.0, 167.0, 119.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 159.0, 161.0, 161.0, 160.0, 162.0, 162.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 112.0, 75.0, 75.0, 75.0, 75.0, 101.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 84.0, 83.0, 85.0, 123.0, 82.0, 88.0, 140.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 150.0, 148.0, 146.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 54.0, 53.0, 53.0, 53.0, 52.0, 52.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 65.0, 65.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 78.0, 82.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 124.0, 120.0, 117.0, 125.0, 126.0, 127.0, 162.0, 122.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 159.0, 156.0, 157.0, 155.0, 157.0, 160.0, 160.0, 158.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0, 70.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1484.3999999999999, "alertThreshold": 2.0}]} 03:54:43 INFO - Return code: 0 03:54:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:44 INFO - # TBPL SUCCESS # 03:54:44 INFO - Running post-action listener: _resource_record_post_action 03:54:44 INFO - [mozharness: 2016-07-25 10:54:44.038441Z] Finished run-tests step (success) 03:54:44 INFO - Running post-run listener: _resource_record_post_run 03:54:44 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555515904; Read time: 184; Write time: 453376 03:54:44 INFO - TinderboxPrint: CPU usage
12.9% 03:54:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 03:54:44 INFO - TinderboxPrint: I/O write bytes / time
555,515,904 / 453,376 03:54:44 INFO - TinderboxPrint: CPU idle
8,274.5 (87.0%) 03:54:44 INFO - TinderboxPrint: CPU user
1,187.8 (12.5%) 03:54:44 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:44 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256692224; Read time: 0; Write time: 238192 03:54:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298823680; Read time: 176; Write time: 215184 03:54:44 INFO - Running post-run listener: _upload_blobber_files 03:54:44 INFO - Blob upload gear active. 03:54:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:44 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 03:54:44 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:54:44 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:54:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:06 INFO - (blobuploader) - INFO - Done attempting. 03:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:07 INFO - (blobuploader) - INFO - Done attempting. 03:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:08 INFO - (blobuploader) - INFO - Done attempting. 03:55:08 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:08 INFO - Return code: 0 03:55:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/18389f4473ba115aee1ea73217a689d2aa592108f9808acdcc88ad2db817d74afe4a55fc8af6bf4b9933ed8dc88f8cadebe096019312da7489ce1c7454ef06c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a92e83cd961b2ee0c46939b07d2d86afa334ec2c901af1cbe48a6baea15c3adeb049eabaad6b8881c31b35999e3c836dc8e6ab93f2a57f1ff452c733110cfee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37d395f39ac9dc6935ff02dd406f136ba5cf1f0199b8c8819ba2397d1c8294bf8b4ccadd8dbcb9d1b9acc2a8bff502431bfc9cb675b71545b41e91c977d1d28b"} 03:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:08 INFO - Contents: 03:55:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/18389f4473ba115aee1ea73217a689d2aa592108f9808acdcc88ad2db817d74afe4a55fc8af6bf4b9933ed8dc88f8cadebe096019312da7489ce1c7454ef06c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a92e83cd961b2ee0c46939b07d2d86afa334ec2c901af1cbe48a6baea15c3adeb049eabaad6b8881c31b35999e3c836dc8e6ab93f2a57f1ff452c733110cfee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37d395f39ac9dc6935ff02dd406f136ba5cf1f0199b8c8819ba2397d1c8294bf8b4ccadd8dbcb9d1b9acc2a8bff502431bfc9cb675b71545b41e91c977d1d28b"} 03:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:08 INFO - Copying logs to upload dir... 03:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.454056 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-25 03:55:06.225255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 03:55:06.228919) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479 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/sha512/18389f4473ba115aee1ea73217a689d2aa592108f9808acdcc88ad2db817d74afe4a55fc8af6bf4b9933ed8dc88f8cadebe096019312da7489ce1c7454ef06c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a92e83cd961b2ee0c46939b07d2d86afa334ec2c901af1cbe48a6baea15c3adeb049eabaad6b8881c31b35999e3c836dc8e6ab93f2a57f1ff452c733110cfee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37d395f39ac9dc6935ff02dd406f136ba5cf1f0199b8c8819ba2397d1c8294bf8b4ccadd8dbcb9d1b9acc2a8bff502431bfc9cb675b71545b41e91c977d1d28b"} build_url:https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/MWoaZCadQC-SghJFFdzRSg/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/sha512/18389f4473ba115aee1ea73217a689d2aa592108f9808acdcc88ad2db817d74afe4a55fc8af6bf4b9933ed8dc88f8cadebe096019312da7489ce1c7454ef06c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a92e83cd961b2ee0c46939b07d2d86afa334ec2c901af1cbe48a6baea15c3adeb049eabaad6b8881c31b35999e3c836dc8e6ab93f2a57f1ff452c733110cfee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37d395f39ac9dc6935ff02dd406f136ba5cf1f0199b8c8819ba2397d1c8294bf8b4ccadd8dbcb9d1b9acc2a8bff502431bfc9cb675b71545b41e91c977d1d28b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 03:55:06.254711) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:55:06.255090) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469442074.710997-592770479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:55:06.342448) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 03:55:06.343127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 03:55:06.343729) ========= ========= Total master_lag: 0.17 =========