builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1475824781.9 results: failure (2) buildid: 20161006213129 builduid: f8e7dd8f379e4ee1a590c14d5f248275 revision: 0e67f06bcfcc83f4317a968914232bb6c82965ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:41.902115) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:41.904113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:41.904461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:41.947854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:41.948180) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 00:19:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-10-07 00:19:42 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:42.112833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:42.113180) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016835 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:42.163813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 00:19:42.164193) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e67f06bcfcc83f4317a968914232bb6c82965ac --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 0e67f06bcfcc83f4317a968914232bb6c82965ac --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=20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 00:19:42,474 truncating revision to first 12 chars 2016-10-07 00:19:42,474 Setting DEBUG logging. 2016-10-07 00:19:42,474 attempt 1/10 2016-10-07 00:19:42,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e67f06bcfcc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 00:19:43,381 unpacking tar archive at: fx-team-0e67f06bcfcc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.239693 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 00:19:43.417917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:43.418358) ========= script_repo_revision: 0e67f06bcfcc83f4317a968914232bb6c82965ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:43.418825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:43.419181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 00:19:43.429030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' failed (results: 2, elapsed: 19 mins, 46 secs) (at 2016-10-07 00:19:43.429468) ========= /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=20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:19:43 INFO - MultiFileLogger online at 20161007 00:19:43 in /builds/slave/test 00:19:43 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 00:19:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:19:43 INFO - {'append_to_log': False, 00:19:43 INFO - 'base_work_dir': '/builds/slave/test', 00:19:43 INFO - 'blob_upload_branch': 'Fx-Team', 00:19:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:19:43 INFO - 'branch': 'Fx-Team', 00:19:43 INFO - 'buildbot_json_path': 'buildprops.json', 00:19:43 INFO - 'config_files': ('talos/linux_config.py',), 00:19:43 INFO - 'default_actions': ('clobber', 00:19:43 INFO - 'read-buildbot-config', 00:19:43 INFO - 'download-and-extract', 00:19:43 INFO - 'populate-webroot', 00:19:43 INFO - 'create-virtualenv', 00:19:43 INFO - 'install', 00:19:43 INFO - 'run-tests'), 00:19:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:19:43 INFO - 'download_minidump_stackwalk': True, 00:19:43 INFO - 'download_symbols': 'ondemand', 00:19:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:19:43 INFO - 'tooltool.py': '/tools/tooltool.py', 00:19:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:19:43 INFO - '/tools/misc-python/virtualenv.py')}, 00:19:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:19:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:19:43 INFO - 'installer_path': 'installer.exe', 00:19:43 INFO - 'log_level': 'info', 00:19:43 INFO - 'log_name': 'talos', 00:19:43 INFO - 'log_to_console': True, 00:19:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:19:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:19:43 INFO - 'opt_config_files': (), 00:19:43 INFO - 'pip_index': False, 00:19:43 INFO - 'sps_profile': False, 00:19:43 INFO - 'sps_profile_interval': 0, 00:19:43 INFO - 'suite': 'dromaeojs', 00:19:43 INFO - 'system_bits': '32', 00:19:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:19:43 INFO - 'title': 'talos-linux64-ix-015', 00:19:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:19:43 INFO - 'use_talos_json': True, 00:19:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:19:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:19:43 INFO - 'work_dir': 'build'} 00:19:43 INFO - [mozharness: 2016-10-07 07:19:43.837127Z] Running clobber step. 00:19:43 INFO - Running pre-action listener: _resource_record_pre_action 00:19:43 INFO - Running main action method: clobber 00:19:43 INFO - rmtree: /builds/slave/test/build 00:19:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:19:44 INFO - Running post-action listener: _resource_record_post_action 00:19:44 INFO - [mozharness: 2016-10-07 07:19:44.799436Z] Finished clobber step (success) 00:19:44 INFO - [mozharness: 2016-10-07 07:19:44.799537Z] Running read-buildbot-config step. 00:19:44 INFO - Running pre-action listener: _resource_record_pre_action 00:19:44 INFO - Running main action method: read_buildbot_config 00:19:44 INFO - Using buildbot properties: 00:19:44 INFO - { 00:19:44 INFO - "project": "", 00:19:44 INFO - "product": "firefox", 00:19:44 INFO - "script_repo_revision": "production", 00:19:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:19:44 INFO - "repository": "", 00:19:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:19:44 INFO - "buildid": "20161006213129", 00:19:44 INFO - "pgo_build": "True", 00:19:44 INFO - "basedir": "/builds/slave/test", 00:19:44 INFO - "buildnumber": 513, 00:19:44 INFO - "slavename": "talos-linux64-ix-015", 00:19:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:19:44 INFO - "platform": "ubuntu64_hw", 00:19:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:19:44 INFO - "branch": "fx-team", 00:19:44 INFO - "repo_path": "integration/fx-team", 00:19:44 INFO - "revision": "0e67f06bcfcc83f4317a968914232bb6c82965ac", 00:19:44 INFO - "stage_platform": "linux64-pgo", 00:19:44 INFO - "builduid": "f8e7dd8f379e4ee1a590c14d5f248275", 00:19:44 INFO - "slavebuilddir": "test" 00:19:44 INFO - } 00:19:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:19:44 INFO - Running post-action listener: _resource_record_post_action 00:19:44 INFO - [mozharness: 2016-10-07 07:19:44.801980Z] Finished read-buildbot-config step (success) 00:19:44 INFO - [mozharness: 2016-10-07 07:19:44.802069Z] Running download-and-extract step. 00:19:44 INFO - Running pre-action listener: _resource_record_pre_action 00:19:44 INFO - Running main action method: download_and_extract 00:19:44 INFO - mkdir: /builds/slave/test/build/tests 00:19:44 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')]} 00:19:44 INFO - trying https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:19:44 INFO - Downloading https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:19:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:19:45 INFO - Downloaded 1361 bytes. 00:19:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:19:45 INFO - Using the following test package requirements: 00:19:45 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:19:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:19:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:19:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:19:45 INFO - u'jsshell-linux-x86_64.zip'], 00:19:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:19:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:19:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:19:45 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:19:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:19:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:19:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:19:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:19:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:19:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:19:45 INFO - Fetch https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:19:45 INFO - Http code: 200 00:19:45 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 00:19:45 INFO - x-amz-cf-id: ezCIxbsoMn7zTxGJjBwiyUUIuwGZaLRIr97QGRl2JYgFeX8nnvTJYQ== 00:19:45 INFO - x-amz-version-id: XCIvUdb9N7TjoIRAauieSjBuVy5ryVxW 00:19:46 INFO - Expected file size: 22022334 00:19:46 INFO - Obtained file size: 22022334 00:19:50 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 00:19:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:19:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:19:50 INFO - Fetch https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:19:51 INFO - Http code: 200 00:19:51 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 00:19:51 INFO - x-amz-cf-id: P9WgPDXr7Pivqit94e3BEAubkV4gfTNjPeiJEZEdMNEojRvYrTdFjg== 00:19:51 INFO - x-amz-version-id: XCIvUdb9N7TjoIRAauieSjBuVy5ryVxW 00:19:51 INFO - Expected file size: 22022334 00:19:51 INFO - Obtained file size: 22022334 00:19:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:19:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:19:55 INFO - Fetch https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:19:56 INFO - Http code: 200 00:19:56 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 00:19:56 INFO - x-amz-cf-id: ch9sMWJZ37atp-dj3z-N9fr42cieaxVIoafyj0w_vYK65S66_Ur_OA== 00:19:56 INFO - x-amz-version-id: E2K56fGuqbOQLL_F9UX48SzJJhisbrQW 00:19:57 INFO - Expected file size: 14409006 00:19:57 INFO - Obtained file size: 14409006 00:19:57 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')]} 00:19:57 INFO - trying https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:19:57 INFO - Downloading https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:19:59 INFO - Downloaded 59727541 bytes. 00:19:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:19:59 INFO - mkdir: /builds/slave/test/properties 00:19:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:19:59 INFO - Writing to file /builds/slave/test/properties/build_url 00:19:59 INFO - Contents: 00:19:59 INFO - build_url:https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:20:00 INFO - Running post-action listener: _resource_record_post_action 00:20:00 INFO - Running post-action listener: set_extra_try_arguments 00:20:00 INFO - [mozharness: 2016-10-07 07:20:00.524264Z] Finished download-and-extract step (success) 00:20:00 INFO - [mozharness: 2016-10-07 07:20:00.524492Z] Running populate-webroot step. 00:20:00 INFO - Running pre-action listener: _resource_record_pre_action 00:20:00 INFO - Running main action method: populate_webroot 00:20:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:20:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:20:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:20:00 INFO - '--tppagecycles', 00:20:00 INFO - '7'], 00:20:00 INFO - 'tests': ['tsvgm']}}, 00:20:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:20:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:20:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:20:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:20:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:00 INFO - 'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:20:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:20:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:00 INFO - 'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['damp', 'tps']}, 00:20:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:00 INFO - 'tests': ['damp', 'tps']}, 00:20:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['dromaeo_dom']}, 00:20:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:20:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['basic_compositor_video']}, 00:20:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:20:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['a11yr', 00:20:00 INFO - 'ts_paint', 00:20:00 INFO - 'tpaint', 00:20:00 INFO - 'sessionrestore', 00:20:00 INFO - 'sessionrestore_no_auto_restore', 00:20:00 INFO - 'tabpaint']}, 00:20:00 INFO - 'other-e10s': {'tests': ['a11yr', 00:20:00 INFO - 'ts_paint', 00:20:00 INFO - 'tpaint', 00:20:00 INFO - 'sessionrestore', 00:20:00 INFO - 'sessionrestore_no_auto_restore', 00:20:00 INFO - 'tabpaint']}, 00:20:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:20:00 INFO - 'ts_paint', 00:20:00 INFO - 'tpaint', 00:20:00 INFO - 'sessionrestore', 00:20:00 INFO - 'sessionrestore_no_auto_restore', 00:20:00 INFO - 'tabpaint']}, 00:20:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:20:00 INFO - 'ts_paint', 00:20:00 INFO - 'tpaint', 00:20:00 INFO - 'sessionrestore', 00:20:00 INFO - 'sessionrestore_no_auto_restore', 00:20:00 INFO - 'tabpaint']}, 00:20:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['a11yr', 00:20:00 INFO - 'ts_paint', 00:20:00 INFO - 'tpaint', 00:20:00 INFO - 'sessionrestore', 00:20:00 INFO - 'sessionrestore_no_auto_restore', 00:20:00 INFO - 'tabpaint']}, 00:20:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['a11yr', 00:20:00 INFO - 'ts_paint', 00:20:00 INFO - 'tpaint', 00:20:00 INFO - 'sessionrestore', 00:20:00 INFO - 'sessionrestore_no_auto_restore', 00:20:00 INFO - 'tabpaint']}, 00:20:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['tsvgx', 00:20:00 INFO - 'tsvgr_opacity', 00:20:00 INFO - 'tart', 00:20:00 INFO - 'tscrollx', 00:20:00 INFO - 'cart']}, 00:20:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:20:00 INFO - 'tsvgr_opacity', 00:20:00 INFO - 'tart', 00:20:00 INFO - 'tscrollx', 00:20:00 INFO - 'cart']}, 00:20:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:00 INFO - 'talos_options': ['--disable-e10s'], 00:20:00 INFO - 'tests': ['tp5o']}, 00:20:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:00 INFO - 'tests': ['tp5o']}, 00:20:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:00 INFO - 'talos_options': ['--disable-e10s', 00:20:00 INFO - '--xperf_path', 00:20:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:20:00 INFO - 'tests': ['tp5n']}, 00:20:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:20:00 INFO - 'talos_options': ['--xperf_path', 00:20:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:20:00 INFO - 'tests': ['tp5n']}}, 00:20:00 INFO - 'talos.zip': {'path': '', 00:20:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:20:00 INFO - Running post-action listener: _resource_record_post_action 00:20:00 INFO - [mozharness: 2016-10-07 07:20:00.545835Z] Finished populate-webroot step (success) 00:20:00 INFO - [mozharness: 2016-10-07 07:20:00.545924Z] Running create-virtualenv step. 00:20:00 INFO - Running pre-action listener: _resource_record_pre_action 00:20:00 INFO - Running main action method: create_virtualenv 00:20:00 INFO - Creating virtualenv /builds/slave/test/build/venv 00:20:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:20:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:20:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:20:00 INFO - Using real prefix '/usr' 00:20:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:20:01 INFO - Installing distribute.............................................................................................................................................................................................done. 00:20:03 INFO - Installing pip.................done. 00:20:03 INFO - Return code: 0 00:20:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:20:03 INFO - Reading from file tmpfile_stdout 00:20:03 INFO - Output received: 00:20:03 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) 00:20:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:03 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:20:03 INFO - Using env: {'DISPLAY': ':0', 00:20:03 INFO - 'HOME': '/home/cltbld', 00:20:03 INFO - 'LANG': 'en_US.UTF-8', 00:20:03 INFO - 'LANGUAGE': 'en_US:en', 00:20:03 INFO - 'LOGNAME': 'cltbld', 00:20:03 INFO - 'MAIL': '/var/mail/cltbld', 00:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:03 INFO - 'MOZ_NO_REMOTE': '1', 00:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:03 INFO - 'NO_EM_RESTART': '1', 00:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:03 INFO - 'PWD': '/builds/slave/test', 00:20:03 INFO - 'SHELL': '/bin/bash', 00:20:03 INFO - 'SHLVL': '1', 00:20:03 INFO - 'TERM': 'linux', 00:20:03 INFO - 'TMOUT': '86400', 00:20:03 INFO - 'USER': 'cltbld', 00:20:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:03 INFO - '_': '/tools/buildbot/bin/python'} 00:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:20:03 INFO - Cleaning up... 00:20:03 INFO - Return code: 0 00:20:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:03 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:20:03 INFO - Using env: {'DISPLAY': ':0', 00:20:03 INFO - 'HOME': '/home/cltbld', 00:20:03 INFO - 'LANG': 'en_US.UTF-8', 00:20:03 INFO - 'LANGUAGE': 'en_US:en', 00:20:03 INFO - 'LOGNAME': 'cltbld', 00:20:03 INFO - 'MAIL': '/var/mail/cltbld', 00:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:03 INFO - 'MOZ_NO_REMOTE': '1', 00:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:03 INFO - 'NO_EM_RESTART': '1', 00:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:03 INFO - 'PWD': '/builds/slave/test', 00:20:03 INFO - 'SHELL': '/bin/bash', 00:20:03 INFO - 'SHLVL': '1', 00:20:03 INFO - 'TERM': 'linux', 00:20:03 INFO - 'TMOUT': '86400', 00:20:03 INFO - 'USER': 'cltbld', 00:20:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:03 INFO - '_': '/tools/buildbot/bin/python'} 00:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:03 INFO - Downloading/unpacking psutil>=3.1.1 00:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:20:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:20:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:20:05 INFO - Installing collected packages: psutil 00:20:05 INFO - Running setup.py install for psutil 00:20:05 INFO - building 'psutil._psutil_linux' extension 00:20:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:20:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:20:06 INFO - building 'psutil._psutil_posix' extension 00:20:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:20:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:20:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:20:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:20:06 INFO - Successfully installed psutil 00:20:06 INFO - Cleaning up... 00:20:06 INFO - Return code: 0 00:20:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:06 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:20:06 INFO - Using env: {'DISPLAY': ':0', 00:20:06 INFO - 'HOME': '/home/cltbld', 00:20:06 INFO - 'LANG': 'en_US.UTF-8', 00:20:06 INFO - 'LANGUAGE': 'en_US:en', 00:20:06 INFO - 'LOGNAME': 'cltbld', 00:20:06 INFO - 'MAIL': '/var/mail/cltbld', 00:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:06 INFO - 'MOZ_NO_REMOTE': '1', 00:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:06 INFO - 'NO_EM_RESTART': '1', 00:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:06 INFO - 'PWD': '/builds/slave/test', 00:20:06 INFO - 'SHELL': '/bin/bash', 00:20:06 INFO - 'SHLVL': '1', 00:20:06 INFO - 'TERM': 'linux', 00:20:06 INFO - 'TMOUT': '86400', 00:20:06 INFO - 'USER': 'cltbld', 00:20:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:06 INFO - '_': '/tools/buildbot/bin/python'} 00:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:20:08 INFO - Installing collected packages: mozsystemmonitor 00:20:08 INFO - Running setup.py install for mozsystemmonitor 00:20:08 INFO - Successfully installed mozsystemmonitor 00:20:08 INFO - Cleaning up... 00:20:08 INFO - Return code: 0 00:20:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:08 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:20:08 INFO - Using env: {'DISPLAY': ':0', 00:20:08 INFO - 'HOME': '/home/cltbld', 00:20:08 INFO - 'LANG': 'en_US.UTF-8', 00:20:08 INFO - 'LANGUAGE': 'en_US:en', 00:20:08 INFO - 'LOGNAME': 'cltbld', 00:20:08 INFO - 'MAIL': '/var/mail/cltbld', 00:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:08 INFO - 'MOZ_NO_REMOTE': '1', 00:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:08 INFO - 'NO_EM_RESTART': '1', 00:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:08 INFO - 'PWD': '/builds/slave/test', 00:20:08 INFO - 'SHELL': '/bin/bash', 00:20:08 INFO - 'SHLVL': '1', 00:20:08 INFO - 'TERM': 'linux', 00:20:08 INFO - 'TMOUT': '86400', 00:20:08 INFO - 'USER': 'cltbld', 00:20:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:08 INFO - '_': '/tools/buildbot/bin/python'} 00:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:08 INFO - Downloading/unpacking jsonschema==2.5.1 00:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:20:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:10 INFO - Downloading functools32-3.2.3-2.tar.gz 00:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:20:10 INFO - warning: no files found matching '*.txt' 00:20:10 INFO - no previously-included directories found matching 'build' 00:20:10 INFO - no previously-included directories found matching 'dist' 00:20:10 INFO - no previously-included directories found matching '.git*' 00:20:10 INFO - Installing collected packages: jsonschema, functools32 00:20:11 INFO - Running setup.py install for functools32 00:20:11 INFO - warning: no files found matching '*.txt' 00:20:11 INFO - no previously-included directories found matching 'build' 00:20:11 INFO - no previously-included directories found matching 'dist' 00:20:11 INFO - no previously-included directories found matching '.git*' 00:20:11 INFO - Successfully installed jsonschema functools32 00:20:11 INFO - Cleaning up... 00:20:11 INFO - Return code: 0 00:20:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:20:11 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')]} 00:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:11 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')]} 00:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:11 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:20:11 INFO - Using env: {'DISPLAY': ':0', 00:20:11 INFO - 'HOME': '/home/cltbld', 00:20:11 INFO - 'LANG': 'en_US.UTF-8', 00:20:11 INFO - 'LANGUAGE': 'en_US:en', 00:20:11 INFO - 'LOGNAME': 'cltbld', 00:20:11 INFO - 'MAIL': '/var/mail/cltbld', 00:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:11 INFO - 'MOZ_NO_REMOTE': '1', 00:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:11 INFO - 'NO_EM_RESTART': '1', 00:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:11 INFO - 'PWD': '/builds/slave/test', 00:20:11 INFO - 'SHELL': '/bin/bash', 00:20:11 INFO - 'SHLVL': '1', 00:20:11 INFO - 'TERM': 'linux', 00:20:11 INFO - 'TMOUT': '86400', 00:20:11 INFO - 'USER': 'cltbld', 00:20:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:11 INFO - '_': '/tools/buildbot/bin/python'} 00:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:20:11 INFO - Cleaning up... 00:20:11 INFO - Return code: 0 00:20:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:20:11 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')]} 00:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:11 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')]} 00:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:11 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:20:11 INFO - Using env: {'DISPLAY': ':0', 00:20:11 INFO - 'HOME': '/home/cltbld', 00:20:11 INFO - 'LANG': 'en_US.UTF-8', 00:20:11 INFO - 'LANGUAGE': 'en_US:en', 00:20:11 INFO - 'LOGNAME': 'cltbld', 00:20:11 INFO - 'MAIL': '/var/mail/cltbld', 00:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:11 INFO - 'MOZ_NO_REMOTE': '1', 00:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:11 INFO - 'NO_EM_RESTART': '1', 00:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:11 INFO - 'PWD': '/builds/slave/test', 00:20:11 INFO - 'SHELL': '/bin/bash', 00:20:11 INFO - 'SHLVL': '1', 00:20:11 INFO - 'TERM': 'linux', 00:20:11 INFO - 'TMOUT': '86400', 00:20:11 INFO - 'USER': 'cltbld', 00:20:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:11 INFO - '_': '/tools/buildbot/bin/python'} 00:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:11 INFO - Downloading/unpacking blobuploader==1.2.4 00:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:13 INFO - Downloading blobuploader-1.2.4.tar.gz 00:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:20:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:20:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:14 INFO - Downloading docopt-0.6.1.tar.gz 00:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:20:14 INFO - Installing collected packages: blobuploader, requests, docopt 00:20:14 INFO - Running setup.py install for blobuploader 00:20:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:20:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:20:14 INFO - Running setup.py install for requests 00:20:14 INFO - Running setup.py install for docopt 00:20:14 INFO - Successfully installed blobuploader requests docopt 00:20:14 INFO - Cleaning up... 00:20:14 INFO - Return code: 0 00:20:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:14 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:20:14 INFO - Using env: {'DISPLAY': ':0', 00:20:14 INFO - 'HOME': '/home/cltbld', 00:20:14 INFO - 'LANG': 'en_US.UTF-8', 00:20:14 INFO - 'LANGUAGE': 'en_US:en', 00:20:14 INFO - 'LOGNAME': 'cltbld', 00:20:14 INFO - 'MAIL': '/var/mail/cltbld', 00:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:14 INFO - 'MOZ_NO_REMOTE': '1', 00:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:14 INFO - 'NO_EM_RESTART': '1', 00:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:14 INFO - 'PWD': '/builds/slave/test', 00:20:14 INFO - 'SHELL': '/bin/bash', 00:20:14 INFO - 'SHLVL': '1', 00:20:14 INFO - 'TERM': 'linux', 00:20:14 INFO - 'TMOUT': '86400', 00:20:14 INFO - 'USER': 'cltbld', 00:20:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:14 INFO - '_': '/tools/buildbot/bin/python'} 00:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:20:15 INFO - Running setup.py (path:/tmp/pip-FRErIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:20:15 INFO - Running setup.py (path:/tmp/pip-e5nFCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:20:15 INFO - Running setup.py (path:/tmp/pip-DRoKEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:20:15 INFO - Running setup.py (path:/tmp/pip-eib5Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:20:15 INFO - Running setup.py (path:/tmp/pip-9vsKkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:20:15 INFO - Running setup.py (path:/tmp/pip-LzBAFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:20:15 INFO - Running setup.py (path:/tmp/pip-L88Qsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:20:15 INFO - Running setup.py (path:/tmp/pip-rEHWYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:20:15 INFO - Running setup.py (path:/tmp/pip-He4oUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:20:15 INFO - Running setup.py (path:/tmp/pip-SKD4UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:20:15 INFO - Running setup.py (path:/tmp/pip-KorLmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:20:15 INFO - Running setup.py (path:/tmp/pip-0Xy2j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:20:16 INFO - Running setup.py (path:/tmp/pip-1g9Mp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:20:16 INFO - Running setup.py (path:/tmp/pip-LiAdEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:16 INFO - Running setup.py (path:/tmp/pip-VNGym4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:20:16 INFO - Running setup.py (path:/tmp/pip-rPFDO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:20:16 INFO - Running setup.py (path:/tmp/pip-TF_qlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:20:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:20:16 INFO - Running setup.py install for manifestparser 00:20:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:20:16 INFO - Running setup.py install for mozcrash 00:20:16 INFO - Running setup.py install for mozdebug 00:20:16 INFO - Running setup.py install for mozdevice 00:20:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:20:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:20:16 INFO - Running setup.py install for mozfile 00:20:16 INFO - Running setup.py install for mozhttpd 00:20:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Running setup.py install for mozinfo 00:20:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Running setup.py install for mozInstall 00:20:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Running setup.py install for mozleak 00:20:17 INFO - Running setup.py install for mozlog 00:20:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Running setup.py install for moznetwork 00:20:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Running setup.py install for mozprocess 00:20:17 INFO - Running setup.py install for mozprofile 00:20:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Running setup.py install for mozrunner 00:20:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:20:17 INFO - Running setup.py install for mozscreenshot 00:20:17 INFO - Running setup.py install for moztest 00:20:18 INFO - Running setup.py install for mozversion 00:20:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:20:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:20:18 INFO - Cleaning up... 00:20:18 INFO - Return code: 0 00:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20:18 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')]} 00:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:18 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')]} 00:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:18 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:20:18 INFO - Using env: {'DISPLAY': ':0', 00:20:18 INFO - 'HOME': '/home/cltbld', 00:20:18 INFO - 'LANG': 'en_US.UTF-8', 00:20:18 INFO - 'LANGUAGE': 'en_US:en', 00:20:18 INFO - 'LOGNAME': 'cltbld', 00:20:18 INFO - 'MAIL': '/var/mail/cltbld', 00:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:18 INFO - 'MOZ_NO_REMOTE': '1', 00:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:18 INFO - 'NO_EM_RESTART': '1', 00:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:18 INFO - 'PWD': '/builds/slave/test', 00:20:18 INFO - 'SHELL': '/bin/bash', 00:20:18 INFO - 'SHLVL': '1', 00:20:18 INFO - 'TERM': 'linux', 00:20:18 INFO - 'TMOUT': '86400', 00:20:18 INFO - 'USER': 'cltbld', 00:20:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:18 INFO - '_': '/tools/buildbot/bin/python'} 00:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:20:18 INFO - Running setup.py (path:/tmp/pip-XWt05e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:20:18 INFO - Running setup.py (path:/tmp/pip-9Mm2Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:20:18 INFO - Running setup.py (path:/tmp/pip-IQNikA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:20:18 INFO - Running setup.py (path:/tmp/pip-4c5Lhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:20:18 INFO - Running setup.py (path:/tmp/pip-zh4OM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:20:18 INFO - Running setup.py (path:/tmp/pip-210e1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:20:18 INFO - Running setup.py (path:/tmp/pip-r2YpTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:20:18 INFO - Running setup.py (path:/tmp/pip-GYElTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:20:19 INFO - Running setup.py (path:/tmp/pip-P7g65P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:20:19 INFO - Running setup.py (path:/tmp/pip-DIEWY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:20:19 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)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:20:19 INFO - Running setup.py (path:/tmp/pip-zicLrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:20:19 INFO - Running setup.py (path:/tmp/pip-6GHc8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:20:19 INFO - Running setup.py (path:/tmp/pip-o0DJ71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:20:19 INFO - Running setup.py (path:/tmp/pip-MHBi5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:19 INFO - Running setup.py (path:/tmp/pip-NNDmyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:20:19 INFO - Running setup.py (path:/tmp/pip-M5bxA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:20:19 INFO - Running setup.py (path:/tmp/pip-vJoeOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:20:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:21 INFO - Downloading blessings-1.6.tar.gz 00:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:20:21 INFO - Installing collected packages: blessings 00:20:21 INFO - Running setup.py install for blessings 00:20:21 INFO - Successfully installed blessings 00:20:21 INFO - Cleaning up... 00:20:21 INFO - Return code: 0 00:20:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:20:22 INFO - Reading from file tmpfile_stdout 00:20:22 INFO - Current package versions: 00:20:22 INFO - argparse == 1.2.1 00:20:22 INFO - blessings == 1.6 00:20:22 INFO - blobuploader == 1.2.4 00:20:22 INFO - docopt == 0.6.1 00:20:22 INFO - functools32 == 3.2.3-2 00:20:22 INFO - jsonschema == 2.5.1 00:20:22 INFO - manifestparser == 1.1 00:20:22 INFO - mozInstall == 1.12 00:20:22 INFO - mozcrash == 0.17 00:20:22 INFO - mozdebug == 0.1 00:20:22 INFO - mozdevice == 0.48 00:20:22 INFO - mozfile == 1.2 00:20:22 INFO - mozhttpd == 0.7 00:20:22 INFO - mozinfo == 0.9 00:20:22 INFO - mozleak == 0.1 00:20:22 INFO - mozlog == 3.4 00:20:22 INFO - moznetwork == 0.27 00:20:22 INFO - mozprocess == 0.23 00:20:22 INFO - mozprofile == 0.28 00:20:22 INFO - mozrunner == 6.12 00:20:22 INFO - mozscreenshot == 0.1 00:20:22 INFO - mozsystemmonitor == 0.3 00:20:22 INFO - moztest == 0.7 00:20:22 INFO - mozversion == 1.4 00:20:22 INFO - psutil == 3.1.1 00:20:22 INFO - requests == 1.2.3 00:20:22 INFO - wsgiref == 0.1.2 00:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:22 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 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:20:22 INFO - Using env: {'DISPLAY': ':0', 00:20:22 INFO - 'HOME': '/home/cltbld', 00:20:22 INFO - 'LANG': 'en_US.UTF-8', 00:20:22 INFO - 'LANGUAGE': 'en_US:en', 00:20:22 INFO - 'LOGNAME': 'cltbld', 00:20:22 INFO - 'MAIL': '/var/mail/cltbld', 00:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:22 INFO - 'MOZ_NO_REMOTE': '1', 00:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:22 INFO - 'NO_EM_RESTART': '1', 00:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:22 INFO - 'PWD': '/builds/slave/test', 00:20:22 INFO - 'SHELL': '/bin/bash', 00:20:22 INFO - 'SHLVL': '1', 00:20:22 INFO - 'TERM': 'linux', 00:20:22 INFO - 'TMOUT': '86400', 00:20:22 INFO - 'USER': 'cltbld', 00:20:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:22 INFO - '_': '/tools/buildbot/bin/python'} 00:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:20:22 INFO - Cleaning up... 00:20:22 INFO - Return code: 0 00:20:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7f3b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, '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': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:20:22 INFO - Using env: {'DISPLAY': ':0', 00:20:22 INFO - 'HOME': '/home/cltbld', 00:20:22 INFO - 'LANG': 'en_US.UTF-8', 00:20:22 INFO - 'LANGUAGE': 'en_US:en', 00:20:22 INFO - 'LOGNAME': 'cltbld', 00:20:22 INFO - 'MAIL': '/var/mail/cltbld', 00:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:22 INFO - 'MOZ_NO_REMOTE': '1', 00:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:22 INFO - 'NO_EM_RESTART': '1', 00:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:22 INFO - 'PWD': '/builds/slave/test', 00:20:22 INFO - 'SHELL': '/bin/bash', 00:20:22 INFO - 'SHLVL': '1', 00:20:22 INFO - 'TERM': 'linux', 00:20:22 INFO - 'TMOUT': '86400', 00:20:22 INFO - 'USER': 'cltbld', 00:20:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:22 INFO - '_': '/tools/buildbot/bin/python'} 00:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:20:22 INFO - Cleaning up... 00:20:22 INFO - Return code: 0 00:20:22 INFO - Running post-action listener: _resource_record_post_action 00:20:22 INFO - Running post-action listener: _start_resource_monitoring 00:20:22 INFO - Starting resource monitoring. 00:20:22 INFO - [mozharness: 2016-10-07 07:20:22.553836Z] Finished create-virtualenv step (success) 00:20:22 INFO - [mozharness: 2016-10-07 07:20:22.554294Z] Running install step. 00:20:22 INFO - Running pre-action listener: _resource_record_pre_action 00:20:22 INFO - Running main action method: install 00:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:20:22 INFO - Reading from file tmpfile_stdout 00:20:22 INFO - Detecting whether we're running mozinstall >=1.0... 00:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:20:22 INFO - Reading from file tmpfile_stdout 00:20:22 INFO - Output received: 00:20:22 INFO - Usage: mozinstall [options] installer 00:20:22 INFO - Options: 00:20:22 INFO - -h, --help show this help message and exit 00:20:22 INFO - -d DEST, --destination=DEST 00:20:22 INFO - Directory to install application into. [default: 00:20:22 INFO - "/builds/slave/test"] 00:20:22 INFO - --app=APP Application being installed. [default: firefox] 00:20:22 INFO - mkdir: /builds/slave/test/build/application 00:20:22 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'] 00:20:22 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 00:20:39 INFO - Reading from file tmpfile_stdout 00:20:39 INFO - Output received: 00:20:39 INFO - /builds/slave/test/build/application/firefox/firefox 00:20:39 INFO - Running post-action listener: _resource_record_post_action 00:20:39 INFO - [mozharness: 2016-10-07 07:20:39.873586Z] Finished install step (success) 00:20:39 INFO - [mozharness: 2016-10-07 07:20:39.873832Z] Running run-tests step. 00:20:39 INFO - Running pre-action listener: _resource_record_pre_action 00:20:39 INFO - Running main action method: run_tests 00:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:20:39 INFO - Python 2.7.3 00:20:39 INFO - Return code: 0 00:20:39 INFO - grabbing minidump binary from tooltool 00:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:39 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 0x1742790>, '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 0x1743690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1743b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:20:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:20:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:20:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:20:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:20:39 INFO - Return code: 0 00:20:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:20:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:20:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:20:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:20:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:20:39 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://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:20:39 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://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:20:39 INFO - Using env: {'DISPLAY': ':0', 00:20:39 INFO - 'HOME': '/home/cltbld', 00:20:39 INFO - 'LANG': 'en_US.UTF-8', 00:20:39 INFO - 'LANGUAGE': 'en_US:en', 00:20:39 INFO - 'LOGNAME': 'cltbld', 00:20:39 INFO - 'MAIL': '/var/mail/cltbld', 00:20:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:20:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:39 INFO - 'MOZ_NO_REMOTE': '1', 00:20:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:20:39 INFO - 'NO_EM_RESTART': '1', 00:20:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:39 INFO - 'PWD': '/builds/slave/test', 00:20:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:20:39 INFO - 'SHELL': '/bin/bash', 00:20:39 INFO - 'SHLVL': '1', 00:20:39 INFO - 'TERM': 'linux', 00:20:39 INFO - 'TMOUT': '86400', 00:20:39 INFO - 'USER': 'cltbld', 00:20:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587', 00:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:39 INFO - '_': '/tools/buildbot/bin/python'} 00:20:39 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://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:20:40 INFO - mozversion application_buildid: 20161006213129 00:20:40 INFO - mozversion application_changeset: 0e67f06bcfcc83f4317a968914232bb6c82965ac 00:20:40 INFO - mozversion application_display_name: Nightly 00:20:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:20:40 INFO - mozversion application_name: Firefox 00:20:40 INFO - mozversion application_remotingname: firefox 00:20:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:20:40 INFO - mozversion application_vendor: Mozilla 00:20:40 INFO - mozversion application_version: 52.0a1 00:20:40 INFO - mozversion platform_buildid: 20161006213129 00:20:40 INFO - mozversion platform_changeset: 0e67f06bcfcc83f4317a968914232bb6c82965ac 00:20:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:20:40 INFO - mozversion platform_version: 52.0a1 00:20:40 INFO - using testdate: 1475824840 00:20:40 INFO - actual date: 1475824840 00:20:40 INFO - starting webserver on 'localhost:47229' 00:20:40 INFO - SUITE-START | Running 2 tests 00:20:40 INFO - TEST-START | dromaeo_css 00:20:40 INFO - operating with platform_type : linux_ 00:20:40 INFO - Initialising browser for dromaeo_css test... 00:20:40 INFO - TEST-INFO | started process 3722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoyl_ES/profile http://localhost:47229/getInfo.html) 00:20:44 INFO - PROCESS | 3722 | __metrics Screen width/height:1600/1200 00:20:44 INFO - PROCESS | 3722 | colorDepth:24 00:20:44 INFO - PROCESS | 3722 | Browser inner width/height: 1024/697 00:20:44 INFO - PROCESS | 3722 | __metrics 00:20:45 INFO - PROCESS | 3722 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:20:45 INFO - PROCESS | 3722 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:20:45 INFO - PROCESS | 3722 | console.error: PushService: 00:20:45 INFO - PROCESS | 3722 | stateChangeProcessEnqueue: Error transitioning state 00:20:45 INFO - PROCESS | 3722 | UnknownError 00:20:46 INFO - TEST-INFO | 3722: exit 0 00:20:46 INFO - Browser initialized. 00:20:46 INFO - Running cycle 1/1 for dromaeo_css test... 00:20:46 INFO - TEST-INFO | started process 3805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoyl_ES/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:20:58 INFO - PROCESS | 3805 | RSS: Main: 173314048 00:20:58 INFO - PROCESS | 3805 | 00:21:49 INFO - PROCESS | 3805 | 1475824909795 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:23:59 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:47229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47229/tests/dromaeo/cssquery-ext.html) 00:24:01 INFO - PROCESS | 3805 | RSS: Main: 429543424 00:24:01 INFO - PROCESS | 3805 | 00:27:04 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:47229/tests/dromaeo/cssquery-ext.html (next: http://localhost:47229/tests/dromaeo/cssquery-jquery.html) 00:27:05 INFO - PROCESS | 3805 | RSS: Main: 290717696 00:27:05 INFO - PROCESS | 3805 | 00:30:07 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:47229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47229/tests/dromaeo/cssquery-mootools.html) 00:30:07 INFO - PROCESS | 3805 | RSS: Main: 264359936 00:30:07 INFO - PROCESS | 3805 | 00:33:09 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:47229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47229/tests/dromaeo/cssquery-prototype.html) 00:33:10 INFO - PROCESS | 3805 | RSS: Main: 247005184 00:33:10 INFO - PROCESS | 3805 | 00:36:13 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:47229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47229/tests/dromaeo/cssquery-yui.html) 00:36:13 INFO - PROCESS | 3805 | RSS: Main: 222117888 00:36:13 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:47229/tests/dromaeo/cssquery-yui.html (next: http://localhost:47229/tests/dromaeo/cssquery-dojo.html) 00:39:16 INFO - PROCESS | 3805 | RSS: Main: 315101184 00:39:16 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | __start_tp_report 00:39:16 INFO - PROCESS | 3805 | _x_x_mozilla_page_load 00:39:16 INFO - PROCESS | 3805 | _x_x_mozilla_page_load_details 00:39:16 INFO - PROCESS | 3805 | |i|pagename|runs| 00:39:16 INFO - PROCESS | 3805 | |0;dojo.html;3002.594649722287;3019.6527399349065;3027.1221345809718;3054.282243672735;3076.0771768469453;5143.691378517292;5201.4278429372835;5210.635255532109;5250.9737451312785;5337.653052551591;5322.574194064466;5360.892782144355;5449.56403487721;5457.345118585766;5508.7521061552225;4606.2303810545545;4825.034993001414;4835.008823191238;4848.87877803056;4850.660453768238;4915.975420122894;4949.059678661061;4980.975095124538;4996;5038.59691224703;4677.4620918594455;4703.882402939919;4819.614430845559;4846.321514987904;4971.353724015873;4844.539768722001;4850.563449289546;4851.175300198975;4893.804247830082;4915.3855768029;4795.448523419782;4828.0585285869265;4830.8792280193275;4848.878778030577;4878.512148785128;5131.281620573122;5137.588992880561;5185.507376799198;5304.20436934459;5342.305500284938;5633.324001119892;5634.71826408682;5691.7438715257495;5699.857503562403;5707.315122185364;5659.434056594308;5670.914936275959;5676.602637815355;5696.544276457915;5722.227499287626;5055.115354812893;5105.183170692671;5332.656170644985;5336.439673834269;5343.519083282523;5566.053770858964;5613.775448982076;5618.2415373924;5622.85942851432;5623.409541998113;5567.8886422272135;5639.605227634026;5642.774289028475;5650;5722.113072473773;5730.598858079978;5731.140328950691;5736.311642602915;5736.340320863071;5795.710214489259;5645.23789288449;5700.059490184073;5703.201551782754;5705.429457054262;5710.229119068873;5409.43200963901;5450.945490545044;5451.400345961941;5541.030319694038;5709.600327977002;4267.061246525759;4296.033392486665;4297.892552686208;4300.075483771005;4322.524522302544;3899.941500877489;3902.746321489151;3905.6484916357094;3907.023244188953;3915.295246855593;5330.253764472899;5491.2312276281355;5495.835124946258;5505.256790333334;5514.944850551443;5755.740991655385;5774.942250577525;5784.479396854219;5787.536997040227;5792.9710351447975;5151.6136289778415;5193.974030129825;5194.532492075731;5269.051570717308;5302;4960.255961605716;4964.776585053682;4968.30443737877;5002.274670172805;5008.874778130576;5708.771649134072;5721.5136713379;5859.882802344015;5891.970540147272;5932.58471906971;5728.627639203439;5746.626469279484;5750.0512415450985;5778.624389414675;5812.21535092757;5936.554758393224;5940.910886336622;5942.762289508544;5945.19739835134;5947.613405128653;5366.463353664759;5441.401445841034;5443.319585051869;5644.88710225785;5646.378898321099;5590.748416321194;5593.161025846156;5598.35618903815;5601.243832082617;5603.355614104267;5424.810131645373;5493.313335833021;5493.7802487900035;5494.5054945055135;5496.450354964471;5442.537384322219;5481.068218402801;5485.259489968963;5488.5334746545395;5493.478119578634;5416.7020813855615;5424.267723857229;5426.755795989111;5428.565714742732;5428.56571474289;5494.752736126964;5503.614746967834;5506.614536982373;5509.614326997232;5586.329640443173;5507.0637991542335;5528.391876893458;5547.611667183259;5602.663840169603;5615.691136987505 00:39:16 INFO - PROCESS | 3805 | |1;ext.html;584.8800995795863;604.2718524178363;605.6487237402307;611.5321778839186;615.4276522833766;32142.839285803566;35222;41454.96362590933;43197.56802431975;43417.7829110854;43953.7802310988;44097.338539921846;44309.33535996963;44443;45321.32018019733;8839.248663863564;8995.370324077317;9001.639934402649;9002.459852408843;9003.14470125337;8791.604377803014;8858.33562482813;8881.95559022204;8883.866741998876;8887.244584210317;8678.088800675932;8680;8683.392162548624;8686.478811271343;8732.51971141587;8855.512946787923;8872.290216782641;8897.555122243863;8942.061083586195;8942.418742781698;8797.868031979526;8866.822663546693;8869.157430044135;8870.068642792543;8874.023857375683;42394.78802605967;42667.57332426698;42746.78626606878;42779.57220427787;42786.57213427888;3297.9835100824585;3314.4753413429853;3383.780054296463;3393.4400823864034;3860;29971.25071873199;30456.390872182656;30908.690913090806;30928;30974.225644358845;3941.763494190358;4025.7181997260204;4059.4925634295714;4060.9187816243807;4112.3420252759415;326776;330901;331209;331584;334141;48699.75650121726;49015.75492122517;49118.75440622846;49121;49284;58384.41615583875;58626.70686646625;58957.705211473665;58999.705001474715;59137;14357.856421435652;14534.781978270334;14539.20034398097;14543.3455494503;14553.78169327461;11732.12009099321;11804;11853.34806585646;11865.228760130563;11875.287482751062;14819.703605927822;15525.767113493306;15599.844001560066;15659.217039147998;15821.525354239391;5805;5912;5984.581079324493;6047.762327938691;6122.571420000557;931.669257413622;1027.773889744255;1057.1489950589848;1075.4353964168874;1084.783043391309;30629.792935200625;30917.536236956465;30951.84524077365;31151.844240779104;31389.52915706266;884.8539990901429;1084.728817795551;1102.9503672334765;1104.4256986367204;1123.3203911633507;15141.924290378478;17687.823121768874;18222.637236008122;18611.162497687637;18880.905595471933;486890;494912;496143;496245;497001;61122.694386528674;61519.38480615226;61610.69194654088;61620.07569886455;61669.07496387558;1171.9062475001979;1191.576990168495;1323.7683405404016;1384.121083112211;1436.1239643817264;28562;32931.34137317288;32945.76355911022;33020.19328357116;33682.49476257809;50423;50935.74532127464;51053.489465104874;51214.74392628013;51216.487835121174;394343;397665;398213;398317;398423;38662.613373865905;41642.375364368956;42878.56971442215;43079.56920430881;45463.545364545935;42747.7862610685;43325.35011974886;43462.782686086364;43562.34656480092;43720.56279437292;38317.42523862088;38536.42195367128;39767;42712;44897.775511123546;38927;40173.39739903962;40546.59453405428;40564.1887162261;41137.38293925534;40639.39040914329;40727.59272407238;41377.793111034254;41916;41963.37054944117;33414.665853341154;36744.30202982438;36969.26061478702;37187;37697.2460550793;27118;27392;27439.314017149733;27514.724852751217;27785.583216252176 00:39:16 INFO - PROCESS | 3805 | |2;jquery.html;369.06258104414786;386.87039841653063;397.07679644825777;397.6580141078673;425.08606496033525;13197.340132993348;15156.317965691544;16173.35306587738;19173.616527669474;19584.510387240327;18751.06244687767;19091.427257182273;19191.712124318146;19551.315703950328;19567.119479623452;5487.588430867681;5509.3664228613725;5767.5962682612235;5773.30720313563;5780.450857168562;5286.3392075990505;5676.063449530822;5693.829185124432;5699.544036477072;5700.087985922253;5503.807366742165;5650.180723795047;5656.490915817576;5660.830175094754;5661.065924122515;5733.5413166946755;5916.556258280624;5925.466707996301;5926.348101708809;5933.940660593382;5456.072467680504;5482.205080263339;5512.503874651301;5750.166225897222;5751.913721294184;13750.86249137506;13917.930410347984;14062.085964412281;14245.572632821031;14313.355898984571;2254.2786308381324;2292.495650956787;2333.57995560799;2380.0479808076734;2409.4337830609966;10129.898701013042;10634.20243481742;10638.521266543024;10682.252242342962;13662.795058074136;1810.994897831703;1827.7623908891892;1838.2555065198617;1880.1163453176985;1893.2616279650947;79561.20438795596;82966.58516707439;83040.16959830385;84038.57980710118;87901.56049219776;10013.549390277454;10157.394125085488;10294;10294.845577316346;10488.63289784869;13883.861161388459;13939.930300348433;13957.79063314051;13958.790618140736;13970.860291397159;7287.599182044933;7349.265073492608;7356.080489938758;7472.626368681545;7566.924330756732;7011.368976792113;7078.504504684725;7140.178879428932;7233.40678669049;7281.126264848146;4139.958600414017;4143.156295448557;4148.191102734938;4166.145940082276;4239.0885959518855;1744.127936031984;1749.0380290840242;1750.8774385792872;1762.7179651255738;1823.6626224148574;909.622506659742;910.3718434280325;965.006043774913;979.5543027922421;1013.4071568132578;18248.81751182498;18685;19423.223071077282;19539;19649.80350196508;903.5708038681573;931.2875650127658;944.9055094490496;992.6277645882794;1023.4677967457029;10307.639232626821;10657.84013239802;10807.297525660806;10813.459327033617;10874.130069594572;415419;431417;448983;453291;454173;88935;89505;91289.54355228182;92267;92289;956.206348730538;1000.0599436529784;1019.0573719309609;1022.0035465421304;1023.6417253961054;15509.922450387676;16454.341826326814;16650.3339866404;16957.745633815255;17160.828391715924;43941.78029109962;44683.10633787371;45111.87986162391;45212.77393613011;47193.056138876345;57072;57447;58143.70928145501;58740.33678911721;59606;8360;8373.916260837557;8463.280621147025;8519.531425771642;8676.219140277406;10450.320729152581;11971.461284242405;12267.325297108744;12267.938660306998;12634.178778379375;10238.180945524191;10350.378977261389;10638.52126654287;10741.624043158452;11244;10436.478176091014;10575.206859485723;10583.5237414315;10795.082417994558;10810.29733067348;9718.12536871685;9726.270529710158;9731.659391921248;9893.406395616286;10071.446070466194;8014.599270036591;8039.397045221514;8187.71343002992;8273.503589784632;8320.583970801557;10521;10653.467326633792;10849.511771970438;10860.185486088732;10951.726206844893 00:39:16 INFO - PROCESS | 3805 | |3;mootools.html;1168.1180708565032;1351.1015174908682;1362.2643772362924;1449.6883170118429;1704.8636109111264;7779;8590.44162129462;8931.866022009675;8949.015608283093;9176.816463670739;8951.373403861733;9012.279017678586;9016.459012459258;9025.323100767437;9032.14194651507;2360.527894421118;2379.428937055103;2380.7143142822883;2381.5117900830373;2386.343755467252;2287.9199228027023;2346;2359.2450415866842;2362.70466191726;2364.255259593231;2332.8367014309006;2339.555484457956;2355.5171189906114;2363.267387109993;2366.3019409274307;2267.954640907189;2291.7364503082194;2299.137823316248;2303.9308820735323;2306.6655334976504;2275.2377953385635;2293.334932869466;2299.7125359330084;2303.1017903017837;2308.4805918668335;8645.956770216171;8910.198082172636;8958.820823583492;8960.910390896073;9031.142041506046;5318.255444237771;5475.0418676731415;5481.342238931314;5490.588205884535;5499.697516636584;3343.782654127498;3369.073504786179;3394.372041172391;3436.1753179237053;3436.914077148066;1081.9404932728696;1083.409541799721;1098.8022156011914;1100.3068067117665;1103.150574057979;12417.44121514534;12425.130240883142;12448.31534265624;12483.251004939733;12528.498860045587;4348.195583817004;4514.187446259639;4644.605208557243;4646.395968524071;4682.578567928903;9665.806683866283;9675.612975481043;9678.080582344666;9679.08048735369;9685.273604479693;5329.866753331198;5335.893282134336;5340.145576707708;5344.064788661969;5345.839624811262;4352.064306174188;4476.41806565151;4807.423109226916;4918.360613120271;4990.575801056878;3673.44898265257;3754.0802503386844;3775.0562359410146;3833.1758671885677;3945.2898478274187;1176.923499972499;1178.4461303187488;1200.3038237822043;1203.1818363512896;1213.2235369363614;893.5308962794585;941.1247539787926;958.3052287091803;963.7638778499313;968.8498282766183;5696.202531645573;5743.310802703702;5894.2926848778425;5909.674967876722;6126.387361263838;428.9661914785415;432.55662945480503;432.8268692523016;435.6623616697085;436.13862621322636;3826.5025546678753;3920.5883382245024;3962.5244970603712;3972.3445631471063;4107.240160570244;10856.457177141112;11140.888591113986;11224.438778061227;11226.550937962553;11232.213745037769;11149.331040137618;11149.442527873574;11158.665240042812;11163.218574699693;11164.385958772184;8154.103048664642;8189.262966333059;8232.50604963692;8237.382196335298;8279.875801862976;5505.532029777353;5536.446355364431;5586.441355864381;5612.943870561242;5858.2677165354335;9655.275854310814;10112.949435252776;10190.28667993263;10199.7450063749;10262.58949642006;10282.640107596199;10339.689809305733;10399.740006499898;10428.843567346345;10553;6918.446524277945;6989.545679530815;7527.247275272429;7537.585432801248;7648.541087534766;8436.409451338348;8445.408821382443;8479.95760021196;8481.57592120404;8489.490630562186;7512.849743005218;7582.54504729718;7695.268949449794;7767.495112817649;7795.493292935941;7292.088488938883;7415.295546923034;7512.887306690294;7609.695612175451;7649.617519124133;6833.794986150423;6948.5483443576;6959.547629404073;6961.338672826073;6969;4903.656744028027;5076.949230507647;5090.694558326512;5116.2069879168785;5209.244659524272;4874.926876096791;4954;5051.722155281494;5102.311187989574;5107.923381149211 00:39:16 INFO - PROCESS | 3805 | |4;prototype.html;315.2449882531337;320.1883226022034;326.6749584163756;329.9736021118311;333.5863529223763;5089.312942752727;5233.86915327117;5235.240890070937;5276.973615131919;5289.8942021159555;5049.9747501262445;5140.228965655154;5144.56271216947;5145.485451454852;5204.557612602934;4118.917621647565;4130.132672138854;4132.690048246379;4132.876013719593;4143.958560414395;3870;4045.898852528681;4127.050778320988;4128.442660240874;4153.02403935075;4016.899577510571;4023.356262997921;4031.5766844481345;4054.513458384998;4055.2903241932545;3993.321135406973;4015.859444919414;4017.517897852247;4057;4064.227796718614;3569.839357228931;3573.982130089359;3580.946285805715;3581.1047238190454;3596;4907.2393778964315;5094;5125;5135.152699804565;5146.9485305146845;4629.097326021427;4642.489326174118;4684.414448193976;4686.6485013624115;4689.413823272091;5404.945950540484;5442.863928401782;5445.727713614304;5491.748383162884;5498.45015498451;3829.483019792348;3918.7060970427333;3930.64624183822;3941;3951.229510245503;5608.803691870806;5636.436356364372;5651.265335506399;5662.207290979266;5665.348484924245;3995.220931918306;3999.5400528938962;3999.6600288975183;4000.3199456092534;4029.37544680575;3859.4789703389683;4035.616616421435;4049.1091959768805;4090.2433049885867;4092.4679791627495;4639.420072490939;4643.303504474288;4648.2562789953445;4659;4664.061641166111;5433.130699088127;5434.864128396743;5464.207689884945;5483.479069488392;5485.286912701403;1300.9349532523524;1329.2755448280711;1344.6974430753003;1363.9113457625222;1371.8490965993933;928.5264515097349;931.3759780946782;954.9283803714749;958.3770549143113;973.7146966004806;5187.688738675692;5222.634415590872;5230.869228269324;5241.397239317451;5249.685018898878;5519.530839878575;5537.889242215133;5539.612227144142;5544.867150060203;5549.472800084066;5061.848144555669;5240.423553409122;5265.631405801557;5266.945891102473;5297.761600727977;2934;2956.5712971618996;2961.5113506271223;2963.5554666800153;2971.450281697893;5781.1328300754385;5796.420357964254;5807.390224026501;5837.854053648608;5855.970720146457;5499.50504454601;5664.433556644302;5689.886202275931;5716.1997320375185;5780.277465316835;5694.943050569607;5780.971095144498;5790.768369265266;5791.913121303184;5800.172945522147;5408.5673146149;5515.503604675599;5588.692621905834;5596.5242954347705;5599.384067752625;5404.838169670787;5478.972780071399;5549.639273447213;5569.777208911761;5584.7207639617045;5768.913466298093;5815.273090863642;5823.3112397404275;5838.299404071538;5841.474267315962;3834.9616503834604;3890.1636148228267;3971.7021223407783;3977.747009691938;3991.1219531702977;5328.893422131613;5567.526760225426;5581.492996890898;5602.439756024528;5613.635113717595;5295.4969277918535;5349.090654588807;5444.237806706985;5444.856580118219;5446;5389.353277606712;5409.6213265071065;5410.513053825174;5418.972905135449;5436.6194366393975;5153.175491921274;5345.251664766858;5347.491988261109;5360.383555891122;5400.162974738922;5415.321250412385;5420.536455157165;5425.891482170414;5436.037359638927;5446.155845843742;5341.839744807662;5376.354837419534;5390.086519285597;5394.190871369169;5397.487238712316 00:39:16 INFO - PROCESS | 3805 | |5;yui.html;682.4847240333547;704.8449341144947;746.1717493582123;767.6775754183243;783.9882401763973;15701.214939253034;17127.486175414757;17153;17228.397006104806;17289.221985010674;14227.573172804807;14286.142831430121;14301.141931484091;14443.855561444383;14570.635734106652;653.7907869481744;668.2515582547553;770.660909199953;780.4107898536597;801.1707882341777;789.0846617923211;795.8965334506506;796.9402294827911;797.8763291689797;798.4610387988114;845.3870943565927;846.8772028055928;850.1413572291999;850.4897061762955;852.0542198160038;589.7847285740695;611.859272367358;820.8399362124388;840.3361344537839;846.7586737779734;616.0635833533049;624.144921457606;624.6626821516376;625.0343219725535;625.433982246068;15462.226888655523;15498.5350439487;15511.767323490156;15516.767248491282;15540.145292008934;14020.649483762885;14290.142591444546;14449.349779259854;14619.195944223064;14716.632084197874;13189.208647481086;13265.602031939057;13503.459861605525;13598.524051658243;13947.860521394758;4077;4126.5255292652555;4162.500499939996;4188.225178342016;4225.598568136023;80222.59888700578;81395.59302203452;83102;83401.58299208526;83561.58219208926;10002.799944001225;10032.046955539212;10102.625882917508;10197.592096316213;10461.895381046092;19649;20786.37640870776;20926;20978.370648880253;21067.157313707587;7658.540487570652;7966.800829979297;8027.7993050173045;8118.553479558681;8202.794930126674;4495.4605447345875;4533.365328853963;4556.88607784808;4578.175928332932;4652.534746525388;3542.1498840278664;3661.6338366163704;3671.742977991515;3674.393725035393;3680.871169509108;662.7779693802534;675.9155105611799;693.2651389527117;703.1070540413646;707.0843257980927;635.3455940381415;674.5093343710357;687.4735347597658;715.7852644206718;732.1177980533445;9723.854142187873;9897.950510247403;9934.105930466148;10064;10766.354018758742;543.8721900353414;648.5200951296007;662.9237637671633;758.7003133762244;759.9450210155145;4750.786214620351;4988.825391111293;5019.623528235397;5100.744962751847;5127.410347809975;74976.25023749802;93104.53447732853;97414.51292743633;97652;109309;86725.56637216774;87227.56386218028;88627.2197038222;89054.10945890458;91935;80300;80810;81467.59266203632;81715.5914220425;83575.16424835795;9604.471754053595;9885;10014.148797352307;10033.34826539258;10072.446015469219;47038.76480617575;47062.52937470582;47806.5219347816;48574.27138592995;49192.75403622959;63606;65124.674376627816;73331;74186;74749.25250747423;12425.37873106359;12553.93723031379;12816.102872798814;12861;13438.126521776054;13379.331033448483;13493.122947008413;13747.106438081493;14219.075760075562;14527.128372297697;13741.793873092112;14146;14190.929045354707;14595.197264150574;15054.172020538537;13124.212547247196;13797.51708690191;14049.719005619625;14059.48512871782;14520;13483.595492134858;13617.523386681418;13680.589582312547;14119.22344271034;14287.214203218922;10479.528421220912;10960.725981850517;11105.944470277596;11218.16623651971;11695.239809412702;9760.365576237522;10297.3399034313;10467.371957682564;11359.54561817518;11576.421178940851 00:39:16 INFO - PROCESS | 3805 | __end_tp_report 00:39:16 INFO - PROCESS | 3805 | __start_cc_report 00:39:16 INFO - PROCESS | 3805 | _x_x_mozilla_cycle_collect,2566 00:39:16 INFO - PROCESS | 3805 | __end_cc_report 00:39:16 INFO - PROCESS | 3805 | __startTimestamp1475825956731__endTimestamp 00:39:16 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | ------- Summary: start ------- 00:39:16 INFO - PROCESS | 3805 | Number of tests: 6 00:39:16 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | [#0] dojo.html Cycles:165 Average:5264.68 Median:5457.35 stddev:596.61 (10.9%) stddev-sans-first:571.44 00:39:16 INFO - PROCESS | 3805 | Values: 3002.6 3019.7 3027.1 3054.3 3076.1 5143.7 5201.4 5210.6 5251.0 5337.7 5322.6 5360.9 5449.6 5457.3 5508.8 4606.2 4825.0 4835.0 4848.9 4850.7 4916.0 4949.1 4981.0 4996.0 5038.6 4677.5 4703.9 4819.6 4846.3 4971.4 4844.5 4850.6 4851.2 4893.8 4915.4 4795.4 4828.1 4830.9 4848.9 4878.5 5131.3 5137.6 5185.5 5304.2 5342.3 5633.3 5634.7 5691.7 5699.9 5707.3 5659.4 5670.9 5676.6 5696.5 5722.2 5055.1 5105.2 5332.7 5336.4 5343.5 5566.1 5613.8 5618.2 5622.9 5623.4 5567.9 5639.6 5642.8 5650.0 5722.1 5730.6 5731.1 5736.3 5736.3 5795.7 5645.2 5700.1 5703.2 5705.4 5710.2 5409.4 5450.9 5451.4 5541.0 5709.6 4267.1 4296.0 4297.9 4300.1 4322.5 3899.9 3902.7 3905.6 3907.0 3915.3 5330.3 5491.2 5495.8 5505.3 5514.9 5755.7 5774.9 5784.5 5787.5 5793.0 5151.6 5194.0 5194.5 5269.1 5302.0 4960.3 4964.8 4968.3 5002.3 5008.9 5708.8 5721.5 5859.9 5892.0 5932.6 5728.6 5746.6 5750.1 5778.6 5812.2 5936.6 5940.9 5942.8 5945.2 5947.6 5366.5 5441.4 5443.3 5644.9 5646.4 5590.7 5593.2 5598.4 5601.2 5603.4 5424.8 5493.3 5493.8 5494.5 5496.5 5442.5 5481.1 5485.3 5488.5 5493.5 5416.7 5424.3 5426.8 5428.6 5428.6 5494.8 5503.6 5506.6 5509.6 5586.3 5507.1 5528.4 5547.6 5602.7 5615.7 00:39:16 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | [#1] ext.html Cycles:180 Average:57117.84 Median:41257.59 stddev:109204.83 (264.7%) stddev-sans-first:109428.69 00:39:16 INFO - PROCESS | 3805 | Values: 584.9 604.3 605.6 611.5 615.4 32142.8 35222.0 41455.0 43197.6 43417.8 43953.8 44097.3 44309.3 44443.0 45321.3 8839.2 8995.4 9001.6 9002.5 9003.1 8791.6 8858.3 8882.0 8883.9 8887.2 8678.1 8680.0 8683.4 8686.5 8732.5 8855.5 8872.3 8897.6 8942.1 8942.4 8797.9 8866.8 8869.2 8870.1 8874.0 42394.8 42667.6 42746.8 42779.6 42786.6 3298.0 3314.5 3383.8 3393.4 3860.0 29971.3 30456.4 30908.7 30928.0 30974.2 3941.8 4025.7 4059.5 4060.9 4112.3 326776.0 330901.0 331209.0 331584.0 334141.0 48699.8 49015.8 49118.8 49121.0 49284.0 58384.4 58626.7 58957.7 58999.7 59137.0 14357.9 14534.8 14539.2 14543.3 14553.8 11732.1 11804.0 11853.3 11865.2 11875.3 14819.7 15525.8 15599.8 15659.2 15821.5 5805.0 5912.0 5984.6 6047.8 6122.6 931.7 1027.8 1057.1 1075.4 1084.8 30629.8 30917.5 30951.8 31151.8 31389.5 884.9 1084.7 1103.0 1104.4 1123.3 15141.9 17687.8 18222.6 18611.2 18880.9 486890.0 494912.0 496143.0 496245.0 497001.0 61122.7 61519.4 61610.7 61620.1 61669.1 1171.9 1191.6 1323.8 1384.1 1436.1 28562.0 32931.3 32945.8 33020.2 33682.5 50423.0 50935.7 51053.5 51214.7 51216.5 394343.0 397665.0 398213.0 398317.0 398423.0 38662.6 41642.4 42878.6 43079.6 45463.5 42747.8 43325.4 43462.8 43562.3 43720.6 38317.4 38536.4 39767.0 42712.0 44897.8 38927.0 40173.4 40546.6 40564.2 41137.4 40639.4 40727.6 41377.8 41916.0 41963.4 33414.7 36744.3 36969.3 37187.0 37697.2 27118.0 27392.0 27439.3 27514.7 27785.6 00:39:16 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | [#2] jquery.html Cycles:180 Average:27135.79 Median:2268.81 stddev:73160.55 (3224.6%) stddev-sans-first:73338.18 00:39:16 INFO - PROCESS | 3805 | Values: 369.1 386.9 397.1 397.7 425.1 13197.3 15156.3 16173.4 19173.6 19584.5 18751.1 19091.4 19191.7 19551.3 19567.1 5487.6 5509.4 5767.6 5773.3 5780.5 5286.3 5676.1 5693.8 5699.5 5700.1 5503.8 5650.2 5656.5 5660.8 5661.1 5733.5 5916.6 5925.5 5926.3 5933.9 5456.1 5482.2 5512.5 5750.2 5751.9 13750.9 13917.9 14062.1 14245.6 14313.4 2254.3 2292.5 2333.6 2380.0 2409.4 10129.9 10634.2 10638.5 10682.3 13662.8 1811.0 1827.8 1838.3 1880.1 1893.3 79561.2 82966.6 83040.2 84038.6 87901.6 10013.5 10157.4 10294.0 10294.8 10488.6 13883.9 13939.9 13957.8 13958.8 13970.9 7287.6 7349.3 7356.1 7472.6 7566.9 7011.4 7078.5 7140.2 7233.4 7281.1 4140.0 4143.2 4148.2 4166.1 4239.1 1744.1 1749.0 1750.9 1762.7 1823.7 909.6 910.4 965.0 979.6 1013.4 18248.8 18685.0 19423.2 19539.0 19649.8 903.6 931.3 944.9 992.6 1023.5 10307.6 10657.8 10807.3 10813.5 10874.1 415419.0 431417.0 448983.0 453291.0 454173.0 88935.0 89505.0 91289.5 92267.0 92289.0 956.2 1000.1 1019.1 1022.0 1023.6 15509.9 16454.3 16650.3 16957.7 17160.8 43941.8 44683.1 45111.9 45212.8 47193.1 57072.0 57447.0 58143.7 58740.3 59606.0 8360.0 8373.9 8463.3 8519.5 8676.2 10450.3 11971.5 12267.3 12267.9 12634.2 10238.2 10350.4 10638.5 10741.6 11244.0 10436.5 10575.2 10583.5 10795.1 10810.3 9718.1 9726.3 9731.7 9893.4 10071.4 8014.6 8039.4 8187.7 8273.5 8320.6 10521.0 10653.5 10849.5 10860.2 10951.7 00:39:16 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | [#3] mootools.html Cycles:180 Average:5754.63 Median:4745.00 stddev:3344.28 (70.5%) stddev-sans-first:3335.89 00:39:16 INFO - PROCESS | 3805 | Values: 1168.1 1351.1 1362.3 1449.7 1704.9 7779.0 8590.4 8931.9 8949.0 9176.8 8951.4 9012.3 9016.5 9025.3 9032.1 2360.5 2379.4 2380.7 2381.5 2386.3 2287.9 2346.0 2359.2 2362.7 2364.3 2332.8 2339.6 2355.5 2363.3 2366.3 2268.0 2291.7 2299.1 2303.9 2306.7 2275.2 2293.3 2299.7 2303.1 2308.5 8646.0 8910.2 8958.8 8960.9 9031.1 5318.3 5475.0 5481.3 5490.6 5499.7 3343.8 3369.1 3394.4 3436.2 3436.9 1081.9 1083.4 1098.8 1100.3 1103.2 12417.4 12425.1 12448.3 12483.3 12528.5 4348.2 4514.2 4644.6 4646.4 4682.6 9665.8 9675.6 9678.1 9679.1 9685.3 5329.9 5335.9 5340.1 5344.1 5345.8 4352.1 4476.4 4807.4 4918.4 4990.6 3673.4 3754.1 3775.1 3833.2 3945.3 1176.9 1178.4 1200.3 1203.2 1213.2 893.5 941.1 958.3 963.8 968.8 5696.2 5743.3 5894.3 5909.7 6126.4 429.0 432.6 432.8 435.7 436.1 3826.5 3920.6 3962.5 3972.3 4107.2 10856.5 11140.9 11224.4 11226.6 11232.2 11149.3 11149.4 11158.7 11163.2 11164.4 8154.1 8189.3 8232.5 8237.4 8279.9 5505.5 5536.4 5586.4 5612.9 5858.3 9655.3 10112.9 10190.3 10199.7 10262.6 10282.6 10339.7 10399.7 10428.8 10553.0 6918.4 6989.5 7527.2 7537.6 7648.5 8436.4 8445.4 8480.0 8481.6 8489.5 7512.8 7582.5 7695.3 7767.5 7795.5 7292.1 7415.3 7512.9 7609.7 7649.6 6833.8 6948.5 6959.5 6961.3 6969.0 4903.7 5076.9 5090.7 5116.2 5209.2 4874.9 4954.0 5051.7 5102.3 5107.9 00:39:16 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | [#4] prototype.html Cycles:180 Average:4589.46 Median:5257.66 stddev:1348.93 (25.7%) stddev-sans-first:1314.01 00:39:16 INFO - PROCESS | 3805 | Values: 315.2 320.2 326.7 330.0 333.6 5089.3 5233.9 5235.2 5277.0 5289.9 5050.0 5140.2 5144.6 5145.5 5204.6 4118.9 4130.1 4132.7 4132.9 4144.0 3870.0 4045.9 4127.1 4128.4 4153.0 4016.9 4023.4 4031.6 4054.5 4055.3 3993.3 4015.9 4017.5 4057.0 4064.2 3569.8 3574.0 3580.9 3581.1 3596.0 4907.2 5094.0 5125.0 5135.2 5146.9 4629.1 4642.5 4684.4 4686.6 4689.4 5404.9 5442.9 5445.7 5491.7 5498.5 3829.5 3918.7 3930.6 3941.0 3951.2 5608.8 5636.4 5651.3 5662.2 5665.3 3995.2 3999.5 3999.7 4000.3 4029.4 3859.5 4035.6 4049.1 4090.2 4092.5 4639.4 4643.3 4648.3 4659.0 4664.1 5433.1 5434.9 5464.2 5483.5 5485.3 1300.9 1329.3 1344.7 1363.9 1371.8 928.5 931.4 954.9 958.4 973.7 5187.7 5222.6 5230.9 5241.4 5249.7 5519.5 5537.9 5539.6 5544.9 5549.5 5061.8 5240.4 5265.6 5266.9 5297.8 2934.0 2956.6 2961.5 2963.6 2971.5 5781.1 5796.4 5807.4 5837.9 5856.0 5499.5 5664.4 5689.9 5716.2 5780.3 5694.9 5781.0 5790.8 5791.9 5800.2 5408.6 5515.5 5588.7 5596.5 5599.4 5404.8 5479.0 5549.6 5569.8 5584.7 5768.9 5815.3 5823.3 5838.3 5841.5 3835.0 3890.2 3971.7 3977.7 3991.1 5328.9 5567.5 5581.5 5602.4 5613.6 5295.5 5349.1 5444.2 5444.9 5446.0 5389.4 5409.6 5410.5 5419.0 5436.6 5153.2 5345.3 5347.5 5360.4 5400.2 5415.3 5420.5 5425.9 5436.0 5446.2 5341.8 5376.4 5390.1 5394.2 5397.5 00:39:16 INFO - PROCESS | 3805 | 00:39:16 INFO - PROCESS | 3805 | [#5] yui.html Cycles:180 Average:19812.30 Median:47050.65 stddev:27292.84 (58.0%) stddev-sans-first:27331.60 00:39:16 INFO - PROCESS | 3805 | Values: 682.5 704.8 746.2 767.7 784.0 15701.2 17127.5 17153.0 17228.4 17289.2 14227.6 14286.1 14301.1 14443.9 14570.6 653.8 668.3 770.7 780.4 801.2 789.1 795.9 796.9 797.9 798.5 845.4 846.9 850.1 850.5 852.1 589.8 611.9 820.8 840.3 846.8 616.1 624.1 624.7 625.0 625.4 15462.2 15498.5 15511.8 15516.8 15540.1 14020.6 14290.1 14449.3 14619.2 14716.6 13189.2 13265.6 13503.5 13598.5 13947.9 4077.0 4126.5 4162.5 4188.2 4225.6 80222.6 81395.6 83102.0 83401.6 83561.6 10002.8 10032.0 10102.6 10197.6 10461.9 19649.0 20786.4 20926.0 20978.4 21067.2 7658.5 7966.8 8027.8 8118.6 8202.8 4495.5 4533.4 4556.9 4578.2 4652.5 3542.1 3661.6 3671.7 3674.4 3680.9 662.8 675.9 693.3 703.1 707.1 635.3 674.5 687.5 715.8 732.1 9723.9 9898.0 9934.1 10064.0 10766.4 543.9 648.5 662.9 758.7 759.9 4750.8 4988.8 5019.6 5100.7 5127.4 74976.3 93104.5 97414.5 97652.0 109309.0 86725.6 87227.6 88627.2 89054.1 91935.0 80300.0 80810.0 81467.6 81715.6 83575.2 9604.5 9885.0 10014.1 10033.3 10072.4 47038.8 47062.5 47806.5 48574.3 49192.8 63606.0 65124.7 73331.0 74186.0 74749.3 12425.4 12553.9 12816.1 12861.0 13438.1 13379.3 13493.1 13747.1 14219.1 14527.1 13741.8 14146.0 14190.9 14595.2 15054.2 13124.2 13797.5 14049.7 14059.5 14520.0 13483.6 13617.5 13680.6 14119.2 14287.2 10479.5 10960.7 11105.9 11218.2 11695.2 9760.4 10297.3 10467.4 11359.5 11576.4 00:39:16 INFO - PROCESS | 3805 | -------- Summary: end -------- 00:39:16 INFO - PROCESS | 3805 | 00:39:17 INFO - TEST-INFO | 3805: exit 0 00:39:17 INFO - TEST-OK | dromaeo_css | took 1117530ms 00:39:17 INFO - TEST-START | kraken 00:39:17 INFO - operating with platform_type : linux_ 00:39:17 INFO - Initialising browser for kraken test... 00:39:17 INFO - TEST-INFO | started process 4108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOOtSi0/profile http://localhost:47229/getInfo.html) 00:39:21 INFO - PROCESS | 4108 | __metrics Screen width/height:1600/1200 00:39:21 INFO - PROCESS | 4108 | colorDepth:24 00:39:21 INFO - PROCESS | 4108 | Browser inner width/height: 1024/697 00:39:21 INFO - PROCESS | 4108 | __metrics 00:39:22 INFO - PROCESS | 4108 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:39:22 INFO - PROCESS | 4108 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:39:23 INFO - PROCESS | 4108 | console.error: PushService: 00:39:23 INFO - PROCESS | 4108 | stateChangeProcessEnqueue: Error transitioning state 00:39:23 INFO - PROCESS | 4108 | UnknownError 00:39:23 INFO - TEST-INFO | 4108: exit 0 00:39:23 INFO - Browser initialized. 00:39:23 INFO - Running cycle 1/1 for kraken test... 00:39:23 INFO - TEST-INFO | started process 4194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOOtSi0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:39:23 INFO - PROCESS | 4194 | Inconsistency detected by ld.so: dl-open.c: 667: _dl_open: Assertion `_dl_debug_initialize (0, args.nsid)->r_state == RT_CONSISTENT' failed! 00:39:23 INFO - Terminating psutil.Process(pid=4194, name='firefox') 00:39:23 INFO - TEST-INFO | 4194: exit 127 00:39:23 INFO - TEST-UNEXPECTED-ERROR | kraken | Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))] 00:39:23 ERROR - Traceback (most recent call last): 00:39:23 INFO - File "/builds/slave/test/build/tests/talos/talos/run_tests.py", line 202, in run_tests 00:39:23 INFO - talos_results.add(mytest.runTest(browser_config, test)) 00:39:23 INFO - File "/builds/slave/test/build/tests/talos/talos/ttest.py", line 70, in runTest 00:39:23 INFO - return self._runTest(browser_config, test_config, setup) 00:39:23 INFO - File "/builds/slave/test/build/tests/talos/talos/ttest.py", line 232, in _runTest 00:39:23 INFO - else None) 00:39:23 INFO - File "/builds/slave/test/build/tests/talos/talos/results.py", line 94, in add 00:39:23 INFO - global_counters=self.global_counters 00:39:23 INFO - File "/builds/slave/test/build/tests/talos/talos/results.py", line 311, in __init__ 00:39:23 INFO - self.parse() 00:39:23 INFO - File "/builds/slave/test/build/tests/talos/talos/results.py", line 338, in parse 00:39:23 INFO - % self.report_tokens) 00:39:23 INFO - File "/builds/slave/test/build/tests/talos/talos/results.py", line 322, in error 00:39:23 INFO - raise utils.TalosError(message) 00:39:23 INFO - TalosError: Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))] 00:39:23 INFO - TEST-INFO took 6292ms 00:39:23 INFO - SUITE-END | took 1123s 00:39:24 ERROR - Return code: 2 00:39:24 WARNING - setting return code to 2 00:39:24 ERROR - # TBPL FAILURE # 00:39:24 INFO - Running post-action listener: _resource_record_post_action 00:39:24 INFO - [mozharness: 2016-10-07 07:39:24.128875Z] Finished run-tests step (success) 00:39:24 INFO - Running post-run listener: _resource_record_post_run 00:39:24 INFO - Total resource usage - Wall time: 1141s; CPU: 13.0%; Read bytes: 4096; Write bytes: 344870912; Read time: 16; Write time: 389428 00:39:24 INFO - TinderboxPrint: CPU usage
13.2% 00:39:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:39:24 INFO - TinderboxPrint: I/O write bytes / time
344,870,912 / 389,428 00:39:24 INFO - TinderboxPrint: CPU idle
7,902.7 (86.8%) 00:39:24 INFO - TinderboxPrint: CPU user
1,161.0 (12.8%) 00:39:24 INFO - TinderboxPrint: Swap in / out
0 / 0 00:39:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103870464; Read time: 0; Write time: 130704 00:39:24 INFO - run-tests - Wall time: 1124s; CPU: 13.0%; Read bytes: 0; Write bytes: 241000448; Read time: 0; Write time: 258724 00:39:24 INFO - Running post-run listener: _upload_blobber_files 00:39:24 INFO - Blob upload gear active. 00:39:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:39:24 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 00:39:24 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'] 00:39:24 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 00:39:25 INFO - (blobuploader) - INFO - Open directory for files ... 00:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:39:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:28 INFO - (blobuploader) - INFO - Done attempting. 00:39:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:39:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:39:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:29 INFO - (blobuploader) - INFO - Done attempting. 00:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:39:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:29 INFO - (blobuploader) - INFO - Done attempting. 00:39:29 INFO - (blobuploader) - INFO - Iteration through files over. 00:39:29 INFO - Return code: 0 00:39:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:39:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:39:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fe215bc79f09d5661719082d0cdc2061632e8d210695140cb48271906b3f896ee99e179fc78fb4f84e3c587b518bfccb9669a5b6100aee4b4bae8032d9fa98c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/859482da41d7b275f0a38bd7771b4a03879beaf9943f039164cbf165db0a60e402386c74678ecaf6536835c28be73ed1c574737f2107ee5e9174a65d10932f5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c85615d308f94c1d2bf24f3a130ff73950eddf8a72cacbe8ccad3617021281182ce5d1b78fd5822b15db33cce67aeb239d2169b55416fde8f5cd1a1e16088ba"} 00:39:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:39:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:39:29 INFO - Contents: 00:39:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fe215bc79f09d5661719082d0cdc2061632e8d210695140cb48271906b3f896ee99e179fc78fb4f84e3c587b518bfccb9669a5b6100aee4b4bae8032d9fa98c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/859482da41d7b275f0a38bd7771b4a03879beaf9943f039164cbf165db0a60e402386c74678ecaf6536835c28be73ed1c574737f2107ee5e9174a65d10932f5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c85615d308f94c1d2bf24f3a130ff73950eddf8a72cacbe8ccad3617021281182ce5d1b78fd5822b15db33cce67aeb239d2169b55416fde8f5cd1a1e16088ba"} 00:39:29 INFO - Running post-run listener: copy_logs_to_upload_dir 00:39:29 INFO - Copying logs to upload dir... 00:39:29 INFO - mkdir: /builds/slave/test/build/upload/logs 00:39:29 INFO - Copying logs to upload dir... 00:39:29 WARNING - returning nonzero exit status 2 program finished with exit code 2 elapsedTime=1186.062048 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' failed (results: 2, elapsed: 19 mins, 46 secs) (at 2016-10-07 00:39:29.521807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 00:39:29.525851) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587 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/3fe215bc79f09d5661719082d0cdc2061632e8d210695140cb48271906b3f896ee99e179fc78fb4f84e3c587b518bfccb9669a5b6100aee4b4bae8032d9fa98c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/859482da41d7b275f0a38bd7771b4a03879beaf9943f039164cbf165db0a60e402386c74678ecaf6536835c28be73ed1c574737f2107ee5e9174a65d10932f5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c85615d308f94c1d2bf24f3a130ff73950eddf8a72cacbe8ccad3617021281182ce5d1b78fd5822b15db33cce67aeb239d2169b55416fde8f5cd1a1e16088ba"} build_url:https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/GCTVF_lNTbK0Jc4xkheOMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fe215bc79f09d5661719082d0cdc2061632e8d210695140cb48271906b3f896ee99e179fc78fb4f84e3c587b518bfccb9669a5b6100aee4b4bae8032d9fa98c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/859482da41d7b275f0a38bd7771b4a03879beaf9943f039164cbf165db0a60e402386c74678ecaf6536835c28be73ed1c574737f2107ee5e9174a65d10932f5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c85615d308f94c1d2bf24f3a130ff73950eddf8a72cacbe8ccad3617021281182ce5d1b78fd5822b15db33cce67aeb239d2169b55416fde8f5cd1a1e16088ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 00:39:29.557305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 00:39:29.557938) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475820590.8582-2145581587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 00:39:29.640268) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 00:39:29.640666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 00:39:29.641008) ========= ========= Total master_lag: 0.20 =========