builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1476711569.41 results: success (0) buildid: 20161017062757 builduid: 0f39a7a8757f4f688b8d61f0be1f340c revision: 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.407186) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.407642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.407916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.422205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.422466) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 06:39:30-- 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% 38.0M=0s 2016-10-17 06:39:30 (38.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.532081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.532433) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017069 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.582237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:29.582588) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 --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 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 06:39:31,102 truncating revision to first 12 chars 2016-10-17 06:39:31,102 Setting DEBUG logging. 2016-10-17 06:39:31,102 attempt 1/10 2016-10-17 06:39:31,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/78bd3dbc3dde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 06:39:31,559 unpacking tar archive at: fx-team-78bd3dbc3dde/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:30.376195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:30.376529) ========= script_repo_revision: 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:30.376914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:30.377201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 06:39:30.385573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-17 06:39:30.385943) ========= /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=eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:39:31 INFO - MultiFileLogger online at 20161017 06:39:31 in /builds/slave/test 06:39:31 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 06:39:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:39:31 INFO - {'append_to_log': False, 06:39:31 INFO - 'base_work_dir': '/builds/slave/test', 06:39:31 INFO - 'blob_upload_branch': 'Fx-Team', 06:39:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:39:31 INFO - 'branch': 'Fx-Team', 06:39:31 INFO - 'buildbot_json_path': 'buildprops.json', 06:39:31 INFO - 'config_files': ('talos/linux_config.py',), 06:39:31 INFO - 'default_actions': ('clobber', 06:39:31 INFO - 'read-buildbot-config', 06:39:31 INFO - 'download-and-extract', 06:39:31 INFO - 'populate-webroot', 06:39:31 INFO - 'create-virtualenv', 06:39:31 INFO - 'install', 06:39:31 INFO - 'run-tests'), 06:39:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:39:31 INFO - 'download_minidump_stackwalk': True, 06:39:31 INFO - 'download_symbols': 'ondemand', 06:39:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:39:31 INFO - 'tooltool.py': '/tools/tooltool.py', 06:39:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:39:31 INFO - '/tools/misc-python/virtualenv.py')}, 06:39:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:39:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:39:31 INFO - 'installer_path': 'installer.exe', 06:39:31 INFO - 'log_level': 'info', 06:39:31 INFO - 'log_name': 'talos', 06:39:31 INFO - 'log_to_console': True, 06:39:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:39:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:39:31 INFO - 'opt_config_files': (), 06:39:31 INFO - 'pip_index': False, 06:39:31 INFO - 'sps_profile': False, 06:39:31 INFO - 'sps_profile_interval': 0, 06:39:31 INFO - 'suite': 'dromaeojs', 06:39:31 INFO - 'system_bits': '32', 06:39:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:39:31 INFO - 'title': 'talos-linux64-ix-010', 06:39:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:39:31 INFO - 'use_talos_json': True, 06:39:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:39:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:39:31 INFO - 'work_dir': 'build'} 06:39:32 INFO - [mozharness: 2016-10-17 13:39:32.000009Z] Running clobber step. 06:39:32 INFO - Running pre-action listener: _resource_record_pre_action 06:39:32 INFO - Running main action method: clobber 06:39:32 INFO - rmtree: /builds/slave/test/build 06:39:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:39:33 INFO - Running post-action listener: _resource_record_post_action 06:39:33 INFO - [mozharness: 2016-10-17 13:39:33.012085Z] Finished clobber step (success) 06:39:33 INFO - [mozharness: 2016-10-17 13:39:33.012186Z] Running read-buildbot-config step. 06:39:33 INFO - Running pre-action listener: _resource_record_pre_action 06:39:33 INFO - Running main action method: read_buildbot_config 06:39:33 INFO - Using buildbot properties: 06:39:33 INFO - { 06:39:33 INFO - "project": "", 06:39:33 INFO - "product": "firefox", 06:39:33 INFO - "script_repo_revision": "production", 06:39:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:39:33 INFO - "repository": "", 06:39:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:39:33 INFO - "buildid": "20161017062757", 06:39:33 INFO - "stage_platform": "linux64-pgo", 06:39:33 INFO - "basedir": "/builds/slave/test", 06:39:33 INFO - "buildnumber": 534, 06:39:33 INFO - "platform": "ubuntu64_hw", 06:39:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:39:33 INFO - "slavebuilddir": "test", 06:39:33 INFO - "branch": "fx-team", 06:39:33 INFO - "revision": "78bd3dbc3ddee84be7d9b79fde3614eec50d39a9", 06:39:33 INFO - "slavename": "talos-linux64-ix-010", 06:39:33 INFO - "builduid": "0f39a7a8757f4f688b8d61f0be1f340c", 06:39:33 INFO - "repo_path": "integration/fx-team" 06:39:33 INFO - } 06:39:33 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:39:33 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 06:39:33 INFO - Running post-action listener: _resource_record_post_action 06:39:33 INFO - [mozharness: 2016-10-17 13:39:33.014566Z] Finished read-buildbot-config step (success) 06:39:33 INFO - [mozharness: 2016-10-17 13:39:33.014655Z] Running download-and-extract step. 06:39:33 INFO - Running pre-action listener: _resource_record_pre_action 06:39:33 INFO - Running main action method: download_and_extract 06:39:33 INFO - mkdir: /builds/slave/test/build/tests 06:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:33 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:39:33 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/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 06:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/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 06:39:33 INFO - Downloaded 1361 bytes. 06:39:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:39:33 INFO - Using the following test package requirements: 06:39:33 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:33 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:39:33 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:39:33 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:33 INFO - u'jsshell-linux-x86_64.zip'], 06:39:33 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:39:33 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:33 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:39:33 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:39:33 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:39:33 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:39:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:39:33 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/1476700208/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:39:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:39:33 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:39:33 INFO - Http code: 200 06:39:33 INFO - via: 1.1 7db492e48a5d55351dcb787a8a14e113.cloudfront.net (CloudFront) 06:39:33 INFO - x-amz-cf-id: -j8gbq7J4cOIn-GIqLiGIoAiOZYVftW9NrBkH0hE1aXLw-u5ku0SJw== 06:39:33 INFO - x-amz-replication-status: COMPLETED 06:39:33 INFO - x-amz-version-id: maSmlsd0AVB7P6NK9EDqkYlBR5kfiUBb 06:39:33 INFO - Expected file size: 22089665 06:39:33 INFO - Obtained file size: 22089665 06:39:37 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 06:39:37 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/1476700208/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:39:37 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:39:37 INFO - Http code: 200 06:39:37 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 06:39:37 INFO - x-amz-cf-id: WquHIYUyKwoBv4UfMxobheouP37gYJ9J87u6SlboMLlYq4PLVir5rQ== 06:39:37 INFO - x-amz-replication-status: COMPLETED 06:39:37 INFO - x-amz-version-id: maSmlsd0AVB7P6NK9EDqkYlBR5kfiUBb 06:39:37 INFO - Expected file size: 22089665 06:39:37 INFO - Obtained file size: 22089665 06:39:41 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/1476700208/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:39:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:39:41 INFO - Http code: 200 06:39:41 INFO - via: 1.1 d01884a3320364227d925bce1a38f0ad.cloudfront.net (CloudFront) 06:39:41 INFO - x-amz-cf-id: lxRrg6Z2rJcknCDLjFNNONdDYI00bPer8KjVg9cRXZrq0lCvwCS6pA== 06:39:41 INFO - x-amz-replication-status: COMPLETED 06:39:41 INFO - x-amz-version-id: jCtTLDJ4fXqlBgA12TgAMsygkhdppcvk 06:39:42 INFO - Expected file size: 14409028 06:39:42 INFO - Obtained file size: 14409028 06:39:42 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')]} 06:39:42 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:39:42 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/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 06:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/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 06:39:43 INFO - Downloaded 59497589 bytes. 06:39:43 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:39:43 INFO - mkdir: /builds/slave/test/properties 06:39:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:39:43 INFO - Writing to file /builds/slave/test/properties/build_url 06:39:43 INFO - Contents: 06:39:43 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:39:43 INFO - Running post-action listener: _resource_record_post_action 06:39:43 INFO - Running post-action listener: set_extra_try_arguments 06:39:43 INFO - [mozharness: 2016-10-17 13:39:43.547914Z] Finished download-and-extract step (success) 06:39:43 INFO - [mozharness: 2016-10-17 13:39:43.548141Z] Running populate-webroot step. 06:39:43 INFO - Running pre-action listener: _resource_record_pre_action 06:39:43 INFO - Running main action method: populate_webroot 06:39:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:39:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:39:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:39:43 INFO - '--tppagecycles', 06:39:43 INFO - '7'], 06:39:43 INFO - 'tests': ['tsvgm']}}, 06:39:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:39:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:39:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:39:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:39:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:43 INFO - 'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:43 INFO - 'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['damp', 'tps']}, 06:39:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:43 INFO - 'tests': ['damp', 'tps']}, 06:39:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['dromaeo_dom']}, 06:39:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:39:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['basic_compositor_video']}, 06:39:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:39:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['a11yr', 06:39:43 INFO - 'ts_paint', 06:39:43 INFO - 'tpaint', 06:39:43 INFO - 'sessionrestore', 06:39:43 INFO - 'sessionrestore_no_auto_restore', 06:39:43 INFO - 'tabpaint']}, 06:39:43 INFO - 'other-e10s': {'tests': ['a11yr', 06:39:43 INFO - 'ts_paint', 06:39:43 INFO - 'tpaint', 06:39:43 INFO - 'sessionrestore', 06:39:43 INFO - 'sessionrestore_no_auto_restore', 06:39:43 INFO - 'tabpaint']}, 06:39:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:39:43 INFO - 'ts_paint', 06:39:43 INFO - 'tpaint', 06:39:43 INFO - 'sessionrestore', 06:39:43 INFO - 'sessionrestore_no_auto_restore', 06:39:43 INFO - 'tabpaint']}, 06:39:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:39:43 INFO - 'ts_paint', 06:39:43 INFO - 'tpaint', 06:39:43 INFO - 'sessionrestore', 06:39:43 INFO - 'sessionrestore_no_auto_restore', 06:39:43 INFO - 'tabpaint']}, 06:39:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['a11yr', 06:39:43 INFO - 'ts_paint', 06:39:43 INFO - 'tpaint', 06:39:43 INFO - 'sessionrestore', 06:39:43 INFO - 'sessionrestore_no_auto_restore', 06:39:43 INFO - 'tabpaint']}, 06:39:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['a11yr', 06:39:43 INFO - 'ts_paint', 06:39:43 INFO - 'tpaint', 06:39:43 INFO - 'sessionrestore', 06:39:43 INFO - 'sessionrestore_no_auto_restore', 06:39:43 INFO - 'tabpaint']}, 06:39:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['tsvgx', 06:39:43 INFO - 'tsvgr_opacity', 06:39:43 INFO - 'tart', 06:39:43 INFO - 'tscrollx', 06:39:43 INFO - 'cart']}, 06:39:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:39:43 INFO - 'tsvgr_opacity', 06:39:43 INFO - 'tart', 06:39:43 INFO - 'tscrollx', 06:39:43 INFO - 'cart']}, 06:39:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:43 INFO - 'talos_options': ['--disable-e10s'], 06:39:43 INFO - 'tests': ['tp5o']}, 06:39:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:43 INFO - 'tests': ['tp5o']}, 06:39:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:43 INFO - 'talos_options': ['--disable-e10s', 06:39:43 INFO - '--xperf_path', 06:39:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:43 INFO - 'tests': ['tp5n']}, 06:39:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:43 INFO - 'talos_options': ['--xperf_path', 06:39:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:43 INFO - 'tests': ['tp5n']}}, 06:39:43 INFO - 'talos.zip': {'path': '', 06:39:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:39:43 INFO - Running post-action listener: _resource_record_post_action 06:39:43 INFO - [mozharness: 2016-10-17 13:39:43.563484Z] Finished populate-webroot step (success) 06:39:43 INFO - [mozharness: 2016-10-17 13:39:43.563572Z] Running create-virtualenv step. 06:39:43 INFO - Running pre-action listener: _resource_record_pre_action 06:39:43 INFO - Running main action method: create_virtualenv 06:39:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:39:43 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 06:39:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:39:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:39:43 INFO - Using real prefix '/usr' 06:39:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:39:44 INFO - Installing distribute.............................................................................................................................................................................................done. 06:39:46 INFO - Installing pip.................done. 06:39:46 INFO - Return code: 0 06:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:39:46 INFO - Reading from file tmpfile_stdout 06:39:46 INFO - Output received: 06:39:46 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) 06:39:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:46 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:39:46 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 06:39:46 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 06:39:46 INFO - Using env: {'DISPLAY': ':0', 06:39:46 INFO - 'HOME': '/home/cltbld', 06:39:46 INFO - 'LANG': 'en_US.UTF-8', 06:39:46 INFO - 'LANGUAGE': 'en_US:en', 06:39:46 INFO - 'LOGNAME': 'cltbld', 06:39:46 INFO - 'MAIL': '/var/mail/cltbld', 06:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:46 INFO - 'MOZ_NO_REMOTE': '1', 06:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:46 INFO - 'NO_EM_RESTART': '1', 06:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:46 INFO - 'PWD': '/builds/slave/test', 06:39:46 INFO - 'SHELL': '/bin/bash', 06:39:46 INFO - 'SHLVL': '1', 06:39:46 INFO - 'TERM': 'linux', 06:39:46 INFO - 'TMOUT': '86400', 06:39:46 INFO - 'USER': 'cltbld', 06:39:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:46 INFO - '_': '/tools/buildbot/bin/python'} 06:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:46 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 06:39:46 INFO - Cleaning up... 06:39:46 INFO - Return code: 0 06:39:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:46 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:39:46 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 06:39:46 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 06:39:46 INFO - Using env: {'DISPLAY': ':0', 06:39:46 INFO - 'HOME': '/home/cltbld', 06:39:46 INFO - 'LANG': 'en_US.UTF-8', 06:39:46 INFO - 'LANGUAGE': 'en_US:en', 06:39:46 INFO - 'LOGNAME': 'cltbld', 06:39:46 INFO - 'MAIL': '/var/mail/cltbld', 06:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:46 INFO - 'MOZ_NO_REMOTE': '1', 06:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:46 INFO - 'NO_EM_RESTART': '1', 06:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:46 INFO - 'PWD': '/builds/slave/test', 06:39:46 INFO - 'SHELL': '/bin/bash', 06:39:46 INFO - 'SHLVL': '1', 06:39:46 INFO - 'TERM': 'linux', 06:39:46 INFO - 'TMOUT': '86400', 06:39:46 INFO - 'USER': 'cltbld', 06:39:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:46 INFO - '_': '/tools/buildbot/bin/python'} 06:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:46 INFO - Downloading/unpacking psutil>=3.1.1 06:39:46 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 06:39:46 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 06:39:46 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 06:39:46 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 06:39:46 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 06:39:46 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 06:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:39:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:48 INFO - Installing collected packages: psutil 06:39:48 INFO - Running setup.py install for psutil 06:39:48 INFO - building 'psutil._psutil_linux' extension 06:39:48 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 06:39:49 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 06:39:49 INFO - building 'psutil._psutil_posix' extension 06:39:49 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 06:39:49 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 06:39:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:49 INFO - Successfully installed psutil 06:39:49 INFO - Cleaning up... 06:39:49 INFO - Return code: 0 06:39:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:39:49 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')]} 06:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:49 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')]} 06:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:49 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:39:49 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 06:39:49 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 06:39:49 INFO - Using env: {'DISPLAY': ':0', 06:39:49 INFO - 'HOME': '/home/cltbld', 06:39:49 INFO - 'LANG': 'en_US.UTF-8', 06:39:49 INFO - 'LANGUAGE': 'en_US:en', 06:39:49 INFO - 'LOGNAME': 'cltbld', 06:39:49 INFO - 'MAIL': '/var/mail/cltbld', 06:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:49 INFO - 'MOZ_NO_REMOTE': '1', 06:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:49 INFO - 'NO_EM_RESTART': '1', 06:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:49 INFO - 'PWD': '/builds/slave/test', 06:39:49 INFO - 'SHELL': '/bin/bash', 06:39:49 INFO - 'SHLVL': '1', 06:39:49 INFO - 'TERM': 'linux', 06:39:49 INFO - 'TMOUT': '86400', 06:39:49 INFO - 'USER': 'cltbld', 06:39:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:49 INFO - '_': '/tools/buildbot/bin/python'} 06:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:39:51 INFO - Installing collected packages: mozsystemmonitor 06:39:51 INFO - Running setup.py install for mozsystemmonitor 06:39:51 INFO - Successfully installed mozsystemmonitor 06:39:51 INFO - Cleaning up... 06:39:51 INFO - Return code: 0 06:39:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:39:51 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')]} 06:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:51 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')]} 06:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:51 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:39:51 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 06:39:51 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 06:39:51 INFO - Using env: {'DISPLAY': ':0', 06:39:51 INFO - 'HOME': '/home/cltbld', 06:39:51 INFO - 'LANG': 'en_US.UTF-8', 06:39:51 INFO - 'LANGUAGE': 'en_US:en', 06:39:51 INFO - 'LOGNAME': 'cltbld', 06:39:51 INFO - 'MAIL': '/var/mail/cltbld', 06:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:51 INFO - 'MOZ_NO_REMOTE': '1', 06:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:51 INFO - 'NO_EM_RESTART': '1', 06:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:51 INFO - 'PWD': '/builds/slave/test', 06:39:51 INFO - 'SHELL': '/bin/bash', 06:39:51 INFO - 'SHLVL': '1', 06:39:51 INFO - 'TERM': 'linux', 06:39:51 INFO - 'TMOUT': '86400', 06:39:51 INFO - 'USER': 'cltbld', 06:39:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:51 INFO - '_': '/tools/buildbot/bin/python'} 06:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:51 INFO - Downloading/unpacking jsonschema==2.5.1 06:39:51 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 06:39:51 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 06:39:51 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 06:39:51 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 06:39:51 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 06:39:51 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 06:39:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:39:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:39:53 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 06:39:53 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 06:39:53 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 06:39:53 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 06:39:53 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 06:39:53 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 06:39:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:39:54 INFO - warning: no files found matching '*.txt' 06:39:54 INFO - no previously-included directories found matching 'build' 06:39:54 INFO - no previously-included directories found matching 'dist' 06:39:54 INFO - no previously-included directories found matching '.git*' 06:39:54 INFO - Installing collected packages: jsonschema, functools32 06:39:54 INFO - Running setup.py install for functools32 06:39:54 INFO - warning: no files found matching '*.txt' 06:39:54 INFO - no previously-included directories found matching 'build' 06:39:54 INFO - no previously-included directories found matching 'dist' 06:39:54 INFO - no previously-included directories found matching '.git*' 06:39:54 INFO - Successfully installed jsonschema functools32 06:39:54 INFO - Cleaning up... 06:39:54 INFO - Return code: 0 06:39:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:54 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:39:54 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 06:39:54 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 06:39:54 INFO - Using env: {'DISPLAY': ':0', 06:39:54 INFO - 'HOME': '/home/cltbld', 06:39:54 INFO - 'LANG': 'en_US.UTF-8', 06:39:54 INFO - 'LANGUAGE': 'en_US:en', 06:39:54 INFO - 'LOGNAME': 'cltbld', 06:39:54 INFO - 'MAIL': '/var/mail/cltbld', 06:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:54 INFO - 'MOZ_NO_REMOTE': '1', 06:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:54 INFO - 'NO_EM_RESTART': '1', 06:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:54 INFO - 'PWD': '/builds/slave/test', 06:39:54 INFO - 'SHELL': '/bin/bash', 06:39:54 INFO - 'SHLVL': '1', 06:39:54 INFO - 'TERM': 'linux', 06:39:54 INFO - 'TMOUT': '86400', 06:39:54 INFO - 'USER': 'cltbld', 06:39:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:54 INFO - '_': '/tools/buildbot/bin/python'} 06:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:39:54 INFO - Cleaning up... 06:39:54 INFO - Return code: 0 06:39:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:54 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:39:54 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 06:39:54 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 06:39:54 INFO - Using env: {'DISPLAY': ':0', 06:39:54 INFO - 'HOME': '/home/cltbld', 06:39:54 INFO - 'LANG': 'en_US.UTF-8', 06:39:54 INFO - 'LANGUAGE': 'en_US:en', 06:39:54 INFO - 'LOGNAME': 'cltbld', 06:39:54 INFO - 'MAIL': '/var/mail/cltbld', 06:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:54 INFO - 'MOZ_NO_REMOTE': '1', 06:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:54 INFO - 'NO_EM_RESTART': '1', 06:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:54 INFO - 'PWD': '/builds/slave/test', 06:39:54 INFO - 'SHELL': '/bin/bash', 06:39:54 INFO - 'SHLVL': '1', 06:39:54 INFO - 'TERM': 'linux', 06:39:54 INFO - 'TMOUT': '86400', 06:39:54 INFO - 'USER': 'cltbld', 06:39:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:54 INFO - '_': '/tools/buildbot/bin/python'} 06:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:54 INFO - Downloading/unpacking blobuploader==1.2.4 06:39:54 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 06:39:54 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 06:39:54 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 06:39:54 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 06:39:54 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 06:39:54 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 06:39:56 INFO - Downloading blobuploader-1.2.4.tar.gz 06:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:39:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:39:56 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 06:39:56 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 06:39:56 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 06:39:56 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 06:39:56 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 06:39:56 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 06:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:39:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:39:57 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 06:39:57 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 06:39:57 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 06:39:57 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 06:39:57 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 06:39:57 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 06:39:57 INFO - Downloading docopt-0.6.1.tar.gz 06:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:39:57 INFO - Installing collected packages: blobuploader, requests, docopt 06:39:57 INFO - Running setup.py install for blobuploader 06:39:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:39:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:39:57 INFO - Running setup.py install for requests 06:39:57 INFO - Running setup.py install for docopt 06:39:58 INFO - Successfully installed blobuploader requests docopt 06:39:58 INFO - Cleaning up... 06:39:58 INFO - Return code: 0 06:39:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:58 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:39:58 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 06:39:58 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 06:39:58 INFO - Using env: {'DISPLAY': ':0', 06:39:58 INFO - 'HOME': '/home/cltbld', 06:39:58 INFO - 'LANG': 'en_US.UTF-8', 06:39:58 INFO - 'LANGUAGE': 'en_US:en', 06:39:58 INFO - 'LOGNAME': 'cltbld', 06:39:58 INFO - 'MAIL': '/var/mail/cltbld', 06:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:58 INFO - 'MOZ_NO_REMOTE': '1', 06:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:58 INFO - 'NO_EM_RESTART': '1', 06:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:58 INFO - 'PWD': '/builds/slave/test', 06:39:58 INFO - 'SHELL': '/bin/bash', 06:39:58 INFO - 'SHLVL': '1', 06:39:58 INFO - 'TERM': 'linux', 06:39:58 INFO - 'TMOUT': '86400', 06:39:58 INFO - 'USER': 'cltbld', 06:39:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:58 INFO - '_': '/tools/buildbot/bin/python'} 06:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:58 INFO - Running setup.py (path:/tmp/pip-DeIBdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:58 INFO - Running setup.py (path:/tmp/pip-zTuc5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:58 INFO - Running setup.py (path:/tmp/pip-ymViTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:58 INFO - Running setup.py (path:/tmp/pip-Gyp3cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:58 INFO - Running setup.py (path:/tmp/pip-JN1OFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:58 INFO - Running setup.py (path:/tmp/pip-tGNJz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:58 INFO - Running setup.py (path:/tmp/pip-LUODrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:58 INFO - Running setup.py (path:/tmp/pip-WDgpJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:58 INFO - Running setup.py (path:/tmp/pip-t6K69z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:59 INFO - Running setup.py (path:/tmp/pip-iqHXgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:59 INFO - Running setup.py (path:/tmp/pip-HRZ05B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:59 INFO - Running setup.py (path:/tmp/pip-lEtnGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:59 INFO - Running setup.py (path:/tmp/pip-9Mihyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:59 INFO - Running setup.py (path:/tmp/pip-eT5fqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:59 INFO - Running setup.py (path:/tmp/pip-_E5p9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:59 INFO - Running setup.py (path:/tmp/pip-TAFDy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:59 INFO - Running setup.py (path:/tmp/pip-xwpgLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:39:59 INFO - Running setup.py install for manifestparser 06:39:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Running setup.py install for mozcrash 06:39:59 INFO - Running setup.py install for mozdebug 06:39:59 INFO - Running setup.py install for mozdevice 06:39:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:39:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Running setup.py install for mozfile 06:40:00 INFO - Running setup.py install for mozhttpd 06:40:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Running setup.py install for mozinfo 06:40:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Running setup.py install for mozInstall 06:40:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Running setup.py install for mozleak 06:40:00 INFO - Running setup.py install for mozlog 06:40:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Running setup.py install for moznetwork 06:40:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Running setup.py install for mozprocess 06:40:00 INFO - Running setup.py install for mozprofile 06:40:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:40:00 INFO - Running setup.py install for mozrunner 06:40:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:40:01 INFO - Running setup.py install for mozscreenshot 06:40:01 INFO - Running setup.py install for moztest 06:40:01 INFO - Running setup.py install for mozversion 06:40:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:40:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:40:01 INFO - Cleaning up... 06:40:01 INFO - Return code: 0 06:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:01 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:40:01 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 06:40:01 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 06:40:01 INFO - Using env: {'DISPLAY': ':0', 06:40:01 INFO - 'HOME': '/home/cltbld', 06:40:01 INFO - 'LANG': 'en_US.UTF-8', 06:40:01 INFO - 'LANGUAGE': 'en_US:en', 06:40:01 INFO - 'LOGNAME': 'cltbld', 06:40:01 INFO - 'MAIL': '/var/mail/cltbld', 06:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:01 INFO - 'MOZ_NO_REMOTE': '1', 06:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:01 INFO - 'NO_EM_RESTART': '1', 06:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:01 INFO - 'PWD': '/builds/slave/test', 06:40:01 INFO - 'SHELL': '/bin/bash', 06:40:01 INFO - 'SHLVL': '1', 06:40:01 INFO - 'TERM': 'linux', 06:40:01 INFO - 'TMOUT': '86400', 06:40:01 INFO - 'USER': 'cltbld', 06:40:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:01 INFO - '_': '/tools/buildbot/bin/python'} 06:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:01 INFO - Running setup.py (path:/tmp/pip-k7GVGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:01 INFO - Running setup.py (path:/tmp/pip-Barr5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:01 INFO - Running setup.py (path:/tmp/pip-yqgRGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:01 INFO - Running setup.py (path:/tmp/pip-9Sz3qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:01 INFO - Running setup.py (path:/tmp/pip-9i2OEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:01 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)) 06:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:01 INFO - Running setup.py (path:/tmp/pip-NBN1Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:02 INFO - Running setup.py (path:/tmp/pip-Mg30du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:40:02 INFO - Running setup.py (path:/tmp/pip-8bGidS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:40:02 INFO - Running setup.py (path:/tmp/pip-6IHcy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:40:02 INFO - Running setup.py (path:/tmp/pip-6uiQxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:40:02 INFO - Running setup.py (path:/tmp/pip-3yi0zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:40:02 INFO - Running setup.py (path:/tmp/pip-iA66PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:40:02 INFO - Running setup.py (path:/tmp/pip-dcWRZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:40:02 INFO - Running setup.py (path:/tmp/pip-qqdDzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:02 INFO - Running setup.py (path:/tmp/pip-59mCgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:40:02 INFO - Running setup.py (path:/tmp/pip-dMzkUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:40:02 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)) 06:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:40:02 INFO - Running setup.py (path:/tmp/pip-QXQKOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:40:02 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)) 06:40:02 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)) 06:40:02 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)) 06:40:02 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)) 06:40:02 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)) 06:40:02 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)) 06:40:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:40:02 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 06:40:02 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 06:40:02 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 06:40:02 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 06:40:02 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 06:40:02 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 06:40:04 INFO - Downloading blessings-1.6.tar.gz 06:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:40:04 INFO - Installing collected packages: blessings 06:40:04 INFO - Running setup.py install for blessings 06:40:04 INFO - Successfully installed blessings 06:40:04 INFO - Cleaning up... 06:40:05 INFO - Return code: 0 06:40:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:05 INFO - Reading from file tmpfile_stdout 06:40:05 INFO - Current package versions: 06:40:05 INFO - argparse == 1.2.1 06:40:05 INFO - blessings == 1.6 06:40:05 INFO - blobuploader == 1.2.4 06:40:05 INFO - docopt == 0.6.1 06:40:05 INFO - functools32 == 3.2.3-2 06:40:05 INFO - jsonschema == 2.5.1 06:40:05 INFO - manifestparser == 1.1 06:40:05 INFO - mozInstall == 1.12 06:40:05 INFO - mozcrash == 0.17 06:40:05 INFO - mozdebug == 0.1 06:40:05 INFO - mozdevice == 0.48 06:40:05 INFO - mozfile == 1.2 06:40:05 INFO - mozhttpd == 0.7 06:40:05 INFO - mozinfo == 0.9 06:40:05 INFO - mozleak == 0.1 06:40:05 INFO - mozlog == 3.4 06:40:05 INFO - moznetwork == 0.27 06:40:05 INFO - mozprocess == 0.23 06:40:05 INFO - mozprofile == 0.28 06:40:05 INFO - mozrunner == 6.12 06:40:05 INFO - mozscreenshot == 0.1 06:40:05 INFO - mozsystemmonitor == 0.3 06:40:05 INFO - moztest == 0.7 06:40:05 INFO - mozversion == 1.4 06:40:05 INFO - psutil == 3.1.1 06:40:05 INFO - requests == 1.2.3 06:40:05 INFO - wsgiref == 0.1.2 06:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:05 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')]} 06:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:05 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')]} 06:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:05 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:40:05 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 06:40:05 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 06:40:05 INFO - Using env: {'DISPLAY': ':0', 06:40:05 INFO - 'HOME': '/home/cltbld', 06:40:05 INFO - 'LANG': 'en_US.UTF-8', 06:40:05 INFO - 'LANGUAGE': 'en_US:en', 06:40:05 INFO - 'LOGNAME': 'cltbld', 06:40:05 INFO - 'MAIL': '/var/mail/cltbld', 06:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:05 INFO - 'MOZ_NO_REMOTE': '1', 06:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:05 INFO - 'NO_EM_RESTART': '1', 06:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:05 INFO - 'PWD': '/builds/slave/test', 06:40:05 INFO - 'SHELL': '/bin/bash', 06:40:05 INFO - 'SHLVL': '1', 06:40:05 INFO - 'TERM': 'linux', 06:40:05 INFO - 'TMOUT': '86400', 06:40:05 INFO - 'USER': 'cltbld', 06:40:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:05 INFO - '_': '/tools/buildbot/bin/python'} 06:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 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)) 06:40:05 INFO - Cleaning up... 06:40:05 INFO - Return code: 0 06:40:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:40:05 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')]} 06:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:05 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')]} 06:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:05 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 0x7fd74a8f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf227b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', '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 06:40:05 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 06:40:05 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 06:40:05 INFO - Using env: {'DISPLAY': ':0', 06:40:05 INFO - 'HOME': '/home/cltbld', 06:40:05 INFO - 'LANG': 'en_US.UTF-8', 06:40:05 INFO - 'LANGUAGE': 'en_US:en', 06:40:05 INFO - 'LOGNAME': 'cltbld', 06:40:05 INFO - 'MAIL': '/var/mail/cltbld', 06:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:05 INFO - 'MOZ_NO_REMOTE': '1', 06:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:05 INFO - 'NO_EM_RESTART': '1', 06:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:05 INFO - 'PWD': '/builds/slave/test', 06:40:05 INFO - 'SHELL': '/bin/bash', 06:40:05 INFO - 'SHLVL': '1', 06:40:05 INFO - 'TERM': 'linux', 06:40:05 INFO - 'TMOUT': '86400', 06:40:05 INFO - 'USER': 'cltbld', 06:40:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:05 INFO - '_': '/tools/buildbot/bin/python'} 06:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:40:05 INFO - Cleaning up... 06:40:05 INFO - Return code: 0 06:40:05 INFO - Running post-action listener: _resource_record_post_action 06:40:05 INFO - Running post-action listener: _start_resource_monitoring 06:40:05 INFO - Starting resource monitoring. 06:40:05 INFO - [mozharness: 2016-10-17 13:40:05.754596Z] Finished create-virtualenv step (success) 06:40:05 INFO - [mozharness: 2016-10-17 13:40:05.755059Z] Running install step. 06:40:05 INFO - Running pre-action listener: _resource_record_pre_action 06:40:05 INFO - Running main action method: install 06:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:05 INFO - Reading from file tmpfile_stdout 06:40:05 INFO - Detecting whether we're running mozinstall >=1.0... 06:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:40:06 INFO - Reading from file tmpfile_stdout 06:40:06 INFO - Output received: 06:40:06 INFO - Usage: mozinstall [options] installer 06:40:06 INFO - Options: 06:40:06 INFO - -h, --help show this help message and exit 06:40:06 INFO - -d DEST, --destination=DEST 06:40:06 INFO - Directory to install application into. [default: 06:40:06 INFO - "/builds/slave/test"] 06:40:06 INFO - --app=APP Application being installed. [default: firefox] 06:40:06 INFO - mkdir: /builds/slave/test/build/application 06:40:06 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'] 06:40:06 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 06:40:23 INFO - Reading from file tmpfile_stdout 06:40:23 INFO - Output received: 06:40:23 INFO - /builds/slave/test/build/application/firefox/firefox 06:40:23 INFO - Running post-action listener: _resource_record_post_action 06:40:23 INFO - [mozharness: 2016-10-17 13:40:23.013596Z] Finished install step (success) 06:40:23 INFO - [mozharness: 2016-10-17 13:40:23.013870Z] Running run-tests step. 06:40:23 INFO - Running pre-action listener: _resource_record_pre_action 06:40:23 INFO - Running main action method: run_tests 06:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:40:23 INFO - Python 2.7.3 06:40:23 INFO - Return code: 0 06:40:23 INFO - grabbing minidump binary from tooltool 06:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:23 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 0xfb1790>, '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 0xfb2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:40:23 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 06:40:23 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 06:40:23 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 06:40:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:40:23 INFO - Return code: 0 06:40:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:40:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:40:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:40:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:40:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:40:23 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/1476700208/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:40:23 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/1476700208/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:40:23 INFO - Using env: {'DISPLAY': ':0', 06:40:23 INFO - 'HOME': '/home/cltbld', 06:40:23 INFO - 'LANG': 'en_US.UTF-8', 06:40:23 INFO - 'LANGUAGE': 'en_US:en', 06:40:23 INFO - 'LOGNAME': 'cltbld', 06:40:23 INFO - 'MAIL': '/var/mail/cltbld', 06:40:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:40:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:23 INFO - 'MOZ_NO_REMOTE': '1', 06:40:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:23 INFO - 'NO_EM_RESTART': '1', 06:40:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:23 INFO - 'PWD': '/builds/slave/test', 06:40:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:40:23 INFO - 'SHELL': '/bin/bash', 06:40:23 INFO - 'SHLVL': '1', 06:40:23 INFO - 'TERM': 'linux', 06:40:23 INFO - 'TMOUT': '86400', 06:40:23 INFO - 'USER': 'cltbld', 06:40:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102', 06:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:23 INFO - '_': '/tools/buildbot/bin/python'} 06:40:23 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/1476700208/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:40:23 INFO - mozversion application_buildid: 20161017033008 06:40:23 INFO - mozversion application_changeset: 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 06:40:23 INFO - mozversion application_display_name: Nightly 06:40:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:40:23 INFO - mozversion application_name: Firefox 06:40:23 INFO - mozversion application_remotingname: firefox 06:40:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:40:23 INFO - mozversion application_vendor: Mozilla 06:40:23 INFO - mozversion application_version: 52.0a1 06:40:23 INFO - mozversion platform_buildid: 20161017033008 06:40:23 INFO - mozversion platform_changeset: 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 06:40:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:40:23 INFO - mozversion platform_version: 52.0a1 06:40:23 INFO - using testdate: 1476711623 06:40:23 INFO - actual date: 1476711623 06:40:23 INFO - starting webserver on 'localhost:60261' 06:40:23 INFO - SUITE-START | Running 2 tests 06:40:23 INFO - TEST-START | dromaeo_css 06:40:23 INFO - operating with platform_type : linux_ 06:40:23 INFO - Initialising browser for dromaeo_css test... 06:40:23 INFO - TEST-INFO | started process 5714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgGhAdT/profile http://localhost:60261/getInfo.html) 06:40:27 INFO - PROCESS | 5714 | __metrics Screen width/height:1600/1200 06:40:27 INFO - PROCESS | 5714 | colorDepth:24 06:40:27 INFO - PROCESS | 5714 | Browser inner width/height: 1024/697 06:40:27 INFO - PROCESS | 5714 | __metrics 06:40:28 INFO - PROCESS | 5714 | 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" 06:40:28 INFO - PROCESS | 5714 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:40:29 INFO - PROCESS | 5714 | console.error: PushService: 06:40:29 INFO - PROCESS | 5714 | stateChangeProcessEnqueue: Error transitioning state 06:40:29 INFO - PROCESS | 5714 | UnknownError 06:40:29 INFO - TEST-INFO | 5714: exit 0 06:40:29 INFO - Browser initialized. 06:40:29 INFO - Running cycle 1/1 for dromaeo_css test... 06:40:29 INFO - TEST-INFO | started process 5796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgGhAdT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:42 INFO - PROCESS | 5796 | RSS: Main: 172027904 06:40:42 INFO - PROCESS | 5796 | 06:41:33 INFO - PROCESS | 5796 | 1476711693500 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] 06:43:44 INFO - PROCESS | 5796 | Cycle 1(1): loaded http://localhost:60261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60261/tests/dromaeo/cssquery-ext.html) 06:43:46 INFO - PROCESS | 5796 | RSS: Main: 285564928 06:43:46 INFO - PROCESS | 5796 | 06:46:48 INFO - PROCESS | 5796 | Cycle 1(1): loaded http://localhost:60261/tests/dromaeo/cssquery-ext.html (next: http://localhost:60261/tests/dromaeo/cssquery-jquery.html) 06:46:49 INFO - PROCESS | 5796 | RSS: Main: 278409216 06:46:49 INFO - PROCESS | 5796 | 06:49:51 INFO - PROCESS | 5796 | Cycle 1(1): loaded http://localhost:60261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60261/tests/dromaeo/cssquery-mootools.html) 06:49:51 INFO - PROCESS | 5796 | RSS: Main: 276930560 06:49:51 INFO - PROCESS | 5796 | 06:52:53 INFO - PROCESS | 5796 | Cycle 1(1): loaded http://localhost:60261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60261/tests/dromaeo/cssquery-prototype.html) 06:52:54 INFO - PROCESS | 5796 | RSS: Main: 250089472 06:52:54 INFO - PROCESS | 5796 | 06:55:57 INFO - PROCESS | 5796 | Cycle 1(1): loaded http://localhost:60261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60261/tests/dromaeo/cssquery-yui.html) 06:55:57 INFO - PROCESS | 5796 | RSS: Main: 215339008 06:55:57 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | Cycle 1(1): loaded http://localhost:60261/tests/dromaeo/cssquery-yui.html (next: http://localhost:60261/tests/dromaeo/cssquery-dojo.html) 06:59:00 INFO - PROCESS | 5796 | RSS: Main: 304586752 06:59:00 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | __start_tp_report 06:59:00 INFO - PROCESS | 5796 | _x_x_mozilla_page_load 06:59:00 INFO - PROCESS | 5796 | _x_x_mozilla_page_load_details 06:59:00 INFO - PROCESS | 5796 | |i|pagename|runs| 06:59:00 INFO - PROCESS | 5796 | |0;dojo.html;3035.741961933236;3078.261217307846;3082.614673165854;3110.6733792951727;3132.123005558443;5211.5049070338355;5268.104422248218;5309.097453432916;5395.460453954607;5406.756695948687;5275.6043296752805;5312.973435132819;5345;5355.116405793039;5367.490088441602;4725.621950243973;4751.833685820997;4793.760311984404;4830.058138662962;4848.636352273594;4903.607711383081;4929.3591833061655;5000.799968001294;5001.899962000758;5063.189889617662;4703.3885594872445;4951;4956.752162391902;5023.899522009558;5069.822556210534;4735.360726301939;4807.062622788558;4807.206810876236;4809.062232864593;4810.06203790261;4742.762861856893;4773.021530586257;4777.665563410563;4782.641301902337;4788.377510923558;5140.1004824156;5187.766550505236;5191.896162076738;5197.246399272084;5198.792048318101;5560.86097847553;5592.384837667853;5631.887362252732;5642.069058605325;5734.4265573442735;5701.971490142564;5716.171155182476;5716.28546431696;5720.456556627156;5723.255976723041;5196.636235463519;5270.183121616155;5303.806643505219;5308.442613525524;5372.516473517402;5643.830685079454;5689.743961521659;5726.284214473191;5771.653700777967;5775.220345253421;5538.113901775697;5540.944590554123;5543.1408131739645;5545.9722701387045;5596;5606.60753747242;5615.0454422748235;5619;5623.184638227434;5628.915566266509;5466.34403871538;5524.475174858382;5527.972360138254;5551.167324901297;5604.131359639263;5570.888582228333;5583.860403489945;5584.525315348241;5587.55299576041;5594.580406469449;4328.696991210648;4334.43652325202;4349.586789255016;4428.13651337986;4436.068425630654;3923.2545816295383;3948.8617898373996;3960.20795840833;3965.2862484753023;3971.046948732341;5346.224797404355;5403.324584426947;5405.702686352289;5408.891822163613;5409.891802163935;5527.2538207342295;5568.777248909998;5572.749226284827;5730.111832665943;5740.56945729072;5231.293775340357;5273.446288139767;5288.338957630296;5296.708681022581;5366;4933.136701077297;4957.553820156203;4969.726665033458;4974.626902982291;5030.170021946411;5734.7132643368495;5923.378045305267;5926.140709596998;5926.585139040226;5931.40685931412;5583.55331573465;5669.121286200645;5732.140178973187;5736.6558006519745;5824.970875145597;5925.081612350093;5935.109733540004;5935.2877654681715;5938.703064846827;5941.287045554561;5636.2954630671165;5642.85892852682;5643.915341269966;5660.29246344207;5667.971660141673;5512.91730624033;5556.305461817273;5672.092465205547;5779.942200577941;5793.073108302651;5635.971820140873;5684.147377893349;5687.118496633028;5691.686957217393;5746.511546518425;5476.589255805751;5560.833175004756;5572.888542229051;5574.191742197439;5603.327600687943;5335.226392173191;5390.892182156256;5505.146702261156;5570.303712035996;5598.692071936082;5637.859053523531;5641.238432811518;5644.858878527905;5687.1753595729215;5704.60067795267;5490.560755139659;5504.559635229092;5505.944940550704;5509.752061157177;5565.916511252253 06:59:00 INFO - PROCESS | 5796 | |1;ext.html;577.4687287695319;606.9833029675293;616.7193926763321;618.4125081172886;625.6277514878645;31543.369132617332;41798.791006044965;42258;42445.302187912486;45939.310910336375;42736;42911.356329655006;43072.78463607685;43115.56884431155;43180.35229471553;7904.328132108749;8082.595870206495;8645.265152462032;8853.867191992125;10362.689119326433;10062.742157230346;10403.583856645762;10413.323133996266;10424.843627345595;10462.686119416392;10514.474276286155;10548.894511054868;10550.261481696285;10558.947205264001;10564.577416903314;7916.327112195441;8101.2708856202635;10168.694939151763;10368.533415996222;10422.947885260563;10469.057784799328;10552.841707374395;10555.313904596176;10558.260921735482;10560.155187584975;41047.179056419;41125.38311925324;41262.38106428406;41270;41294.38058429096;3247.626522949867;3471.444568868994;3784.564775050849;3786.9431958520645;4069.348904175318;28888.27779305513;31922;32000.359992800248;32027.359452811048;32125.51811722826;4124.154548317588;4208.3687446882905;4288.742675439484;4298.548652391516;4310.892227694301;303699;304728;305076;305681;306016;57970;58363.4163658358;58375.12437313444;58384.41615583875;58399;61159.694201528706;61298.69350653218;61299;61437.38562614406;61454.38545614487;16090.517284481484;16278.674426511403;16288.185590720417;16308.83691163097;16315.755263671055;11908.880911190778;12166.330851803235;13049.478020879249;13212;13216.273104979318;18602.627947440975;18750.343737969106;18829.623407532046;18842.246310147442;18877.811221887605;6863.519553631298;6893.827654308582;6925.480588955848;6948.305169483011;7256.274372562807;953.6519170502855;987.9357841740264;1074.3446497636435;1112.8497652816927;1117.9826358014168;31626;31687.366252675278;31723.52414713781;31805.52291715626;32396.35207295888;1059.2849826367171;1069.946502674863;1088.6298658456162;1129.474794220675;1142.988226024415;15717.764233536505;16412.261448234858;16501.422450214184;16563.254653540618;16978.23597938096;459293;485438;495714;496585;771661;55683.16475252875;56283.838843367485;56290;56454;56565.15152272719;1274.6877015131352;1291.0639786154964;1293.9001848428761;1296.9689097167775;1327.674719693662;30042.026210429114;32393.838030809697;32504.83747581247;32767.34465310728;32828.1792955178;47668.284975724695;48230.75884620554;48245.75877120592;48278.75860620674;48449.27326090041;409839;410500;411593;411889;411936;26354.604680929417;27346.179614611592;27472.313192170357;27523.587146193222;27541;32235;37510;43359.34960975651;45844.54155458403;47924.28113578369;37407.43888841724;37482.94253195259;38327.80836095801;38856.61143388643;39929.40105898356;37231.627683722814;37349.62650373462;37578.812105939294;37735;37881.431778523896;34776.47835282524;34856.47715284222;38522;39419.40870886882;39461.40807887827;31472.685273146977;34138.31723365568;34234.82882585571;34916.127096822784;35163.82418087893;27115.054150182274;27259.454810904066;27300.59049114225;27437.86281068582;27494.17517474479 06:59:00 INFO - PROCESS | 5796 | |2;jquery.html;373.8018850009494;387.46916724088004;391.14339596284134;394.60736567115725;405.4992084775302;17574.912125439372;19401.611967760637;19798.30705925293;19957.70063449046;19969.201231950723;15385.307661155246;15669.981451205664;15702.685946281068;16560.58598535037;18973.14620842062;5414.377346605142;5661.745221465044;5662.915056274159;5669.376368599451;5670.206171136044;5371.973140134313;5690;5692;5717.742701578418;5725.656460612356;5541.750621222034;5702.116171993348;5714.914276285859;5720.513756330696;5737.7991770288045;5626.212330273745;5707.657540547539;5719.45665161811;5723.399043100456;5769.105788602773;4959.231319145538;5237.711925844077;5584.21820945068;5589.133684278943;5590;13414.865851341558;13641.795373069412;13643.113197642122;13647.86352136476;19561.315353962542;2116.016052535578;2166.6749987501844;2206;2421.5278020785954;2578.419855532509;9375;9629.614815407374;9722.465264410455;9865.632248260437;13705.246211458365;1741.9825801741947;1766.779197215975;1865.32848174657;1880.4922670878923;1894.0151121416786;74701.6264918672;82513.17486825175;83910.58044709737;84040.15959840384;84364;10262.486875656188;10421.635242766619;10543.630972916064;10735.946320268506;11314.830277545843;14836.258187090601;14836.258187090601;14843.554693359216;14849.554513364616;14885.404583816526;7407.703691852374;7671.961640191764;7695.23047695226;7766.766996990099;7946.682132714626;7517.699292028257;7550.735724249625;7559.697612095454;7775.805604859811;7827.373810095179;4446.777661116996;4482.46210454741;4488.955110448854;4572.222722137245;4587.495375508692;1841.778986521626;1885.7171424286466;1894.7631546056743;1915.6647586672555;1929.5947850951177;954.5609019850807;976.6630512473185;999.5102399824034;1030.6804890483975;1056.4470228763705;18169;19191.712124318146;19301.131449084824;19301.51746206328;19694;951.167728237792;971.9659811906549;991.3011327014437;1010.8989101089979;1052.8631277933973;10157.644482443078;10612.57549698019;10762.73093172677;10792.892071079346;10793.892061079447;400014;439602;444299;451066;452691;54988.72505637446;73551;95338;97188;97188.51405743067;1005.4369553050316;1023.2734758321675;1061.4692653673317;1066.1204506282347;1070.3310430980637;15471.973015857067;16808.159592020107;17283.65432691314;17619.55951101233;17667.38164164248;38597.61402386052;41891.37162942619;41896;42412;43886.56113438825;52645;54269.72865135649;54596.45403546072;55168.17247741207;56400.43599564116;8037.638306276349;8141.9185808141165;8454.23911847912;8473.78815529592;8549.529775862387;11778.764424711286;12304.75390492203;12554.686132846751;12750.362481876055;12944.870551294367;10911.290766100177;10916;11322.60370887015;11670.416479176178;11928.642140735792;11001.284916480403;11207.551697931991;11311.773764524827;11432.142589306002;11528.769424611628;11581.82627260575;11644.2431241969;11658.708532286422;11689.298642081503;12063.276203427822;7406.333429991327;7591.3926885847895;8304.418690691835;8551.605550445885;8617.82764344697;10906;11374.94312528432;11657.708557286136;11724.616834482213;11922.523099076287 06:59:00 INFO - PROCESS | 5796 | |3;mootools.html;1321.7686904791658;1403.8175037245157;1477.903936244144;1585.9603509912251;1786.428342930262;7844.92155078449;8600.74197774067;8829.028806831251;8963.55182240887;9156.267498600113;8940.508272045035;8975;9046.457212567235;9050.592723327449;9054.637814487429;2307.2616762636003;2348.1781376518165;2351.5767161910935;2360.9409764755846;2366.4557151855083;2269.1263863412623;2306.527161931808;2312.1213938703268;2318.119114736398;2344.284993077111;2276.715410573678;2304.83866129371;2310.27226423676;2313.27131953435;2323.0475505042937;2247.550489902026;2251.403378104787;2257.8532395394245;2260.8469680463;2281.7261928568514;2253.346529506441;2260.7174103237094;2265.6374980003284;2266.5353602511445;2271.329957662477;8586.527740974245;8681.04508504064;8686.391952563323;9025.187733103987;9071.455712657196;5208.114620514521;5396.676199428047;5397.055515284809;5407.351117865881;5419.430959749209;3355.5134505496812;3487.459443786217;3549.503069570262;3555.288942211568;3566.4115420955513;1008.909198172168;1047.7223535763028;1058.9629362972337;1107.1032463704425;1107.850440190572;12636.873631263661;12717.427715752814;12719.74560508794;12738.235705857585;12742.426590803436;4347.260965635849;4453.46558412986;4583;4597.356370108188;4614.515475874985;9878.753031174278;9953.502324883726;9962.252831037556;9964.651237206663;9969.651062212788;5235.947640523546;5238.292830467914;5238.292830467914;5246.658967167122;5275.525202731773;4166;4306.504751953503;4769.165396055676;4874.6344024197615;4907.87730306738;3766.322062028861;3828.1960788234783;3834.2906562285507;3847.5382954045695;3944.9802750986637;1151.9654410367702;1160.9419529023514;1165.2775279326872;1166.3876464856019;1167.5038108803724;898.4160295807646;939.5537119868145;950.3157726436955;960.2126256469628;991.9107280344804;5870.119482077723;5983.611065280743;6096.481799047131;6129.754809807647;6235.469985051231;872.8690696395591;897.1701176411793;904.5206040798388;919.797644518205;925.9027802080819;3809.1429428378947;3883;4162.91674166515;4184.100418409996;4202.810873510699;11080.667579972614;11132;11173.10615150786;11318.717032074264;11518.94240528792;11318.886811131782;11343.886561134448;11345.829812552818;11349.489272982735;11352.886471135349;7751.534907905544;7987.720429785046;8034.83930321402;8056;8065.516069035877;5627.155926611041;5627.718614069362;5745.166950792195;5774.595778295479;5806.4483874033585;9497.857532136884;9531.904680953101;9554.522273886418;9558.426494410358;9745.707628771148;9668.613255469703;9669.371490853073;9859.161971232526;10283.971602839656;10295.433751143759;7102.538335008208;7319.707211711472;7325.6337183141695;7663.961680191564;7829.412794040356;7877.330426913776;7891.092524359542;8322.250997410261;8532.488050716976;8613.181747733955;7631.3894888407685;7664.655090520829;7767.145613982344;8044.798880028046;8048.275655191061;7401.185869554237;7465.328120469184;7489.101307842876;7505.774826755206;7569.886451703119;6808.217055038734;6914.55055421396;6916.20463646687;6918.481113916577;6920.342567456084;4836.733979631154;4956.504349565159;5040.117979353672;5058.64589478733;5137.8201762938115;4982.2775697524385;5043.193089105725;5100.872478188075;5165.845024649267;5341.092014357646 06:59:00 INFO - PROCESS | 5796 | |4;prototype.html;319.6531763037103;325.5593996565198;326.97711160218785;332.4813291265625;335.59895924370386;5094;5244.606654500918;5264.8157314494;5300.734963251836;5307.999999999995;5003.374578177728;5123.820666276681;5175.637705360627;5227.26818245446;5259.684418934857;4131.648809851166;4143.7513749175;4145.502539695226;4162.396452514391;4166.708330416872;4003.399490076483;4118.794060296988;4134.710570260083;4138.730982486144;4166.9791651041705;4046.4739583854207;4088.9591104088877;4092.631663150316;4094.34490481523;4121.793910304487;4068.674506039539;4091.8363265469347;4098.631123198911;4114.917701645965;4116.526599441073;3645.198056427582;3648.6351364863303;3648.9817550912076;3649.1754122938532;3658.762180458262;5098.515641014098;5109.310243117206;5115.388652574465;5148.716820574867;5168.656149401145;4677.6257899367965;4681.1743420066205;4699.78850951708;4702.200625893606;4704.95295047052;5330.7334633268565;5471.616986810925;5473.17902314652;5473.534749546293;5493.544210784145;3907.1208977980014;3912.68698504119;3926.88219353417;3939.113699417637;3955.624215699504;5723.57073219506;5754.654720716729;5759.712014399305;5765.279340082489;5781.595288329819;4061.248668996245;4062.8171732272117;4071.185762847442;4072.5927407259037;4075.7976396962968;3877.166409222031;4051.2505186540584;4062.654674352654;4076.8369265229057;4117.876463706094;4642.582167604932;4653.953460465352;4655.976720116378;4659.487456379796;4669.34629151919;5459.727013649302;5472.781088756485;5502.5968378063335;5513;5600.767831077156;1277.8338815953866;1282.2306616030307;1369.4179973511218;1383.4466213514675;1385.7228554288981;871.324723339417;884.2086332732168;905.8958219804675;908.4549270437817;912.4616476278894;4647.604953578916;4676.433394812708;4687.976560117246;4690.671652984258;4694.2254528002495;4933.333999910038;4938.987217797141;4941.876453088702;4942.901141977212;4948.257761335828;4616.469106052779;4638;4645.953540464619;4646.279826626878;4659.906801863944;2773.833569985807;2954.6749857515656;2986.611740473768;2994.5358469437274;3001.7598592112577;5841.335219462433;5855.2973643163095;5856.180134781134;5875.6474611523445;5901.262342207224;5561.833145005657;5705.315362156568;5741.770329186869;5788.797392091341;5822.9518686635965;5805.332386775491;5805.477507024388;5841.649501029951;5843.328017278068;5872.354041055395;5640.266765320482;5644.209810626598;5654.36023553165;5675.687837168995;5692;5402.35171779389;5550.944490555043;5623.184638227516;5638.210650509014;5655.85860353478;5816.651000939957;5856.765729370777;5867.442592953663;5894.616849904743;5964.701764911824;4063.288924438152;4141.316682747313;4150.775521221187;4154.127633197062;4169.833206671699;5338.4127745947135;5597.608167428404;5598.21624972496;5639.943600563942;5664.26364572603;5401.189821526646;5402.621816472809;5519.199716041232;5520.309961254843;5521.398794349594;5507.485441503458;5530.889382212414;5539.612227144061;5548.750306236148;5590.385057643737;5216.478352164905;5440.727963601883;5488.945110549003;5489.670619762827;5500.42245564226;5520.972395137998;5525.585581081355;5541.168824676331;5550.4449555044175;5559.944400555943;5408.621396502364;5431.9185212221055;5433.9184912225555;5464.016477034013;5500.559955203654 06:59:00 INFO - PROCESS | 5796 | |5;yui.html;739.9371053460452;744.2854859335039;749.3218637133397;751.4326683354067;780.3211206250561;14456.132632042085;15478.380864765395;15635.374585016585;15638.687226255468;15653.608659783511;13750.518731844388;13920;13938.09402388844;13942.860571394283;13962.092463989833;647.3720491123603;667.2560095493538;770.7533589251456;783.5259667900923;789.171370061436;797.8683517219681;810.1291112054536;812.4110020235341;812.5043723328765;813.040612077751;851.9148085191493;852.1946760311508;854.3506934729588;854.7051267312767;855.5636625321068;695.9756408525677;695.979120626382;827.5076329583887;853.4836423963505;855.0936007831718;621.7792683597303;621.9036049412348;622.2284367384456;622.3403192615841;622.396275612655;15176.772348414783;15194;15297.770533441895;15310.693786124326;15323.387064517407;13514.797278040838;13605.931970340085;13827.79258311126;13828.170309781344;14053.946748058284;11018.559257629686;11020.228583999124;11164.665060048212;11172.497237624326;11283.774324513546;4159.7920103994675;4190.832366705328;4254.340577210537;4275.850345237933;4312.784360781949;73020;73144.63427682828;73408;74808;77678.6116069416;10618.575256989634;10623.575056997788;10630.501453777842;10855.457227138611;10877.347359158475;20896.37310880676;20985.79014209869;21033.579328413347;21034.368968930652;21056.15775368968;8342.958285208657;8414.326853851677;8448.32413406926;8610.956945215234;8685.739427817176;4522.773861306987;4586.2661974083985;4623.815047398134;4698.859034228979;4703.929441058387;3164.6360668522952;3261.38033773587;3263.167892187477;3265.559149514833;3265.9836700816345;612.1735656863289;615.4399496458291;628.720219502317;635.2155088465742;636.3699937062275;615.8429600451946;718.9604571748499;721.7185297733888;739.1425945902727;739.5784402890301;8861.082099434747;9749.561269742879;9776.706698799047;10049.487628092977;10054.145397641136;583.6585597425553;628.446966669328;671.2113266911359;675.4427597232303;759.5670467833393;4312.525622181557;4640.767961601974;4755.881102972453;4806.951930480651;4850.83022094225;74819.25180748232;108415;112521.43739281251;114504;117386;91242.54378728064;94423.52788236152;97224.51387743157;97776;97877.51061244648;80861.59569202116;85847.57076214578;87056;90297.54851225702;90953.54523227342;9167.404118732262;9284.350095493252;9348.766280843034;9517;9529.066038158098;50112;50130;50508.24237636365;50774.238386423494;52000.73999629977;68721.5022798185;73789;75045.72302341645;75408.62295688706;77636;11696.473658685209;12058.698532536757;12259.938700306442;12352.4441400139;12457.252564846138;12063.276203427822;12271.57049503263;12606.432710528232;13188.406521706738;13275.86724132785;13073.803892941803;14049.438022478986;14321.355539000979;15171.393144274105;15199.544013679608;14101;14824.555263342118;15261.771073434129;15593.610159746097;15616.453424130556;14011.789823152865;14856.702865942836;14861.181321676797;14917.179555124572;15433.614159646098;11230.55077796879;11271.830922536004;11383.88398386012;11846.881531184577;11896.524139034342;10932.344059356465;11083.889161108285;11107.166962478008;11207.271527350696;11258.7748245033 06:59:00 INFO - PROCESS | 5796 | __end_tp_report 06:59:00 INFO - PROCESS | 5796 | __start_cc_report 06:59:00 INFO - PROCESS | 5796 | _x_x_mozilla_cycle_collect,1054 06:59:00 INFO - PROCESS | 5796 | __end_cc_report 06:59:00 INFO - PROCESS | 5796 | __startTimestamp1476712740888__endTimestamp 06:59:00 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | ------- Summary: start ------- 06:59:00 INFO - PROCESS | 5796 | Number of tests: 6 06:59:00 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | [#0] dojo.html Cycles:165 Average:5279.25 Median:5505.94 stddev:586.16 (10.6%) stddev-sans-first:560.92 06:59:00 INFO - PROCESS | 5796 | Values: 3035.7 3078.3 3082.6 3110.7 3132.1 5211.5 5268.1 5309.1 5395.5 5406.8 5275.6 5313.0 5345.0 5355.1 5367.5 4725.6 4751.8 4793.8 4830.1 4848.6 4903.6 4929.4 5000.8 5001.9 5063.2 4703.4 4951.0 4956.8 5023.9 5069.8 4735.4 4807.1 4807.2 4809.1 4810.1 4742.8 4773.0 4777.7 4782.6 4788.4 5140.1 5187.8 5191.9 5197.2 5198.8 5560.9 5592.4 5631.9 5642.1 5734.4 5702.0 5716.2 5716.3 5720.5 5723.3 5196.6 5270.2 5303.8 5308.4 5372.5 5643.8 5689.7 5726.3 5771.7 5775.2 5538.1 5540.9 5543.1 5546.0 5596.0 5606.6 5615.0 5619.0 5623.2 5628.9 5466.3 5524.5 5528.0 5551.2 5604.1 5570.9 5583.9 5584.5 5587.6 5594.6 4328.7 4334.4 4349.6 4428.1 4436.1 3923.3 3948.9 3960.2 3965.3 3971.0 5346.2 5403.3 5405.7 5408.9 5409.9 5527.3 5568.8 5572.7 5730.1 5740.6 5231.3 5273.4 5288.3 5296.7 5366.0 4933.1 4957.6 4969.7 4974.6 5030.2 5734.7 5923.4 5926.1 5926.6 5931.4 5583.6 5669.1 5732.1 5736.7 5825.0 5925.1 5935.1 5935.3 5938.7 5941.3 5636.3 5642.9 5643.9 5660.3 5668.0 5512.9 5556.3 5672.1 5779.9 5793.1 5636.0 5684.1 5687.1 5691.7 5746.5 5476.6 5560.8 5572.9 5574.2 5603.3 5335.2 5390.9 5505.1 5570.3 5598.7 5637.9 5641.2 5644.9 5687.2 5704.6 5490.6 5504.6 5505.9 5509.8 5565.9 06:59:00 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | [#1] ext.html Cycles:180 Average:57732.33 Median:34886.30 stddev:115817.52 (332.0%) stddev-sans-first:116062.92 06:59:00 INFO - PROCESS | 5796 | Values: 577.5 607.0 616.7 618.4 625.6 31543.4 41798.8 42258.0 42445.3 45939.3 42736.0 42911.4 43072.8 43115.6 43180.4 7904.3 8082.6 8645.3 8853.9 10362.7 10062.7 10403.6 10413.3 10424.8 10462.7 10514.5 10548.9 10550.3 10558.9 10564.6 7916.3 8101.3 10168.7 10368.5 10422.9 10469.1 10552.8 10555.3 10558.3 10560.2 41047.2 41125.4 41262.4 41270.0 41294.4 3247.6 3471.4 3784.6 3786.9 4069.3 28888.3 31922.0 32000.4 32027.4 32125.5 4124.2 4208.4 4288.7 4298.5 4310.9 303699.0 304728.0 305076.0 305681.0 306016.0 57970.0 58363.4 58375.1 58384.4 58399.0 61159.7 61298.7 61299.0 61437.4 61454.4 16090.5 16278.7 16288.2 16308.8 16315.8 11908.9 12166.3 13049.5 13212.0 13216.3 18602.6 18750.3 18829.6 18842.2 18877.8 6863.5 6893.8 6925.5 6948.3 7256.3 953.7 987.9 1074.3 1112.8 1118.0 31626.0 31687.4 31723.5 31805.5 32396.4 1059.3 1069.9 1088.6 1129.5 1143.0 15717.8 16412.3 16501.4 16563.3 16978.2 459293.0 485438.0 495714.0 496585.0 771661.0 55683.2 56283.8 56290.0 56454.0 56565.2 1274.7 1291.1 1293.9 1297.0 1327.7 30042.0 32393.8 32504.8 32767.3 32828.2 47668.3 48230.8 48245.8 48278.8 48449.3 409839.0 410500.0 411593.0 411889.0 411936.0 26354.6 27346.2 27472.3 27523.6 27541.0 32235.0 37510.0 43359.3 45844.5 47924.3 37407.4 37482.9 38327.8 38856.6 39929.4 37231.6 37349.6 37578.8 37735.0 37881.4 34776.5 34856.5 38522.0 39419.4 39461.4 31472.7 34138.3 34234.8 34916.1 35163.8 27115.1 27259.5 27300.6 27437.9 27494.2 06:59:00 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | [#2] jquery.html Cycles:180 Average:26801.50 Median:19485.71 stddev:72447.18 (371.8%) stddev-sans-first:72623.24 06:59:00 INFO - PROCESS | 5796 | Values: 373.8 387.5 391.1 394.6 405.5 17574.9 19401.6 19798.3 19957.7 19969.2 15385.3 15670.0 15702.7 16560.6 18973.1 5414.4 5661.7 5662.9 5669.4 5670.2 5372.0 5690.0 5692.0 5717.7 5725.7 5541.8 5702.1 5714.9 5720.5 5737.8 5626.2 5707.7 5719.5 5723.4 5769.1 4959.2 5237.7 5584.2 5589.1 5590.0 13414.9 13641.8 13643.1 13647.9 19561.3 2116.0 2166.7 2206.0 2421.5 2578.4 9375.0 9629.6 9722.5 9865.6 13705.2 1742.0 1766.8 1865.3 1880.5 1894.0 74701.6 82513.2 83910.6 84040.2 84364.0 10262.5 10421.6 10543.6 10735.9 11314.8 14836.3 14836.3 14843.6 14849.6 14885.4 7407.7 7672.0 7695.2 7766.8 7946.7 7517.7 7550.7 7559.7 7775.8 7827.4 4446.8 4482.5 4489.0 4572.2 4587.5 1841.8 1885.7 1894.8 1915.7 1929.6 954.6 976.7 999.5 1030.7 1056.4 18169.0 19191.7 19301.1 19301.5 19694.0 951.2 972.0 991.3 1010.9 1052.9 10157.6 10612.6 10762.7 10792.9 10793.9 400014.0 439602.0 444299.0 451066.0 452691.0 54988.7 73551.0 95338.0 97188.0 97188.5 1005.4 1023.3 1061.5 1066.1 1070.3 15472.0 16808.2 17283.7 17619.6 17667.4 38597.6 41891.4 41896.0 42412.0 43886.6 52645.0 54269.7 54596.5 55168.2 56400.4 8037.6 8141.9 8454.2 8473.8 8549.5 11778.8 12304.8 12554.7 12750.4 12944.9 10911.3 10916.0 11322.6 11670.4 11928.6 11001.3 11207.6 11311.8 11432.1 11528.8 11581.8 11644.2 11658.7 11689.3 12063.3 7406.3 7591.4 8304.4 8551.6 8617.8 10906.0 11374.9 11657.7 11724.6 11922.5 06:59:00 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | [#3] mootools.html Cycles:180 Average:5758.13 Median:5186.98 stddev:3321.36 (64.0%) stddev-sans-first:3313.94 06:59:00 INFO - PROCESS | 5796 | Values: 1321.8 1403.8 1477.9 1586.0 1786.4 7844.9 8600.7 8829.0 8963.6 9156.3 8940.5 8975.0 9046.5 9050.6 9054.6 2307.3 2348.2 2351.6 2360.9 2366.5 2269.1 2306.5 2312.1 2318.1 2344.3 2276.7 2304.8 2310.3 2313.3 2323.0 2247.6 2251.4 2257.9 2260.8 2281.7 2253.3 2260.7 2265.6 2266.5 2271.3 8586.5 8681.0 8686.4 9025.2 9071.5 5208.1 5396.7 5397.1 5407.4 5419.4 3355.5 3487.5 3549.5 3555.3 3566.4 1008.9 1047.7 1059.0 1107.1 1107.9 12636.9 12717.4 12719.7 12738.2 12742.4 4347.3 4453.5 4583.0 4597.4 4614.5 9878.8 9953.5 9962.3 9964.7 9969.7 5235.9 5238.3 5238.3 5246.7 5275.5 4166.0 4306.5 4769.2 4874.6 4907.9 3766.3 3828.2 3834.3 3847.5 3945.0 1152.0 1160.9 1165.3 1166.4 1167.5 898.4 939.6 950.3 960.2 991.9 5870.1 5983.6 6096.5 6129.8 6235.5 872.9 897.2 904.5 919.8 925.9 3809.1 3883.0 4162.9 4184.1 4202.8 11080.7 11132.0 11173.1 11318.7 11518.9 11318.9 11343.9 11345.8 11349.5 11352.9 7751.5 7987.7 8034.8 8056.0 8065.5 5627.2 5627.7 5745.2 5774.6 5806.4 9497.9 9531.9 9554.5 9558.4 9745.7 9668.6 9669.4 9859.2 10284.0 10295.4 7102.5 7319.7 7325.6 7664.0 7829.4 7877.3 7891.1 8322.3 8532.5 8613.2 7631.4 7664.7 7767.1 8044.8 8048.3 7401.2 7465.3 7489.1 7505.8 7569.9 6808.2 6914.6 6916.2 6918.5 6920.3 4836.7 4956.5 5040.1 5058.6 5137.8 4982.3 5043.2 5100.9 5165.8 5341.1 06:59:00 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | [#4] prototype.html Cycles:180 Average:4588.03 Median:5136.27 stddev:1353.22 (26.3%) stddev-sans-first:1318.55 06:59:00 INFO - PROCESS | 5796 | Values: 319.7 325.6 327.0 332.5 335.6 5094.0 5244.6 5264.8 5300.7 5308.0 5003.4 5123.8 5175.6 5227.3 5259.7 4131.6 4143.8 4145.5 4162.4 4166.7 4003.4 4118.8 4134.7 4138.7 4167.0 4046.5 4089.0 4092.6 4094.3 4121.8 4068.7 4091.8 4098.6 4114.9 4116.5 3645.2 3648.6 3649.0 3649.2 3658.8 5098.5 5109.3 5115.4 5148.7 5168.7 4677.6 4681.2 4699.8 4702.2 4705.0 5330.7 5471.6 5473.2 5473.5 5493.5 3907.1 3912.7 3926.9 3939.1 3955.6 5723.6 5754.7 5759.7 5765.3 5781.6 4061.2 4062.8 4071.2 4072.6 4075.8 3877.2 4051.3 4062.7 4076.8 4117.9 4642.6 4654.0 4656.0 4659.5 4669.3 5459.7 5472.8 5502.6 5513.0 5600.8 1277.8 1282.2 1369.4 1383.4 1385.7 871.3 884.2 905.9 908.5 912.5 4647.6 4676.4 4688.0 4690.7 4694.2 4933.3 4939.0 4941.9 4942.9 4948.3 4616.5 4638.0 4646.0 4646.3 4659.9 2773.8 2954.7 2986.6 2994.5 3001.8 5841.3 5855.3 5856.2 5875.6 5901.3 5561.8 5705.3 5741.8 5788.8 5823.0 5805.3 5805.5 5841.6 5843.3 5872.4 5640.3 5644.2 5654.4 5675.7 5692.0 5402.4 5550.9 5623.2 5638.2 5655.9 5816.7 5856.8 5867.4 5894.6 5964.7 4063.3 4141.3 4150.8 4154.1 4169.8 5338.4 5597.6 5598.2 5639.9 5664.3 5401.2 5402.6 5519.2 5520.3 5521.4 5507.5 5530.9 5539.6 5548.8 5590.4 5216.5 5440.7 5488.9 5489.7 5500.4 5521.0 5525.6 5541.2 5550.4 5559.9 5408.6 5431.9 5433.9 5464.0 5500.6 06:59:00 INFO - PROCESS | 5796 | 06:59:00 INFO - PROCESS | 5796 | [#5] yui.html Cycles:180 Average:20313.50 Median:4669.81 stddev:28934.81 (619.6%) stddev-sans-first:28978.65 06:59:00 INFO - PROCESS | 5796 | Values: 739.9 744.3 749.3 751.4 780.3 14456.1 15478.4 15635.4 15638.7 15653.6 13750.5 13920.0 13938.1 13942.9 13962.1 647.4 667.3 770.8 783.5 789.2 797.9 810.1 812.4 812.5 813.0 851.9 852.2 854.4 854.7 855.6 696.0 696.0 827.5 853.5 855.1 621.8 621.9 622.2 622.3 622.4 15176.8 15194.0 15297.8 15310.7 15323.4 13514.8 13605.9 13827.8 13828.2 14053.9 11018.6 11020.2 11164.7 11172.5 11283.8 4159.8 4190.8 4254.3 4275.9 4312.8 73020.0 73144.6 73408.0 74808.0 77678.6 10618.6 10623.6 10630.5 10855.5 10877.3 20896.4 20985.8 21033.6 21034.4 21056.2 8343.0 8414.3 8448.3 8611.0 8685.7 4522.8 4586.3 4623.8 4698.9 4703.9 3164.6 3261.4 3263.2 3265.6 3266.0 612.2 615.4 628.7 635.2 636.4 615.8 719.0 721.7 739.1 739.6 8861.1 9749.6 9776.7 10049.5 10054.1 583.7 628.4 671.2 675.4 759.6 4312.5 4640.8 4755.9 4807.0 4850.8 74819.3 108415.0 112521.4 114504.0 117386.0 91242.5 94423.5 97224.5 97776.0 97877.5 80861.6 85847.6 87056.0 90297.5 90953.5 9167.4 9284.4 9348.8 9517.0 9529.1 50112.0 50130.0 50508.2 50774.2 52000.7 68721.5 73789.0 75045.7 75408.6 77636.0 11696.5 12058.7 12259.9 12352.4 12457.3 12063.3 12271.6 12606.4 13188.4 13275.9 13073.8 14049.4 14321.4 15171.4 15199.5 14101.0 14824.6 15261.8 15593.6 15616.5 14011.8 14856.7 14861.2 14917.2 15433.6 11230.6 11271.8 11383.9 11846.9 11896.5 10932.3 11083.9 11107.2 11207.3 11258.8 06:59:00 INFO - PROCESS | 5796 | -------- Summary: end -------- 06:59:00 INFO - PROCESS | 5796 | 06:59:01 INFO - TEST-INFO | 5796: exit 0 06:59:01 INFO - TEST-OK | dromaeo_css | took 1118564ms 06:59:01 INFO - TEST-START | kraken 06:59:01 INFO - operating with platform_type : linux_ 06:59:01 INFO - Initialising browser for kraken test... 06:59:01 INFO - TEST-INFO | started process 6106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8CLMrl/profile http://localhost:60261/getInfo.html) 06:59:06 INFO - PROCESS | 6106 | __metrics Screen width/height:1600/1200 06:59:06 INFO - PROCESS | 6106 | colorDepth:24 06:59:06 INFO - PROCESS | 6106 | Browser inner width/height: 1024/697 06:59:06 INFO - PROCESS | 6106 | __metrics 06:59:06 INFO - PROCESS | 6106 | 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" 06:59:06 INFO - PROCESS | 6106 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:59:07 INFO - PROCESS | 6106 | console.error: 06:59:07 INFO - PROCESS | 6106 | Message: Error: Connection closed before committing the transaction. 06:59:07 INFO - PROCESS | 6106 | Stack: 06:59:07 INFO - PROCESS | 6106 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 06:59:07 INFO - PROCESS | 6106 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 06:59:07 INFO - PROCESS | 6106 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 06:59:07 INFO - PROCESS | 6106 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 06:59:07 INFO - PROCESS | 6106 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 06:59:07 INFO - PROCESS | 6106 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 06:59:07 INFO - PROCESS | 6106 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 06:59:07 INFO - PROCESS | 6106 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 06:59:07 INFO - PROCESS | 6106 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 06:59:07 INFO - PROCESS | 6106 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 06:59:07 INFO - PROCESS | 6106 | Barrier/this.client.addBlocker/promise13.1% 07:00:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:00:04 INFO - TinderboxPrint: I/O write bytes / time
397,094,912 / 395,284 07:00:04 INFO - TinderboxPrint: CPU idle
8,304.9 (86.9%) 07:00:04 INFO - TinderboxPrint: CPU user
1,199.0 (12.5%) 07:00:04 INFO - TinderboxPrint: Swap in / out
0 / 0 07:00:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109207552; Read time: 0; Write time: 145188 07:00:04 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287272960; Read time: 0; Write time: 250096 07:00:05 INFO - Running post-run listener: _upload_blobber_files 07:00:05 INFO - Blob upload gear active. 07:00:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:00:05 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 07:00:05 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'] 07:00:05 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 07:00:05 INFO - (blobuploader) - INFO - Open directory for files ... 07:00:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:00:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:00:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:07 INFO - (blobuploader) - INFO - Done attempting. 07:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:10 INFO - (blobuploader) - INFO - Done attempting. 07:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:11 INFO - (blobuploader) - INFO - Done attempting. 07:00:11 INFO - (blobuploader) - INFO - Iteration through files over. 07:00:11 INFO - Return code: 0 07:00:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:00:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:00:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/274c28e62eed8ce5337cbaf67007e97ccd4942eca4745d854492cf50dcc7ef38631ee63bb3598785b0af932ad18ce087b187ce90a896b7db35cfa94279e66b34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11cd140437963a018e8f2c750297b7b659093c8f4e7e9b4505a6fa8fcdde23513e49b9320308ea6a1bd2187f0d9b7723502353e63688ef653b6dff921d60a206", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/079b2caad8b6db3343c7c61fedcd2f2b51f2296d8a54d3a165759817063b8e9a121b1778328b30c9be76080ac79e0fb2f543e2511eb33f3e275fbf51f1137a33"} 07:00:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:00:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:00:11 INFO - Contents: 07:00:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/274c28e62eed8ce5337cbaf67007e97ccd4942eca4745d854492cf50dcc7ef38631ee63bb3598785b0af932ad18ce087b187ce90a896b7db35cfa94279e66b34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11cd140437963a018e8f2c750297b7b659093c8f4e7e9b4505a6fa8fcdde23513e49b9320308ea6a1bd2187f0d9b7723502353e63688ef653b6dff921d60a206", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/079b2caad8b6db3343c7c61fedcd2f2b51f2296d8a54d3a165759817063b8e9a121b1778328b30c9be76080ac79e0fb2f543e2511eb33f3e275fbf51f1137a33"} 07:00:11 INFO - Running post-run listener: copy_logs_to_upload_dir 07:00:11 INFO - Copying logs to upload dir... 07:00:11 INFO - mkdir: /builds/slave/test/build/upload/logs 07:00:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.746814 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-17 07:00:10.183845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 07:00:10.190742) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102 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/274c28e62eed8ce5337cbaf67007e97ccd4942eca4745d854492cf50dcc7ef38631ee63bb3598785b0af932ad18ce087b187ce90a896b7db35cfa94279e66b34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11cd140437963a018e8f2c750297b7b659093c8f4e7e9b4505a6fa8fcdde23513e49b9320308ea6a1bd2187f0d9b7723502353e63688ef653b6dff921d60a206", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/079b2caad8b6db3343c7c61fedcd2f2b51f2296d8a54d3a165759817063b8e9a121b1778328b30c9be76080ac79e0fb2f543e2511eb33f3e275fbf51f1137a33"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476700208/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/274c28e62eed8ce5337cbaf67007e97ccd4942eca4745d854492cf50dcc7ef38631ee63bb3598785b0af932ad18ce087b187ce90a896b7db35cfa94279e66b34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11cd140437963a018e8f2c750297b7b659093c8f4e7e9b4505a6fa8fcdde23513e49b9320308ea6a1bd2187f0d9b7723502353e63688ef653b6dff921d60a206", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/079b2caad8b6db3343c7c61fedcd2f2b51f2296d8a54d3a165759817063b8e9a121b1778328b30c9be76080ac79e0fb2f543e2511eb33f3e275fbf51f1137a33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 07:00:10.218573) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 07:00:10.218953) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1476711570.220197-1347385102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 07:00:10.301025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 07:00:10.303457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 07:00:10.303834) ========= ========= Total master_lag: 0.20 =========