builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1476466936.14 results: success (0) buildid: 20161014095309 builduid: 63a95e2dc403466787f132557f967058 revision: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.137723) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.138725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.139183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.155826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.156101) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 10:42:16-- 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% 109M=0s 2016-10-14 10:42:16 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.323069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.323400) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.374082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:16.374406) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c899672fff6ae00f5b3affbec48ee4daac35fa1 --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 0c899672fff6ae00f5b3affbec48ee4daac35fa1 --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=edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 10:42:16,602 truncating revision to first 12 chars 2016-10-14 10:42:16,602 Setting DEBUG logging. 2016-10-14 10:42:16,602 attempt 1/10 2016-10-14 10:42:16,602 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c899672fff6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 10:42:16,906 unpacking tar archive at: fx-team-0c899672fff6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626055 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:17.013698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:17.014032) ========= script_repo_revision: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:17.014457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:17.014747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:42:17.024462) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-14 10:42:17.024866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:42:17 INFO - MultiFileLogger online at 20161014 10:42:17 in /builds/slave/test 10:42:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:42:17 INFO - {'append_to_log': False, 10:42:17 INFO - 'base_work_dir': '/builds/slave/test', 10:42:17 INFO - 'blob_upload_branch': 'Fx-Team', 10:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:42:17 INFO - 'branch': 'Fx-Team', 10:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 10:42:17 INFO - 'config_files': ('talos/linux_config.py',), 10:42:17 INFO - 'default_actions': ('clobber', 10:42:17 INFO - 'read-buildbot-config', 10:42:17 INFO - 'download-and-extract', 10:42:17 INFO - 'populate-webroot', 10:42:17 INFO - 'create-virtualenv', 10:42:17 INFO - 'install', 10:42:17 INFO - 'run-tests'), 10:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:42:17 INFO - 'download_minidump_stackwalk': True, 10:42:17 INFO - 'download_symbols': 'ondemand', 10:42:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:42:17 INFO - 'tooltool.py': '/tools/tooltool.py', 10:42:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:42:17 INFO - '/tools/misc-python/virtualenv.py')}, 10:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:42:17 INFO - 'installer_path': 'installer.exe', 10:42:17 INFO - 'log_level': 'info', 10:42:17 INFO - 'log_name': 'talos', 10:42:17 INFO - 'log_to_console': True, 10:42:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:42:17 INFO - 'opt_config_files': (), 10:42:17 INFO - 'pip_index': False, 10:42:17 INFO - 'sps_profile': False, 10:42:17 INFO - 'sps_profile_interval': 0, 10:42:17 INFO - 'suite': 'dromaeojs', 10:42:17 INFO - 'system_bits': '32', 10:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:42:17 INFO - 'title': 'talos-linux64-ix-033', 10:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:42:17 INFO - 'use_talos_json': True, 10:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:42:17 INFO - 'work_dir': 'build'} 10:42:17 INFO - [mozharness: 2016-10-14 17:42:17.349969Z] Running clobber step. 10:42:17 INFO - Running pre-action listener: _resource_record_pre_action 10:42:17 INFO - Running main action method: clobber 10:42:17 INFO - rmtree: /builds/slave/test/build 10:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:42:17 INFO - Running post-action listener: _resource_record_post_action 10:42:17 INFO - [mozharness: 2016-10-14 17:42:17.814168Z] Finished clobber step (success) 10:42:17 INFO - [mozharness: 2016-10-14 17:42:17.814268Z] Running read-buildbot-config step. 10:42:17 INFO - Running pre-action listener: _resource_record_pre_action 10:42:17 INFO - Running main action method: read_buildbot_config 10:42:17 INFO - Using buildbot properties: 10:42:17 INFO - { 10:42:17 INFO - "project": "", 10:42:17 INFO - "product": "firefox", 10:42:17 INFO - "script_repo_revision": "production", 10:42:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:42:17 INFO - "repository": "", 10:42:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:42:17 INFO - "buildid": "20161014095309", 10:42:17 INFO - "stage_platform": "linux64-pgo", 10:42:17 INFO - "basedir": "/builds/slave/test", 10:42:17 INFO - "buildnumber": 1135, 10:42:17 INFO - "platform": "ubuntu64_hw", 10:42:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:42:17 INFO - "slavebuilddir": "test", 10:42:17 INFO - "branch": "fx-team", 10:42:17 INFO - "revision": "0c899672fff6ae00f5b3affbec48ee4daac35fa1", 10:42:17 INFO - "slavename": "talos-linux64-ix-033", 10:42:17 INFO - "builduid": "63a95e2dc403466787f132557f967058", 10:42:17 INFO - "repo_path": "integration/fx-team" 10:42:17 INFO - } 10:42:17 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:42:17 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 10:42:17 INFO - Running post-action listener: _resource_record_post_action 10:42:17 INFO - [mozharness: 2016-10-14 17:42:17.816609Z] Finished read-buildbot-config step (success) 10:42:17 INFO - [mozharness: 2016-10-14 17:42:17.816697Z] Running download-and-extract step. 10:42:17 INFO - Running pre-action listener: _resource_record_pre_action 10:42:17 INFO - Running main action method: download_and_extract 10:42:17 INFO - mkdir: /builds/slave/test/build/tests 10:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:17 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:42:17 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/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 10:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/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 10:42:17 INFO - Downloaded 1361 bytes. 10:42:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:42:17 INFO - Using the following test package requirements: 10:42:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:42:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:42:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:42:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'jsshell-linux-x86_64.zip'], 10:42:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:42:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:42:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:42:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:42:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:42:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:42:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:42:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:42:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:42:17 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:42:17 INFO - Http code: 200 10:42:17 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 10:42:17 INFO - x-amz-cf-id: DlOX0PTAqdJ-yIUSmxZfIyx07tyy12btf_sCBolBbrhahIye2VptAA== 10:42:17 INFO - x-amz-replication-status: COMPLETED 10:42:17 INFO - x-amz-version-id: XrfjTtnl9CBMwNwW9o064QplO5q7xR9e 10:42:18 INFO - Expected file size: 22123341 10:42:18 INFO - Obtained file size: 22123341 10:42:22 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 10:42:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:42:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:42:22 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:42:22 INFO - Http code: 200 10:42:22 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 10:42:22 INFO - x-amz-cf-id: zwmjW79QeNpOG3bXUJcAP2xLM4zRd9edJA1rFqdEFT76llPMZP1xtg== 10:42:22 INFO - x-amz-replication-status: COMPLETED 10:42:22 INFO - x-amz-version-id: XrfjTtnl9CBMwNwW9o064QplO5q7xR9e 10:42:22 INFO - Expected file size: 22123341 10:42:22 INFO - Obtained file size: 22123341 10:42:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:42:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:42:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:42:27 INFO - Http code: 200 10:42:27 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:42:27 INFO - x-amz-cf-id: Lp_5FtpFH4JuZPvbClH5XAxo18LYD8ZX8F-65Uh3PjVbKb0UL-ABKQ== 10:42:27 INFO - x-amz-replication-status: COMPLETED 10:42:27 INFO - x-amz-version-id: b_EiVbpGRxV0Wl.PP1HPKC3RSirj95vq 10:42:27 INFO - Expected file size: 14409006 10:42:27 INFO - Obtained file size: 14409006 10:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:42:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/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 10:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/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 10:42:28 INFO - Downloaded 59606677 bytes. 10:42:28 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:42:28 INFO - mkdir: /builds/slave/test/properties 10:42:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:42:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:42:28 INFO - Contents: 10:42:28 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:42:28 INFO - Running post-action listener: _resource_record_post_action 10:42:28 INFO - Running post-action listener: set_extra_try_arguments 10:42:28 INFO - [mozharness: 2016-10-14 17:42:28.519978Z] Finished download-and-extract step (success) 10:42:28 INFO - [mozharness: 2016-10-14 17:42:28.520204Z] Running populate-webroot step. 10:42:28 INFO - Running pre-action listener: _resource_record_pre_action 10:42:28 INFO - Running main action method: populate_webroot 10:42:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:42:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:42:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:42:28 INFO - '--tppagecycles', 10:42:28 INFO - '7'], 10:42:28 INFO - 'tests': ['tsvgm']}}, 10:42:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:42:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:42:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:42:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:42:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:28 INFO - 'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:28 INFO - 'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['damp', 'tps']}, 10:42:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:28 INFO - 'tests': ['damp', 'tps']}, 10:42:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['dromaeo_dom']}, 10:42:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:42:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['basic_compositor_video']}, 10:42:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:42:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['a11yr', 10:42:28 INFO - 'ts_paint', 10:42:28 INFO - 'tpaint', 10:42:28 INFO - 'sessionrestore', 10:42:28 INFO - 'sessionrestore_no_auto_restore', 10:42:28 INFO - 'tabpaint']}, 10:42:28 INFO - 'other-e10s': {'tests': ['a11yr', 10:42:28 INFO - 'ts_paint', 10:42:28 INFO - 'tpaint', 10:42:28 INFO - 'sessionrestore', 10:42:28 INFO - 'sessionrestore_no_auto_restore', 10:42:28 INFO - 'tabpaint']}, 10:42:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:42:28 INFO - 'ts_paint', 10:42:28 INFO - 'tpaint', 10:42:28 INFO - 'sessionrestore', 10:42:28 INFO - 'sessionrestore_no_auto_restore', 10:42:28 INFO - 'tabpaint']}, 10:42:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:42:28 INFO - 'ts_paint', 10:42:28 INFO - 'tpaint', 10:42:28 INFO - 'sessionrestore', 10:42:28 INFO - 'sessionrestore_no_auto_restore', 10:42:28 INFO - 'tabpaint']}, 10:42:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['a11yr', 10:42:28 INFO - 'ts_paint', 10:42:28 INFO - 'tpaint', 10:42:28 INFO - 'sessionrestore', 10:42:28 INFO - 'sessionrestore_no_auto_restore', 10:42:28 INFO - 'tabpaint']}, 10:42:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['a11yr', 10:42:28 INFO - 'ts_paint', 10:42:28 INFO - 'tpaint', 10:42:28 INFO - 'sessionrestore', 10:42:28 INFO - 'sessionrestore_no_auto_restore', 10:42:28 INFO - 'tabpaint']}, 10:42:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['tsvgx', 10:42:28 INFO - 'tsvgr_opacity', 10:42:28 INFO - 'tart', 10:42:28 INFO - 'tscrollx', 10:42:28 INFO - 'cart']}, 10:42:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:42:28 INFO - 'tsvgr_opacity', 10:42:28 INFO - 'tart', 10:42:28 INFO - 'tscrollx', 10:42:28 INFO - 'cart']}, 10:42:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:28 INFO - 'talos_options': ['--disable-e10s'], 10:42:28 INFO - 'tests': ['tp5o']}, 10:42:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:28 INFO - 'tests': ['tp5o']}, 10:42:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:28 INFO - 'talos_options': ['--disable-e10s', 10:42:28 INFO - '--xperf_path', 10:42:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:28 INFO - 'tests': ['tp5n']}, 10:42:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:28 INFO - 'talos_options': ['--xperf_path', 10:42:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:28 INFO - 'tests': ['tp5n']}}, 10:42:28 INFO - 'talos.zip': {'path': '', 10:42:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:42:28 INFO - Running post-action listener: _resource_record_post_action 10:42:28 INFO - [mozharness: 2016-10-14 17:42:28.539386Z] Finished populate-webroot step (success) 10:42:28 INFO - [mozharness: 2016-10-14 17:42:28.539474Z] Running create-virtualenv step. 10:42:28 INFO - Running pre-action listener: _resource_record_pre_action 10:42:28 INFO - Running main action method: create_virtualenv 10:42:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:42:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:42:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:42:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:42:28 INFO - Using real prefix '/usr' 10:42:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:42:29 INFO - Installing distribute.............................................................................................................................................................................................done. 10:42:31 INFO - Installing pip.................done. 10:42:31 INFO - Return code: 0 10:42:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:42:31 INFO - Reading from file tmpfile_stdout 10:42:31 INFO - Output received: 10:42:31 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) 10:42:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:42:31 INFO - Using env: {'DISPLAY': ':0', 10:42:31 INFO - 'HOME': '/home/cltbld', 10:42:31 INFO - 'LANG': 'en_US.UTF-8', 10:42:31 INFO - 'LANGUAGE': 'en_US:en', 10:42:31 INFO - 'LOGNAME': 'cltbld', 10:42:31 INFO - 'MAIL': '/var/mail/cltbld', 10:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:31 INFO - 'MOZ_NO_REMOTE': '1', 10:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:31 INFO - 'NO_EM_RESTART': '1', 10:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:31 INFO - 'PWD': '/builds/slave/test', 10:42:31 INFO - 'SHELL': '/bin/bash', 10:42:31 INFO - 'SHLVL': '1', 10:42:31 INFO - 'TERM': 'linux', 10:42:31 INFO - 'TMOUT': '86400', 10:42:31 INFO - 'USER': 'cltbld', 10:42:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:31 INFO - '_': '/tools/buildbot/bin/python'} 10:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:42:31 INFO - Cleaning up... 10:42:31 INFO - Return code: 0 10:42:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:42:31 INFO - Using env: {'DISPLAY': ':0', 10:42:31 INFO - 'HOME': '/home/cltbld', 10:42:31 INFO - 'LANG': 'en_US.UTF-8', 10:42:31 INFO - 'LANGUAGE': 'en_US:en', 10:42:31 INFO - 'LOGNAME': 'cltbld', 10:42:31 INFO - 'MAIL': '/var/mail/cltbld', 10:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:31 INFO - 'MOZ_NO_REMOTE': '1', 10:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:31 INFO - 'NO_EM_RESTART': '1', 10:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:31 INFO - 'PWD': '/builds/slave/test', 10:42:31 INFO - 'SHELL': '/bin/bash', 10:42:31 INFO - 'SHLVL': '1', 10:42:31 INFO - 'TERM': 'linux', 10:42:31 INFO - 'TMOUT': '86400', 10:42:31 INFO - 'USER': 'cltbld', 10:42:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:31 INFO - '_': '/tools/buildbot/bin/python'} 10:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:31 INFO - Downloading/unpacking psutil>=3.1.1 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:42:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:33 INFO - Installing collected packages: psutil 10:42:33 INFO - Running setup.py install for psutil 10:42:33 INFO - building 'psutil._psutil_linux' extension 10:42:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:42:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:42:34 INFO - building 'psutil._psutil_posix' extension 10:42:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:42:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:42:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:34 INFO - Successfully installed psutil 10:42:34 INFO - Cleaning up... 10:42:34 INFO - Return code: 0 10:42:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:42:34 INFO - Using env: {'DISPLAY': ':0', 10:42:34 INFO - 'HOME': '/home/cltbld', 10:42:34 INFO - 'LANG': 'en_US.UTF-8', 10:42:34 INFO - 'LANGUAGE': 'en_US:en', 10:42:34 INFO - 'LOGNAME': 'cltbld', 10:42:34 INFO - 'MAIL': '/var/mail/cltbld', 10:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:34 INFO - 'MOZ_NO_REMOTE': '1', 10:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:34 INFO - 'NO_EM_RESTART': '1', 10:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:34 INFO - 'PWD': '/builds/slave/test', 10:42:34 INFO - 'SHELL': '/bin/bash', 10:42:34 INFO - 'SHLVL': '1', 10:42:34 INFO - 'TERM': 'linux', 10:42:34 INFO - 'TMOUT': '86400', 10:42:34 INFO - 'USER': 'cltbld', 10:42:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:34 INFO - '_': '/tools/buildbot/bin/python'} 10:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:42:36 INFO - Installing collected packages: mozsystemmonitor 10:42:36 INFO - Running setup.py install for mozsystemmonitor 10:42:36 INFO - Successfully installed mozsystemmonitor 10:42:36 INFO - Cleaning up... 10:42:36 INFO - Return code: 0 10:42:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:42:36 INFO - Using env: {'DISPLAY': ':0', 10:42:36 INFO - 'HOME': '/home/cltbld', 10:42:36 INFO - 'LANG': 'en_US.UTF-8', 10:42:36 INFO - 'LANGUAGE': 'en_US:en', 10:42:36 INFO - 'LOGNAME': 'cltbld', 10:42:36 INFO - 'MAIL': '/var/mail/cltbld', 10:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:36 INFO - 'MOZ_NO_REMOTE': '1', 10:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:36 INFO - 'NO_EM_RESTART': '1', 10:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:36 INFO - 'PWD': '/builds/slave/test', 10:42:36 INFO - 'SHELL': '/bin/bash', 10:42:36 INFO - 'SHLVL': '1', 10:42:36 INFO - 'TERM': 'linux', 10:42:36 INFO - 'TMOUT': '86400', 10:42:36 INFO - 'USER': 'cltbld', 10:42:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:36 INFO - '_': '/tools/buildbot/bin/python'} 10:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:42:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:42:39 INFO - warning: no files found matching '*.txt' 10:42:39 INFO - no previously-included directories found matching 'build' 10:42:39 INFO - no previously-included directories found matching 'dist' 10:42:39 INFO - no previously-included directories found matching '.git*' 10:42:39 INFO - Installing collected packages: jsonschema, functools32 10:42:39 INFO - Running setup.py install for functools32 10:42:39 INFO - warning: no files found matching '*.txt' 10:42:39 INFO - no previously-included directories found matching 'build' 10:42:39 INFO - no previously-included directories found matching 'dist' 10:42:39 INFO - no previously-included directories found matching '.git*' 10:42:39 INFO - Successfully installed jsonschema functools32 10:42:39 INFO - Cleaning up... 10:42:39 INFO - Return code: 0 10:42:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:42: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')]} 10:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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')]} 10:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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', '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 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:42: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 functools32==3.2.3-2 10:42:39 INFO - Using env: {'DISPLAY': ':0', 10:42:39 INFO - 'HOME': '/home/cltbld', 10:42:39 INFO - 'LANG': 'en_US.UTF-8', 10:42:39 INFO - 'LANGUAGE': 'en_US:en', 10:42:39 INFO - 'LOGNAME': 'cltbld', 10:42:39 INFO - 'MAIL': '/var/mail/cltbld', 10:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:39 INFO - 'MOZ_NO_REMOTE': '1', 10:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:39 INFO - 'NO_EM_RESTART': '1', 10:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:39 INFO - 'PWD': '/builds/slave/test', 10:42:39 INFO - 'SHELL': '/bin/bash', 10:42:39 INFO - 'SHLVL': '1', 10:42:39 INFO - 'TERM': 'linux', 10:42:39 INFO - 'TMOUT': '86400', 10:42:39 INFO - 'USER': 'cltbld', 10:42:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:39 INFO - '_': '/tools/buildbot/bin/python'} 10:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:42:39 INFO - Cleaning up... 10:42:39 INFO - Return code: 0 10:42:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:42: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')]} 10:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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')]} 10:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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', '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 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:42: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 blobuploader==1.2.4 10:42:39 INFO - Using env: {'DISPLAY': ':0', 10:42:39 INFO - 'HOME': '/home/cltbld', 10:42:39 INFO - 'LANG': 'en_US.UTF-8', 10:42:39 INFO - 'LANGUAGE': 'en_US:en', 10:42:39 INFO - 'LOGNAME': 'cltbld', 10:42:39 INFO - 'MAIL': '/var/mail/cltbld', 10:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:39 INFO - 'MOZ_NO_REMOTE': '1', 10:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:39 INFO - 'NO_EM_RESTART': '1', 10:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:39 INFO - 'PWD': '/builds/slave/test', 10:42:39 INFO - 'SHELL': '/bin/bash', 10:42:39 INFO - 'SHLVL': '1', 10:42:39 INFO - 'TERM': 'linux', 10:42:39 INFO - 'TMOUT': '86400', 10:42:39 INFO - 'USER': 'cltbld', 10:42:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:39 INFO - '_': '/tools/buildbot/bin/python'} 10:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:42:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:42:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:42 INFO - Downloading docopt-0.6.1.tar.gz 10:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:42:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:42:42 INFO - Running setup.py install for blobuploader 10:42:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:42:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:42:42 INFO - Running setup.py install for requests 10:42:42 INFO - Running setup.py install for docopt 10:42:43 INFO - Successfully installed blobuploader requests docopt 10:42:43 INFO - Cleaning up... 10:42:43 INFO - Return code: 0 10:42:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:43 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')]} 10:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:43 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')]} 10:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:43 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 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:42:43 INFO - Using env: {'DISPLAY': ':0', 10:42:43 INFO - 'HOME': '/home/cltbld', 10:42:43 INFO - 'LANG': 'en_US.UTF-8', 10:42:43 INFO - 'LANGUAGE': 'en_US:en', 10:42:43 INFO - 'LOGNAME': 'cltbld', 10:42:43 INFO - 'MAIL': '/var/mail/cltbld', 10:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:43 INFO - 'MOZ_NO_REMOTE': '1', 10:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:43 INFO - 'NO_EM_RESTART': '1', 10:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:43 INFO - 'PWD': '/builds/slave/test', 10:42:43 INFO - 'SHELL': '/bin/bash', 10:42:43 INFO - 'SHLVL': '1', 10:42:43 INFO - 'TERM': 'linux', 10:42:43 INFO - 'TMOUT': '86400', 10:42:43 INFO - 'USER': 'cltbld', 10:42:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:43 INFO - '_': '/tools/buildbot/bin/python'} 10:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:43 INFO - Running setup.py (path:/tmp/pip-9OTarw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:43 INFO - Running setup.py (path:/tmp/pip-ItY3hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:43 INFO - Running setup.py (path:/tmp/pip-O77Y6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:43 INFO - Running setup.py (path:/tmp/pip-jH_rlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:43 INFO - Running setup.py (path:/tmp/pip-dmt8LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:43 INFO - Running setup.py (path:/tmp/pip-QBQSRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:43 INFO - Running setup.py (path:/tmp/pip-JUWo_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:43 INFO - Running setup.py (path:/tmp/pip-0oG4bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:43 INFO - Running setup.py (path:/tmp/pip-LjSIIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:43 INFO - Running setup.py (path:/tmp/pip-rWfgG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:44 INFO - Running setup.py (path:/tmp/pip-wIDwfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:44 INFO - Running setup.py (path:/tmp/pip-6tnf5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:44 INFO - Running setup.py (path:/tmp/pip-ke_D9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:44 INFO - Running setup.py (path:/tmp/pip-OZIcJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:44 INFO - Running setup.py (path:/tmp/pip-rQq6Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:44 INFO - Running setup.py (path:/tmp/pip-FNd8uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:44 INFO - Running setup.py (path:/tmp/pip-WUnVns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:42:44 INFO - Running setup.py install for manifestparser 10:42:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:42:44 INFO - Running setup.py install for mozcrash 10:42:44 INFO - Running setup.py install for mozdebug 10:42:44 INFO - Running setup.py install for mozdevice 10:42:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:42:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:42:44 INFO - Running setup.py install for mozfile 10:42:45 INFO - Running setup.py install for mozhttpd 10:42:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Running setup.py install for mozinfo 10:42:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Running setup.py install for mozInstall 10:42:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Running setup.py install for mozleak 10:42:45 INFO - Running setup.py install for mozlog 10:42:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Running setup.py install for moznetwork 10:42:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Running setup.py install for mozprocess 10:42:45 INFO - Running setup.py install for mozprofile 10:42:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:42:45 INFO - Running setup.py install for mozrunner 10:42:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:42:46 INFO - Running setup.py install for mozscreenshot 10:42:46 INFO - Running setup.py install for moztest 10:42:46 INFO - Running setup.py install for mozversion 10:42:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:42:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:42:46 INFO - Cleaning up... 10:42:46 INFO - Return code: 0 10:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:46 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')]} 10:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:46 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')]} 10:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:46 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 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:42:46 INFO - Using env: {'DISPLAY': ':0', 10:42:46 INFO - 'HOME': '/home/cltbld', 10:42:46 INFO - 'LANG': 'en_US.UTF-8', 10:42:46 INFO - 'LANGUAGE': 'en_US:en', 10:42:46 INFO - 'LOGNAME': 'cltbld', 10:42:46 INFO - 'MAIL': '/var/mail/cltbld', 10:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:46 INFO - 'MOZ_NO_REMOTE': '1', 10:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:46 INFO - 'NO_EM_RESTART': '1', 10:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:46 INFO - 'PWD': '/builds/slave/test', 10:42:46 INFO - 'SHELL': '/bin/bash', 10:42:46 INFO - 'SHLVL': '1', 10:42:46 INFO - 'TERM': 'linux', 10:42:46 INFO - 'TMOUT': '86400', 10:42:46 INFO - 'USER': 'cltbld', 10:42:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:46 INFO - '_': '/tools/buildbot/bin/python'} 10:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:46 INFO - Running setup.py (path:/tmp/pip-I0Ptp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:46 INFO - Running setup.py (path:/tmp/pip-RClJmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:46 INFO - Running setup.py (path:/tmp/pip-xEmtSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:46 INFO - Running setup.py (path:/tmp/pip-dpom_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:46 INFO - Running setup.py (path:/tmp/pip-__H4Av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:46 INFO - Running setup.py (path:/tmp/pip-bPvd3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:47 INFO - Running setup.py (path:/tmp/pip-BdTPUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:47 INFO - Running setup.py (path:/tmp/pip-vKmsdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:47 INFO - Running setup.py (path:/tmp/pip-WAh5kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:47 INFO - Running setup.py (path:/tmp/pip-n8xQ7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:47 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)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:47 INFO - Running setup.py (path:/tmp/pip-xh8s5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:47 INFO - Running setup.py (path:/tmp/pip-61VDFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:47 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)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:47 INFO - Running setup.py (path:/tmp/pip-HBqckP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:47 INFO - Running setup.py (path:/tmp/pip-bFSCxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:47 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)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:47 INFO - Running setup.py (path:/tmp/pip-OYFNVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:47 INFO - Running setup.py (path:/tmp/pip-6HUlz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:47 INFO - Running setup.py (path:/tmp/pip-XoBHk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:42:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:49 INFO - Downloading blessings-1.6.tar.gz 10:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:42:49 INFO - Installing collected packages: blessings 10:42:49 INFO - Running setup.py install for blessings 10:42:49 INFO - Successfully installed blessings 10:42:49 INFO - Cleaning up... 10:42:50 INFO - Return code: 0 10:42:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:50 INFO - Reading from file tmpfile_stdout 10:42:50 INFO - Current package versions: 10:42:50 INFO - argparse == 1.2.1 10:42:50 INFO - blessings == 1.6 10:42:50 INFO - blobuploader == 1.2.4 10:42:50 INFO - docopt == 0.6.1 10:42:50 INFO - functools32 == 3.2.3-2 10:42:50 INFO - jsonschema == 2.5.1 10:42:50 INFO - manifestparser == 1.1 10:42:50 INFO - mozInstall == 1.12 10:42:50 INFO - mozcrash == 0.17 10:42:50 INFO - mozdebug == 0.1 10:42:50 INFO - mozdevice == 0.48 10:42:50 INFO - mozfile == 1.2 10:42:50 INFO - mozhttpd == 0.7 10:42:50 INFO - mozinfo == 0.9 10:42:50 INFO - mozleak == 0.1 10:42:50 INFO - mozlog == 3.4 10:42:50 INFO - moznetwork == 0.27 10:42:50 INFO - mozprocess == 0.23 10:42:50 INFO - mozprofile == 0.28 10:42:50 INFO - mozrunner == 6.12 10:42:50 INFO - mozscreenshot == 0.1 10:42:50 INFO - mozsystemmonitor == 0.3 10:42:50 INFO - moztest == 0.7 10:42:50 INFO - mozversion == 1.4 10:42:50 INFO - psutil == 3.1.1 10:42:50 INFO - requests == 1.2.3 10:42:50 INFO - wsgiref == 0.1.2 10:42:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:50 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')]} 10:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:50 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')]} 10:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:50 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 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:42:50 INFO - Using env: {'DISPLAY': ':0', 10:42:50 INFO - 'HOME': '/home/cltbld', 10:42:50 INFO - 'LANG': 'en_US.UTF-8', 10:42:50 INFO - 'LANGUAGE': 'en_US:en', 10:42:50 INFO - 'LOGNAME': 'cltbld', 10:42:50 INFO - 'MAIL': '/var/mail/cltbld', 10:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:50 INFO - 'MOZ_NO_REMOTE': '1', 10:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:50 INFO - 'NO_EM_RESTART': '1', 10:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:50 INFO - 'PWD': '/builds/slave/test', 10:42:50 INFO - 'SHELL': '/bin/bash', 10:42:50 INFO - 'SHLVL': '1', 10:42:50 INFO - 'TERM': 'linux', 10:42:50 INFO - 'TMOUT': '86400', 10:42:50 INFO - 'USER': 'cltbld', 10:42:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:50 INFO - '_': '/tools/buildbot/bin/python'} 10:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:42:50 INFO - Cleaning up... 10:42:50 INFO - Return code: 0 10:42:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:42:50 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')]} 10:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:50 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')]} 10:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:50 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 0x7fb06d476f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:42:50 INFO - Using env: {'DISPLAY': ':0', 10:42:50 INFO - 'HOME': '/home/cltbld', 10:42:50 INFO - 'LANG': 'en_US.UTF-8', 10:42:50 INFO - 'LANGUAGE': 'en_US:en', 10:42:50 INFO - 'LOGNAME': 'cltbld', 10:42:50 INFO - 'MAIL': '/var/mail/cltbld', 10:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:50 INFO - 'MOZ_NO_REMOTE': '1', 10:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:50 INFO - 'NO_EM_RESTART': '1', 10:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:50 INFO - 'PWD': '/builds/slave/test', 10:42:50 INFO - 'SHELL': '/bin/bash', 10:42:50 INFO - 'SHLVL': '1', 10:42:50 INFO - 'TERM': 'linux', 10:42:50 INFO - 'TMOUT': '86400', 10:42:50 INFO - 'USER': 'cltbld', 10:42:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:50 INFO - '_': '/tools/buildbot/bin/python'} 10:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:42:50 INFO - Cleaning up... 10:42:50 INFO - Return code: 0 10:42:50 INFO - Running post-action listener: _resource_record_post_action 10:42:50 INFO - Running post-action listener: _start_resource_monitoring 10:42:50 INFO - Starting resource monitoring. 10:42:50 INFO - [mozharness: 2016-10-14 17:42:50.710148Z] Finished create-virtualenv step (success) 10:42:50 INFO - [mozharness: 2016-10-14 17:42:50.710662Z] Running install step. 10:42:50 INFO - Running pre-action listener: _resource_record_pre_action 10:42:50 INFO - Running main action method: install 10:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:50 INFO - Reading from file tmpfile_stdout 10:42:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:42:51 INFO - Reading from file tmpfile_stdout 10:42:51 INFO - Output received: 10:42:51 INFO - Usage: mozinstall [options] installer 10:42:51 INFO - Options: 10:42:51 INFO - -h, --help show this help message and exit 10:42:51 INFO - -d DEST, --destination=DEST 10:42:51 INFO - Directory to install application into. [default: 10:42:51 INFO - "/builds/slave/test"] 10:42:51 INFO - --app=APP Application being installed. [default: firefox] 10:42:51 INFO - mkdir: /builds/slave/test/build/application 10:42:51 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'] 10:42:51 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 10:43:08 INFO - Reading from file tmpfile_stdout 10:43:08 INFO - Output received: 10:43:08 INFO - /builds/slave/test/build/application/firefox/firefox 10:43:08 INFO - Running post-action listener: _resource_record_post_action 10:43:08 INFO - [mozharness: 2016-10-14 17:43:08.065548Z] Finished install step (success) 10:43:08 INFO - [mozharness: 2016-10-14 17:43:08.065820Z] Running run-tests step. 10:43:08 INFO - Running pre-action listener: _resource_record_pre_action 10:43:08 INFO - Running main action method: run_tests 10:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:43:08 INFO - Python 2.7.3 10:43:08 INFO - Return code: 0 10:43:08 INFO - grabbing minidump binary from tooltool 10:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:08 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 0x25fc930>, '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 0x25fd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:43:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:43:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:43:08 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 10:43:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:43:08 INFO - Return code: 0 10:43:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:43:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:43:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:43:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:43:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:43:08 INFO - Using env: {'DISPLAY': ':0', 10:43:08 INFO - 'HOME': '/home/cltbld', 10:43:08 INFO - 'LANG': 'en_US.UTF-8', 10:43:08 INFO - 'LANGUAGE': 'en_US:en', 10:43:08 INFO - 'LOGNAME': 'cltbld', 10:43:08 INFO - 'MAIL': '/var/mail/cltbld', 10:43:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:43:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:08 INFO - 'MOZ_NO_REMOTE': '1', 10:43:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:08 INFO - 'NO_EM_RESTART': '1', 10:43:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:08 INFO - 'PWD': '/builds/slave/test', 10:43:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:43:08 INFO - 'SHELL': '/bin/bash', 10:43:08 INFO - 'SHLVL': '1', 10:43:08 INFO - 'TERM': 'linux', 10:43:08 INFO - 'TMOUT': '86400', 10:43:08 INFO - 'USER': 'cltbld', 10:43:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959', 10:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:08 INFO - '_': '/tools/buildbot/bin/python'} 10:43:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:43:08 INFO - mozversion application_buildid: 20161014063008 10:43:08 INFO - mozversion application_changeset: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 10:43:08 INFO - mozversion application_display_name: Nightly 10:43:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:43:08 INFO - mozversion application_name: Firefox 10:43:08 INFO - mozversion application_remotingname: firefox 10:43:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:43:08 INFO - mozversion application_vendor: Mozilla 10:43:08 INFO - mozversion application_version: 52.0a1 10:43:08 INFO - mozversion platform_buildid: 20161014063008 10:43:08 INFO - mozversion platform_changeset: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 10:43:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:43:08 INFO - mozversion platform_version: 52.0a1 10:43:08 INFO - using testdate: 1476466988 10:43:08 INFO - actual date: 1476466988 10:43:08 INFO - starting webserver on 'localhost:43101' 10:43:08 INFO - SUITE-START | Running 2 tests 10:43:08 INFO - TEST-START | dromaeo_css 10:43:08 INFO - operating with platform_type : linux_ 10:43:08 INFO - Initialising browser for dromaeo_css test... 10:43:08 INFO - TEST-INFO | started process 20256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOtpHup/profile http://localhost:43101/getInfo.html) 10:43:12 INFO - PROCESS | 20256 | __metrics Screen width/height:1600/1200 10:43:12 INFO - PROCESS | 20256 | colorDepth:24 10:43:12 INFO - PROCESS | 20256 | Browser inner width/height: 1024/697 10:43:12 INFO - PROCESS | 20256 | __metrics 10:43:13 INFO - PROCESS | 20256 | 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" 10:43:13 INFO - PROCESS | 20256 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:43:14 INFO - PROCESS | 20256 | console.error: PushService: 10:43:14 INFO - PROCESS | 20256 | stateChangeProcessEnqueue: Error transitioning state 10:43:14 INFO - PROCESS | 20256 | UnknownError 10:43:15 INFO - TEST-INFO | 20256: exit 0 10:43:15 INFO - Browser initialized. 10:43:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:43:15 INFO - TEST-INFO | started process 20336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOtpHup/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:43:27 INFO - PROCESS | 20336 | RSS: Main: 172048384 10:43:27 INFO - PROCESS | 20336 | 10:44:18 INFO - PROCESS | 20336 | 1476467058277 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:46:29 INFO - PROCESS | 20336 | Cycle 1(1): loaded http://localhost:43101/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43101/tests/dromaeo/cssquery-ext.html) 10:46:31 INFO - PROCESS | 20336 | RSS: Main: 294109184 10:46:31 INFO - PROCESS | 20336 | 10:49:33 INFO - PROCESS | 20336 | Cycle 1(1): loaded http://localhost:43101/tests/dromaeo/cssquery-ext.html (next: http://localhost:43101/tests/dromaeo/cssquery-jquery.html) 10:49:34 INFO - PROCESS | 20336 | RSS: Main: 275697664 10:49:34 INFO - PROCESS | 20336 | 10:52:36 INFO - PROCESS | 20336 | Cycle 1(1): loaded http://localhost:43101/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43101/tests/dromaeo/cssquery-mootools.html) 10:52:36 INFO - PROCESS | 20336 | RSS: Main: 216510464 10:52:36 INFO - PROCESS | 20336 | 10:55:39 INFO - PROCESS | 20336 | Cycle 1(1): loaded http://localhost:43101/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43101/tests/dromaeo/cssquery-prototype.html) 10:55:39 INFO - PROCESS | 20336 | RSS: Main: 235819008 10:55:39 INFO - PROCESS | 20336 | 10:58:42 INFO - PROCESS | 20336 | Cycle 1(1): loaded http://localhost:43101/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43101/tests/dromaeo/cssquery-yui.html) 10:58:42 INFO - PROCESS | 20336 | RSS: Main: 218169344 10:58:42 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | Cycle 1(1): loaded http://localhost:43101/tests/dromaeo/cssquery-yui.html (next: http://localhost:43101/tests/dromaeo/cssquery-dojo.html) 11:01:46 INFO - PROCESS | 20336 | RSS: Main: 309776384 11:01:46 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | __start_tp_report 11:01:46 INFO - PROCESS | 20336 | _x_x_mozilla_page_load 11:01:46 INFO - PROCESS | 20336 | _x_x_mozilla_page_load_details 11:01:46 INFO - PROCESS | 20336 | |i|pagename|runs| 11:01:46 INFO - PROCESS | 20336 | |0;dojo.html;3039;3046.9238269043276;3056.0373482353043;3110.984445077774;3118.719315261626;5202.167653175493;5209.244659524366;5302.734863256841;5332.760025798839;5341.732913354326;5325.653832500885;5339.466053394659;5351.625386222966;5353.0899747042995;5370.355557333116;4832.081904438163;4858.368412106422;4868.732219727914;4910.901781964377;4930.137225985438;4847.345608342882;4862.78117484714;4878.024395120972;4882.487338829425;4886.315915771795;4871.805127794902;4883.609311255109;4884.975575122119;4919.827806026789;4929.8028078876805;4965.32968049316;4979.502049795028;4985.302057711923;4992.850214493535;5050.520200580939;4742.596879265267;4775.904481910377;4778.522147785228;4868.634852386085;4878.829240976549;5183.092958732244;5229.450907654679;5243.475652434764;5264.341957255343;5267.130923397634;5617.269754931874;5651.40660230674;5656.462636049569;5662.150677398382;5724.055530837407;5584.776608935637;5621.4659607337235;5768.509676677488;5795.3045634523705;5854.677992710399;5283.207518872162;5334.199870019528;5335.733213339357;5365.275687782178;5420.566354691615;5794.797182098607;5833.7083145842535;5844.15259787337;5844.47399734026;5847.44449277318;5425.755840987165;5614.29821272341;5622.044252477089;5625.54995600351;5634.098544232985;5526.834194974157;5580.665160090408;5691.658500489983;5698.344690360662;5708.971455142698;5583.776648934078;5621.4659607337235;5629.54963602919;5634.4365563443325;5637.267155269788;5628.634138780966;5630.60585758993;5640.633358831663;5643.435656434406;5696.886062278814;4294.527601963781;4308.91382172361;4314.805833737427;4343.630791382705;4371.759553224603;3894.4547763313158;3901.31726947783;3937.822797974098;3938.6455219030427;3958.3468727659615;5338.172583249525;5338.172583249602;5344.893102137936;5347.465253474699;5398.1902714593125;5492.890142197213;5546.168074788814;5592.384837667853;5594.580406469531;5656.745446454919;5333.973330133324;5355.678659280456;5363.624546281801;5424.376196737426;5448.945510544923;4947.529984651453;4948.925766113512;4950.628702847301;4963.6277279204205;4965.4041515018425;5673.8297851064535;5716.28546431696;5891.1457838614015;5894.410558944071;5895.351511333835;5678.77284908599;5707.771689132388;5712.5429965601825;5737.971310143589;5803.7968671096305;5925.229720136354;5926.555508336805;5928.555358348055;5931.466168044896;5943.791967281298;5298.364196296469;5379.2469054333205;5651.208830763779;5655.349634792052;5658.490735833795;5693.259876216065;5735.3977832327;5751.511121554548;5783.450572195635;5851.970740146272;5594.664320140804;5617.550595952396;5625.578081643975;5634.690092044977;5648.802291919763;5395.622306438511;5590.133529302964;5608.495235428831;5610.691411972381;5625.8593535161945;5390.784368625211;5393.9730301348245;5423.755930983037;5476.397596264487;5593.07714227148;5595.132754423071;5621.634593751393;5630.8029218977135;5640.32316122068;5643.548516118619;5248.081585722407;5322.201669749568;5484.506394424521;5516.862078448071;5519.420460851553 11:01:46 INFO - PROCESS | 20336 | |1;ext.html;559.7740947325357;594.9528829260502;611.8959776837937;612.7181496511604;636.6784773689286;33278.83360583197;34055.489167662505;34138.65861341389;44659.10681786362;45778.77110614451;42993;43297.56702432975;43335.34996975048;43340.349894751605;43398.78300608492;8717.084706105847;8864.290856731446;8870.645174193056;8870.955645221766;8871.866921996176;7894.092179399357;8041.95979020107;8783.604737786814;10389.792204155912;10638.521266542986;10839.078678312353;10901.073408760225;10903.454827258605;10903.781924361547;10913.126949843994;10666.253362264644;10695.358278503314;10724.678259652144;10735.40955247461;10737.355758654428;10545.894541054568;10609.575616975311;10614.363138211655;10614.840777388345;10615.840762388492;41480.58519414797;41763.582364176276;41845.581544184475;41854.79072604648;41933.58066419327;3196.360727854438;3239.9352012959844;3260.494623333387;3264.316173473956;3395.9320813583836;30748.58099473996;31520.211994700316;31817.522737158728;31897.043088707145;31938.730109531898;3990.1890404403002;4113.465249517573;4116.567760385146;4122;4134.449581406972;325388;329045;330805;429597;431549;56924;57639.711801440724;57660.71169644125;57697;57716;61584;61887.69056154691;62077;62658;62686.68656656779;15203.847961520465;15481.84518154804;15692.529224123295;15718.21408929549;15733.246681830633;10203.846942295871;11630.244034137753;11670.88329116698;11758.58844940423;11988.940055299841;16158.27287772053;18458;18560.350387736635;18720.344787932358;19457.610847782966;6895.862082758316;6984.21902414881;7105.92894071063;7153.177384600734;7167;903.503073309677;1023.918086553074;1027.1833892055834;1047.4186826311318;1082.8700555933337;30617.38765224683;30694;31014.534781978287;31122.247789996192;31241;1033.7312298802365;1063.9521221545049;1089.1014912697058;1107.1585594947737;1141.6004398460473;15306.464273750365;16192.919035404982;16209.432669856498;16377.344906203856;16497.587560311087;533835;536776;537219;538339;540131;56836.715816420656;57369.71315143398;57419.425805741404;57451;57452;1180.3449085757316;1206.312401930891;1259.6724851538665;1269.5429645327858;1282.0704988882985;27393.72606273912;31331.84334078315;31896.840515797274;31928.68071319257;32420;46508.53491465042;47020.529794701615;47068.7646561765;47076;47132.52867471281;393985;394270;394893;394933;398131;23996;24060.15789447361;24514.264572062868;24776.38059048466;25803.226403115485;45363;45510;45851.08297834091;46904.53095469002;47119.05761884811;37548.24903501969;38036.6935885933;38089.23821523499;38932;39676.60323396729;37612.811935940146;37656.43515347327;37808.43287350637;38862.6113738859;38934;36802.8159859199;37163.6283637171;37809.24381512409;38035.80982095183;38389.424158638205;32298;35196;35262.823685881405;35370.29259414849;35534.822325888206;26129.216123516326;26685.599716004665;26861.194164175107;26925;27035.594466083418 11:01:46 INFO - PROCESS | 20336 | |2;jquery.html;351.80826449584976;374.65157403614626;377.5016977589582;381.62981907549687;401.99701744148337;13882.861171388284;18024.279028838846;18514.814851851494;19465.51336216595;19643.5089122772;15294;17981.730274045898;18434.07829608521;19243.71134432981;19423.61152776947;5283.86790330241;5608.523275521586;5610.635308704921;5613.354464236624;5621.128725047603;4045.9595404046026;4057.2291264659766;4173.499180098393;5466.726663666821;5565.638233514808;4220.050488640062;6233.563650544464;6249.750009999617;6252.562320637558;6273.937260627404;6010.27876654802;6138.662373569452;6188.721507532172;6238.4697300729495;6243.125962365272;5473.972630136864;5480.424555421703;5482.068048431776;5506.284183056177;5520.06158952979;22060.88969555142;22331.44171395728;22434.775652243596;22738.204162854385;22743.772562274495;2023.5447024419534;2190.1567896359857;2234.7988681018787;2241.2043724477903;2412.2522018174423;9613.423194608346;9894.604215831358;10165.186785057178;10495.63265285719;13892.374843132084;1817.323226046974;1942.9902850485657;1946.9513262168418;1952.9316473923345;2000.4498762840335;80318;81121;81614;83302.58348708278;85356;10504;10720;10745.355278683304;10758.515866786014;11042.392668403154;14837.851621483864;14861.182634955181;14871.553853384416;14883.776743348859;14897.106173629616;7310.52481588695;7683.231676832272;7755.573443460551;7924.881126783102;7957.681692732342;7304.488685791944;7381.630918454056;7499.512531685423;7581.3176814087;7656.387489000978;4499.3251012347755;4523.592876641118;4609.1703493371515;4614.930776038362;4700.388949436551;1890.423420856652;1893.4414347767442;1903.8857668539931;1921.28912302449;1953.7948515405963;810.6838333050115;889.0931250124836;891.1534042659499;895.7491902267376;980.8087422952599;17296.91351543234;17688.380906668204;18294.359697410793;19017.80982190188;19305.131269092926;915.1763412928418;925.7778133247972;954.0697819625948;968.864358989742;973.6981535723949;9602.375845570015;10716.517756700967;10742.570297188026;11087;11123.110151187886;453264;454230;458928;479666;482444;88550.55724721465;88801.55599222092;89992.5500372494;91112.54443727872;92047.39763011957;969.6896992962326;998.92615438404;1022.3712416863575;1035.166690813887;1039.2517387481003;16408.507744767678;16582.25379857885;17029.744553831453;17122.743158852878;17403.216855241797;38879.80560097181;40476.79761601173;40570.59429405668;40604.59395406008;40765.1846963065;55814.72092639511;55925.44074559202;56533;57808.42191578199;58250.4174958245;6812;7176.677049532679;7221.133463984355;8030;8311.83376332458;12301.876981230072;12633.178843375152;13167.53913613019;13445.394957226752;13790.172589644653;9901.108900199017;10648.041676248866;10666.786664266827;11428.828567571327;11530.250533715282;10684.893151068702;11176.832347514632;11213.439328033728;11244.100471962387;11531.884681153417;11427.771444571228;11552.768944620891;11601.941990289995;11836.46735896904;11977.101717371057;8221.54781487;8273.33813294947;8298.253157215879;8395.664173432995;8513.233808957224;10330.896691032993;11074.224804263946;11196.496157673088;11292.43537823122;11537.48081336325 11:01:46 INFO - PROCESS | 20336 | |3;mootools.html;1308.6074177746673;1432.8208973878266;1488.4046381447422;1628.7882575265214;1769.5841477252843;7219.314165154315;8213.137620549838;8302.33581313495;8320.70877519287;8506;8356.080831108588;8420.24217820396;8421.494710317385;8426.831463370745;8438.91561084389;2171.923982660607;2187.9890600546973;2199.065397206189;2206.0403724379867;2216.8448208625405;2090.090810497431;2126.4046067101235;2147.7530084040377;2157.5361297321074;2160.7839216078346;2127.7765834587376;2145.549434618732;2154.504463973287;2155.4072630026712;2167.0898222746405;2124.798144176301;2127.617028934791;2142.1966762464076;2146.6565349544076;2150.3226483657677;2058.1561559760426;2159.6112699714045;2159.6544552871464;2162.0811155259107;2168.913243470259;8360.665573377057;8448.662053517852;8527.573621318908;8780.73657790261;8781.38530302879;5135.64050516464;5346.304980352529;5355.866103347408;5360.758765855546;5363.410024897258;3332.350191712617;3334.683205095512;3374.156460884779;3398.3373242217776;3407.863685452604;1049.4490392543976;1052.55792567122;1072.9892701072968;1082.0477979378174;1085.396483674202;12100.81848772269;12120.151589388746;12171.93914030433;12223.08326875479;12292.569760058355;4142.46148000764;4299.441072660534;4340.9131817364105;4444.2222611042935;4464.374987501752;9600.135987760996;9612.375195612263;9615.951920240494;9617.759556011015;9628.855567166498;4973.254011898244;4983.401991761012;4985.700857948462;4986.177280748636;4988.875278118004;4009.859654912064;4078.163146293988;4589.632829373642;4662.137504561667;4664.207084795593;3627.8911632650534;3665.4135338345736;3776.2258736958856;3780.697544196458;3794.29805485986;1095.2935356695045;1117.1118960426481;1129.6102844518628;1130.9943450282697;1131.2364154195884;797.5972134072256;805.8468890910708;914.3782228084966;940.5344354544544;943.7310366545502;5730.914036289459;5734.770609175586;5846.444587764156;5893.6463812171405;5997.580169388189;918.196577994255;926.4024704065974;927.2581934452411;941.0824446164935;980.1962390839585;3554.0048786339867;3841.9039524012123;3879.3405121129476;3913.8043097844993;3939.5075615548058;10662.626808061681;11153.498092585853;11156.944215278872;11176.888231117748;11183.161262905314;11019.228653994143;11020.779584408267;11029.889701102886;11035.172362072877;11047.72380690489;7804;8021.839563208703;8120.066192387951;8213.95893020531;8222.83554328922;5836.737346819488;5906.438888305604;5925.614835035709;5928.436798504135;6080.7567697291615;9902.900970990486;9988.200943924614;10111.64609238673;10148;10214.285000049926;9920.40477571348;10198.43908585035;10238.641647542598;10256.12822910061;10268.64059757905;7640.541567505745;7669.61651917413;7712.730054448068;7734;7803.843923121619;8341.916580834113;8434.114417986268;8452.957735211285;8505.74482765518;8507.82984340322;7418.554886706815;7463.925360746323;7586.772396828104;7764.728234511765;7826.843463130592;7499.212582678959;7635.694572217049;7659.157492675689;7667.233276672511;7680.731174408869;6638.76764313266;6738.528303018742;6749.223839258548;6753.729850805913;6757.22291936414;4863.319135321129;4877.6829506081995;4888.120138375127;4907.435644900739;4926.768307923019;4922.655414120977;5020;5054.16606259963;5115.104856649997;5168.405633352213 11:01:46 INFO - PROCESS | 20336 | |4;prototype.html;281.3669244200549;292.31306429889764;296.9035063604329;318.2933886771367;320.09572956398176;5086.542211200991;5265.684058956455;5283.867903302419;5298.390685071218;5319.308489896308;5036.67261627994;5180.171172612383;5189.636725429222;5212.21816727491;5235.534050465866;4065.2885744994655;4126.628603425691;4128;4143.606357396043;4156.314208155651;3897.610238976094;4069.470968774055;4099.651529619971;4151.792410379484;4159.875203743877;4067.7966101694947;4072.1855628874346;4072.857449989251;4073.8574149904757;4085.447529938634;4035.8183881725395;4036.0515278909434;4058.6550143237714;4081.8571350002903;4084.835037430137;3432.2963792422493;3515;3545.7340699447386;3546.592141903688;3602.67575918166;5127.128388174019;5132.435432102466;5149.304843846107;5152.742362881841;5159.613029022838;4640;4652.441706995149;4656.557627025461;4660.766961651938;4670.556297151765;5400.540954018913;5406;5450.727463626803;5475.616706830523;5569.192467092289;3839.7504162229366;3840.636574016212;3848.8261080370476;3857.4213867919757;3860.6911447084167;5684.317881854204;5712.857178570527;5756.82729518111;5766.846630673882;5776.913346299851;3744.457053727249;3891.3190191716335;3915.7063220258597;3965.72239943207;3986;3958.6635136013188;3970.622790834866;3977.76133431995;3978.522577290744;3979.522457305142;4624.329472226508;4630.791614377361;4636.165490211727;4636.605888499448;4637.582617564368;5343.412224655285;5484.875600501888;5562.610617256834;5594.636348637326;5654.869026194778;1311.7179806341683;1342.684469149749;1343.5431953135785;1345.724126554054;1347.1311004402105;937.8124375125002;950.9429434233969;960.4861399151421;961.7259081161975;966.9991558736674;5257.894842103136;5257.973710131425;5329.25390445338;5340.359156901197;5348.197770334403;5478.616496845262;5577;5588.972055139699;5667.518260947783;5724.685142317129;5371.791346946984;5380.461953804666;5389.191621256843;5393.732472868873;5393.892122157535;2958.349163184096;2961.5113506271655;3005.2036210404262;3017.4116047370553;3023.3953209358215;5818.418158184232;5824.737886795105;5854.648721076749;5858.619189752652;5864.589478736448;5766;5768.154190659033;5773.769049238067;5794.420557944256;5818.359980402152;5573.442655734475;5732.226149469769;5804.448577385142;5850.970745146247;5901.527877769769;5588.776448941997;5601.327840659147;5640.689762062962;5654.7455364509515;5671.149327600893;5550.888982220414;5579.386267510489;5581.520896962227;5593.720313984366;5612.186232996111;5603.739158689263;5827.213326200908;5844.824655260349;5847.883042339215;5864.44287792659;4071.7964101795383;4096.05790668154;4111.239420707178;4149.419081328677;4154.709170358046;5363.865903352447;5671.6597004179885;5673.631213971079;5712.885742285048;5716.399778023248;5456.536194423518;5458.972705136608;5477.397486276427;5480.451954804487;5485.232067510472;5241.187615919539;5423.728813559385;5461.890762184655;5467.72661366938;5505.311836020497;5245.186996015624;5351.839444816662;5439.184122381675;5450;5459.2902922619805;5435.483629055233;5507.944920550904;5539.390667026543;5601.495865372136;5620.992768868636;5207.411739419514;5375.139977603565;5391.9460805391445;5443.972780136074;5453.918191227055 11:01:46 INFO - PROCESS | 20336 | |5;yui.html;684.3669605614812;709.7019251914196;740.474263273076;797.6450479536605;810.6311628209165;15061.698766024687;16308.347666093343;16329.183540822942;16340.75488867668;16419.179041047944;14608.415663373453;14975;15427.151506667129;15472.149031803247;15474.071555706638;819.3649921310987;832.3382910586099;835.9373047021468;837.2506606587132;838.7357982235607;682.2324884504932;838.0278876503257;840.0591337701783;840.3865178419758;840.8444437779;723.9239879812623;848.961796719146;849.817289282804;874.2874557235864;876.6230520876021;867.7440155154245;868.0841711993844;868.5440143924491;868.6872725818732;868.8132051608903;511.4936213148993;632.3328888023134;633.7750098714982;633.9397757213058;634.0204384226381;11957.88042119585;13195.86804131956;13351.132176408502;13357.065005449622;13910.860891391058;14682.339294731762;14699.26503674812;14917.850821491755;15257.465988690454;15418.537443876701;11715.94142029293;11900.821487677691;12081.214721043192;12213.694657633541;12517.311547864863;3845.5962123977138;3887.844486220548;3951.36778115503;4037.838486460538;4075.551689314173;74376.6281168596;76222;76851;77351.613241934;77897.61051194707;11506.584101353705;11735.354555499358;11929.449171607635;12239.20445171061;12245.816312755316;22209;22669.2065777697;22681.659775103388;22733.658995115085;22762;8131.14622964592;8138.552379619059;8201.13888041759;8315.168483151758;8567.785805354792;4642.651801114863;4660.580547750718;4728.172569800271;4793.065352256276;4805.255185446262;3294.5222942673176;3471.444568868969;3476.28736109097;3477.2697733476252;3483.8432270547887;596.979105731306;597.8385835824303;599.9160117583542;606.5844896246085;607.4957785038407;576.5733357315556;676.8443258050676;677.8847595908708;690.5821977703517;706.7950294414562;9086.182243598108;9091.681791137278;9429.3399462037;9487.90512094884;9668.468234247184;608.9208402907593;632.5635311635049;671.3353779758004;693.748785192055;693.7883945396602;4104.462796791859;4373.934390984138;4467.843625473093;4502.212112880233;4506.380053988888;110108.4494577538;112196.43901780603;115299.42350288195;115959;118772.40613797048;75894;77807.61096194483;77839.61080194563;104040;104699.476502617;77668.2233177661;78613;80006.59996700096;80156.59921700471;82402.58798705968;8595.914040859512;9182.586783594888;9214.907850921405;9286.535673216447;9331;45688.08623827571;45693.62919112432;47171.29243061425;47495.52504474911;47699;66333;70281.64859175672;71599.28400715927;71971;74645;12298.569550065704;12311.876881231074;12411.266315548388;12625.936870315589;13260.53588124411;13219.603411897659;13558.389872455566;13839.308034598029;14252.857471425568;14653.120812750843;13545.932270338586;13601.319934003459;13645.522406715718;13708.931455343058;14118.294085295489;13130.241687650061;13216.273104979318;13254.734905301648;13657.317134143452;13942;12707.745845083231;13155.802662959872;13307.866921330662;13345.266010369134;13421.060525763103;10636;10648;10760.62337818204;10909.890901090888;11035.61375351891;10166.542505587118;11201.159913006393;11392.974632283134;11399.601013964471;11526.654200374001 11:01:46 INFO - PROCESS | 20336 | __end_tp_report 11:01:46 INFO - PROCESS | 20336 | __start_cc_report 11:01:46 INFO - PROCESS | 20336 | _x_x_mozilla_cycle_collect,1081 11:01:46 INFO - PROCESS | 20336 | __end_cc_report 11:01:46 INFO - PROCESS | 20336 | __startTimestamp1476468106323__endTimestamp 11:01:46 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | ------- Summary: start ------- 11:01:46 INFO - PROCESS | 20336 | Number of tests: 6 11:01:46 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | [#0] dojo.html Cycles:165 Average:5285.83 Median:5425.76 stddev:589.91 (10.9%) stddev-sans-first:564.77 11:01:46 INFO - PROCESS | 20336 | Values: 3039.0 3046.9 3056.0 3111.0 3118.7 5202.2 5209.2 5302.7 5332.8 5341.7 5325.7 5339.5 5351.6 5353.1 5370.4 4832.1 4858.4 4868.7 4910.9 4930.1 4847.3 4862.8 4878.0 4882.5 4886.3 4871.8 4883.6 4885.0 4919.8 4929.8 4965.3 4979.5 4985.3 4992.9 5050.5 4742.6 4775.9 4778.5 4868.6 4878.8 5183.1 5229.5 5243.5 5264.3 5267.1 5617.3 5651.4 5656.5 5662.2 5724.1 5584.8 5621.5 5768.5 5795.3 5854.7 5283.2 5334.2 5335.7 5365.3 5420.6 5794.8 5833.7 5844.2 5844.5 5847.4 5425.8 5614.3 5622.0 5625.5 5634.1 5526.8 5580.7 5691.7 5698.3 5709.0 5583.8 5621.5 5629.5 5634.4 5637.3 5628.6 5630.6 5640.6 5643.4 5696.9 4294.5 4308.9 4314.8 4343.6 4371.8 3894.5 3901.3 3937.8 3938.6 3958.3 5338.2 5338.2 5344.9 5347.5 5398.2 5492.9 5546.2 5592.4 5594.6 5656.7 5334.0 5355.7 5363.6 5424.4 5448.9 4947.5 4948.9 4950.6 4963.6 4965.4 5673.8 5716.3 5891.1 5894.4 5895.4 5678.8 5707.8 5712.5 5738.0 5803.8 5925.2 5926.6 5928.6 5931.5 5943.8 5298.4 5379.2 5651.2 5655.3 5658.5 5693.3 5735.4 5751.5 5783.5 5852.0 5594.7 5617.6 5625.6 5634.7 5648.8 5395.6 5590.1 5608.5 5610.7 5625.9 5390.8 5394.0 5423.8 5476.4 5593.1 5595.1 5621.6 5630.8 5640.3 5643.5 5248.1 5322.2 5484.5 5516.9 5519.4 11:01:46 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | [#1] ext.html Cycles:180 Average:58866.17 Median:35452.56 stddev:117025.12 (330.1%) stddev-sans-first:117271.52 11:01:46 INFO - PROCESS | 20336 | Values: 559.8 595.0 611.9 612.7 636.7 33278.8 34055.5 34138.7 44659.1 45778.8 42993.0 43297.6 43335.3 43340.3 43398.8 8717.1 8864.3 8870.6 8871.0 8871.9 7894.1 8042.0 8783.6 10389.8 10638.5 10839.1 10901.1 10903.5 10903.8 10913.1 10666.3 10695.4 10724.7 10735.4 10737.4 10545.9 10609.6 10614.4 10614.8 10615.8 41480.6 41763.6 41845.6 41854.8 41933.6 3196.4 3239.9 3260.5 3264.3 3395.9 30748.6 31520.2 31817.5 31897.0 31938.7 3990.2 4113.5 4116.6 4122.0 4134.4 325388.0 329045.0 330805.0 429597.0 431549.0 56924.0 57639.7 57660.7 57697.0 57716.0 61584.0 61887.7 62077.0 62658.0 62686.7 15203.8 15481.8 15692.5 15718.2 15733.2 10203.8 11630.2 11670.9 11758.6 11988.9 16158.3 18458.0 18560.4 18720.3 19457.6 6895.9 6984.2 7105.9 7153.2 7167.0 903.5 1023.9 1027.2 1047.4 1082.9 30617.4 30694.0 31014.5 31122.2 31241.0 1033.7 1064.0 1089.1 1107.2 1141.6 15306.5 16192.9 16209.4 16377.3 16497.6 533835.0 536776.0 537219.0 538339.0 540131.0 56836.7 57369.7 57419.4 57451.0 57452.0 1180.3 1206.3 1259.7 1269.5 1282.1 27393.7 31331.8 31896.8 31928.7 32420.0 46508.5 47020.5 47068.8 47076.0 47132.5 393985.0 394270.0 394893.0 394933.0 398131.0 23996.0 24060.2 24514.3 24776.4 25803.2 45363.0 45510.0 45851.1 46904.5 47119.1 37548.2 38036.7 38089.2 38932.0 39676.6 37612.8 37656.4 37808.4 38862.6 38934.0 36802.8 37163.6 37809.2 38035.8 38389.4 32298.0 35196.0 35262.8 35370.3 35534.8 26129.2 26685.6 26861.2 26925.0 27035.6 11:01:46 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | [#2] jquery.html Cycles:180 Average:27959.38 Median:22261.38 stddev:76974.87 (345.8%) stddev-sans-first:77162.89 11:01:46 INFO - PROCESS | 20336 | Values: 351.8 374.7 377.5 381.6 402.0 13882.9 18024.3 18514.8 19465.5 19643.5 15294.0 17981.7 18434.1 19243.7 19423.6 5283.9 5608.5 5610.6 5613.4 5621.1 4046.0 4057.2 4173.5 5466.7 5565.6 4220.1 6233.6 6249.8 6252.6 6273.9 6010.3 6138.7 6188.7 6238.5 6243.1 5474.0 5480.4 5482.1 5506.3 5520.1 22060.9 22331.4 22434.8 22738.2 22743.8 2023.5 2190.2 2234.8 2241.2 2412.3 9613.4 9894.6 10165.2 10495.6 13892.4 1817.3 1943.0 1947.0 1952.9 2000.4 80318.0 81121.0 81614.0 83302.6 85356.0 10504.0 10720.0 10745.4 10758.5 11042.4 14837.9 14861.2 14871.6 14883.8 14897.1 7310.5 7683.2 7755.6 7924.9 7957.7 7304.5 7381.6 7499.5 7581.3 7656.4 4499.3 4523.6 4609.2 4614.9 4700.4 1890.4 1893.4 1903.9 1921.3 1953.8 810.7 889.1 891.2 895.7 980.8 17296.9 17688.4 18294.4 19017.8 19305.1 915.2 925.8 954.1 968.9 973.7 9602.4 10716.5 10742.6 11087.0 11123.1 453264.0 454230.0 458928.0 479666.0 482444.0 88550.6 88801.6 89992.6 91112.5 92047.4 969.7 998.9 1022.4 1035.2 1039.3 16408.5 16582.3 17029.7 17122.7 17403.2 38879.8 40476.8 40570.6 40604.6 40765.2 55814.7 55925.4 56533.0 57808.4 58250.4 6812.0 7176.7 7221.1 8030.0 8311.8 12301.9 12633.2 13167.5 13445.4 13790.2 9901.1 10648.0 10666.8 11428.8 11530.3 10684.9 11176.8 11213.4 11244.1 11531.9 11427.8 11552.8 11601.9 11836.5 11977.1 8221.5 8273.3 8298.3 8395.7 8513.2 10330.9 11074.2 11196.5 11292.4 11537.5 11:01:46 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | [#3] mootools.html Cycles:180 Average:5650.96 Median:4915.05 stddev:3292.94 (67.0%) stddev-sans-first:3286.01 11:01:46 INFO - PROCESS | 20336 | Values: 1308.6 1432.8 1488.4 1628.8 1769.6 7219.3 8213.1 8302.3 8320.7 8506.0 8356.1 8420.2 8421.5 8426.8 8438.9 2171.9 2188.0 2199.1 2206.0 2216.8 2090.1 2126.4 2147.8 2157.5 2160.8 2127.8 2145.5 2154.5 2155.4 2167.1 2124.8 2127.6 2142.2 2146.7 2150.3 2058.2 2159.6 2159.7 2162.1 2168.9 8360.7 8448.7 8527.6 8780.7 8781.4 5135.6 5346.3 5355.9 5360.8 5363.4 3332.4 3334.7 3374.2 3398.3 3407.9 1049.4 1052.6 1073.0 1082.0 1085.4 12100.8 12120.2 12171.9 12223.1 12292.6 4142.5 4299.4 4340.9 4444.2 4464.4 9600.1 9612.4 9616.0 9617.8 9628.9 4973.3 4983.4 4985.7 4986.2 4988.9 4009.9 4078.2 4589.6 4662.1 4664.2 3627.9 3665.4 3776.2 3780.7 3794.3 1095.3 1117.1 1129.6 1131.0 1131.2 797.6 805.8 914.4 940.5 943.7 5730.9 5734.8 5846.4 5893.6 5997.6 918.2 926.4 927.3 941.1 980.2 3554.0 3841.9 3879.3 3913.8 3939.5 10662.6 11153.5 11156.9 11176.9 11183.2 11019.2 11020.8 11029.9 11035.2 11047.7 7804.0 8021.8 8120.1 8214.0 8222.8 5836.7 5906.4 5925.6 5928.4 6080.8 9902.9 9988.2 10111.6 10148.0 10214.3 9920.4 10198.4 10238.6 10256.1 10268.6 7640.5 7669.6 7712.7 7734.0 7803.8 8341.9 8434.1 8453.0 8505.7 8507.8 7418.6 7463.9 7586.8 7764.7 7826.8 7499.2 7635.7 7659.2 7667.2 7680.7 6638.8 6738.5 6749.2 6753.7 6757.2 4863.3 4877.7 4888.1 4907.4 4926.8 4922.7 5020.0 5054.2 5115.1 5168.4 11:01:46 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | [#4] prototype.html Cycles:180 Average:4622.52 Median:5334.81 stddev:1372.68 (25.7%) stddev-sans-first:1337.30 11:01:46 INFO - PROCESS | 20336 | Values: 281.4 292.3 296.9 318.3 320.1 5086.5 5265.7 5283.9 5298.4 5319.3 5036.7 5180.2 5189.6 5212.2 5235.5 4065.3 4126.6 4128.0 4143.6 4156.3 3897.6 4069.5 4099.7 4151.8 4159.9 4067.8 4072.2 4072.9 4073.9 4085.4 4035.8 4036.1 4058.7 4081.9 4084.8 3432.3 3515.0 3545.7 3546.6 3602.7 5127.1 5132.4 5149.3 5152.7 5159.6 4640.0 4652.4 4656.6 4660.8 4670.6 5400.5 5406.0 5450.7 5475.6 5569.2 3839.8 3840.6 3848.8 3857.4 3860.7 5684.3 5712.9 5756.8 5766.8 5776.9 3744.5 3891.3 3915.7 3965.7 3986.0 3958.7 3970.6 3977.8 3978.5 3979.5 4624.3 4630.8 4636.2 4636.6 4637.6 5343.4 5484.9 5562.6 5594.6 5654.9 1311.7 1342.7 1343.5 1345.7 1347.1 937.8 950.9 960.5 961.7 967.0 5257.9 5258.0 5329.3 5340.4 5348.2 5478.6 5577.0 5589.0 5667.5 5724.7 5371.8 5380.5 5389.2 5393.7 5393.9 2958.3 2961.5 3005.2 3017.4 3023.4 5818.4 5824.7 5854.6 5858.6 5864.6 5766.0 5768.2 5773.8 5794.4 5818.4 5573.4 5732.2 5804.4 5851.0 5901.5 5588.8 5601.3 5640.7 5654.7 5671.1 5550.9 5579.4 5581.5 5593.7 5612.2 5603.7 5827.2 5844.8 5847.9 5864.4 4071.8 4096.1 4111.2 4149.4 4154.7 5363.9 5671.7 5673.6 5712.9 5716.4 5456.5 5459.0 5477.4 5480.5 5485.2 5241.2 5423.7 5461.9 5467.7 5505.3 5245.2 5351.8 5439.2 5450.0 5459.3 5435.5 5507.9 5539.4 5601.5 5621.0 5207.4 5375.1 5391.9 5444.0 5453.9 11:01:46 INFO - PROCESS | 20336 | 11:01:46 INFO - PROCESS | 20336 | [#5] yui.html Cycles:180 Average:20035.41 Median:4504.30 stddev:28552.55 (633.9%) stddev-sans-first:28595.67 11:01:46 INFO - PROCESS | 20336 | Values: 684.4 709.7 740.5 797.6 810.6 15061.7 16308.3 16329.2 16340.8 16419.2 14608.4 14975.0 15427.2 15472.1 15474.1 819.4 832.3 835.9 837.3 838.7 682.2 838.0 840.1 840.4 840.8 723.9 849.0 849.8 874.3 876.6 867.7 868.1 868.5 868.7 868.8 511.5 632.3 633.8 633.9 634.0 11957.9 13195.9 13351.1 13357.1 13910.9 14682.3 14699.3 14917.9 15257.5 15418.5 11715.9 11900.8 12081.2 12213.7 12517.3 3845.6 3887.8 3951.4 4037.8 4075.6 74376.6 76222.0 76851.0 77351.6 77897.6 11506.6 11735.4 11929.4 12239.2 12245.8 22209.0 22669.2 22681.7 22733.7 22762.0 8131.1 8138.6 8201.1 8315.2 8567.8 4642.7 4660.6 4728.2 4793.1 4805.3 3294.5 3471.4 3476.3 3477.3 3483.8 597.0 597.8 599.9 606.6 607.5 576.6 676.8 677.9 690.6 706.8 9086.2 9091.7 9429.3 9487.9 9668.5 608.9 632.6 671.3 693.7 693.8 4104.5 4373.9 4467.8 4502.2 4506.4 110108.4 112196.4 115299.4 115959.0 118772.4 75894.0 77807.6 77839.6 104040.0 104699.5 77668.2 78613.0 80006.6 80156.6 82402.6 8595.9 9182.6 9214.9 9286.5 9331.0 45688.1 45693.6 47171.3 47495.5 47699.0 66333.0 70281.6 71599.3 71971.0 74645.0 12298.6 12311.9 12411.3 12625.9 13260.5 13219.6 13558.4 13839.3 14252.9 14653.1 13545.9 13601.3 13645.5 13708.9 14118.3 13130.2 13216.3 13254.7 13657.3 13942.0 12707.7 13155.8 13307.9 13345.3 13421.1 10636.0 10648.0 10760.6 10909.9 11035.6 10166.5 11201.2 11393.0 11399.6 11526.7 11:01:46 INFO - PROCESS | 20336 | -------- Summary: end -------- 11:01:46 INFO - PROCESS | 20336 | 11:01:47 INFO - TEST-INFO | 20336: exit 0 11:01:47 INFO - TEST-OK | dromaeo_css | took 1119050ms 11:01:47 INFO - TEST-START | kraken 11:01:47 INFO - operating with platform_type : linux_ 11:01:47 INFO - Initialising browser for kraken test... 11:01:47 INFO - TEST-INFO | started process 20644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf3ExB5/profile http://localhost:43101/getInfo.html) 11:01:51 INFO - PROCESS | 20644 | __metrics Screen width/height:1600/1200 11:01:51 INFO - PROCESS | 20644 | colorDepth:24 11:01:51 INFO - PROCESS | 20644 | Browser inner width/height: 1024/697 11:01:51 INFO - PROCESS | 20644 | __metrics 11:01:52 INFO - PROCESS | 20644 | 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:01:52 INFO - PROCESS | 20644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:52 INFO - PROCESS | 20644 | console.error: 11:01:52 INFO - PROCESS | 20644 | Message: Error: Connection closed before committing the transaction. 11:01:52 INFO - PROCESS | 20644 | Stack: 11:01:52 INFO - PROCESS | 20644 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 11:01:52 INFO - PROCESS | 20644 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 11:01:52 INFO - PROCESS | 20644 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 11:01:52 INFO - PROCESS | 20644 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 11:01:52 INFO - PROCESS | 20644 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 11:01:52 INFO - PROCESS | 20644 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 11:01:52 INFO - PROCESS | 20644 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 11:01:52 INFO - PROCESS | 20644 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 11:01:52 INFO - PROCESS | 20644 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 11:01:52 INFO - PROCESS | 20644 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 11:01:52 INFO - PROCESS | 20644 | Barrier/this.client.addBlocker/promise13.1% 11:02:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:02:50 INFO - TinderboxPrint: I/O write bytes / time
394,072,064 / 615,108 11:02:50 INFO - TinderboxPrint: CPU idle
8,312.2 (86.9%) 11:02:50 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 11:02:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:02:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105377792; Read time: 0; Write time: 126040 11:02:50 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287805440; Read time: 0; Write time: 489048 11:02:50 INFO - Running post-run listener: _upload_blobber_files 11:02:50 INFO - Blob upload gear active. 11:02:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:02:50 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:02:50 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:02:50 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:02:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:02:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:54 INFO - (blobuploader) - INFO - Done attempting. 11:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:55 INFO - (blobuploader) - INFO - Done attempting. 11:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:55 INFO - (blobuploader) - INFO - Done attempting. 11:02:55 INFO - (blobuploader) - INFO - Iteration through files over. 11:02:55 INFO - Return code: 0 11:02:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:02:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:02:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44fcb22f402357fa917ba44a4c19f3224f9aa8a7843c40f5e4e5bed79b9cf9a4ce6473362c97913f852d4445ca3883bd95fd83d714b49e3848fda9a3166e0d37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b59c12f5775b898edd4294fd5b809ce6b416a1f8b89069088274aa27c70abeb5da80e98fffb1fc3e632af43926a7dc51bd2b0e7cd1a0201eb1914bce227f2f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00bd91958e8bc1467def637b16ee12a56ba21995e93b9289bde38226a8600b20a5a51ef4477a0eb2567e40b028bd59f2dac01af7052560c4871ed378330e8cd4"} 11:02:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:02:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:02:55 INFO - Contents: 11:02:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44fcb22f402357fa917ba44a4c19f3224f9aa8a7843c40f5e4e5bed79b9cf9a4ce6473362c97913f852d4445ca3883bd95fd83d714b49e3848fda9a3166e0d37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b59c12f5775b898edd4294fd5b809ce6b416a1f8b89069088274aa27c70abeb5da80e98fffb1fc3e632af43926a7dc51bd2b0e7cd1a0201eb1914bce227f2f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00bd91958e8bc1467def637b16ee12a56ba21995e93b9289bde38226a8600b20a5a51ef4477a0eb2567e40b028bd59f2dac01af7052560c4871ed378330e8cd4"} 11:02:55 INFO - Running post-run listener: copy_logs_to_upload_dir 11:02:55 INFO - Copying logs to upload dir... 11:02:55 INFO - mkdir: /builds/slave/test/build/upload/logs 11:02:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.747032 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-14 11:02:55.796072) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 11:02:55.799119) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959 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/sha512/44fcb22f402357fa917ba44a4c19f3224f9aa8a7843c40f5e4e5bed79b9cf9a4ce6473362c97913f852d4445ca3883bd95fd83d714b49e3848fda9a3166e0d37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b59c12f5775b898edd4294fd5b809ce6b416a1f8b89069088274aa27c70abeb5da80e98fffb1fc3e632af43926a7dc51bd2b0e7cd1a0201eb1914bce227f2f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00bd91958e8bc1467def637b16ee12a56ba21995e93b9289bde38226a8600b20a5a51ef4477a0eb2567e40b028bd59f2dac01af7052560c4871ed378330e8cd4"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476451808/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/sha512/44fcb22f402357fa917ba44a4c19f3224f9aa8a7843c40f5e4e5bed79b9cf9a4ce6473362c97913f852d4445ca3883bd95fd83d714b49e3848fda9a3166e0d37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b59c12f5775b898edd4294fd5b809ce6b416a1f8b89069088274aa27c70abeb5da80e98fffb1fc3e632af43926a7dc51bd2b0e7cd1a0201eb1914bce227f2f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00bd91958e8bc1467def637b16ee12a56ba21995e93b9289bde38226a8600b20a5a51ef4477a0eb2567e40b028bd59f2dac01af7052560c4871ed378330e8cd4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 11:02:55.824778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 11:02:55.825129) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1476466935.444104-647966959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 11:02:55.908365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 11:02:55.908666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 11:02:55.908960) ========= ========= Total master_lag: 0.18 =========