builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1476901019.13 results: success (0) buildid: 20161019102522 builduid: fafca15e434243bab1d5f1cae786e901 revision: 557c6a8209fe88525f3a061a9e250aa43962709a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.135209) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.136384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.137201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.202701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.203006) ========= 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=eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 11:16: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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.3M=0s 2016-10-19 11:16:59 (69.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.364741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.365073) ========= 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=eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016646 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.415930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:16:59.416337) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 557c6a8209fe88525f3a061a9e250aa43962709a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 557c6a8209fe88525f3a061a9e250aa43962709a --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=eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 11:16:59,644 truncating revision to first 12 chars 2016-10-19 11:16:59,644 Setting DEBUG logging. 2016-10-19 11:16:59,644 attempt 1/10 2016-10-19 11:16:59,644 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/557c6a8209fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 11:16:59,949 unpacking tar archive at: fx-team-557c6a8209fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611522 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:17:00.042641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 11:17:00.042985) ========= script_repo_revision: 557c6a8209fe88525f3a061a9e250aa43962709a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 11:17:00.043449) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 11:17:00.043765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 11:17:00.052974) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-19 11:17:00.053309) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:17:00 INFO - MultiFileLogger online at 20161019 11:17:00 in /builds/slave/test 11:17:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:17:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:00 INFO - {'append_to_log': False, 11:17:00 INFO - 'base_work_dir': '/builds/slave/test', 11:17:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:17:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:00 INFO - 'branch': 'Fx-Team-Non-PGO', 11:17:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:00 INFO - 'config_files': ('talos/linux_config.py',), 11:17:00 INFO - 'default_actions': ('clobber', 11:17:00 INFO - 'read-buildbot-config', 11:17:00 INFO - 'download-and-extract', 11:17:00 INFO - 'populate-webroot', 11:17:00 INFO - 'create-virtualenv', 11:17:00 INFO - 'install', 11:17:00 INFO - 'run-tests'), 11:17:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:00 INFO - 'download_minidump_stackwalk': True, 11:17:00 INFO - 'download_symbols': 'ondemand', 11:17:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:00 INFO - 'installer_path': 'installer.exe', 11:17:00 INFO - 'log_level': 'info', 11:17:00 INFO - 'log_name': 'talos', 11:17:00 INFO - 'log_to_console': True, 11:17:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:17:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:17:00 INFO - 'opt_config_files': (), 11:17:00 INFO - 'pip_index': False, 11:17:00 INFO - 'sps_profile': False, 11:17:00 INFO - 'sps_profile_interval': 0, 11:17:00 INFO - 'suite': 'dromaeojs', 11:17:00 INFO - 'system_bits': '32', 11:17:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:00 INFO - 'title': 'talos-linux64-ix-010', 11:17:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:00 INFO - 'use_talos_json': True, 11:17:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:00 INFO - 'work_dir': 'build'} 11:17:00 INFO - [mozharness: 2016-10-19 18:17:00.374829Z] Running clobber step. 11:17:00 INFO - Running pre-action listener: _resource_record_pre_action 11:17:00 INFO - Running main action method: clobber 11:17:00 INFO - rmtree: /builds/slave/test/build 11:17:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:01 INFO - Running post-action listener: _resource_record_post_action 11:17:01 INFO - [mozharness: 2016-10-19 18:17:01.354795Z] Finished clobber step (success) 11:17:01 INFO - [mozharness: 2016-10-19 18:17:01.354896Z] Running read-buildbot-config step. 11:17:01 INFO - Running pre-action listener: _resource_record_pre_action 11:17:01 INFO - Running main action method: read_buildbot_config 11:17:01 INFO - Using buildbot properties: 11:17:01 INFO - { 11:17:01 INFO - "project": "", 11:17:01 INFO - "product": "firefox", 11:17:01 INFO - "script_repo_revision": "production", 11:17:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:17:01 INFO - "repository": "", 11:17:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:17:01 INFO - "buildid": "20161019102522", 11:17:01 INFO - "pgo_build": "False", 11:17:01 INFO - "basedir": "/builds/slave/test", 11:17:01 INFO - "buildnumber": 2208, 11:17:01 INFO - "slavename": "talos-linux64-ix-010", 11:17:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:17:01 INFO - "platform": "ubuntu64_hw", 11:17:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:17:01 INFO - "branch": "fx-team", 11:17:01 INFO - "repo_path": "integration/fx-team", 11:17:01 INFO - "revision": "557c6a8209fe88525f3a061a9e250aa43962709a", 11:17:01 INFO - "stage_platform": "linux64", 11:17:01 INFO - "builduid": "fafca15e434243bab1d5f1cae786e901", 11:17:01 INFO - "slavebuilddir": "test" 11:17:01 INFO - } 11:17:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:17:01 INFO - Running post-action listener: _resource_record_post_action 11:17:01 INFO - [mozharness: 2016-10-19 18:17:01.357344Z] Finished read-buildbot-config step (success) 11:17:01 INFO - [mozharness: 2016-10-19 18:17:01.357431Z] Running download-and-extract step. 11:17:01 INFO - Running pre-action listener: _resource_record_pre_action 11:17:01 INFO - Running main action method: download_and_extract 11:17:01 INFO - mkdir: /builds/slave/test/build/tests 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:01 INFO - trying https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:17:01 INFO - Downloading https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:17:01 INFO - Downloaded 1361 bytes. 11:17:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:17:01 INFO - Using the following test package requirements: 11:17:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:17:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:01 INFO - u'jsshell-linux-x86_64.zip'], 11:17:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:17:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:17:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:17:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:17:01 INFO - Fetch https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:17:03 INFO - Http code: 200 11:17:03 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 11:17:03 INFO - x-amz-cf-id: jg8a9OErP_6c6q7JzJYghbP9Cw2bPMdzSQuIkFOsR8wljI-MFfPG0A== 11:17:03 INFO - x-amz-version-id: 2YIS_Uf8s0sjcezoY1z2eHO0UhxThhXy 11:17:03 INFO - Expected file size: 20542225 11:17:03 INFO - Obtained file size: 20542225 11:17:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:17:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:17:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:17:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:17:08 INFO - Http code: 200 11:17:08 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 11:17:08 INFO - x-amz-cf-id: ddR08lSenWdA-8JX1TNDR7JODS8J_RhocpuWsJtFfYBg2oMX6LbvaA== 11:17:08 INFO - x-amz-version-id: 2YIS_Uf8s0sjcezoY1z2eHO0UhxThhXy 11:17:08 INFO - Expected file size: 20542225 11:17:08 INFO - Obtained file size: 20542225 11:17:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:17:13 INFO - Fetch https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:17:14 INFO - Http code: 200 11:17:14 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 11:17:14 INFO - x-amz-cf-id: IixPBcMmDVeFOwarwOZ1Nug90ozK8w98FskTAgz2s--kX8BRbfsW6Q== 11:17:14 INFO - x-amz-version-id: p3TZMvWEfzFAGbDY9kwaW_UNVu1eqUw. 11:17:14 INFO - Expected file size: 14409028 11:17:14 INFO - Obtained file size: 14409028 11:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:14 INFO - trying https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:17:14 INFO - Downloading https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:17:16 INFO - Downloaded 55524894 bytes. 11:17:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:17:16 INFO - mkdir: /builds/slave/test/properties 11:17:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:16 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:16 INFO - Contents: 11:17:16 INFO - build_url:https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:17:17 INFO - Running post-action listener: _resource_record_post_action 11:17:17 INFO - Running post-action listener: set_extra_try_arguments 11:17:17 INFO - [mozharness: 2016-10-19 18:17:17.564155Z] Finished download-and-extract step (success) 11:17:17 INFO - [mozharness: 2016-10-19 18:17:17.564380Z] Running populate-webroot step. 11:17:17 INFO - Running pre-action listener: _resource_record_pre_action 11:17:17 INFO - Running main action method: populate_webroot 11:17:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:17:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:17:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:17:17 INFO - '--tppagecycles', 11:17:17 INFO - '7'], 11:17:17 INFO - 'tests': ['tsvgm']}}, 11:17:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:17:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:17:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:17:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:17 INFO - 'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:17 INFO - 'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['damp', 'tps']}, 11:17:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:17 INFO - 'tests': ['damp', 'tps']}, 11:17:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['dromaeo_dom']}, 11:17:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['basic_compositor_video']}, 11:17:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:17:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['a11yr', 11:17:17 INFO - 'ts_paint', 11:17:17 INFO - 'tpaint', 11:17:17 INFO - 'sessionrestore', 11:17:17 INFO - 'sessionrestore_no_auto_restore', 11:17:17 INFO - 'tabpaint']}, 11:17:17 INFO - 'other-e10s': {'tests': ['a11yr', 11:17:17 INFO - 'ts_paint', 11:17:17 INFO - 'tpaint', 11:17:17 INFO - 'sessionrestore', 11:17:17 INFO - 'sessionrestore_no_auto_restore', 11:17:17 INFO - 'tabpaint']}, 11:17:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:17:17 INFO - 'ts_paint', 11:17:17 INFO - 'tpaint', 11:17:17 INFO - 'sessionrestore', 11:17:17 INFO - 'sessionrestore_no_auto_restore', 11:17:17 INFO - 'tabpaint']}, 11:17:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:17:17 INFO - 'ts_paint', 11:17:17 INFO - 'tpaint', 11:17:17 INFO - 'sessionrestore', 11:17:17 INFO - 'sessionrestore_no_auto_restore', 11:17:17 INFO - 'tabpaint']}, 11:17:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['a11yr', 11:17:17 INFO - 'ts_paint', 11:17:17 INFO - 'tpaint', 11:17:17 INFO - 'sessionrestore', 11:17:17 INFO - 'sessionrestore_no_auto_restore', 11:17:17 INFO - 'tabpaint']}, 11:17:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['a11yr', 11:17:17 INFO - 'ts_paint', 11:17:17 INFO - 'tpaint', 11:17:17 INFO - 'sessionrestore', 11:17:17 INFO - 'sessionrestore_no_auto_restore', 11:17:17 INFO - 'tabpaint']}, 11:17:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['tsvgx', 11:17:17 INFO - 'tsvgr_opacity', 11:17:17 INFO - 'tart', 11:17:17 INFO - 'tscrollx', 11:17:17 INFO - 'cart']}, 11:17:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:17:17 INFO - 'tsvgr_opacity', 11:17:17 INFO - 'tart', 11:17:17 INFO - 'tscrollx', 11:17:17 INFO - 'cart']}, 11:17:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:17 INFO - 'talos_options': ['--disable-e10s'], 11:17:17 INFO - 'tests': ['tp5o']}, 11:17:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:17 INFO - 'tests': ['tp5o']}, 11:17:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:17 INFO - 'talos_options': ['--disable-e10s', 11:17:17 INFO - '--xperf_path', 11:17:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:17 INFO - 'tests': ['tp5n']}, 11:17:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:17 INFO - 'talos_options': ['--xperf_path', 11:17:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:17 INFO - 'tests': ['tp5n']}}, 11:17:17 INFO - 'talos.zip': {'path': '', 11:17:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:17:17 INFO - Running post-action listener: _resource_record_post_action 11:17:17 INFO - [mozharness: 2016-10-19 18:17:17.584520Z] Finished populate-webroot step (success) 11:17:17 INFO - [mozharness: 2016-10-19 18:17:17.584609Z] Running create-virtualenv step. 11:17:17 INFO - Running pre-action listener: _resource_record_pre_action 11:17:17 INFO - Running main action method: create_virtualenv 11:17:17 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:17 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 11:17:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:17:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:17 INFO - Using real prefix '/usr' 11:17:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:18 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:20 INFO - Installing pip.................done. 11:17:20 INFO - Return code: 0 11:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:17:20 INFO - Reading from file tmpfile_stdout 11:17:20 INFO - Output received: 11:17:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:17:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:20 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:20 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 11:17:20 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 11:17:20 INFO - Using env: {'DISPLAY': ':0', 11:17:20 INFO - 'HOME': '/home/cltbld', 11:17:20 INFO - 'LANG': 'en_US.UTF-8', 11:17:20 INFO - 'LANGUAGE': 'en_US:en', 11:17:20 INFO - 'LOGNAME': 'cltbld', 11:17:20 INFO - 'MAIL': '/var/mail/cltbld', 11:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:20 INFO - 'MOZ_NO_REMOTE': '1', 11:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:20 INFO - 'NO_EM_RESTART': '1', 11:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:20 INFO - 'PWD': '/builds/slave/test', 11:17:20 INFO - 'SHELL': '/bin/bash', 11:17:20 INFO - 'SHLVL': '1', 11:17:20 INFO - 'TERM': 'linux', 11:17:20 INFO - 'TMOUT': '86400', 11:17:20 INFO - 'USER': 'cltbld', 11:17:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:20 INFO - '_': '/tools/buildbot/bin/python'} 11:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:20 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 11:17:20 INFO - Cleaning up... 11:17:20 INFO - Return code: 0 11:17:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:20 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:20 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 11:17:20 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 11:17:20 INFO - Using env: {'DISPLAY': ':0', 11:17:20 INFO - 'HOME': '/home/cltbld', 11:17:20 INFO - 'LANG': 'en_US.UTF-8', 11:17:20 INFO - 'LANGUAGE': 'en_US:en', 11:17:20 INFO - 'LOGNAME': 'cltbld', 11:17:20 INFO - 'MAIL': '/var/mail/cltbld', 11:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:20 INFO - 'MOZ_NO_REMOTE': '1', 11:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:20 INFO - 'NO_EM_RESTART': '1', 11:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:20 INFO - 'PWD': '/builds/slave/test', 11:17:20 INFO - 'SHELL': '/bin/bash', 11:17:20 INFO - 'SHLVL': '1', 11:17:20 INFO - 'TERM': 'linux', 11:17:20 INFO - 'TMOUT': '86400', 11:17:20 INFO - 'USER': 'cltbld', 11:17:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:20 INFO - '_': '/tools/buildbot/bin/python'} 11:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:20 INFO - Downloading/unpacking psutil>=3.1.1 11:17:20 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 11:17:20 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 11:17:20 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 11:17:20 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 11:17:20 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 11:17:20 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 11:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:22 INFO - Installing collected packages: psutil 11:17:22 INFO - Running setup.py install for psutil 11:17:22 INFO - building 'psutil._psutil_linux' extension 11:17:22 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 11:17:23 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 11:17:23 INFO - building 'psutil._psutil_posix' extension 11:17:23 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 11:17:23 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 11:17:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:23 INFO - Successfully installed psutil 11:17:23 INFO - Cleaning up... 11:17:23 INFO - Return code: 0 11:17:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:23 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:23 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 11:17:23 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 11:17:23 INFO - Using env: {'DISPLAY': ':0', 11:17:23 INFO - 'HOME': '/home/cltbld', 11:17:23 INFO - 'LANG': 'en_US.UTF-8', 11:17:23 INFO - 'LANGUAGE': 'en_US:en', 11:17:23 INFO - 'LOGNAME': 'cltbld', 11:17:23 INFO - 'MAIL': '/var/mail/cltbld', 11:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:23 INFO - 'MOZ_NO_REMOTE': '1', 11:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:23 INFO - 'NO_EM_RESTART': '1', 11:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:23 INFO - 'PWD': '/builds/slave/test', 11:17:23 INFO - 'SHELL': '/bin/bash', 11:17:23 INFO - 'SHLVL': '1', 11:17:23 INFO - 'TERM': 'linux', 11:17:23 INFO - 'TMOUT': '86400', 11:17:23 INFO - 'USER': 'cltbld', 11:17:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:23 INFO - '_': '/tools/buildbot/bin/python'} 11:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:25 INFO - Installing collected packages: mozsystemmonitor 11:17:25 INFO - Running setup.py install for mozsystemmonitor 11:17:25 INFO - Successfully installed mozsystemmonitor 11:17:25 INFO - Cleaning up... 11:17:25 INFO - Return code: 0 11:17:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:25 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:25 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 11:17:25 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 11:17:25 INFO - Using env: {'DISPLAY': ':0', 11:17:25 INFO - 'HOME': '/home/cltbld', 11:17:25 INFO - 'LANG': 'en_US.UTF-8', 11:17:25 INFO - 'LANGUAGE': 'en_US:en', 11:17:25 INFO - 'LOGNAME': 'cltbld', 11:17:25 INFO - 'MAIL': '/var/mail/cltbld', 11:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:25 INFO - 'MOZ_NO_REMOTE': '1', 11:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:25 INFO - 'NO_EM_RESTART': '1', 11:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:25 INFO - 'PWD': '/builds/slave/test', 11:17:25 INFO - 'SHELL': '/bin/bash', 11:17:25 INFO - 'SHLVL': '1', 11:17:25 INFO - 'TERM': 'linux', 11:17:25 INFO - 'TMOUT': '86400', 11:17:25 INFO - 'USER': 'cltbld', 11:17:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:25 INFO - '_': '/tools/buildbot/bin/python'} 11:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:26 INFO - Downloading/unpacking jsonschema==2.5.1 11:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17:28 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 11:17:28 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 11:17:28 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 11:17:28 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 11:17:28 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 11:17:28 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 11:17:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:28 INFO - warning: no files found matching '*.txt' 11:17:28 INFO - no previously-included directories found matching 'build' 11:17:28 INFO - no previously-included directories found matching 'dist' 11:17:28 INFO - no previously-included directories found matching '.git*' 11:17:28 INFO - Installing collected packages: jsonschema, functools32 11:17:28 INFO - Running setup.py install for functools32 11:17:28 INFO - warning: no files found matching '*.txt' 11:17:28 INFO - no previously-included directories found matching 'build' 11:17:28 INFO - no previously-included directories found matching 'dist' 11:17:28 INFO - no previously-included directories found matching '.git*' 11:17:28 INFO - Successfully installed jsonschema functools32 11:17:28 INFO - Cleaning up... 11:17:28 INFO - Return code: 0 11:17:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:28 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 11:17:28 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 11:17:28 INFO - Using env: {'DISPLAY': ':0', 11:17:28 INFO - 'HOME': '/home/cltbld', 11:17:28 INFO - 'LANG': 'en_US.UTF-8', 11:17:28 INFO - 'LANGUAGE': 'en_US:en', 11:17:28 INFO - 'LOGNAME': 'cltbld', 11:17:28 INFO - 'MAIL': '/var/mail/cltbld', 11:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:28 INFO - 'MOZ_NO_REMOTE': '1', 11:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:28 INFO - 'NO_EM_RESTART': '1', 11:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:28 INFO - 'PWD': '/builds/slave/test', 11:17:28 INFO - 'SHELL': '/bin/bash', 11:17:28 INFO - 'SHLVL': '1', 11:17:28 INFO - 'TERM': 'linux', 11:17:28 INFO - 'TMOUT': '86400', 11:17:28 INFO - 'USER': 'cltbld', 11:17:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:28 INFO - '_': '/tools/buildbot/bin/python'} 11:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:17:28 INFO - Cleaning up... 11:17:28 INFO - Return code: 0 11:17:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:28 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 11:17:28 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 11:17:28 INFO - Using env: {'DISPLAY': ':0', 11:17:28 INFO - 'HOME': '/home/cltbld', 11:17:28 INFO - 'LANG': 'en_US.UTF-8', 11:17:28 INFO - 'LANGUAGE': 'en_US:en', 11:17:28 INFO - 'LOGNAME': 'cltbld', 11:17:28 INFO - 'MAIL': '/var/mail/cltbld', 11:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:28 INFO - 'MOZ_NO_REMOTE': '1', 11:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:28 INFO - 'NO_EM_RESTART': '1', 11:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:28 INFO - 'PWD': '/builds/slave/test', 11:17:28 INFO - 'SHELL': '/bin/bash', 11:17:28 INFO - 'SHLVL': '1', 11:17:28 INFO - 'TERM': 'linux', 11:17:28 INFO - 'TMOUT': '86400', 11:17:28 INFO - 'USER': 'cltbld', 11:17:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:28 INFO - '_': '/tools/buildbot/bin/python'} 11:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:28 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 11:17:28 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 11:17:28 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 11:17:28 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 11:17:28 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 11:17:28 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 11:17:30 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:31 INFO - Downloading docopt-0.6.1.tar.gz 11:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:31 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:31 INFO - Running setup.py install for blobuploader 11:17:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:31 INFO - Running setup.py install for requests 11:17:32 INFO - Running setup.py install for docopt 11:17:32 INFO - Successfully installed blobuploader requests docopt 11:17:32 INFO - Cleaning up... 11:17:32 INFO - Return code: 0 11:17:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:32 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:32 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 11:17:32 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 11:17:32 INFO - Using env: {'DISPLAY': ':0', 11:17:32 INFO - 'HOME': '/home/cltbld', 11:17:32 INFO - 'LANG': 'en_US.UTF-8', 11:17:32 INFO - 'LANGUAGE': 'en_US:en', 11:17:32 INFO - 'LOGNAME': 'cltbld', 11:17:32 INFO - 'MAIL': '/var/mail/cltbld', 11:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:32 INFO - 'MOZ_NO_REMOTE': '1', 11:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:32 INFO - 'NO_EM_RESTART': '1', 11:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:32 INFO - 'PWD': '/builds/slave/test', 11:17:32 INFO - 'SHELL': '/bin/bash', 11:17:32 INFO - 'SHLVL': '1', 11:17:32 INFO - 'TERM': 'linux', 11:17:32 INFO - 'TMOUT': '86400', 11:17:32 INFO - 'USER': 'cltbld', 11:17:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:32 INFO - '_': '/tools/buildbot/bin/python'} 11:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:32 INFO - Running setup.py (path:/tmp/pip-oiXUnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:32 INFO - Running setup.py (path:/tmp/pip-lOQ87Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:32 INFO - Running setup.py (path:/tmp/pip-p93DUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:32 INFO - Running setup.py (path:/tmp/pip-pMkmEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:32 INFO - Running setup.py (path:/tmp/pip-cVSSeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:32 INFO - Running setup.py (path:/tmp/pip-jiENjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:32 INFO - Running setup.py (path:/tmp/pip-ZtYyka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:33 INFO - Running setup.py (path:/tmp/pip-lKWWSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:33 INFO - Running setup.py (path:/tmp/pip-qplL7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:33 INFO - Running setup.py (path:/tmp/pip-y2vhVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:33 INFO - Running setup.py (path:/tmp/pip-xaHuIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:33 INFO - Running setup.py (path:/tmp/pip-dYE2hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:33 INFO - Running setup.py (path:/tmp/pip-sDcmmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:33 INFO - Running setup.py (path:/tmp/pip-ZPxNsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:33 INFO - Running setup.py (path:/tmp/pip-zdlxZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:33 INFO - Running setup.py (path:/tmp/pip-BlZ4W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:33 INFO - Running setup.py (path:/tmp/pip-ZJUz9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:33 INFO - Running setup.py install for manifestparser 11:17:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Running setup.py install for mozcrash 11:17:34 INFO - Running setup.py install for mozdebug 11:17:34 INFO - Running setup.py install for mozdevice 11:17:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for mozfile 11:17:34 INFO - Running setup.py install for mozhttpd 11:17:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for mozinfo 11:17:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for mozInstall 11:17:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for mozleak 11:17:34 INFO - Running setup.py install for mozlog 11:17:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for moznetwork 11:17:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for mozprocess 11:17:35 INFO - Running setup.py install for mozprofile 11:17:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:35 INFO - Running setup.py install for mozrunner 11:17:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:35 INFO - Running setup.py install for mozscreenshot 11:17:35 INFO - Running setup.py install for moztest 11:17:35 INFO - Running setup.py install for mozversion 11:17:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:35 INFO - Cleaning up... 11:17:35 INFO - Return code: 0 11:17:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:35 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:35 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 11:17:35 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 11:17:35 INFO - Using env: {'DISPLAY': ':0', 11:17:35 INFO - 'HOME': '/home/cltbld', 11:17:35 INFO - 'LANG': 'en_US.UTF-8', 11:17:35 INFO - 'LANGUAGE': 'en_US:en', 11:17:35 INFO - 'LOGNAME': 'cltbld', 11:17:35 INFO - 'MAIL': '/var/mail/cltbld', 11:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:35 INFO - 'MOZ_NO_REMOTE': '1', 11:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:35 INFO - 'NO_EM_RESTART': '1', 11:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:35 INFO - 'PWD': '/builds/slave/test', 11:17:35 INFO - 'SHELL': '/bin/bash', 11:17:35 INFO - 'SHLVL': '1', 11:17:35 INFO - 'TERM': 'linux', 11:17:35 INFO - 'TMOUT': '86400', 11:17:35 INFO - 'USER': 'cltbld', 11:17:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:35 INFO - '_': '/tools/buildbot/bin/python'} 11:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:35 INFO - Running setup.py (path:/tmp/pip-o6XWyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:35 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)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:35 INFO - Running setup.py (path:/tmp/pip-tGpTuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:35 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)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:35 INFO - Running setup.py (path:/tmp/pip-6AsKao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:36 INFO - Running setup.py (path:/tmp/pip-xASuWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:36 INFO - Running setup.py (path:/tmp/pip-ZFZwwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:36 INFO - Running setup.py (path:/tmp/pip-hf9EcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:36 INFO - Running setup.py (path:/tmp/pip-kgmGHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:36 INFO - Running setup.py (path:/tmp/pip-eoPODT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:36 INFO - Running setup.py (path:/tmp/pip-kulkgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:36 INFO - Running setup.py (path:/tmp/pip-2JnzmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:36 INFO - Running setup.py (path:/tmp/pip-0BJOgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:36 INFO - Running setup.py (path:/tmp/pip-4PXOVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:36 INFO - Running setup.py (path:/tmp/pip-wPt8P7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:36 INFO - Running setup.py (path:/tmp/pip-rIb4wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:36 INFO - Running setup.py (path:/tmp/pip-yhZ_fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:36 INFO - Running setup.py (path:/tmp/pip-7StaKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:36 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)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:36 INFO - Running setup.py (path:/tmp/pip-d2HEzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:37 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)) 11:17:37 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)) 11:17:37 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)) 11:17:37 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)) 11:17:37 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)) 11:17:37 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)) 11:17:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:37 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 11:17:37 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 11:17:37 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 11:17:37 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 11:17:37 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 11:17:37 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 11:17:38 INFO - Downloading blessings-1.6.tar.gz 11:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:39 INFO - Installing collected packages: blessings 11:17:39 INFO - Running setup.py install for blessings 11:17:39 INFO - Successfully installed blessings 11:17:39 INFO - Cleaning up... 11:17:39 INFO - Return code: 0 11:17:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:39 INFO - Reading from file tmpfile_stdout 11:17:39 INFO - Current package versions: 11:17:39 INFO - argparse == 1.2.1 11:17:39 INFO - blessings == 1.6 11:17:39 INFO - blobuploader == 1.2.4 11:17:39 INFO - docopt == 0.6.1 11:17:39 INFO - functools32 == 3.2.3-2 11:17:39 INFO - jsonschema == 2.5.1 11:17:39 INFO - manifestparser == 1.1 11:17:39 INFO - mozInstall == 1.12 11:17:39 INFO - mozcrash == 0.17 11:17:39 INFO - mozdebug == 0.1 11:17:39 INFO - mozdevice == 0.48 11:17:39 INFO - mozfile == 1.2 11:17:39 INFO - mozhttpd == 0.7 11:17:39 INFO - mozinfo == 0.9 11:17:39 INFO - mozleak == 0.1 11:17:39 INFO - mozlog == 3.4 11:17:39 INFO - moznetwork == 0.27 11:17:39 INFO - mozprocess == 0.23 11:17:39 INFO - mozprofile == 0.28 11:17:39 INFO - mozrunner == 6.12 11:17:39 INFO - mozscreenshot == 0.1 11:17:39 INFO - mozsystemmonitor == 0.3 11:17:39 INFO - moztest == 0.7 11:17:39 INFO - mozversion == 1.4 11:17:39 INFO - psutil == 3.1.1 11:17:39 INFO - requests == 1.2.3 11:17:39 INFO - wsgiref == 0.1.2 11:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:39 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 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17:39 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 11:17:39 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 11:17:39 INFO - Using env: {'DISPLAY': ':0', 11:17:39 INFO - 'HOME': '/home/cltbld', 11:17:39 INFO - 'LANG': 'en_US.UTF-8', 11:17:39 INFO - 'LANGUAGE': 'en_US:en', 11:17:39 INFO - 'LOGNAME': 'cltbld', 11:17:39 INFO - 'MAIL': '/var/mail/cltbld', 11:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:39 INFO - 'MOZ_NO_REMOTE': '1', 11:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:39 INFO - 'NO_EM_RESTART': '1', 11:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:39 INFO - 'PWD': '/builds/slave/test', 11:17:39 INFO - 'SHELL': '/bin/bash', 11:17:39 INFO - 'SHLVL': '1', 11:17:39 INFO - 'TERM': 'linux', 11:17:39 INFO - 'TMOUT': '86400', 11:17:39 INFO - 'USER': 'cltbld', 11:17:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:39 INFO - '_': '/tools/buildbot/bin/python'} 11:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 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)) 11:17:39 INFO - Cleaning up... 11:17:39 INFO - Return code: 0 11:17:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62fdd4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', '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 11:17: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'] in /builds/slave/test/build 11:17: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 11:17:39 INFO - Using env: {'DISPLAY': ':0', 11:17:39 INFO - 'HOME': '/home/cltbld', 11:17:39 INFO - 'LANG': 'en_US.UTF-8', 11:17:39 INFO - 'LANGUAGE': 'en_US:en', 11:17:39 INFO - 'LOGNAME': 'cltbld', 11:17:39 INFO - 'MAIL': '/var/mail/cltbld', 11:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:39 INFO - 'MOZ_NO_REMOTE': '1', 11:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:39 INFO - 'NO_EM_RESTART': '1', 11:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:39 INFO - 'PWD': '/builds/slave/test', 11:17:39 INFO - 'SHELL': '/bin/bash', 11:17:39 INFO - 'SHLVL': '1', 11:17:39 INFO - 'TERM': 'linux', 11:17:39 INFO - 'TMOUT': '86400', 11:17:39 INFO - 'USER': 'cltbld', 11:17:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:39 INFO - '_': '/tools/buildbot/bin/python'} 11:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:39 INFO - Cleaning up... 11:17:39 INFO - Return code: 0 11:17:39 INFO - Running post-action listener: _resource_record_post_action 11:17:39 INFO - Running post-action listener: _start_resource_monitoring 11:17:39 INFO - Starting resource monitoring. 11:17:39 INFO - [mozharness: 2016-10-19 18:17:39.934702Z] Finished create-virtualenv step (success) 11:17:39 INFO - [mozharness: 2016-10-19 18:17:39.935212Z] Running install step. 11:17:39 INFO - Running pre-action listener: _resource_record_pre_action 11:17:39 INFO - Running main action method: install 11:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:40 INFO - Reading from file tmpfile_stdout 11:17:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:40 INFO - Reading from file tmpfile_stdout 11:17:40 INFO - Output received: 11:17:40 INFO - Usage: mozinstall [options] installer 11:17:40 INFO - Options: 11:17:40 INFO - -h, --help show this help message and exit 11:17:40 INFO - -d DEST, --destination=DEST 11:17:40 INFO - Directory to install application into. [default: 11:17:40 INFO - "/builds/slave/test"] 11:17:40 INFO - --app=APP Application being installed. [default: firefox] 11:17:40 INFO - mkdir: /builds/slave/test/build/application 11:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:17:56 INFO - Reading from file tmpfile_stdout 11:17:56 INFO - Output received: 11:17:56 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:56 INFO - Running post-action listener: _resource_record_post_action 11:17:56 INFO - [mozharness: 2016-10-19 18:17:56.256111Z] Finished install step (success) 11:17:56 INFO - [mozharness: 2016-10-19 18:17:56.256357Z] Running run-tests step. 11:17:56 INFO - Running pre-action listener: _resource_record_pre_action 11:17:56 INFO - Running main action method: run_tests 11:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:56 INFO - Python 2.7.3 11:17:56 INFO - Return code: 0 11:17:56 INFO - grabbing minidump binary from tooltool 11:17:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:56 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 0x19cef60>, '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 0x19cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:56 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 11:17:56 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 11:17:56 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 11:17:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:56 INFO - Return code: 0 11:17:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 11:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 11:17:56 INFO - Using env: {'DISPLAY': ':0', 11:17:56 INFO - 'HOME': '/home/cltbld', 11:17:56 INFO - 'LANG': 'en_US.UTF-8', 11:17:56 INFO - 'LANGUAGE': 'en_US:en', 11:17:56 INFO - 'LOGNAME': 'cltbld', 11:17:56 INFO - 'MAIL': '/var/mail/cltbld', 11:17:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:56 INFO - 'MOZ_NO_REMOTE': '1', 11:17:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:56 INFO - 'NO_EM_RESTART': '1', 11:17:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:56 INFO - 'PWD': '/builds/slave/test', 11:17:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:56 INFO - 'SHELL': '/bin/bash', 11:17:56 INFO - 'SHLVL': '1', 11:17:56 INFO - 'TERM': 'linux', 11:17:56 INFO - 'TMOUT': '86400', 11:17:56 INFO - 'USER': 'cltbld', 11:17:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562', 11:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:56 INFO - '_': '/tools/buildbot/bin/python'} 11:17:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 11:17:56 INFO - mozversion application_buildid: 20161019102522 11:17:56 INFO - mozversion application_changeset: 557c6a8209fe88525f3a061a9e250aa43962709a 11:17:56 INFO - mozversion application_display_name: Nightly 11:17:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:56 INFO - mozversion application_name: Firefox 11:17:56 INFO - mozversion application_remotingname: firefox 11:17:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:17:56 INFO - mozversion application_vendor: Mozilla 11:17:56 INFO - mozversion application_version: 52.0a1 11:17:56 INFO - mozversion platform_buildid: 20161019102522 11:17:56 INFO - mozversion platform_changeset: 557c6a8209fe88525f3a061a9e250aa43962709a 11:17:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:17:56 INFO - mozversion platform_version: 52.0a1 11:17:56 INFO - using testdate: 1476901076 11:17:56 INFO - actual date: 1476901076 11:17:56 INFO - starting webserver on 'localhost:36118' 11:17:56 INFO - SUITE-START | Running 2 tests 11:17:56 INFO - TEST-START | dromaeo_css 11:17:56 INFO - operating with platform_type : linux_ 11:17:56 INFO - Initialising browser for dromaeo_css test... 11:17:56 INFO - TEST-INFO | started process 12280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjGMbj4/profile http://localhost:36118/getInfo.html) 11:18:01 INFO - PROCESS | 12280 | __metrics Screen width/height:1600/1200 11:18:01 INFO - PROCESS | 12280 | colorDepth:24 11:18:01 INFO - PROCESS | 12280 | Browser inner width/height: 1024/697 11:18:01 INFO - PROCESS | 12280 | __metrics 11:18:02 INFO - PROCESS | 12280 | 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" 11:18:02 INFO - PROCESS | 12280 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:02 INFO - PROCESS | 12280 | console.error: PushService: 11:18:02 INFO - PROCESS | 12280 | stateChangeProcessEnqueue: Error transitioning state 11:18:02 INFO - PROCESS | 12280 | UnknownError 11:18:03 INFO - TEST-INFO | 12280: exit 0 11:18:03 INFO - Browser initialized. 11:18:03 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:03 INFO - TEST-INFO | started process 12363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjGMbj4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:15 INFO - PROCESS | 12363 | RSS: Main: 173109248 11:18:15 INFO - PROCESS | 12363 | 11:19:07 INFO - PROCESS | 12363 | 1476901147306 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] 11:21:20 INFO - PROCESS | 12363 | Cycle 1(1): loaded http://localhost:36118/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36118/tests/dromaeo/cssquery-ext.html) 11:21:23 INFO - PROCESS | 12363 | RSS: Main: 372252672 11:21:23 INFO - PROCESS | 12363 | 11:24:25 INFO - PROCESS | 12363 | Cycle 1(1): loaded http://localhost:36118/tests/dromaeo/cssquery-ext.html (next: http://localhost:36118/tests/dromaeo/cssquery-jquery.html) 11:24:26 INFO - PROCESS | 12363 | RSS: Main: 276987904 11:24:26 INFO - PROCESS | 12363 | 11:27:28 INFO - PROCESS | 12363 | Cycle 1(1): loaded http://localhost:36118/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36118/tests/dromaeo/cssquery-mootools.html) 11:27:29 INFO - PROCESS | 12363 | RSS: Main: 220225536 11:27:29 INFO - PROCESS | 12363 | 11:30:31 INFO - PROCESS | 12363 | Cycle 1(1): loaded http://localhost:36118/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36118/tests/dromaeo/cssquery-prototype.html) 11:30:32 INFO - PROCESS | 12363 | RSS: Main: 247853056 11:30:32 INFO - PROCESS | 12363 | 11:33:35 INFO - PROCESS | 12363 | Cycle 1(1): loaded http://localhost:36118/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36118/tests/dromaeo/cssquery-yui.html) 11:33:36 INFO - PROCESS | 12363 | RSS: Main: 220540928 11:33:36 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | Cycle 1(1): loaded http://localhost:36118/tests/dromaeo/cssquery-yui.html (next: http://localhost:36118/tests/dromaeo/cssquery-dojo.html) 11:36:39 INFO - PROCESS | 12363 | RSS: Main: 289570816 11:36:39 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | __start_tp_report 11:36:39 INFO - PROCESS | 12363 | _x_x_mozilla_page_load 11:36:39 INFO - PROCESS | 12363 | _x_x_mozilla_page_load_details 11:36:39 INFO - PROCESS | 12363 | |i|pagename|runs| 11:36:39 INFO - PROCESS | 12363 | |0;dojo.html;2589.7928165746735;2602.557565213913;2628.9737102628974;2645.2328824640854;2655.150351887397;4629.90740185197;4716.7169969801835;4725.480197178312;4756.66703330767;4786.353842231302;4714.834980775673;4722.315264286676;4729.7635118244125;4733.029728905566;4741.122892264925;4353.151135528566;4369.847055353048;4388.210122178007;4407.911841763163;4447.88880277994;4435.401220835194;4446.444194475691;4463.910721785563;4464.575865292792;4466.263066594008;4324.07032488015;4342.3052311630145;4357.455318085239;4413.029133590621;4458.71018383804;4422.646188304944;4422.954346267222;4425.845095421645;4431.8448854289945;4439.289713645801;4265.829366825324;4314.158739045887;4317.827286908519;4336.501302350239;4401.163778882003;4715.599174070174;4752.382190315237;4758;4767;4767.070421267854;5062.215356619729;5087.618428617869;5109.029284435983;5111.539961403454;5160.948390516084;4954.677945933503;5011.223260394645;5012.874678133039;5126.5898728101665;5131.692098474104;4700.482946875841;4719.646026547954;4726.905461890743;4731.526847315241;4798.160321943716;5174.767135478913;5183.870403239949;5192.065428222956;5192.3769147702515;5258.763355649005;4874.488178741252;4977.427595826454;4984.725840078758;4986;4992.425871024806;4988.027334669705;5036.647434679538;5055.418626857885;5059.822906198266;5077.822276220315;5035.924461133086;5038.420581633159;5041.495850414929;5084.313617661568;5102.515261050195;5016.097102521581;5023.924641130386;5028.79884804611;5029.798808047637;5086.033653605803;4182.330827067715;4260.808263628144;4262.595053469915;4298.376735373354;4342.544032876503;3738.813059347022;3747.1568896997956;3749.775013499199;3760.5487341519192;3768.3217020935945;4300.268954277781;4322.546132656089;4339.392485052095;4344.109457561192;4383.232934236496;5056.772445239973;5063.468335824759;5072.239164125411;5086.186210206423;5135.666181698178;4212.49450065994;4263.658907287409;4266.402703621496;4317.726270750136;4318.52496225415;4430.18041662287;4447.688661793643;4482.081173359518;4537.274036154199;4542.046170304207;4720.409948756405;4724.267738500538;4729.054189162112;4770.475247722818;4784.832530861403;4993.600511958962;5000.449950505515;5040;5048.7223202722735;5113.411957624772;4648.140094082605;4678.251479763221;4697.882552936204;4719.59883409914;4726;4983.725895075806;4983.800647974041;4986.80052797884;4991.326170966873;4993.925091123709;5056.6713163644245;5066.9239961401345;5069.619778516552;5070.974645126751;5074.035933172685;4871.098846713369;4900.338454308765;4923.630727695366;4938.950610493849;4990.850274491771;4916.06594746997;4951.5048495150195;4965.280034395065;4967.3542439482635;5010.974945125251;4884.3650325457465;4900.387451568554;4906.705597664151;4911.066897289504;4941.678790878582;4781.9043619128115;4822.95177048225;4835.8065677372515;4897.338859253955;5047.470015648304;4820.373351464427;4845.103655823684;4892.48628893961;4896.2410826321975;4905.337779399735 11:36:39 INFO - PROCESS | 12363 | |1;ext.html;551.1814954792133;557.7908284393352;560.7476635514017;571.1090698510325;578.4995978478614;27403;30382.54426183606;36779.63220367799;38288.23423531528;38645.61354386455;39291;39693.80153099231;39782.8010859946;39794.40308395369;39821.60178398215;7314.96342518288;7445.218252083534;7459.850802983937;7461.179270280265;7463.067116610424;7581.052368453943;7617.733379331725;7671.156172820985;7676.1172465166665;7677.270659287359;7667.654955526987;7719.459637825355;7723.459357844953;7725.61371931404;7729.227077292254;7650.808729781745;7711.845763084763;7715.6913723451;7717.189695081992;7718.189590093071;7589.316961473494;7638.8472230555635;7654.885176722353;7660.425468089916;7666.731664391719;35129.824350878334;35306.11734706653;35374;35447;35455.645443545494;2854.049992832751;2950.3214260720156;3201.295714942709;3567.5362202913716;3623.927521449556;25081.749182508123;27341.863290683617;27844.229067843768;27876.16371508858;27909.720902790916;3416.3260002598795;3420.7263418926427;3471.75697701161;3509.333226686947;3616.4575313703153;251264;252222;254306;254334;254808.99999999814;45025.54974450214;53881.46118538843;54459;54487.45512544903;54541.727291364085;54276.45723542793;54678;60702.696486518165;60746.392536074956;60761.69619151876;15157.090574565562;15447.150406727513;15454.76361891046;15457.690846183013;15460.304286307142;10100.343477673927;10103.393796372242;10104.595816167272;10104.797904041878;10155.289129760846;18234.817651823578;18581.90709046446;18666.719999200024;18736.625267494575;18782.718259226123;6876.587404755631;6928.163062391251;6968.616726080013;7213.747518836815;7242.275772422716;922.6493932305815;939.3612343606277;957.9664711735056;959.7168835193635;964.1515466389533;26936;26998.190054298404;27230.591541126898;27402.45195096087;27989.72010279871;899.9415038022507;930.7626555228509;938.9812203755887;941;952.7522844060455;13868.930655346861;14347.282635868374;14614.780778288334;14642.780358294634;14753.188574628284;373597;443615;454387;455413;686860;50517;50933.236001460005;50967.74516127395;50990.490095098576;51057.99999999926;1089.4607169451015;1116.2019156303281;1167.988320116805;1207.2997661356392;1207.704112492445;24942.251732448054;27754;27843;29060;30496.542551861297;46973.2954005697;47765.283520746525;47835.76082119567;47863.76068119637;47884.521154788;338184.78168481984;340257.29871350486;340690;340762;341069;24022.39944001344;24153.879230603736;24706.13528526493;24911.501769964863;24946.750532494443;40552.391714123725;40572.18855622812;40688;40920.59079409168;41958.37062444127;34293.48559771655;34339;34474.655253448145;34562.654373455945;34703.65296347004;34657.13357166091;34675.47986780251;34801;34878;34890.302193956486;26687.48259814608;31702.682973170897;32757;34864.65135348614;36177;30305.848470757504;30792.692073078983;31408.576533651165;34511.13722156966;35044.47433288554;23977.52044959056;24497.75502245026;24668;24990.62514062327;25072.62391064099 11:36:39 INFO - PROCESS | 12363 | |2;jquery.html;346.66373617590943;352.8447483107431;366.8459247116211;368.1826345512962;392.99214015719684;15193.924030379847;15842.84157158428;16440.506784796475;16557.17214139294;16591.087490188034;16130.677386452264;16491.752623710654;16721.581960450996;17092.914535427306;17219.483415497554;4796.136695394836;5120.513551212629;5122.667026643275;5125.384953805548;5128.461511541291;3694.6305369463107;3896.922061558767;5038.445770965191;5700.173474846145;5961.225040744697;6030.698465076751;6037.275526936752;6040.637561746309;6046.33490316067;6049.516038716914;5837.445442682938;6098.237720284965;6127.509799216052;6129.38706129388;6131.693415329216;5193.974030129825;5335.711403277164;5367.1680889462195;5391;5394.02907476654;20118.49703757403;20412.285570004977;20445.182192712273;20452.07965641535;20526.897365513225;1959.931402400909;1961.6370971370343;1976.347805224287;2097.2345094040566;2368.5499755046485;12821.743565128645;13001.934990325082;13088.738225235536;13271.402786874614;13715.725685486233;1640.9261583228783;1675.2126500544725;1688.6116193275493;1719.2864961041153;1745.7206846904562;46973.76513117447;65283.67358163226;67181;67906.66046669734;70055.29944700538;8984.281257499384;9291.163795258459;9364.344495885223;9366.203872670763;9698.951505242429;12687.11190216676;12690;12701;12705.237685738884;12715.93642031784;6415.498202299293;6583.275839657634;6726.596404215665;6812.4550035997;6840.555363901331;6185.350538193515;6246.875062498724;6432.35676432353;6441.32366101562;6471.967640161769;5774.624649397776;5902.704864756745;5945.554083443759;5993.970030149909;6041.214642096587;1554;1670.548951783036;1687.9240434180492;1726.5165753589015;1730.351118330626;851.9062903080656;863.5466380150472;866.6013633728555;886.3972498700816;953.8521529162991;15845.68308633821;16133.435329763402;16319.428819991243;16636.33454661824;17319.913400432917;829.1832544943226;862.7627402464373;873.7291439653601;897.699270744295;934.1592566690033;9000.414973026733;9395.953020234854;9522.90477095234;9742.269329800294;9772.218222542322;376541;382629;384287;389705;395569;65180.39601684818;66456;66726;67154.66422667952;68638.65680671665;863.9031638602146;895.1719659315107;899.7165892743765;913.3743385780762;913.6939125392935;14644.41422343137;14716.926415368283;15226.46707365237;15257.237138143271;15348.138386818247;33628.159296017795;33906.32187356288;34550;34589.65410345864;34823.12942176466;42538;44470.77764611286;44789.552104479844;45161.322580161985;46081;7157.427405807627;7415.443841711785;7555.395568354628;7614.466987311057;7742.612869356397;10971.902809719284;11075.889241107487;11159.721006974565;11208.27146235492;11303.848363009633;7309.415246780139;9609.039096090335;9877.111060004634;10098;10140.13808826258;9849.162821160282;10185.796284074426;10231.641892533726;10313.690589282334;10598.20513461478;10129.544170512198;10187.796244074929;10206.948965255126;10334;10941.07000904932;7487;7523.360514356122;7664.923350766421;7727.343175830118;7759.030121234846;10377.896221037692;10386.688399348031;10416.635417760343;10589.9470502647;10940.835887461535 11:36:39 INFO - PROCESS | 12363 | |3;mootools.html;1369.5275130080124;1427.1365823676676;1463.985360146399;1687.1226961979778;1711.5122190175803;6927.792166235008;7202.459815513831;7495.550266983978;8140.837183256332;8147.714829980944;7650;7980.361571074314;7983;7985.361171106312;7988.600569971507;2151.5051538146276;2170.869747815136;2180.6947027416095;2188.5622875424897;2194.5391467791783;1848.0944337274707;1914.0525439907265;2111;2145.0990583954776;2162.664786958024;2090.0353667552527;2193.6819161221615;2195.626743453609;2199.395166329264;2209.1384360099573;2164.0910817456706;2181.1057466438683;2183.879886606236;2186.2020362567628;2188.2559929623844;2121.4908421978766;2125.5430082532175;2127.5319429725437;2128.936131916045;2130.371540395587;7905.130435652074;7943.523388596703;7979.922710434075;7990.600469976536;7994.720184793504;4520.367148599199;4648.86053418398;4657.743824089674;4663.51033141522;4664.836730714443;2697.9325516862236;2847.615571897809;2891;2893.2622181343622;2901.7243361880587;872.1017352127319;876.2595606712318;876.7676565710092;881.0440671871028;897.3897749530316;10697.946510267477;10729.678109656645;10730.678079657622;10733.355998640185;10739;3897.902552436212;4025.75845449274;4220.78896055196;4239.766812825263;4334.176506463762;9170.174684278447;9170.724878253663;9171.587278572346;9175.128362805657;9177.449353038839;4704.670673052853;4755.833545825949;4759;4766.880827979328;4773.689710168828;4232.957670423318;4330;4350.2387082260475;4352.455943007124;4355.586219309224;3603.5135256740527;3629.6370362963494;3674.8530058797883;3780.092777733324;3781.546214454283;1066.1950227578284;1126.4987080748988;1162.436218434059;1188.916775825684;1205.4756181061266;645.386882461654;732.1360794262821;733.3436574266002;741.7181471041077;755.1693137548652;4917.803287868445;5021.297018417425;5057;5097.362829646294;5153.175491921274;753.9283768042027;761.0486891385768;765.7549584133023;817.5626040068535;863.8401895649325;3360.344732777085;3481.8433170506883;3496.42309019009;3517.43721004638;3530.2586456843837;9483.14651681352;9784;9897.406155630686;9932.205423566098;9940;9809.362391444532;9824.4105353679;9834.950825245827;9839.262055345878;9839.409635421898;7377.668004939791;7453.813654658677;7457.552546847098;7458.962705186439;7465.141508726458;4839.563380703586;5014.373203349582;5094.974525127499;5115.974420127875;5138.379426492441;8869.093144973604;8884.511351875708;9044.14080662336;9051.683191088281;9071.365004449624;9010;9129.77175570616;9177.77055573616;9240.399374040666;9293.581788819383;6710.228323742832;6777.1189745332795;6821.624810635462;6826.2832402599;6836.623985680636;7420.740274090381;7430.702771889064;7469.327760501581;7470.813229669085;7472.476926615085;6684.933150668626;6697.0958920547055;6836.93163068363;6873.759418420332;6912.896306555305;6491.740330386731;6600.405963463311;6639.402453779183;6791.694373753292;6826.8634627308165;5920.822375328747;6069.817905462844;6072.180255665428;6073.696315184311;6078.513718902565;4025.9396109058976;4036.29364861154;4095.610916962884;4107.732997355162;4170.2910505214795;4208.410822484916;4272.1455708858975;4281.593248641374;4360.345948107809;4409.338599210144 11:36:39 INFO - PROCESS | 12363 | |4;prototype.html;284.9415869746702;286.1929359207036;294.6272964699655;294.73032175559365;299.52076677316285;4546.863594092182;4671.696339737915;4764.309175169598;4765.809367625299;4791.478263476346;4544.295634176699;4630.259158534635;4665.510121437251;4703.8118475261035;4761.928571071437;3778.263238668461;3786.3563194256903;3786.7917264550438;3786.86745963892;3808.447775072613;3559.252556963028;3791.748722921443;3796.810159492028;3799.639034291738;3800.429935509682;3453.5855697316356;3703.6666699996995;3704.870014645532;3713.3316003119426;3733.9358282889248;3712.313222053902;3712.870049548253;3719.75821571597;3722.758020728644;3743.569489508714;3277.4264503711993;3288.5067239913965;3294.2917272786226;3295.703386695209;3311.205310725433;4528.547145285478;4596.149712303235;4613.884652883671;4654.511276316006;4675.88310292242;4210.2842516772225;4212;4216.746995180299;4221.24017676818;4230.365445183216;4897.559219670211;4902.19113846215;4912.091263116335;4924.236743304794;4940.5059494050665;3482.703970162539;3574.946375804365;3590.7666001710068;3593.838277277529;3596.3166998270244;5136.972605478919;5140.331756871583;5191.260927589262;5206.817761378372;5223.791048358061;3663.5054267674054;3673.412254039394;3674.9632503675157;3685.760425572329;3692.7230457715777;3720.976731398887;3743.737938344344;3743.7753734776;3747.793871337048;3757.6618104370737;4055.7566546007333;4249.192653395845;4253.702240843111;4266.701330906869;4267.1892340455215;4941.851744447672;4947.455779864212;4963.329950456642;4966.180580204225;4970.204767237225;1207.4264724255909;1242.6023672424737;1287.3177216075308;1304.7260075384277;1308.8691130887025;852.9147085291421;883.650957871637;890.283321925843;898.8247291778041;903.1826197291462;4292.549282325311;4297.505786834491;4322.805473753689;4381.780910954503;4386.188555117314;5033.219850923113;5034.974825125851;5052.130711636718;5060.139776238048;5060.49395060491;4211.410402543646;4335.783210839445;4411.316245981878;4423.845165419195;4454.242778727624;2693.7575618194064;2731.576605626131;2735.9863200683867;2738.4523095381005;2742.7120152384114;4795.880102997383;4804.639652026112;4819.349387832598;4837.733924634109;4837.927431088537;5057.393112826484;5201.973990130025;5218.6868787872845;5240.764165612481;5269.841904742787;4769.189237829647;4789.976050119727;4795.712257264506;4798.832040878622;4818.542238487478;5117.513836185556;5136.2552429896705;5142.740028692994;5149.845504634867;5177.404598471224;4829.710217386968;5054.545090941833;5078.263651770399;5086.135356989246;5103.234514822658;4850.393700787402;4856.368672072608;4859.805607775649;4865.391826021747;4905.533974272438;3631.473436351767;3643.9250421125303;3654.3604869148326;3654.543182102237;3665.560132784083;5045.8280262731;5110.61670374716;5145.562627176732;5165.690058596496;5183.185884940241;5012.47369026247;5014.52362025607;5014.774335154853;5017.147084995632;5021.372328458942;5012.072766538202;5035.672681275705;5054.75063596696;5059.721715305694;5083.262926875656;4663.883402914954;4770.546798054179;4805;4879.658423910292;4927.423224568247;4869.537393947569;4991.700497969988;5016.899662006813;5022.623303252344;5027.32131162303;4904.975475122745;4929.876753081202;4930.580900623487;4935.654504184817;4954.430240522242 11:36:39 INFO - PROCESS | 12363 | |5;yui.html;617.3116974573351;637.6588525139051;660.824881406427;710.7547895975887;738.5347231244315;11995.220310679812;12777;12808.487660493593;12832.422540985655;12844.422001009954;12048.337341446217;12680.112392132554;12695.93652031741;12802.487900483993;12818.423170957307;745.3440971944694;791.89309443225;809.3565615335792;810.2100452059225;811;645.6481217736322;662.4965026579786;770.9845803083934;790.9920900791004;796.410656114474;843.8987321521427;846.4836449765638;849.477571293653;851.1233429567556;855.6406309350087;830.713403875665;839.6431516605418;840.8108175660489;840.8948881389827;841.3857883744839;489.08541028276994;490.23523303646425;492.63298842362667;500.36703569984;500.43200966902464;12225.510979560808;12576.937115314457;12611.621651350475;12673.366331683472;13107.737845243042;11568.768624627544;12121.636350909486;12351.752964940652;12423.4409451574;12683.936580317131;11494.36780977046;11570.42147892602;11633;11690.240134391237;11747;4070.3690927906223;4095.8566450174103;4096.262672718909;4115.670746340285;4155.480564929384;61264.38735612676;61757.6912115441;61896.69051654758;62344.68827655878;62600.68699656518;9798.755031124136;9817.950910245403;10008.299419040597;10238.692839214835;10260.897391025994;18680.53298667517;18694.53263668419;18737.34419295318;18786.248550057844;18809.247630094917;6579.374959378852;6634.573566683186;6647.302033286532;6708.993650952396;6872.759453419107;3256.5929258842643;3325.3681800457834;3378.915527111842;3395.592528896548;3400.1499625093725;2692.3134600676703;2987.865546050433;3041;3060.0513840709004;3091.381723655278;538.0422847331756;542.2002546244258;544.8174861421389;547.0344841354932;553.1067326268048;474.34540334339084;525.0129756058585;546.1861825879411;565.1381642994467;574.4743559642964;7585.1656317805;7638.69445222196;7658.463907526531;7814.413918956101;7895.684172633145;552.5910825988819;558.2770312445393;561.2759540193105;581.8690794571188;584.0480017571332;3513.94729079064;3577.373959557067;3637.8181090945345;3643.690286325639;3643.7267204959735;96870;97857.51071244598;98801.50599246958;99531;104348;86336.56831715927;86782.56608716917;87062;87086;89564;74136;74386.62806685932;76840;77753.61123194348;77755.61122194353;6548.639824809681;6590.7693230736695;6596.80209593713;6812.080369150101;6812.795616131326;43166;45910.08179836451;46593.53406465892;46674.53325466702;46872.76563617297;61859.690701546206;62079.37920620736;68175;68538;69550;9418.481983490974;9548.236141108555;9596.18432433251;10872.402017888775;10931.78136437251;12078.698032549257;12082.818757718816;12206.816897746363;12597.93701031489;13744.518941836988;10758.569657213624;10968.561257549927;11090;11315.434228288717;11498.25261358009;10547.57809687604;10631.468426578795;10954.195250135439;11317.660470185907;11580.710482237675;11126.388048657402;11222.831657524981;11485;11665.125115616192;11846.52613895469;10095.747606309607;10313.535890885078;10326.431229709626;10510.527026283682;10668.46657667098;10101.595936162765;10420.072286626695;10598.735031624272;10707.785844283226;10728.249022568345 11:36:39 INFO - PROCESS | 12363 | __end_tp_report 11:36:39 INFO - PROCESS | 12363 | __start_cc_report 11:36:39 INFO - PROCESS | 12363 | _x_x_mozilla_cycle_collect,2278 11:36:39 INFO - PROCESS | 12363 | __end_cc_report 11:36:39 INFO - PROCESS | 12363 | __startTimestamp1476902199252__endTimestamp 11:36:39 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | ------- Summary: start ------- 11:36:39 INFO - PROCESS | 12363 | Number of tests: 6 11:36:39 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | [#0] dojo.html Cycles:165 Average:4675.48 Median:4781.90 stddev:491.40 (10.3%) stddev-sans-first:464.87 11:36:39 INFO - PROCESS | 12363 | Values: 2589.8 2602.6 2629.0 2645.2 2655.2 4629.9 4716.7 4725.5 4756.7 4786.4 4714.8 4722.3 4729.8 4733.0 4741.1 4353.2 4369.8 4388.2 4407.9 4447.9 4435.4 4446.4 4463.9 4464.6 4466.3 4324.1 4342.3 4357.5 4413.0 4458.7 4422.6 4423.0 4425.8 4431.8 4439.3 4265.8 4314.2 4317.8 4336.5 4401.2 4715.6 4752.4 4758.0 4767.0 4767.1 5062.2 5087.6 5109.0 5111.5 5160.9 4954.7 5011.2 5012.9 5126.6 5131.7 4700.5 4719.6 4726.9 4731.5 4798.2 5174.8 5183.9 5192.1 5192.4 5258.8 4874.5 4977.4 4984.7 4986.0 4992.4 4988.0 5036.6 5055.4 5059.8 5077.8 5035.9 5038.4 5041.5 5084.3 5102.5 5016.1 5023.9 5028.8 5029.8 5086.0 4182.3 4260.8 4262.6 4298.4 4342.5 3738.8 3747.2 3749.8 3760.5 3768.3 4300.3 4322.5 4339.4 4344.1 4383.2 5056.8 5063.5 5072.2 5086.2 5135.7 4212.5 4263.7 4266.4 4317.7 4318.5 4430.2 4447.7 4482.1 4537.3 4542.0 4720.4 4724.3 4729.1 4770.5 4784.8 4993.6 5000.4 5040.0 5048.7 5113.4 4648.1 4678.3 4697.9 4719.6 4726.0 4983.7 4983.8 4986.8 4991.3 4993.9 5056.7 5066.9 5069.6 5071.0 5074.0 4871.1 4900.3 4923.6 4939.0 4990.9 4916.1 4951.5 4965.3 4967.4 5011.0 4884.4 4900.4 4906.7 4911.1 4941.7 4781.9 4823.0 4835.8 4897.3 5047.5 4820.4 4845.1 4892.5 4896.2 4905.3 11:36:39 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | [#1] ext.html Cycles:180 Average:50438.31 Median:35410.50 stddev:100104.30 (282.7%) stddev-sans-first:100315.04 11:36:39 INFO - PROCESS | 12363 | Values: 551.2 557.8 560.7 571.1 578.5 27403.0 30382.5 36779.6 38288.2 38645.6 39291.0 39693.8 39782.8 39794.4 39821.6 7315.0 7445.2 7459.9 7461.2 7463.1 7581.1 7617.7 7671.2 7676.1 7677.3 7667.7 7719.5 7723.5 7725.6 7729.2 7650.8 7711.8 7715.7 7717.2 7718.2 7589.3 7638.8 7654.9 7660.4 7666.7 35129.8 35306.1 35374.0 35447.0 35455.6 2854.0 2950.3 3201.3 3567.5 3623.9 25081.7 27341.9 27844.2 27876.2 27909.7 3416.3 3420.7 3471.8 3509.3 3616.5 251264.0 252222.0 254306.0 254334.0 254809.0 45025.5 53881.5 54459.0 54487.5 54541.7 54276.5 54678.0 60702.7 60746.4 60761.7 15157.1 15447.2 15454.8 15457.7 15460.3 10100.3 10103.4 10104.6 10104.8 10155.3 18234.8 18581.9 18666.7 18736.6 18782.7 6876.6 6928.2 6968.6 7213.7 7242.3 922.6 939.4 958.0 959.7 964.2 26936.0 26998.2 27230.6 27402.5 27989.7 899.9 930.8 939.0 941.0 952.8 13868.9 14347.3 14614.8 14642.8 14753.2 373597.0 443615.0 454387.0 455413.0 686860.0 50517.0 50933.2 50967.7 50990.5 51058.0 1089.5 1116.2 1168.0 1207.3 1207.7 24942.3 27754.0 27843.0 29060.0 30496.5 46973.3 47765.3 47835.8 47863.8 47884.5 338184.8 340257.3 340690.0 340762.0 341069.0 24022.4 24153.9 24706.1 24911.5 24946.8 40552.4 40572.2 40688.0 40920.6 41958.4 34293.5 34339.0 34474.7 34562.7 34703.7 34657.1 34675.5 34801.0 34878.0 34890.3 26687.5 31702.7 32757.0 34864.7 36177.0 30305.8 30792.7 31408.6 34511.1 35044.5 23977.5 24497.8 24668.0 24990.6 25072.6 11:36:39 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | [#2] jquery.html Cycles:180 Average:23500.46 Median:44975.44 stddev:63333.36 (140.8%) stddev-sans-first:63487.17 11:36:39 INFO - PROCESS | 12363 | Values: 346.7 352.8 366.8 368.2 393.0 15193.9 15842.8 16440.5 16557.2 16591.1 16130.7 16491.8 16721.6 17092.9 17219.5 4796.1 5120.5 5122.7 5125.4 5128.5 3694.6 3896.9 5038.4 5700.2 5961.2 6030.7 6037.3 6040.6 6046.3 6049.5 5837.4 6098.2 6127.5 6129.4 6131.7 5194.0 5335.7 5367.2 5391.0 5394.0 20118.5 20412.3 20445.2 20452.1 20526.9 1959.9 1961.6 1976.3 2097.2 2368.5 12821.7 13001.9 13088.7 13271.4 13715.7 1640.9 1675.2 1688.6 1719.3 1745.7 46973.8 65283.7 67181.0 67906.7 70055.3 8984.3 9291.2 9364.3 9366.2 9699.0 12687.1 12690.0 12701.0 12705.2 12715.9 6415.5 6583.3 6726.6 6812.5 6840.6 6185.4 6246.9 6432.4 6441.3 6472.0 5774.6 5902.7 5945.6 5994.0 6041.2 1554.0 1670.5 1687.9 1726.5 1730.4 851.9 863.5 866.6 886.4 953.9 15845.7 16133.4 16319.4 16636.3 17319.9 829.2 862.8 873.7 897.7 934.2 9000.4 9396.0 9522.9 9742.3 9772.2 376541.0 382629.0 384287.0 389705.0 395569.0 65180.4 66456.0 66726.0 67154.7 68638.7 863.9 895.2 899.7 913.4 913.7 14644.4 14716.9 15226.5 15257.2 15348.1 33628.2 33906.3 34550.0 34589.7 34823.1 42538.0 44470.8 44789.6 45161.3 46081.0 7157.4 7415.4 7555.4 7614.5 7742.6 10971.9 11075.9 11159.7 11208.3 11303.8 7309.4 9609.0 9877.1 10098.0 10140.1 9849.2 10185.8 10231.6 10313.7 10598.2 10129.5 10187.8 10206.9 10334.0 10941.1 7487.0 7523.4 7664.9 7727.3 7759.0 10377.9 10386.7 10416.6 10589.9 10940.8 11:36:39 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | [#3] mootools.html Cycles:180 Average:5124.57 Median:5096.17 stddev:2934.12 (57.6%) stddev-sans-first:2928.78 11:36:39 INFO - PROCESS | 12363 | Values: 1369.5 1427.1 1464.0 1687.1 1711.5 6927.8 7202.5 7495.6 8140.8 8147.7 7650.0 7980.4 7983.0 7985.4 7988.6 2151.5 2170.9 2180.7 2188.6 2194.5 1848.1 1914.1 2111.0 2145.1 2162.7 2090.0 2193.7 2195.6 2199.4 2209.1 2164.1 2181.1 2183.9 2186.2 2188.3 2121.5 2125.5 2127.5 2128.9 2130.4 7905.1 7943.5 7979.9 7990.6 7994.7 4520.4 4648.9 4657.7 4663.5 4664.8 2697.9 2847.6 2891.0 2893.3 2901.7 872.1 876.3 876.8 881.0 897.4 10697.9 10729.7 10730.7 10733.4 10739.0 3897.9 4025.8 4220.8 4239.8 4334.2 9170.2 9170.7 9171.6 9175.1 9177.4 4704.7 4755.8 4759.0 4766.9 4773.7 4233.0 4330.0 4350.2 4352.5 4355.6 3603.5 3629.6 3674.9 3780.1 3781.5 1066.2 1126.5 1162.4 1188.9 1205.5 645.4 732.1 733.3 741.7 755.2 4917.8 5021.3 5057.0 5097.4 5153.2 753.9 761.0 765.8 817.6 863.8 3360.3 3481.8 3496.4 3517.4 3530.3 9483.1 9784.0 9897.4 9932.2 9940.0 9809.4 9824.4 9835.0 9839.3 9839.4 7377.7 7453.8 7457.6 7459.0 7465.1 4839.6 5014.4 5095.0 5116.0 5138.4 8869.1 8884.5 9044.1 9051.7 9071.4 9010.0 9129.8 9177.8 9240.4 9293.6 6710.2 6777.1 6821.6 6826.3 6836.6 7420.7 7430.7 7469.3 7470.8 7472.5 6684.9 6697.1 6836.9 6873.8 6912.9 6491.7 6600.4 6639.4 6791.7 6826.9 5920.8 6069.8 6072.2 6073.7 6078.5 4025.9 4036.3 4095.6 4107.7 4170.3 4208.4 4272.1 4281.6 4360.3 4409.3 11:36:39 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | [#4] prototype.html Cycles:180 Average:4139.75 Median:4689.85 stddev:1191.80 (25.4%) stddev-sans-first:1159.50 11:36:39 INFO - PROCESS | 12363 | Values: 284.9 286.2 294.6 294.7 299.5 4546.9 4671.7 4764.3 4765.8 4791.5 4544.3 4630.3 4665.5 4703.8 4761.9 3778.3 3786.4 3786.8 3786.9 3808.4 3559.3 3791.7 3796.8 3799.6 3800.4 3453.6 3703.7 3704.9 3713.3 3733.9 3712.3 3712.9 3719.8 3722.8 3743.6 3277.4 3288.5 3294.3 3295.7 3311.2 4528.5 4596.1 4613.9 4654.5 4675.9 4210.3 4212.0 4216.7 4221.2 4230.4 4897.6 4902.2 4912.1 4924.2 4940.5 3482.7 3574.9 3590.8 3593.8 3596.3 5137.0 5140.3 5191.3 5206.8 5223.8 3663.5 3673.4 3675.0 3685.8 3692.7 3721.0 3743.7 3743.8 3747.8 3757.7 4055.8 4249.2 4253.7 4266.7 4267.2 4941.9 4947.5 4963.3 4966.2 4970.2 1207.4 1242.6 1287.3 1304.7 1308.9 852.9 883.7 890.3 898.8 903.2 4292.5 4297.5 4322.8 4381.8 4386.2 5033.2 5035.0 5052.1 5060.1 5060.5 4211.4 4335.8 4411.3 4423.8 4454.2 2693.8 2731.6 2736.0 2738.5 2742.7 4795.9 4804.6 4819.3 4837.7 4837.9 5057.4 5202.0 5218.7 5240.8 5269.8 4769.2 4790.0 4795.7 4798.8 4818.5 5117.5 5136.3 5142.7 5149.8 5177.4 4829.7 5054.5 5078.3 5086.1 5103.2 4850.4 4856.4 4859.8 4865.4 4905.5 3631.5 3643.9 3654.4 3654.5 3665.6 5045.8 5110.6 5145.6 5165.7 5183.2 5012.5 5014.5 5014.8 5017.1 5021.4 5012.1 5035.7 5054.8 5059.7 5083.3 4663.9 4770.5 4805.0 4879.7 4927.4 4869.5 4991.7 5016.9 5022.6 5027.3 4905.0 4929.9 4930.6 4935.7 4954.4 11:36:39 INFO - PROCESS | 12363 | 11:36:39 INFO - PROCESS | 12363 | [#5] yui.html Cycles:180 Average:17935.02 Median:23673.56 stddev:26081.70 (110.2%) stddev-sans-first:26122.45 11:36:39 INFO - PROCESS | 12363 | Values: 617.3 637.7 660.8 710.8 738.5 11995.2 12777.0 12808.5 12832.4 12844.4 12048.3 12680.1 12695.9 12802.5 12818.4 745.3 791.9 809.4 810.2 811.0 645.6 662.5 771.0 791.0 796.4 843.9 846.5 849.5 851.1 855.6 830.7 839.6 840.8 840.9 841.4 489.1 490.2 492.6 500.4 500.4 12225.5 12576.9 12611.6 12673.4 13107.7 11568.8 12121.6 12351.8 12423.4 12683.9 11494.4 11570.4 11633.0 11690.2 11747.0 4070.4 4095.9 4096.3 4115.7 4155.5 61264.4 61757.7 61896.7 62344.7 62600.7 9798.8 9818.0 10008.3 10238.7 10260.9 18680.5 18694.5 18737.3 18786.2 18809.2 6579.4 6634.6 6647.3 6709.0 6872.8 3256.6 3325.4 3378.9 3395.6 3400.1 2692.3 2987.9 3041.0 3060.1 3091.4 538.0 542.2 544.8 547.0 553.1 474.3 525.0 546.2 565.1 574.5 7585.2 7638.7 7658.5 7814.4 7895.7 552.6 558.3 561.3 581.9 584.0 3513.9 3577.4 3637.8 3643.7 3643.7 96870.0 97857.5 98801.5 99531.0 104348.0 86336.6 86782.6 87062.0 87086.0 89564.0 74136.0 74386.6 76840.0 77753.6 77755.6 6548.6 6590.8 6596.8 6812.1 6812.8 43166.0 45910.1 46593.5 46674.5 46872.8 61859.7 62079.4 68175.0 68538.0 69550.0 9418.5 9548.2 9596.2 10872.4 10931.8 12078.7 12082.8 12206.8 12597.9 13744.5 10758.6 10968.6 11090.0 11315.4 11498.3 10547.6 10631.5 10954.2 11317.7 11580.7 11126.4 11222.8 11485.0 11665.1 11846.5 10095.7 10313.5 10326.4 10510.5 10668.5 10101.6 10420.1 10598.7 10707.8 10728.2 11:36:39 INFO - PROCESS | 12363 | -------- Summary: end -------- 11:36:39 INFO - PROCESS | 12363 | 11:36:40 INFO - TEST-INFO | 12363: exit 0 11:36:40 INFO - TEST-OK | dromaeo_css | took 1123701ms 11:36:40 INFO - TEST-START | kraken 11:36:40 INFO - operating with platform_type : linux_ 11:36:40 INFO - Initialising browser for kraken test... 11:36:40 INFO - TEST-INFO | started process 12672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQAu7b1/profile http://localhost:36118/getInfo.html) 11:36:44 INFO - PROCESS | 12672 | __metrics Screen width/height:1600/1200 11:36:44 INFO - PROCESS | 12672 | colorDepth:24 11:36:44 INFO - PROCESS | 12672 | Browser inner width/height: 1024/697 11:36:44 INFO - PROCESS | 12672 | __metrics 11:36:45 INFO - PROCESS | 12672 | 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" 11:36:45 INFO - PROCESS | 12672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:45 INFO - PROCESS | 12672 | console.error: 11:36:45 INFO - PROCESS | 12672 | Message: Error: Connection closed before committing the transaction. 11:36:45 INFO - PROCESS | 12672 | Stack: 11:36:45 INFO - PROCESS | 12672 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 11:36:45 INFO - PROCESS | 12672 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 11:36:45 INFO - PROCESS | 12672 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 11:36:45 INFO - PROCESS | 12672 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 11:36:45 INFO - PROCESS | 12672 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 11:36:45 INFO - PROCESS | 12672 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 11:36:45 INFO - PROCESS | 12672 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 11:36:45 INFO - PROCESS | 12672 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 11:36:45 INFO - PROCESS | 12672 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 11:36:45 INFO - PROCESS | 12672 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 11:36:45 INFO - PROCESS | 12672 | Barrier/this.client.addBlocker/promise13.0% 11:37:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 11:37:45 INFO - TinderboxPrint: I/O write bytes / time
388,681,728 / 453,152 11:37:45 INFO - TinderboxPrint: CPU idle
8,362.1 (87.0%) 11:37:45 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 11:37:45 INFO - TinderboxPrint: Swap in / out
0 / 0 11:37:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99651584; Read time: 0; Write time: 187660 11:37:45 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 289030144; Read time: 0; Write time: 265492 11:37:46 INFO - Running post-run listener: _upload_blobber_files 11:37:46 INFO - Blob upload gear active. 11:37:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:46 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 11:37:46 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:37:46 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:37:46 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:37:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:37:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:47 INFO - (blobuploader) - INFO - Done attempting. 11:37:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:52 INFO - (blobuploader) - INFO - Done attempting. 11:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:53 INFO - (blobuploader) - INFO - Done attempting. 11:37:53 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:53 INFO - Return code: 0 11:37:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dcb4186066f2ebb60dd43d9142f489c186fa89b7537324814da6a169f78657c5fcc3ad0aeecf044b10b24424323165d0031279ee866934b330a2bb2ec93fda1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eba5e5eacaba39b7add17621753009400f782edd531ea9a1b27ca533fdfbd3c5c8f0103f83fa2db94150fa5d306cf63d9b2b41ce8fcbe2024131c179ff1a288c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5fc2f0ef339d15962a472109a026fa3ca9c5cb4589a5fef619e31a1f80ee990bfbe18f17c4e30c2902753be7a18192a2544fabfea15584c50135abb075defc3"} 11:37:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:53 INFO - Contents: 11:37:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dcb4186066f2ebb60dd43d9142f489c186fa89b7537324814da6a169f78657c5fcc3ad0aeecf044b10b24424323165d0031279ee866934b330a2bb2ec93fda1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eba5e5eacaba39b7add17621753009400f782edd531ea9a1b27ca533fdfbd3c5c8f0103f83fa2db94150fa5d306cf63d9b2b41ce8fcbe2024131c179ff1a288c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5fc2f0ef339d15962a472109a026fa3ca9c5cb4589a5fef619e31a1f80ee990bfbe18f17c4e30c2902753be7a18192a2544fabfea15584c50135abb075defc3"} 11:37:53 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:53 INFO - Copying logs to upload dir... 11:37:53 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.570675 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-19 11:37:53.645827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 11:37:53.649593) ========= 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=eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dcb4186066f2ebb60dd43d9142f489c186fa89b7537324814da6a169f78657c5fcc3ad0aeecf044b10b24424323165d0031279ee866934b330a2bb2ec93fda1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eba5e5eacaba39b7add17621753009400f782edd531ea9a1b27ca533fdfbd3c5c8f0103f83fa2db94150fa5d306cf63d9b2b41ce8fcbe2024131c179ff1a288c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5fc2f0ef339d15962a472109a026fa3ca9c5cb4589a5fef619e31a1f80ee990bfbe18f17c4e30c2902753be7a18192a2544fabfea15584c50135abb075defc3"} build_url:https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/NSOiFVelTSGIJU1LnKRt0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dcb4186066f2ebb60dd43d9142f489c186fa89b7537324814da6a169f78657c5fcc3ad0aeecf044b10b24424323165d0031279ee866934b330a2bb2ec93fda1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eba5e5eacaba39b7add17621753009400f782edd531ea9a1b27ca533fdfbd3c5c8f0103f83fa2db94150fa5d306cf63d9b2b41ce8fcbe2024131c179ff1a288c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5fc2f0ef339d15962a472109a026fa3ca9c5cb4589a5fef619e31a1f80ee990bfbe18f17c4e30c2902753be7a18192a2544fabfea15584c50135abb075defc3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 11:37:53.680107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:37:53.680922) ========= 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=eca2ab57546de7b41f256b19000001ef-1476900333.278989-463181562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 11:37:53.763967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 11:37:53.764354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 11:37:53.764713) ========= ========= Total master_lag: 0.19 =========