builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1465508715.0 results: success (0) buildid: 20160609124436 builduid: d65f4cb840b34b3c9d6edf43a31ec54b revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.001631) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.002096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.002381) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.021159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.021474) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 14:45:15-- 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% 33.7M=0s 2016-06-09 14:45:15 (33.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103243 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.138586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.138895) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023078 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.188630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.189018) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f8bdceb55c9d191380176ab25e2385737bd9e1ab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev f8bdceb55c9d191380176ab25e2385737bd9e1ab --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=8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 14:45:15,406 truncating revision to first 12 chars 2016-06-09 14:45:15,406 Setting DEBUG logging. 2016-06-09 14:45:15,406 attempt 1/10 2016-06-09 14:45:15,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f8bdceb55c9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 14:45:15,709 unpacking tar archive at: autoland-f8bdceb55c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684354 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.886668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.886993) ========= script_repo_revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.887413) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.887732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:45:15.896880) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-09 14:45:15.897342) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:45:16 INFO - MultiFileLogger online at 20160609 14:45:16 in /builds/slave/test 14:45:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 14:45:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:45:16 INFO - {'append_to_log': False, 14:45:16 INFO - 'base_work_dir': '/builds/slave/test', 14:45:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:45:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:45:16 INFO - 'branch': 'Autoland-Non-PGO', 14:45:16 INFO - 'buildbot_json_path': 'buildprops.json', 14:45:16 INFO - 'config_files': ('talos/linux_config.py',), 14:45:16 INFO - 'default_actions': ('clobber', 14:45:16 INFO - 'read-buildbot-config', 14:45:16 INFO - 'download-and-extract', 14:45:16 INFO - 'populate-webroot', 14:45:16 INFO - 'create-virtualenv', 14:45:16 INFO - 'install', 14:45:16 INFO - 'run-tests'), 14:45:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:45:16 INFO - 'download_minidump_stackwalk': True, 14:45:16 INFO - 'download_symbols': 'ondemand', 14:45:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:45:16 INFO - 'tooltool.py': '/tools/tooltool.py', 14:45:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:45:16 INFO - '/tools/misc-python/virtualenv.py')}, 14:45:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:45:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:45:16 INFO - 'installer_path': 'installer.exe', 14:45:16 INFO - 'log_level': 'info', 14:45:16 INFO - 'log_name': 'talos', 14:45:16 INFO - 'log_to_console': True, 14:45:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:45:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:45:16 INFO - 'opt_config_files': (), 14:45:16 INFO - 'pip_index': False, 14:45:16 INFO - 'sps_profile': False, 14:45:16 INFO - 'sps_profile_interval': 0, 14:45:16 INFO - 'suite': 'dromaeojs', 14:45:16 INFO - 'system_bits': '32', 14:45:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:45:16 INFO - 'title': 'talos-linux64-ix-001', 14:45:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:45:16 INFO - 'use_talos_json': True, 14:45:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:45:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:45:16 INFO - 'work_dir': 'build'} 14:45:16 INFO - ##### 14:45:16 INFO - ##### Running clobber step. 14:45:16 INFO - ##### 14:45:16 INFO - Running pre-action listener: _resource_record_pre_action 14:45:16 INFO - Running main action method: clobber 14:45:16 INFO - rmtree: /builds/slave/test/build 14:45:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:45:16 INFO - Running post-action listener: _resource_record_post_action 14:45:16 INFO - ##### 14:45:16 INFO - ##### Finished clobber step (success) 14:45:16 INFO - ##### 14:45:16 INFO - ##### 14:45:16 INFO - ##### Running read-buildbot-config step. 14:45:16 INFO - ##### 14:45:16 INFO - Running pre-action listener: _resource_record_pre_action 14:45:16 INFO - Running main action method: read_buildbot_config 14:45:16 INFO - Using buildbot properties: 14:45:16 INFO - { 14:45:16 INFO - "project": "", 14:45:16 INFO - "product": "firefox", 14:45:16 INFO - "script_repo_revision": "production", 14:45:16 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 14:45:16 INFO - "repository": "", 14:45:16 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 14:45:16 INFO - "buildid": "20160609124436", 14:45:16 INFO - "pgo_build": "False", 14:45:16 INFO - "basedir": "/builds/slave/test", 14:45:16 INFO - "buildnumber": 2, 14:45:16 INFO - "slavename": "talos-linux64-ix-001", 14:45:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:45:16 INFO - "platform": "ubuntu64_hw", 14:45:16 INFO - "scheduler": "tests-autoland-linux64-talos", 14:45:16 INFO - "branch": "autoland", 14:45:16 INFO - "repo_path": "integration/autoland", 14:45:16 INFO - "revision": "f8bdceb55c9d191380176ab25e2385737bd9e1ab", 14:45:16 INFO - "stage_platform": "linux64", 14:45:16 INFO - "builduid": "d65f4cb840b34b3c9d6edf43a31ec54b", 14:45:16 INFO - "slavebuilddir": "test" 14:45:16 INFO - } 14:45:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:45:16 INFO - Running post-action listener: _resource_record_post_action 14:45:16 INFO - ##### 14:45:16 INFO - ##### Finished read-buildbot-config step (success) 14:45:16 INFO - ##### 14:45:16 INFO - ##### 14:45:16 INFO - ##### Running download-and-extract step. 14:45:16 INFO - ##### 14:45:16 INFO - Running pre-action listener: _resource_record_pre_action 14:45:16 INFO - Running main action method: download_and_extract 14:45:16 INFO - mkdir: /builds/slave/test/build/tests 14:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:16 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:45:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:45:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:45:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:45:17 INFO - Downloaded 1361 bytes. 14:45:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:45:17 INFO - Using the following test package requirements: 14:45:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:45:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:45:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:45:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:17 INFO - u'jsshell-linux-x86_64.zip'], 14:45:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:45:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:45:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:45:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:45:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:45:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:45:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:17 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:45:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:45:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:45:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:45:18 INFO - Downloaded 22879070 bytes. 14:45:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:45:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:45:19 INFO - Return code: 0 14:45:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:19 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:45:20 INFO - Downloaded 22879070 bytes. 14:45:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:45:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:45:22 INFO - Return code: 0 14:45: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:22 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:45:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:45:23 INFO - Downloaded 10833369 bytes. 14:45:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:45:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:45:23 INFO - Return code: 0 14:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:23 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:45:24 INFO - Downloaded 55335849 bytes. 14:45:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:45:24 INFO - mkdir: /builds/slave/test/properties 14:45:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:45:24 INFO - Writing to file /builds/slave/test/properties/build_url 14:45:24 INFO - Contents: 14:45:24 INFO - build_url:https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:45:25 INFO - Running post-action listener: _resource_record_post_action 14:45:25 INFO - Running post-action listener: set_extra_try_arguments 14:45:25 INFO - ##### 14:45:25 INFO - ##### Finished download-and-extract step (success) 14:45:25 INFO - ##### 14:45:25 INFO - ##### 14:45:25 INFO - ##### Running populate-webroot step. 14:45:25 INFO - ##### 14:45:25 INFO - Running pre-action listener: _resource_record_pre_action 14:45:25 INFO - Running main action method: populate_webroot 14:45:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:45:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:45:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:45:25 INFO - '--tppagecycles', 14:45:25 INFO - '7'], 14:45:25 INFO - 'tests': ['tsvgm']}}, 14:45:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:45:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:45:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:45:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:45:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:25 INFO - 'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:25 INFO - 'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['damp', 'tps']}, 14:45:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:25 INFO - 'tests': ['damp', 'tps']}, 14:45:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['dromaeo_dom']}, 14:45:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:45:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['a11yr', 14:45:25 INFO - 'ts_paint', 14:45:25 INFO - 'tpaint', 14:45:25 INFO - 'sessionrestore', 14:45:25 INFO - 'sessionrestore_no_auto_restore', 14:45:25 INFO - 'tabpaint']}, 14:45:25 INFO - 'other-e10s': {'tests': ['a11yr', 14:45:25 INFO - 'ts_paint', 14:45:25 INFO - 'tpaint', 14:45:25 INFO - 'sessionrestore', 14:45:25 INFO - 'sessionrestore_no_auto_restore', 14:45:25 INFO - 'tabpaint']}, 14:45:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:45:25 INFO - 'ts_paint', 14:45:25 INFO - 'tpaint', 14:45:25 INFO - 'sessionrestore', 14:45:25 INFO - 'sessionrestore_no_auto_restore', 14:45:25 INFO - 'tabpaint']}, 14:45:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:45:25 INFO - 'ts_paint', 14:45:25 INFO - 'tpaint', 14:45:25 INFO - 'sessionrestore', 14:45:25 INFO - 'sessionrestore_no_auto_restore', 14:45:25 INFO - 'tabpaint']}, 14:45:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['a11yr', 14:45:25 INFO - 'ts_paint', 14:45:25 INFO - 'tpaint', 14:45:25 INFO - 'sessionrestore', 14:45:25 INFO - 'sessionrestore_no_auto_restore', 14:45:25 INFO - 'tabpaint']}, 14:45:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['a11yr', 14:45:25 INFO - 'ts_paint', 14:45:25 INFO - 'tpaint', 14:45:25 INFO - 'sessionrestore', 14:45:25 INFO - 'sessionrestore_no_auto_restore', 14:45:25 INFO - 'tabpaint']}, 14:45:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['tsvgx', 14:45:25 INFO - 'tsvgr_opacity', 14:45:25 INFO - 'tart', 14:45:25 INFO - 'tscrollx', 14:45:25 INFO - 'cart']}, 14:45:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:45:25 INFO - 'tsvgr_opacity', 14:45:25 INFO - 'tart', 14:45:25 INFO - 'tscrollx', 14:45:25 INFO - 'cart']}, 14:45:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:25 INFO - 'talos_options': ['--disable-e10s'], 14:45:25 INFO - 'tests': ['tp5o']}, 14:45:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:25 INFO - 'tests': ['tp5o']}, 14:45:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:25 INFO - 'talos_options': ['--disable-e10s', 14:45:25 INFO - '--xperf_path', 14:45:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:25 INFO - 'tests': ['tp5n']}, 14:45:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:25 INFO - 'talos_options': ['--xperf_path', 14:45:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:25 INFO - 'tests': ['tp5n']}}, 14:45:25 INFO - 'talos.zip': {'path': '', 14:45:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:45:25 INFO - Running post-action listener: _resource_record_post_action 14:45:25 INFO - ##### 14:45:25 INFO - ##### Finished populate-webroot step (success) 14:45:25 INFO - ##### 14:45:25 INFO - ##### 14:45:25 INFO - ##### Running create-virtualenv step. 14:45:25 INFO - ##### 14:45:25 INFO - Running pre-action listener: _resource_record_pre_action 14:45:25 INFO - Running main action method: create_virtualenv 14:45:25 INFO - Creating virtualenv /builds/slave/test/build/venv 14:45:25 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 14:45:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:45:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:45:25 INFO - Using real prefix '/usr' 14:45:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:45:26 INFO - Installing distribute.............................................................................................................................................................................................done. 14:45:28 INFO - Installing pip.................done. 14:45:28 INFO - Return code: 0 14:45:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:45:28 INFO - Using env: {'DISPLAY': ':0', 14:45:28 INFO - 'HOME': '/home/cltbld', 14:45:28 INFO - 'LANG': 'en_US.UTF-8', 14:45:28 INFO - 'LANGUAGE': 'en_US:en', 14:45:28 INFO - 'LOGNAME': 'cltbld', 14:45:28 INFO - 'MAIL': '/var/mail/cltbld', 14:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:28 INFO - 'MOZ_NO_REMOTE': '1', 14:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:28 INFO - 'NO_EM_RESTART': '1', 14:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:28 INFO - 'PWD': '/builds/slave/test', 14:45:28 INFO - 'SHELL': '/bin/bash', 14:45:28 INFO - 'SHLVL': '1', 14:45:28 INFO - 'TERM': 'linux', 14:45:28 INFO - 'TMOUT': '86400', 14:45:28 INFO - 'USER': 'cltbld', 14:45:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:28 INFO - '_': '/tools/buildbot/bin/python'} 14:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:28 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 14:45:28 INFO - Cleaning up... 14:45:28 INFO - Return code: 0 14:45:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:45:28 INFO - Using env: {'DISPLAY': ':0', 14:45:28 INFO - 'HOME': '/home/cltbld', 14:45:28 INFO - 'LANG': 'en_US.UTF-8', 14:45:28 INFO - 'LANGUAGE': 'en_US:en', 14:45:28 INFO - 'LOGNAME': 'cltbld', 14:45:28 INFO - 'MAIL': '/var/mail/cltbld', 14:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:28 INFO - 'MOZ_NO_REMOTE': '1', 14:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:28 INFO - 'NO_EM_RESTART': '1', 14:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:28 INFO - 'PWD': '/builds/slave/test', 14:45:28 INFO - 'SHELL': '/bin/bash', 14:45:28 INFO - 'SHLVL': '1', 14:45:28 INFO - 'TERM': 'linux', 14:45:28 INFO - 'TMOUT': '86400', 14:45:28 INFO - 'USER': 'cltbld', 14:45:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:28 INFO - '_': '/tools/buildbot/bin/python'} 14:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:28 INFO - Downloading/unpacking psutil>=3.1.1 14:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:45:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:30 INFO - Installing collected packages: psutil 14:45:30 INFO - Running setup.py install for psutil 14:45:30 INFO - building 'psutil._psutil_linux' extension 14:45:30 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 14:45:30 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 14:45:30 INFO - building 'psutil._psutil_posix' extension 14:45:30 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 14:45:30 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 14:45:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:30 INFO - Successfully installed psutil 14:45:30 INFO - Cleaning up... 14:45:31 INFO - Return code: 0 14:45:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:45:31 INFO - Using env: {'DISPLAY': ':0', 14:45:31 INFO - 'HOME': '/home/cltbld', 14:45:31 INFO - 'LANG': 'en_US.UTF-8', 14:45:31 INFO - 'LANGUAGE': 'en_US:en', 14:45:31 INFO - 'LOGNAME': 'cltbld', 14:45:31 INFO - 'MAIL': '/var/mail/cltbld', 14:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:31 INFO - 'MOZ_NO_REMOTE': '1', 14:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:31 INFO - 'NO_EM_RESTART': '1', 14:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:31 INFO - 'PWD': '/builds/slave/test', 14:45:31 INFO - 'SHELL': '/bin/bash', 14:45:31 INFO - 'SHLVL': '1', 14:45:31 INFO - 'TERM': 'linux', 14:45:31 INFO - 'TMOUT': '86400', 14:45:31 INFO - 'USER': 'cltbld', 14:45:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:31 INFO - '_': '/tools/buildbot/bin/python'} 14:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:45:33 INFO - Installing collected packages: mozsystemmonitor 14:45:33 INFO - Running setup.py install for mozsystemmonitor 14:45:33 INFO - Successfully installed mozsystemmonitor 14:45:33 INFO - Cleaning up... 14:45:33 INFO - Return code: 0 14:45:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:45:33 INFO - Using env: {'DISPLAY': ':0', 14:45:33 INFO - 'HOME': '/home/cltbld', 14:45:33 INFO - 'LANG': 'en_US.UTF-8', 14:45:33 INFO - 'LANGUAGE': 'en_US:en', 14:45:33 INFO - 'LOGNAME': 'cltbld', 14:45:33 INFO - 'MAIL': '/var/mail/cltbld', 14:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:33 INFO - 'MOZ_NO_REMOTE': '1', 14:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:33 INFO - 'NO_EM_RESTART': '1', 14:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:33 INFO - 'PWD': '/builds/slave/test', 14:45:33 INFO - 'SHELL': '/bin/bash', 14:45:33 INFO - 'SHLVL': '1', 14:45:33 INFO - 'TERM': 'linux', 14:45:33 INFO - 'TMOUT': '86400', 14:45:33 INFO - 'USER': 'cltbld', 14:45:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:33 INFO - '_': '/tools/buildbot/bin/python'} 14:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:33 INFO - Downloading/unpacking jsonschema==2.5.1 14:45:33 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 14:45:33 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 14:45:33 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 14:45:33 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 14:45:33 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 14:45:33 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 14:45:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:45:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:45:35 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 14:45:35 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 14:45:35 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 14:45:35 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 14:45:35 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 14:45:35 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 14:45:35 INFO - Downloading functools32-3.2.3-2.tar.gz 14:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:45:35 INFO - warning: no files found matching '*.txt' 14:45:35 INFO - no previously-included directories found matching 'build' 14:45:35 INFO - no previously-included directories found matching 'dist' 14:45:35 INFO - no previously-included directories found matching '.git*' 14:45:35 INFO - Installing collected packages: jsonschema, functools32 14:45:35 INFO - Running setup.py install for functools32 14:45:35 INFO - warning: no files found matching '*.txt' 14:45:35 INFO - no previously-included directories found matching 'build' 14:45:35 INFO - no previously-included directories found matching 'dist' 14:45:35 INFO - no previously-included directories found matching '.git*' 14:45:35 INFO - Successfully installed jsonschema functools32 14:45:35 INFO - Cleaning up... 14:45:35 INFO - Return code: 0 14:45:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:35 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 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:35 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 14:45:35 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 14:45:35 INFO - Using env: {'DISPLAY': ':0', 14:45:35 INFO - 'HOME': '/home/cltbld', 14:45:35 INFO - 'LANG': 'en_US.UTF-8', 14:45:35 INFO - 'LANGUAGE': 'en_US:en', 14:45:35 INFO - 'LOGNAME': 'cltbld', 14:45:35 INFO - 'MAIL': '/var/mail/cltbld', 14:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:35 INFO - 'MOZ_NO_REMOTE': '1', 14:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:35 INFO - 'NO_EM_RESTART': '1', 14:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:35 INFO - 'PWD': '/builds/slave/test', 14:45:35 INFO - 'SHELL': '/bin/bash', 14:45:35 INFO - 'SHLVL': '1', 14:45:35 INFO - 'TERM': 'linux', 14:45:35 INFO - 'TMOUT': '86400', 14:45:35 INFO - 'USER': 'cltbld', 14:45:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:35 INFO - '_': '/tools/buildbot/bin/python'} 14:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:36 INFO - Downloading/unpacking blobuploader==1.2.4 14:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:38 INFO - Downloading blobuploader-1.2.4.tar.gz 14:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:45:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:45:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:38 INFO - Downloading docopt-0.6.1.tar.gz 14:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:45:38 INFO - Installing collected packages: blobuploader, requests, docopt 14:45:38 INFO - Running setup.py install for blobuploader 14:45:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:45:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:45:38 INFO - Running setup.py install for requests 14:45:39 INFO - Running setup.py install for docopt 14:45:39 INFO - Successfully installed blobuploader requests docopt 14:45:39 INFO - Cleaning up... 14:45:39 INFO - Return code: 0 14:45:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:39 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 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:39 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 14:45:39 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 14:45:39 INFO - Using env: {'DISPLAY': ':0', 14:45:39 INFO - 'HOME': '/home/cltbld', 14:45:39 INFO - 'LANG': 'en_US.UTF-8', 14:45:39 INFO - 'LANGUAGE': 'en_US:en', 14:45:39 INFO - 'LOGNAME': 'cltbld', 14:45:39 INFO - 'MAIL': '/var/mail/cltbld', 14:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:39 INFO - 'MOZ_NO_REMOTE': '1', 14:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:39 INFO - 'NO_EM_RESTART': '1', 14:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:39 INFO - 'PWD': '/builds/slave/test', 14:45:39 INFO - 'SHELL': '/bin/bash', 14:45:39 INFO - 'SHLVL': '1', 14:45:39 INFO - 'TERM': 'linux', 14:45:39 INFO - 'TMOUT': '86400', 14:45:39 INFO - 'USER': 'cltbld', 14:45:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:39 INFO - '_': '/tools/buildbot/bin/python'} 14:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:45:39 INFO - Running setup.py (path:/tmp/pip-hbBHWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:45:39 INFO - Running setup.py (path:/tmp/pip-NEWk88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:45:39 INFO - Running setup.py (path:/tmp/pip-jGkXc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:45:39 INFO - Running setup.py (path:/tmp/pip-jiMHpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:45:39 INFO - Running setup.py (path:/tmp/pip-AmcdJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:45:40 INFO - Running setup.py (path:/tmp/pip-W1EcwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:45:40 INFO - Running setup.py (path:/tmp/pip-VZoBGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:45:40 INFO - Running setup.py (path:/tmp/pip-_X9Piw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:45:40 INFO - Running setup.py (path:/tmp/pip-eSXOjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:45:40 INFO - Running setup.py (path:/tmp/pip-oBT4mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:45:40 INFO - Running setup.py (path:/tmp/pip-0DhhwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:45:40 INFO - Running setup.py (path:/tmp/pip-QFzp9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:45:40 INFO - Running setup.py (path:/tmp/pip-GPqpGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:45:40 INFO - Running setup.py (path:/tmp/pip-lIsBtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:40 INFO - Running setup.py (path:/tmp/pip-SOdfz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:45:40 INFO - Running setup.py (path:/tmp/pip-6URL_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:45:40 INFO - Running setup.py (path:/tmp/pip-SXEbLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:45:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:45:40 INFO - Running setup.py install for manifestparser 14:45:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:45:40 INFO - Running setup.py install for mozcrash 14:45:41 INFO - Running setup.py install for mozdebug 14:45:41 INFO - Running setup.py install for mozdevice 14:45:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Running setup.py install for mozfile 14:45:41 INFO - Running setup.py install for mozhttpd 14:45:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Running setup.py install for mozinfo 14:45:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Running setup.py install for mozInstall 14:45:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Running setup.py install for mozleak 14:45:41 INFO - Running setup.py install for mozlog 14:45:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:45:41 INFO - Running setup.py install for moznetwork 14:45:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:45:42 INFO - Running setup.py install for mozprocess 14:45:42 INFO - Running setup.py install for mozprofile 14:45:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:45:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:45:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:45:42 INFO - Running setup.py install for mozrunner 14:45:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:45:42 INFO - Running setup.py install for mozscreenshot 14:45:42 INFO - Running setup.py install for moztest 14:45:42 INFO - Running setup.py install for mozversion 14:45:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:45:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:45:42 INFO - Cleaning up... 14:45:42 INFO - Return code: 0 14:45:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:42 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 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:42 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 14:45:42 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 14:45:42 INFO - Using env: {'DISPLAY': ':0', 14:45:42 INFO - 'HOME': '/home/cltbld', 14:45:42 INFO - 'LANG': 'en_US.UTF-8', 14:45:42 INFO - 'LANGUAGE': 'en_US:en', 14:45:42 INFO - 'LOGNAME': 'cltbld', 14:45:42 INFO - 'MAIL': '/var/mail/cltbld', 14:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:42 INFO - 'MOZ_NO_REMOTE': '1', 14:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:42 INFO - 'NO_EM_RESTART': '1', 14:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:42 INFO - 'PWD': '/builds/slave/test', 14:45:42 INFO - 'SHELL': '/bin/bash', 14:45:42 INFO - 'SHLVL': '1', 14:45:42 INFO - 'TERM': 'linux', 14:45:42 INFO - 'TMOUT': '86400', 14:45:42 INFO - 'USER': 'cltbld', 14:45:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:42 INFO - '_': '/tools/buildbot/bin/python'} 14:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:45:42 INFO - Running setup.py (path:/tmp/pip-TTtg85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:45:42 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)) 14:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:45:42 INFO - Running setup.py (path:/tmp/pip-z9USKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:45:43 INFO - Running setup.py (path:/tmp/pip-vT1Wqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:45:43 INFO - Running setup.py (path:/tmp/pip-AVnXcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:45:43 INFO - Running setup.py (path:/tmp/pip-GnazeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:45:43 INFO - Running setup.py (path:/tmp/pip-Ztg4c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:45:43 INFO - Running setup.py (path:/tmp/pip-kstIsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:45:43 INFO - Running setup.py (path:/tmp/pip-X7C0zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:45:43 INFO - Running setup.py (path:/tmp/pip-YS0efl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:45:43 INFO - Running setup.py (path:/tmp/pip-dV2Vos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:45:43 INFO - Running setup.py (path:/tmp/pip-UPXKoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:45:43 INFO - Running setup.py (path:/tmp/pip-xg5uBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:45:43 INFO - Running setup.py (path:/tmp/pip-ncua5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:45:43 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:45:43 INFO - Running setup.py (path:/tmp/pip-JzPnrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:43 INFO - Running setup.py (path:/tmp/pip-dbeFda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:44 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)) 14:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:45:44 INFO - Running setup.py (path:/tmp/pip-0cSnd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:45:44 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)) 14:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:45:44 INFO - Running setup.py (path:/tmp/pip-r5UhEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:45:44 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)) 14:45:44 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)) 14:45:44 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)) 14:45:44 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)) 14:45:44 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)) 14:45:44 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)) 14:45:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:46 INFO - Downloading blessings-1.6.tar.gz 14:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:45:46 INFO - Installing collected packages: blessings 14:45:46 INFO - Running setup.py install for blessings 14:45:46 INFO - Successfully installed blessings 14:45:46 INFO - Cleaning up... 14:45:46 INFO - Return code: 0 14:45:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:45:46 INFO - Reading from file tmpfile_stdout 14:45:46 INFO - Current package versions: 14:45:46 INFO - argparse == 1.2.1 14:45:46 INFO - blessings == 1.6 14:45:46 INFO - blobuploader == 1.2.4 14:45:46 INFO - docopt == 0.6.1 14:45:46 INFO - functools32 == 3.2.3-2 14:45:46 INFO - jsonschema == 2.5.1 14:45:46 INFO - manifestparser == 1.1 14:45:46 INFO - mozInstall == 1.12 14:45:46 INFO - mozcrash == 0.17 14:45:46 INFO - mozdebug == 0.1 14:45:46 INFO - mozdevice == 0.48 14:45:46 INFO - mozfile == 1.2 14:45:46 INFO - mozhttpd == 0.7 14:45:46 INFO - mozinfo == 0.9 14:45:46 INFO - mozleak == 0.1 14:45:46 INFO - mozlog == 3.2 14:45:46 INFO - moznetwork == 0.27 14:45:46 INFO - mozprocess == 0.22 14:45:46 INFO - mozprofile == 0.28 14:45:46 INFO - mozrunner == 6.11 14:45:46 INFO - mozscreenshot == 0.1 14:45:46 INFO - mozsystemmonitor == 0.3 14:45:46 INFO - moztest == 0.7 14:45:46 INFO - mozversion == 1.4 14:45:46 INFO - psutil == 3.1.1 14:45:46 INFO - requests == 1.2.3 14:45:46 INFO - wsgiref == 0.1.2 14:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:46 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 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:46 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 14:45:46 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 14:45:46 INFO - Using env: {'DISPLAY': ':0', 14:45:46 INFO - 'HOME': '/home/cltbld', 14:45:46 INFO - 'LANG': 'en_US.UTF-8', 14:45:46 INFO - 'LANGUAGE': 'en_US:en', 14:45:46 INFO - 'LOGNAME': 'cltbld', 14:45:46 INFO - 'MAIL': '/var/mail/cltbld', 14:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:46 INFO - 'MOZ_NO_REMOTE': '1', 14:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:46 INFO - 'NO_EM_RESTART': '1', 14:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:46 INFO - 'PWD': '/builds/slave/test', 14:45:46 INFO - 'SHELL': '/bin/bash', 14:45:46 INFO - 'SHLVL': '1', 14:45:46 INFO - 'TERM': 'linux', 14:45:46 INFO - 'TMOUT': '86400', 14:45:46 INFO - 'USER': 'cltbld', 14:45:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:46 INFO - '_': '/tools/buildbot/bin/python'} 14:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 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)) 14:45:46 INFO - Cleaning up... 14:45:46 INFO - Return code: 0 14:45:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:45:46 INFO - Using env: {'DISPLAY': ':0', 14:45:46 INFO - 'HOME': '/home/cltbld', 14:45:46 INFO - 'LANG': 'en_US.UTF-8', 14:45:46 INFO - 'LANGUAGE': 'en_US:en', 14:45:46 INFO - 'LOGNAME': 'cltbld', 14:45:46 INFO - 'MAIL': '/var/mail/cltbld', 14:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:46 INFO - 'MOZ_NO_REMOTE': '1', 14:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:46 INFO - 'NO_EM_RESTART': '1', 14:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:46 INFO - 'PWD': '/builds/slave/test', 14:45:46 INFO - 'SHELL': '/bin/bash', 14:45:46 INFO - 'SHLVL': '1', 14:45:46 INFO - 'TERM': 'linux', 14:45:46 INFO - 'TMOUT': '86400', 14:45:46 INFO - 'USER': 'cltbld', 14:45:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:46 INFO - '_': '/tools/buildbot/bin/python'} 14:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:45:47 INFO - Cleaning up... 14:45:47 INFO - Return code: 0 14:45:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:47 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73eff50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18eb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', '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 14:45:47 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', 'flake8'] in /builds/slave/test/build 14:45:47 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 flake8 14:45:47 INFO - Using env: {'DISPLAY': ':0', 14:45:47 INFO - 'HOME': '/home/cltbld', 14:45:47 INFO - 'LANG': 'en_US.UTF-8', 14:45:47 INFO - 'LANGUAGE': 'en_US:en', 14:45:47 INFO - 'LOGNAME': 'cltbld', 14:45:47 INFO - 'MAIL': '/var/mail/cltbld', 14:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:47 INFO - 'MOZ_NO_REMOTE': '1', 14:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:47 INFO - 'NO_EM_RESTART': '1', 14:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:47 INFO - 'PWD': '/builds/slave/test', 14:45:47 INFO - 'SHELL': '/bin/bash', 14:45:47 INFO - 'SHLVL': '1', 14:45:47 INFO - 'TERM': 'linux', 14:45:47 INFO - 'TMOUT': '86400', 14:45:47 INFO - 'USER': 'cltbld', 14:45:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:47 INFO - '_': '/tools/buildbot/bin/python'} 14:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:47 INFO - Downloading/unpacking flake8 14:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:45:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:45:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:45:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:45:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:45:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:45:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:45:50 INFO - no previously-included directories found matching 'docs/_build' 14:45:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:45:50 INFO - Running setup.py install for pep8 14:45:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:45:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:45:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:45:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:45:50 INFO - no previously-included directories found matching 'docs/_build' 14:45:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:45:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:45:50 INFO - Cleaning up... 14:45:50 INFO - Return code: 0 14:45:50 INFO - Running post-action listener: _resource_record_post_action 14:45:50 INFO - Running post-action listener: _start_resource_monitoring 14:45:50 INFO - Starting resource monitoring. 14:45:50 INFO - ##### 14:45:50 INFO - ##### Finished create-virtualenv step (success) 14:45:50 INFO - ##### 14:45:50 INFO - ##### 14:45:50 INFO - ##### Running install step. 14:45:50 INFO - ##### 14:45:50 INFO - Running pre-action listener: _resource_record_pre_action 14:45:50 INFO - Running main action method: install 14:45:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:45:50 INFO - Reading from file tmpfile_stdout 14:45:50 INFO - Detecting whether we're running mozinstall >=1.0... 14:45:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:45:50 INFO - Reading from file tmpfile_stdout 14:45:50 INFO - Output received: 14:45:50 INFO - Usage: mozinstall [options] installer 14:45:50 INFO - Options: 14:45:50 INFO - -h, --help show this help message and exit 14:45:50 INFO - -d DEST, --destination=DEST 14:45:50 INFO - Directory to install application into. [default: 14:45:50 INFO - "/builds/slave/test"] 14:45:50 INFO - --app=APP Application being installed. [default: firefox] 14:45:50 INFO - mkdir: /builds/slave/test/build/application 14:45:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:46:06 INFO - Reading from file tmpfile_stdout 14:46:06 INFO - Output received: 14:46:06 INFO - /builds/slave/test/build/application/firefox/firefox 14:46:06 INFO - Running post-action listener: _resource_record_post_action 14:46:06 INFO - ##### 14:46:06 INFO - ##### Finished install step (success) 14:46:06 INFO - ##### 14:46:06 INFO - ##### 14:46:06 INFO - ##### Running run-tests step. 14:46:06 INFO - ##### 14:46:06 INFO - Running pre-action listener: _resource_record_pre_action 14:46:06 INFO - Running main action method: run_tests 14:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:46:06 INFO - Python 2.7.3 14:46:06 INFO - Return code: 0 14:46:06 INFO - grabbing minidump binary from tooltool 14:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:06 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 0x197a1c0>, '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 0x197b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:46:06 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 14:46:06 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 14:46:06 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 14:46:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:46:06 INFO - Return code: 0 14:46:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:46:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:46:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:46:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:46:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:46:07 INFO - Return code: 0 14:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 14:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 14:46:07 INFO - Using env: {'DISPLAY': ':0', 14:46:07 INFO - 'HOME': '/home/cltbld', 14:46:07 INFO - 'LANG': 'en_US.UTF-8', 14:46:07 INFO - 'LANGUAGE': 'en_US:en', 14:46:07 INFO - 'LOGNAME': 'cltbld', 14:46:07 INFO - 'MAIL': '/var/mail/cltbld', 14:46:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:46:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:07 INFO - 'MOZ_NO_REMOTE': '1', 14:46:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:07 INFO - 'NO_EM_RESTART': '1', 14:46:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:07 INFO - 'PWD': '/builds/slave/test', 14:46:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:46:07 INFO - 'SHELL': '/bin/bash', 14:46:07 INFO - 'SHLVL': '1', 14:46:07 INFO - 'TERM': 'linux', 14:46:07 INFO - 'TMOUT': '86400', 14:46:07 INFO - 'USER': 'cltbld', 14:46:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782', 14:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:07 INFO - '_': '/tools/buildbot/bin/python'} 14:46:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 14:46:07 INFO - mozversion application_buildid: 20160609124436 14:46:07 INFO - mozversion application_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 14:46:07 INFO - mozversion application_display_name: Nightly 14:46:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:46:07 INFO - mozversion application_name: Firefox 14:46:07 INFO - mozversion application_remotingname: firefox 14:46:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:46:07 INFO - mozversion application_vendor: Mozilla 14:46:07 INFO - mozversion application_version: 50.0a1 14:46:07 INFO - mozversion platform_buildid: 20160609124436 14:46:07 INFO - mozversion platform_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 14:46:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:46:07 INFO - mozversion platform_version: 50.0a1 14:46:07 INFO - using testdate: 1465508767 14:46:07 INFO - actual date: 1465508767 14:46:07 INFO - starting webserver on 'localhost:55962' 14:46:07 INFO - SUITE-START | Running 2 tests 14:46:07 INFO - TEST-START | dromaeo_css 14:46:07 INFO - operating with platform_type : linux_ 14:46:07 INFO - Initialising browser for dromaeo_css test... 14:46:07 INFO - TEST-INFO | started process 10213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJhYO9D/profile http://localhost:55962/getInfo.html) 14:46:12 INFO - PROCESS | 10213 | __metrics Screen width/height:1600/1200 14:46:12 INFO - PROCESS | 10213 | colorDepth:24 14:46:12 INFO - PROCESS | 10213 | Browser inner width/height: 1024/697 14:46:12 INFO - PROCESS | 10213 | __metrics 14:46:13 ERROR - PROCESS | 10213 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:46:13 INFO - PROCESS | 10213 | console.error: PushService: 14:46:13 INFO - PROCESS | 10213 | stateChangeProcessEnqueue: Error transitioning state 14:46:13 INFO - PROCESS | 10213 | UnknownError 14:46:14 INFO - TEST-INFO | 10213: exit 0 14:46:14 INFO - Browser initialized. 14:46:14 INFO - Running cycle 1/1 for dromaeo_css test... 14:46:14 INFO - TEST-INFO | started process 10294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJhYO9D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:26 INFO - PROCESS | 10294 | RSS: Main: 157020160 14:46:26 INFO - PROCESS | 10294 | 14:47:17 INFO - PROCESS | 10294 | 1465508837579 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] 14:49:29 INFO - PROCESS | 10294 | Cycle 1(1): loaded http://localhost:55962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55962/tests/dromaeo/cssquery-ext.html) 14:49:30 INFO - PROCESS | 10294 | RSS: Main: 268189696 14:49:30 INFO - PROCESS | 10294 | 14:52:33 INFO - PROCESS | 10294 | Cycle 1(1): loaded http://localhost:55962/tests/dromaeo/cssquery-ext.html (next: http://localhost:55962/tests/dromaeo/cssquery-jquery.html) 14:52:33 INFO - PROCESS | 10294 | RSS: Main: 242106368 14:52:33 INFO - PROCESS | 10294 | 14:55:35 INFO - PROCESS | 10294 | Cycle 1(1): loaded http://localhost:55962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55962/tests/dromaeo/cssquery-mootools.html) 14:55:36 INFO - PROCESS | 10294 | RSS: Main: 237441024 14:55:36 INFO - PROCESS | 10294 | 14:58:38 INFO - PROCESS | 10294 | Cycle 1(1): loaded http://localhost:55962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55962/tests/dromaeo/cssquery-prototype.html) 14:58:39 INFO - PROCESS | 10294 | RSS: Main: 237666304 14:58:39 INFO - PROCESS | 10294 | 15:01:42 INFO - PROCESS | 10294 | Cycle 1(1): loaded http://localhost:55962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55962/tests/dromaeo/cssquery-yui.html) 15:01:42 INFO - PROCESS | 10294 | RSS: Main: 217526272 15:01:42 INFO - PROCESS | 10294 | 15:04:45 INFO - PROCESS | 10294 | Cycle 1(1): loaded http://localhost:55962/tests/dromaeo/cssquery-yui.html (next: http://localhost:55962/tests/dromaeo/cssquery-dojo.html) 15:04:46 INFO - PROCESS | 10294 | RSS: Main: 288813056 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - PROCESS | 10294 | __start_tp_report 15:04:46 INFO - PROCESS | 10294 | _x_x_mozilla_page_load 15:04:46 INFO - PROCESS | 10294 | _x_x_mozilla_page_load_details 15:04:46 INFO - PROCESS | 10294 | |i|pagename|runs| 15:04:46 INFO - PROCESS | 10294 | |0;dojo.html;2633.2890119667686;2664.160789351353;2679.4373181631863;2701.149138021523;2701.6893057298403;4588.9770551147285;4645.3264276679865;4673.228917228653;4731.053789242148;4771.950170962387;4626.653001024928;4672.579467847893;4680.227762419206;4694.014257006024;4702.012577358751;4254.149170165963;4270.0605866709275;4274.679399045084;4324.027093903878;4399.758013309267;4317.222899878021;4350.086481838817;4415.580519850625;4444.355568442574;4444.97777511112;4206.768627725474;4348.934765978513;4367.672424568154;4393.0994146199955;4401.427814384126;4225.852095176654;4233.745975241495;4248.383984322287;4275.679324050678;4285.657147428198;4213.536510983789;4272.5727427257025;4314;4338.479382474092;4373.518912919576;4389.912201755947;4646.883827904296;4648.163330600491;4668.906621867578;4675.719456832601;4943.085529177114;4999.600031997432;5010.624203184776;5080.237964305346;5081.110805609041;5073.2643766654;5087.262346959707;5088.160453525164;5092.9745351273;5105.897882042375;4552.908941821145;4610.216263235258;4650.697704649187;4693.6010439112715;4709.670323077386;5052.418971818214;5121.95000024994;5160.329157209539;5166.070107380632;5177.715225662625;4947.703137811743;4953.752312384367;4955.380577427822;4956.8760780980765;4957.950420495821;4866.075445665383;4937.432195297587;4940.950590494121;4998.02538504988;5039.042581909499;4946.629002824802;4964.205727083649;4967.453580106186;4968;5007.674501157413;4947.727874966839;4952.752362381866;4953.554180123734;4966.726830024383;4988.72562009093;4024.0342317844093;4063.6952228582973;4127.731697439657;4129.628333449944;4201.705880588391;3644.927101457956;3667.339878821784;3689.1146124929824;3689.6863766579604;3709.5919448861146;4387.934180987288;4393.604575588212;4394.714343567658;4397.384366188736;4437.755923424243;4930.728809915489;4981.825636102792;4989.476105008995;5027.4469808321055;5040.6219533534395;4395.406620106245;4421.845235416745;4450.421445212101;4469.5306992765945;4469.776511174428;4514.593686568224;4515.683902126885;4525.117602067565;4527.411436513298;4568.977155114203;4538.614217791524;4752.643551733703;4764.380630518011;4774;4806.903861922672;5105.617078719037;5126.871828204325;5128.282040514406;5129.74351282427;5162.535371816554;4855.514448555116;4856.004519073652;4856.271559266138;4856.660033797601;4886.511348865085;4798.184308667465;4822.855314340575;4855.393075865517;4874;5045.520675535819;4925.778339974781;4944.950550494449;4948.653594248368;4950.084234416644;5001.049800537886;4787.473377928494;4794.2089555223;4799.136155492045;4842.8619274471175;4852.199387101089;4821.397325334333;4839.758012099311;4859.611231101433;4887.3890763654545;4898;4825.469198388104;4828.203346447937;4890.217565189552;4894.216925291937;4894.877628059327;4802.375691160127;4920.778564964514;4921.6062714982;4954.405471343462;4976.427710813303;4744.240921452551;4748.715077095385;4778.187708089564;4787.880302992314;4795.616350692006 15:04:46 INFO - PROCESS | 10294 | |1;ext.html;571.7941541045226;572.7050568956985;575.5108158065644;580.1877371679648;580.3239226301358;27793.44413111739;40202.396964045525;41665.16669666605;41735.58264417351;45105.32342014872;40955.18089638205;41275;41303;41329.17341653165;41368.58631413693;7784.961075194616;7936.5238085714755;7937.126916039231;7938.1664925182895;7938.245866642688;7706.266090129704;7741.845163096735;7797.961010194941;7804.570748608824;7809;7813.648385822652;7851.842963140763;7852.05775306964;7852.685892564291;7854.057513098436;7801.375889928792;7815.804604884895;7839.412044096659;7843.098043724987;7849.4897831640765;7713.3443657288635;7790.104138024143;7808.297253247179;7816.49192802466;7818.648160832776;38187.42718859219;38538.22923541541;38564.421533677014;38651.61348386508;38655.42016869749;3087.8764849405998;3113.828739419331;3204.7115759581748;3586.7309951753464;3893.0851249956236;29067.12798616045;29693.851530742424;30237.848810756026;31760.364792704248;31788.682113179035;3320.3027364253535;3557.6661472632336;3578.928421431583;3615.6926661233565;3721.404575267944;251180;253097;253256;253459;253986;28538;28893.71106288952;56758.71620641871;56890.14664780031;57376.13935790966;34464.82767586146;34551.82724086363;34640.30719385598;34657.826710866284;34668.13329666779;13751.518696845562;13869.791953120712;13877.514286999907;13885.791713124312;13886.23625700576;10804.837927431096;10805.513751881184;10808.891911080946;10815.35107893529;10815.945920270506;7834.138244793068;7937.936136604524;7945.642446089824;8035.799105022421;8040.517568945765;3101.8449077546034;3125;3130.6869313068964;3148.496240601493;3148.8110713357273;891.1266958380694;892.4511425473416;896.7309807057857;925.5557332480313;942.8397172480695;27086.45827083447;28162;28196.57438757187;28457.288567785556;28840.855795720887;830.3025458614793;918.9494577798151;964.8793900762405;976.0337266106645;1020.8468729690605;14885;15180.468683596022;15230.619234519005;15305.770413443808;15365.665896843637;358212;364083;364363;364692;365543;48743.75628121837;50124.74937625288;50230.74884625627;50308.49691503038;50332.74833625882;1052.4264275969615;1176.9823452648218;1188.9464974076188;1207.6920385301692;1215.9452824622913;27248.318792029564;28387.290317742223;28469.145925622266;28781.56827647629;29043.709562904947;42859.357109642755;42878;43275.35086973635;43341.783291084605;43409;307121;308594;308799;309065;538715;25164.87417562974;25679.743202567734;25803.741962580134;26819.731802681723;26874;41720.91987028788;42061;42290;42569.57430425656;43745.78127109344;34904.65095349014;35240;36133;36133.457998129525;36312.27375452529;35392;36049;36230;36318.818405907805;36417.27165456623;35188;36108.81945590255;36114.27771444504;36220.27559448744;36221.45667814932;29988.550171747003;31563.84218078895;31802.363952720352;32054.19864503406;32288.83855580707;24515.397920436248;24788.38029049288;24819.379515511533;25039.749602503744;25042.248732538053 15:04:46 INFO - PROCESS | 10294 | |2;jquery.html;354.15533951525606;358.46767550187974;358.7650089191579;376.2118362031543;378.74245513051113;15619.843801561981;16569.75145372819;17574.736378954327;17575.209115589798;17591.824081759194;14867.702645947102;14919.254037298146;15306.923465382686;15370.231488425561;15391.538253852374;4401.669874759382;4702.553257440538;4714.198586240347;4777.904441911177;4786.449558300805;3463.722902167833;3650.4159334506485;4667.7199368037855;6547.541672082956;6943.548669336477;6716.1604799400075;6924.723011079551;7029.578225306498;7057.752978645748;7080.362767350937;6947.40947019504;6975.720971161148;6979.930200697979;6980.825479363006;7018.789436316919;3821.102041020358;6112.602680825777;6443.645599492026;6452.967735161341;6763.053172555797;22946.65580016301;23144.42138946523;23148.88425557878;23368.182113625942;23368.182113626113;2015.0629957070032;2025.574629327843;2075.6374673029636;2251.3020963501203;2267.841251112423;13590.796138057936;14074.499139243013;14208.573742787732;14235.857641423558;14747;1866.850651947841;1890.8487321014286;1921.4790712021897;1927.7493925789558;2005.81947624713;77780;79620.99999999942;79911;81017.59491202566;82030;16068.517944461684;16241.91879040621;16452.670946581242;16490.20725233203;16603.252853621616;29500.262493437836;29545.85227073851;29719.25701857471;29787.55318670222;29832.701672983425;9119.908800911906;9431.669891553762;9441.103095205945;9572.664956726621;9647.324687271823;7834.804129896798;7867.370610351159;7875.330596899214;7963.8805417918775;7970.242826931432;8284.378671599654;8501.702440414556;8549.487030778173;8567.914320856711;8630.870536941951;2519.91180308692;3215.347473014211;3316.6683331667123;3454.6372630873398;3535.5022939329074;777.941654375924;803.1727320859524;892.8839250897341;949.1362859797551;962.855571664256;16005.519834404986;16356;16362.672746545002;16528.917355413145;16888.071156086535;820.5938060660012;877.7542288159326;892.7366426904078;894.1594900793234;900.9819803603891;8931.598078086501;9359.906400936039;9361.812763744823;9397.248220142508;9583.137517623447;380507;388517;390086;394192;396207;70950;72951;74359.62820185973;74428.62785686037;75859;889.8398288308038;908.8636704494246;909.4588719711761;923.630547780893;925.8009527951523;14338.211398373189;14667;15736.159019282015;16481.505554833373;16588.336466541205;35795.284094318486;36349;36962.344099775626;37259.44110838394;37538.24923501569;46326;51166.74416627893;51551.742241290056;51647.741761290956;51706.74146629243;6759.425448836904;6955.539336739139;7248.420126389981;7250.60121693312;7725.845483090195;5974.940250597612;8532.488050716976;11159.944200278947;11363.829542557034;12060.396980151132;10420.739481513023;10513.421761802869;10587.20595955291;10601.946990265;10666.360018398611;9766.706998790047;9855.45794981283;9914.752131196778;9945.552450139616;9950.900490994998;5469.480399362054;7200.1719802223415;8074.540357737824;9738.659146929824;9903.405795651996;6699.899501507579;6931.653417329214;7164.713411463692;7933.880991785243;8042.67829286822;10527.157827373945;10554.050135487536;10787.352758834495;10899.891001089887;11019.669409917715 15:04:46 INFO - PROCESS | 10294 | |3;mootools.html;1184.0764203920944;1376.4150236149635;1398.8111604933333;1460.430432131469;1730.9048002359873;6758.729650813968;7437.367823734982;7705.499142555737;7714.575698336589;7919.326857217129;7762.184970578092;7855.25375089367;7868.960655196716;7883.80290492738;7896.289333959942;1827.369557502666;2073.8548301618894;2138.2302371146416;2149.6345621244427;2166.11189412341;2187.223535644847;2205.8014778669917;2208.9226877059305;2210.171185805323;2210.4473881529616;2138.7968143026465;2153.752318483379;2178.0307763045453;2180.4875854174334;2180.8364372672036;1769.062396929623;2041.2651445479617;2078.5011597216635;2101.9910442987452;2105.884176370299;2135.8718476891436;2147.473868902129;2150.0754675489534;2150.6989021536997;2155.041006751996;7751.069871615386;7799.220077992212;7828.452008359417;7832.804179895548;7851.725189618336;4311.525732169459;4425.911481770347;4437.556244375537;4451.109778044404;4456.331550267453;2668.3996100877343;2827.9293017674518;2834.829910205374;2840.247334456371;2842.616246806696;813.7111325479428;831.1563762780783;845.7166849105557;846.0735494633367;849.9362547808877;10612;10616.734581635521;10657.893421065768;10690.946545267223;10735.677929662123;4003.459532963013;4083.2854250506043;4134.462519872457;4164.3961625564125;4182.1008483176265;9093.681721139728;9104.908950910538;9119.042500537347;9151.405158664666;9152.130547597968;4528.705634133771;4535.863924082283;4540.02389486262;4541;4547.681662283609;3653.1415117447377;4061.2283666103936;4125.092479654471;4169.145325208325;4234.1108367242605;3559.341521818472;3565.4830049642655;3683.1528748387486;3703.222323312081;3712.461693054492;1122.2424863217295;1152.6311580294393;1163.8603367595942;1167.2996202278734;1169.771894480568;693.8785712500293;827.8096037911314;828.3125006244923;859.4155973937658;861.3066481482467;5142;5387.023804173605;5414.07960646691;5438.728063596884;5538.280023596906;398.9880303590897;403.4472772301965;408.6016134269123;408.73636504455055;412.72759978414103;3680.5583330000036;3711.9443208351895;3743.794091324949;3769;3817.6945844332386;9259.120383563686;9633.662821801203;9725.319227653996;9727.562259698188;9750.90249097514;9459.432434053979;9616.567254473566;9661.082197191256;9681.225501959827;9685.951570242245;7382.114146302478;7386.3352298294485;7481.177070522238;7489.85020299591;7501.774946751606;5070.847874563769;5071.239314102914;5109.310243117132;5255.080360936744;5258.158694608845;8868.64525418976;8878.357503861806;8994.235489983163;9040;9101.499417532099;8417.368697347845;8747.693830715894;8827;9080.682176123804;9103.544822758968;6143.262808463013;6636.369544893228;6730.125083739083;6837.555558888856;6858.897116543156;7662.961685191538;7711.652975615999;7731.845363092819;7736.690532378641;7744.070711514429;6727.327267273429;6788.185417749902;6845.5550389224545;6880.931190688029;7140.036095127091;6641.833954151185;6662.267150613526;6674.132362792806;6773.830654233487;6889.138857642794;6223.906641400292;6254.530910181846;6276.152719382825;6362.745490180341;6378.77674281398;4741.431028276491;4749.4063242094735;4770.499097594703;4780.450248221499;4837.588804951619;4536.455625324982;4647.65142614312;4686.882827929329;4743.905121897612;4760.619150468024 15:04:46 INFO - PROCESS | 10294 | |4;prototype.html;279.2376811305137;282.78508333666406;283.40020583804437;285.4020826368757;290.34092609775803;4703.965127671911;4743.549362810528;4743.691660042099;4766.571008609225;4773.711098003537;4598.793054312556;4638.165130276549;4643.605293550044;4667.973045929898;4714.834980775673;3509.227969846636;3596.029072150518;3597.118705917041;3685.281370132812;3713.814309284525;3676.1544844685736;3686.889393318205;3688.0779805048737;3704.9259014819686;3734.4024956007042;3500.8599656013857;3685.8709945151927;3688.336099502102;3696.20531585709;3699.167687270356;3555.448905419651;3687;3698.556173259199;3710.239400922804;3715.386961151407;3274.2796584751554;3279.918002049968;3283.91630761848;3287.161773747703;3308.8676452941854;4496.617787488068;4509.7970591323465;4530.728156310632;4532.070925460305;4546.976930190714;3928.921421571581;4165.97917010413;4180.456540649727;4238.491381034265;4244.129953359585;4879.389526603286;4904.779284932151;4907.656464047518;4929.22547882762;4953.6037117030555;3527.894163175109;3530.7642325186234;3532;3532.858685652571;3538.7699799513207;4996.000799840047;5149.407818100929;5184.326037615124;5204.334612923866;5207.739613019372;3474.1488335358;3476.11359103427;3479.9652003480146;3491.546099007113;3495.07380544156;3540.415831387792;3540.5574303212097;3547.787132772042;3551.7391326079387;3554.7689400188906;4120.866761640573;4122.443470131554;4125.958740412618;4132.194222126716;4142.5857414258935;4689.882752931136;4873.561379475864;4887.926681099786;4896.3389942358035;4973.502649734997;1207.7825991321647;1209.5585111434264;1213.5327898759042;1218.4760552962312;1224.6081253998814;762.4853224073728;773.7640019794017;774.2992591704516;774.7714424244862;787.629813987425;4308.482982042112;4336.414584031116;4345.609404990373;4455.376247325377;4473.284274516127;5036.395632524047;5045.167547354646;5045.924311135336;5071.822486213038;5083.466236045162;4319.848805291863;4387.166438376698;4401.163778882003;4438.245498265303;4447.933281000787;2658.2955516788065;2667.399835037101;2676.585129304961;2680.557707978162;2689.892404303806;4776.471529110651;4778.354922085544;4779.928301075487;4805.4233491980485;4806.951930480651;4904.337914381585;5141.460146684619;5169.172932330809;5171.017506673795;5172.741362931838;4761.928571071506;4774.785134668949;4783.378160839069;4818.614510839195;4825.431734686241;5042.235217673785;5054.74726263678;5067.746612669278;5078.441371449064;5082.872928176826;4650.465196502446;4937.530934561211;4961.677490963076;4985.651004429655;4998.3002379667605;4787.976060119677;4808.595702148926;4809.278608208657;4811.831585894477;4819.674589487779;3497.772644778183;3540.1857572758927;3541.5750109986966;3546.255286389887;3549.272399158218;4815.133276010351;5094.108531007133;5111.983929481624;5117.15566931467;5121.8463446096675;4908.9754551227015;4916.06594746997;4921.581665558325;4929.9014019720125;4932.062908047459;4916.778744956557;4923.704577725348;4925.433575138762;4951.183054795918;4954.5788607968725;4562.292844609091;4888.266759986031;4898.583620392306;4903.190973489334;4903.60771138301;4740.360051393156;4800.855974320776;4903.190973489334;4975;4984.352034235526;4853.296272040605;4867.9269810952155;4888.169011268022;4901.877453063702;4909.803607855646 15:04:46 INFO - PROCESS | 10294 | |5;yui.html;624.9562530622858;625.1685258606054;640.7533099756594;733.2594079979219;747.6261869065465;11965.042796576265;12841;12945.676358091052;12950.093493455463;13044.347782610856;12687.809682854764;13179.802302965463;13207.603771886836;13282.601521954357;13457.461701531927;786.3984052200071;794.0868001797921;798.9440739148262;799.0890384961149;799.1768478467159;633.2243002322142;768.2240936653964;792.7304716396424;800.3477166109602;802.2779498451382;825.5542007316042;828.2545708862042;828.5318794880903;829.701307529292;831.3432388413146;574.1015311038212;821.6015232612178;822.2928281677753;823.9464434811748;825.8926339575846;578.5747475605426;598.9970050149722;599.7541008186666;600.1058422949817;600.5195843325322;13021.609351719464;13032.218066916015;13416.262105584188;13456.663583410394;13458.259795711232;12419.75160496785;12831;12872.678183045406;12877.291748953803;12958.87041129586;11887.465064072137;12023.458944347525;12105.45525451348;12128.393580320948;12430.627081187578;3961.1879564689457;4006.1186538961383;4025.778582177979;4120.402541631476;4198.9370159447635;59388;59472;60235.39764602342;60482;60492.85810706095;10152.137068349273;10300.175985921109;10319.535620896928;10473.895261047444;10760.569577216824;16539.83460165383;16576.502704918872;16606.169691515377;16613.08628025446;16649.750253746202;6575.309592492815;6627.801165965029;6666.533342665967;6681.600762930301;6870.3473170048765;3668.1563240454843;3721.6650501455;3760.0599850037493;3780.6597406233573;3880.010597297671;2703.45930813838;2798.888044478198;2800.383915538578;2800.957985630217;2801.8038737288603;471.9811207551728;474.962003039756;479.53964194373094;487.3858937738475;488.62131847817517;494.29069285575315;497.477648469106;565.5277843001057;602.2471910112359;603.7592746905152;7667.233276672288;8281.710140145065;8293.792655183548;8664.913350866536;9054.909450905538;527.1828665568354;587.4859497939303;613.1140501974604;620.5997131849931;628.5286035473395;3947.4078888167005;4001.2797696414923;4115.176964607091;4127.318992366226;4143.772092534879;85607.57196213979;86208.56895715481;87537.56231218803;88143.55928220446;88536.11463885408;73462.6326868373;79195.20804791994;79593.60203198947;79598.60200698959;82784.52223009158;72088;72506.63746681233;72876;74309;74613;8052.751823467372;8075.232852878967;8134.186581341818;8185.304249138651;8220.794480138044;44465.777671111435;44648.33027504655;45017.774911125234;45176;45437.545624544655;54050;61867.38132618796;62201.37798621956;62754;63386;10114.393136411838;10169.9491502542;10289.74275643115;10555.15558755313;10591.94704026475;11240.887591123985;11421.200515964136;11518.07855371585;11980.880191198325;11998.460069297078;10081.344712593658;10585.259031867696;10594.841077383999;10596.258261921592;10632.681019569425;10940.124790016938;11147.331160130094;11325.093992480417;11651.650450486499;11661.300321980709;10046.648367307109;10229.43738094412;10578.312409693346;11021.859888902069;11441;9901.752456188653;9915.30592858493;10231.181505479693;10388.37669739818;10525.263231573716;9516.809663806824;10209;10215.94892025535;10542.736431588964;10700.143988480748 15:04:46 INFO - PROCESS | 10294 | __end_tp_report 15:04:46 INFO - PROCESS | 10294 | __start_cc_report 15:04:46 INFO - PROCESS | 10294 | _x_x_mozilla_cycle_collect,1017 15:04:46 INFO - PROCESS | 10294 | __end_cc_report 15:04:46 INFO - PROCESS | 10294 | __startTimestamp1465509886238__endTimestamp 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - PROCESS | 10294 | ------- Summary: start ------- 15:04:46 INFO - PROCESS | 10294 | Number of tests: 6 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - PROCESS | 10294 | [#0] dojo.html Cycles:165 Average:4633.72 Median:4787.47 stddev:480.71 (10.0%) stddev-sans-first:455.85 15:04:46 INFO - PROCESS | 10294 | Values: 2633.3 2664.2 2679.4 2701.1 2701.7 4589.0 4645.3 4673.2 4731.1 4772.0 4626.7 4672.6 4680.2 4694.0 4702.0 4254.1 4270.1 4274.7 4324.0 4399.8 4317.2 4350.1 4415.6 4444.4 4445.0 4206.8 4348.9 4367.7 4393.1 4401.4 4225.9 4233.7 4248.4 4275.7 4285.7 4213.5 4272.6 4314.0 4338.5 4373.5 4389.9 4646.9 4648.2 4668.9 4675.7 4943.1 4999.6 5010.6 5080.2 5081.1 5073.3 5087.3 5088.2 5093.0 5105.9 4552.9 4610.2 4650.7 4693.6 4709.7 5052.4 5122.0 5160.3 5166.1 5177.7 4947.7 4953.8 4955.4 4956.9 4958.0 4866.1 4937.4 4941.0 4998.0 5039.0 4946.6 4964.2 4967.5 4968.0 5007.7 4947.7 4952.8 4953.6 4966.7 4988.7 4024.0 4063.7 4127.7 4129.6 4201.7 3644.9 3667.3 3689.1 3689.7 3709.6 4387.9 4393.6 4394.7 4397.4 4437.8 4930.7 4981.8 4989.5 5027.4 5040.6 4395.4 4421.8 4450.4 4469.5 4469.8 4514.6 4515.7 4525.1 4527.4 4569.0 4538.6 4752.6 4764.4 4774.0 4806.9 5105.6 5126.9 5128.3 5129.7 5162.5 4855.5 4856.0 4856.3 4856.7 4886.5 4798.2 4822.9 4855.4 4874.0 5045.5 4925.8 4945.0 4948.7 4950.1 5001.0 4787.5 4794.2 4799.1 4842.9 4852.2 4821.4 4839.8 4859.6 4887.4 4898.0 4825.5 4828.2 4890.2 4894.2 4894.9 4802.4 4920.8 4921.6 4954.4 4976.4 4744.2 4748.7 4778.2 4787.9 4795.6 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - PROCESS | 10294 | [#1] ext.html Cycles:180 Average:46768.84 Median:19917.98 stddev:87723.00 (440.4%) stddev-sans-first:87900.51 15:04:46 INFO - PROCESS | 10294 | Values: 571.8 572.7 575.5 580.2 580.3 27793.4 40202.4 41665.2 41735.6 45105.3 40955.2 41275.0 41303.0 41329.2 41368.6 7785.0 7936.5 7937.1 7938.2 7938.2 7706.3 7741.8 7798.0 7804.6 7809.0 7813.6 7851.8 7852.1 7852.7 7854.1 7801.4 7815.8 7839.4 7843.1 7849.5 7713.3 7790.1 7808.3 7816.5 7818.6 38187.4 38538.2 38564.4 38651.6 38655.4 3087.9 3113.8 3204.7 3586.7 3893.1 29067.1 29693.9 30237.8 31760.4 31788.7 3320.3 3557.7 3578.9 3615.7 3721.4 251180.0 253097.0 253256.0 253459.0 253986.0 28538.0 28893.7 56758.7 56890.1 57376.1 34464.8 34551.8 34640.3 34657.8 34668.1 13751.5 13869.8 13877.5 13885.8 13886.2 10804.8 10805.5 10808.9 10815.4 10815.9 7834.1 7937.9 7945.6 8035.8 8040.5 3101.8 3125.0 3130.7 3148.5 3148.8 891.1 892.5 896.7 925.6 942.8 27086.5 28162.0 28196.6 28457.3 28840.9 830.3 918.9 964.9 976.0 1020.8 14885.0 15180.5 15230.6 15305.8 15365.7 358212.0 364083.0 364363.0 364692.0 365543.0 48743.8 50124.7 50230.7 50308.5 50332.7 1052.4 1177.0 1188.9 1207.7 1215.9 27248.3 28387.3 28469.1 28781.6 29043.7 42859.4 42878.0 43275.4 43341.8 43409.0 307121.0 308594.0 308799.0 309065.0 538715.0 25164.9 25679.7 25803.7 26819.7 26874.0 41720.9 42061.0 42290.0 42569.6 43745.8 34904.7 35240.0 36133.0 36133.5 36312.3 35392.0 36049.0 36230.0 36318.8 36417.3 35188.0 36108.8 36114.3 36220.3 36221.5 29988.6 31563.8 31802.4 32054.2 32288.8 24515.4 24788.4 24819.4 25039.7 25042.2 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - PROCESS | 10294 | [#2] jquery.html Cycles:180 Average:25477.98 Median:4746.05 stddev:64400.04 (1356.9%) stddev-sans-first:64553.07 15:04:46 INFO - PROCESS | 10294 | Values: 354.2 358.5 358.8 376.2 378.7 15619.8 16569.8 17574.7 17575.2 17591.8 14867.7 14919.3 15306.9 15370.2 15391.5 4401.7 4702.6 4714.2 4777.9 4786.4 3463.7 3650.4 4667.7 6547.5 6943.5 6716.2 6924.7 7029.6 7057.8 7080.4 6947.4 6975.7 6979.9 6980.8 7018.8 3821.1 6112.6 6443.6 6453.0 6763.1 22946.7 23144.4 23148.9 23368.2 23368.2 2015.1 2025.6 2075.6 2251.3 2267.8 13590.8 14074.5 14208.6 14235.9 14747.0 1866.9 1890.8 1921.5 1927.7 2005.8 77780.0 79621.0 79911.0 81017.6 82030.0 16068.5 16241.9 16452.7 16490.2 16603.3 29500.3 29545.9 29719.3 29787.6 29832.7 9119.9 9431.7 9441.1 9572.7 9647.3 7834.8 7867.4 7875.3 7963.9 7970.2 8284.4 8501.7 8549.5 8567.9 8630.9 2519.9 3215.3 3316.7 3454.6 3535.5 777.9 803.2 892.9 949.1 962.9 16005.5 16356.0 16362.7 16528.9 16888.1 820.6 877.8 892.7 894.2 901.0 8931.6 9359.9 9361.8 9397.2 9583.1 380507.0 388517.0 390086.0 394192.0 396207.0 70950.0 72951.0 74359.6 74428.6 75859.0 889.8 908.9 909.5 923.6 925.8 14338.2 14667.0 15736.2 16481.5 16588.3 35795.3 36349.0 36962.3 37259.4 37538.2 46326.0 51166.7 51551.7 51647.7 51706.7 6759.4 6955.5 7248.4 7250.6 7725.8 5974.9 8532.5 11159.9 11363.8 12060.4 10420.7 10513.4 10587.2 10601.9 10666.4 9766.7 9855.5 9914.8 9945.6 9950.9 5469.5 7200.2 8074.5 9738.7 9903.4 6699.9 6931.7 7164.7 7933.9 8042.7 10527.2 10554.1 10787.4 10899.9 11019.7 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - PROCESS | 10294 | [#3] mootools.html Cycles:180 Average:5118.68 Median:5071.04 stddev:2917.22 (57.5%) stddev-sans-first:2910.41 15:04:46 INFO - PROCESS | 10294 | Values: 1184.1 1376.4 1398.8 1460.4 1730.9 6758.7 7437.4 7705.5 7714.6 7919.3 7762.2 7855.3 7869.0 7883.8 7896.3 1827.4 2073.9 2138.2 2149.6 2166.1 2187.2 2205.8 2208.9 2210.2 2210.4 2138.8 2153.8 2178.0 2180.5 2180.8 1769.1 2041.3 2078.5 2102.0 2105.9 2135.9 2147.5 2150.1 2150.7 2155.0 7751.1 7799.2 7828.5 7832.8 7851.7 4311.5 4425.9 4437.6 4451.1 4456.3 2668.4 2827.9 2834.8 2840.2 2842.6 813.7 831.2 845.7 846.1 849.9 10612.0 10616.7 10657.9 10690.9 10735.7 4003.5 4083.3 4134.5 4164.4 4182.1 9093.7 9104.9 9119.0 9151.4 9152.1 4528.7 4535.9 4540.0 4541.0 4547.7 3653.1 4061.2 4125.1 4169.1 4234.1 3559.3 3565.5 3683.2 3703.2 3712.5 1122.2 1152.6 1163.9 1167.3 1169.8 693.9 827.8 828.3 859.4 861.3 5142.0 5387.0 5414.1 5438.7 5538.3 399.0 403.4 408.6 408.7 412.7 3680.6 3711.9 3743.8 3769.0 3817.7 9259.1 9633.7 9725.3 9727.6 9750.9 9459.4 9616.6 9661.1 9681.2 9686.0 7382.1 7386.3 7481.2 7489.9 7501.8 5070.8 5071.2 5109.3 5255.1 5258.2 8868.6 8878.4 8994.2 9040.0 9101.5 8417.4 8747.7 8827.0 9080.7 9103.5 6143.3 6636.4 6730.1 6837.6 6858.9 7663.0 7711.7 7731.8 7736.7 7744.1 6727.3 6788.2 6845.6 6880.9 7140.0 6641.8 6662.3 6674.1 6773.8 6889.1 6223.9 6254.5 6276.2 6362.7 6378.8 4741.4 4749.4 4770.5 4780.5 4837.6 4536.5 4647.7 4686.9 4743.9 4760.6 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - PROCESS | 10294 | [#4] prototype.html Cycles:180 Average:4081.27 Median:4678.93 stddev:1196.89 (25.6%) stddev-sans-first:1165.73 15:04:46 INFO - PROCESS | 10294 | Values: 279.2 282.8 283.4 285.4 290.3 4704.0 4743.5 4743.7 4766.6 4773.7 4598.8 4638.2 4643.6 4668.0 4714.8 3509.2 3596.0 3597.1 3685.3 3713.8 3676.2 3686.9 3688.1 3704.9 3734.4 3500.9 3685.9 3688.3 3696.2 3699.2 3555.4 3687.0 3698.6 3710.2 3715.4 3274.3 3279.9 3283.9 3287.2 3308.9 4496.6 4509.8 4530.7 4532.1 4547.0 3928.9 4166.0 4180.5 4238.5 4244.1 4879.4 4904.8 4907.7 4929.2 4953.6 3527.9 3530.8 3532.0 3532.9 3538.8 4996.0 5149.4 5184.3 5204.3 5207.7 3474.1 3476.1 3480.0 3491.5 3495.1 3540.4 3540.6 3547.8 3551.7 3554.8 4120.9 4122.4 4126.0 4132.2 4142.6 4689.9 4873.6 4887.9 4896.3 4973.5 1207.8 1209.6 1213.5 1218.5 1224.6 762.5 773.8 774.3 774.8 787.6 4308.5 4336.4 4345.6 4455.4 4473.3 5036.4 5045.2 5045.9 5071.8 5083.5 4319.8 4387.2 4401.2 4438.2 4447.9 2658.3 2667.4 2676.6 2680.6 2689.9 4776.5 4778.4 4779.9 4805.4 4807.0 4904.3 5141.5 5169.2 5171.0 5172.7 4761.9 4774.8 4783.4 4818.6 4825.4 5042.2 5054.7 5067.7 5078.4 5082.9 4650.5 4937.5 4961.7 4985.7 4998.3 4788.0 4808.6 4809.3 4811.8 4819.7 3497.8 3540.2 3541.6 3546.3 3549.3 4815.1 5094.1 5112.0 5117.2 5121.8 4909.0 4916.1 4921.6 4929.9 4932.1 4916.8 4923.7 4925.4 4951.2 4954.6 4562.3 4888.3 4898.6 4903.2 4903.6 4740.4 4800.9 4903.2 4975.0 4984.4 4853.3 4867.9 4888.2 4901.9 4909.8 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - PROCESS | 10294 | [#5] yui.html Cycles:180 Average:17088.12 Median:45306.77 stddev:23808.04 (52.5%) stddev-sans-first:23842.73 15:04:46 INFO - PROCESS | 10294 | Values: 625.0 625.2 640.8 733.3 747.6 11965.0 12841.0 12945.7 12950.1 13044.3 12687.8 13179.8 13207.6 13282.6 13457.5 786.4 794.1 798.9 799.1 799.2 633.2 768.2 792.7 800.3 802.3 825.6 828.3 828.5 829.7 831.3 574.1 821.6 822.3 823.9 825.9 578.6 599.0 599.8 600.1 600.5 13021.6 13032.2 13416.3 13456.7 13458.3 12419.8 12831.0 12872.7 12877.3 12958.9 11887.5 12023.5 12105.5 12128.4 12430.6 3961.2 4006.1 4025.8 4120.4 4198.9 59388.0 59472.0 60235.4 60482.0 60492.9 10152.1 10300.2 10319.5 10473.9 10760.6 16539.8 16576.5 16606.2 16613.1 16649.8 6575.3 6627.8 6666.5 6681.6 6870.3 3668.2 3721.7 3760.1 3780.7 3880.0 2703.5 2798.9 2800.4 2801.0 2801.8 472.0 475.0 479.5 487.4 488.6 494.3 497.5 565.5 602.2 603.8 7667.2 8281.7 8293.8 8664.9 9054.9 527.2 587.5 613.1 620.6 628.5 3947.4 4001.3 4115.2 4127.3 4143.8 85607.6 86208.6 87537.6 88143.6 88536.1 73462.6 79195.2 79593.6 79598.6 82784.5 72088.0 72506.6 72876.0 74309.0 74613.0 8052.8 8075.2 8134.2 8185.3 8220.8 44465.8 44648.3 45017.8 45176.0 45437.5 54050.0 61867.4 62201.4 62754.0 63386.0 10114.4 10169.9 10289.7 10555.2 10591.9 11240.9 11421.2 11518.1 11980.9 11998.5 10081.3 10585.3 10594.8 10596.3 10632.7 10940.1 11147.3 11325.1 11651.7 11661.3 10046.6 10229.4 10578.3 11021.9 11441.0 9901.8 9915.3 10231.2 10388.4 10525.3 9516.8 10209.0 10215.9 10542.7 10700.1 15:04:46 INFO - PROCESS | 10294 | -------- Summary: end -------- 15:04:46 INFO - PROCESS | 10294 | 15:04:46 INFO - TEST-INFO | 10294: exit 0 15:04:46 INFO - TEST-OK | dromaeo_css | took 1119149ms 15:04:46 INFO - TEST-START | kraken 15:04:46 INFO - operating with platform_type : linux_ 15:04:46 INFO - Initialising browser for kraken test... 15:04:46 INFO - TEST-INFO | started process 10474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpegYnSp/profile http://localhost:55962/getInfo.html) 15:04:51 INFO - PROCESS | 10474 | __metrics Screen width/height:1600/1200 15:04:51 INFO - PROCESS | 10474 | colorDepth:24 15:04:51 INFO - PROCESS | 10474 | Browser inner width/height: 1024/697 15:04:51 INFO - PROCESS | 10474 | __metrics 15:04:52 ERROR - PROCESS | 10474 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:04:52 INFO - PROCESS | 10474 | console.error: PushService: 15:04:52 INFO - PROCESS | 10474 | stateChangeProcessEnqueue: Error transitioning state 15:04:52 INFO - PROCESS | 10474 | UnknownError 15:04:53 INFO - TEST-INFO | 10474: exit 0 15:04:53 INFO - Browser initialized. 15:04:53 INFO - Running cycle 1/1 for kraken test... 15:04:53 INFO - TEST-INFO | started process 10555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpegYnSp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:05:05 INFO - PROCESS | 10555 | RSS: Main: 158425088 15:05:05 INFO - PROCESS | 10555 | 15:05:07 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55962/tests/kraken/driver.html?testName=audio-beat-detection) 15:05:08 INFO - PROCESS | 10555 | RSS: Main: 216260608 15:05:08 INFO - PROCESS | 10555 | 15:05:11 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55962/tests/kraken/driver.html?testName=audio-dft) 15:05:12 INFO - PROCESS | 10555 | RSS: Main: 203014144 15:05:12 INFO - PROCESS | 10555 | 15:05:15 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55962/tests/kraken/driver.html?testName=audio-fft) 15:05:16 INFO - PROCESS | 10555 | RSS: Main: 270618624 15:05:16 INFO - PROCESS | 10555 | 15:05:18 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55962/tests/kraken/driver.html?testName=audio-oscillator) 15:05:18 INFO - PROCESS | 10555 | RSS: Main: 180719616 15:05:18 INFO - PROCESS | 10555 | 15:05:21 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:05:21 INFO - PROCESS | 10555 | RSS: Main: 183869440 15:05:21 INFO - PROCESS | 10555 | 15:05:24 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55962/tests/kraken/driver.html?testName=imaging-darkroom) 15:05:25 INFO - PROCESS | 10555 | RSS: Main: 220602368 15:05:25 INFO - PROCESS | 10555 | 15:05:28 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55962/tests/kraken/driver.html?testName=imaging-desaturate) 15:05:29 INFO - PROCESS | 10555 | RSS: Main: 216268800 15:05:29 INFO - PROCESS | 10555 | 15:05:32 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55962/tests/kraken/driver.html?testName=json-parse-financial) 15:05:33 INFO - PROCESS | 10555 | RSS: Main: 218894336 15:05:33 INFO - PROCESS | 10555 | 15:05:34 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:05:35 INFO - PROCESS | 10555 | RSS: Main: 209477632 15:05:35 INFO - PROCESS | 10555 | 15:05:37 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55962/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:05:38 INFO - PROCESS | 10555 | RSS: Main: 209477632 15:05:38 INFO - PROCESS | 10555 | 15:05:40 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:05:40 INFO - PROCESS | 10555 | RSS: Main: 217559040 15:05:40 INFO - PROCESS | 10555 | 15:05:43 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:05:44 INFO - PROCESS | 10555 | RSS: Main: 223584256 15:05:44 INFO - PROCESS | 10555 | 15:05:47 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:05:47 INFO - PROCESS | 10555 | RSS: Main: 222621696 15:05:47 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | Cycle 1(1): loaded http://localhost:55962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55962/tests/kraken/driver.html?testName=ai-astar) 15:05:49 INFO - PROCESS | 10555 | RSS: Main: 265080832 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | __start_tp_report 15:05:49 INFO - PROCESS | 10555 | _x_x_mozilla_page_load 15:05:49 INFO - PROCESS | 10555 | _x_x_mozilla_page_load_details 15:05:49 INFO - PROCESS | 10555 | |i|pagename|runs| 15:05:49 INFO - PROCESS | 10555 | |0;ai-astar;117;109;114;113;113;112;113;113;113;113 15:05:49 INFO - PROCESS | 10555 | |1;audio-beat-detection;164;131;130;186;138;158;164;132;194;129 15:05:49 INFO - PROCESS | 10555 | |2;audio-dft;163;162;161;164;160;159;163;161;161;161 15:05:49 INFO - PROCESS | 10555 | |3;audio-fft;76;76;76;108;76;76;76;76;100;76 15:05:49 INFO - PROCESS | 10555 | |4;audio-oscillator;85;86;112;86;86;85;125;86;86;122 15:05:49 INFO - PROCESS | 10555 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;118 15:05:49 INFO - PROCESS | 10555 | |6;imaging-darkroom;147;146;147;146;146;148;148;147;146;145 15:05:49 INFO - PROCESS | 10555 | |7;imaging-desaturate;94;95;95;95;96;95;95;96;95;95 15:05:49 INFO - PROCESS | 10555 | |8;json-parse-financial;65;63;64;64;75;65;63;64;63;65 15:05:49 INFO - PROCESS | 10555 | |9;json-stringify-tinderbox;65;64;65;65;65;65;66;65;65;66 15:05:49 INFO - PROCESS | 10555 | |10;stanford-crypto-aes;83;86;90;88;84;85;84;88;116;85 15:05:49 INFO - PROCESS | 10555 | |11;stanford-crypto-ccm;132;132;142;129;131;128;131;137;135;130 15:05:49 INFO - PROCESS | 10555 | |12;stanford-crypto-pbkdf2;173;168;167;171;175;166;169;171;167;167 15:05:49 INFO - PROCESS | 10555 | |13;stanford-crypto-sha256-iterative;69;70;67;66;67;68;66;67;66;66 15:05:49 INFO - PROCESS | 10555 | __end_tp_report 15:05:49 INFO - PROCESS | 10555 | __start_cc_report 15:05:49 INFO - PROCESS | 10555 | _x_x_mozilla_cycle_collect,1907 15:05:49 INFO - PROCESS | 10555 | __end_cc_report 15:05:49 INFO - PROCESS | 10555 | __startTimestamp1465509949763__endTimestamp 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | ------- Summary: start ------- 15:05:49 INFO - PROCESS | 10555 | Number of tests: 14 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:1.94 (1.7%) stddev-sans-first:1.42 15:05:49 INFO - PROCESS | 10555 | Values: 117.0 109.0 114.0 113.0 113.0 112.0 113.0 113.0 113.0 113.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:161.00 stddev:24.25 (15.1%) stddev-sans-first:25.36 15:05:49 INFO - PROCESS | 10555 | Values: 164.0 131.0 130.0 186.0 138.0 158.0 164.0 132.0 194.0 129.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.50 15:05:49 INFO - PROCESS | 10555 | Values: 163.0 162.0 161.0 164.0 160.0 159.0 163.0 161.0 161.0 161.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:11.96 (15.7%) stddev-sans-first:12.51 15:05:49 INFO - PROCESS | 10555 | Values: 76.0 76.0 76.0 108.0 76.0 76.0 76.0 76.0 100.0 76.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:86.00 stddev:16.72 (19.4%) stddev-sans-first:17.26 15:05:49 INFO - PROCESS | 10555 | Values: 85.0 86.0 112.0 86.0 86.0 85.0 125.0 86.0 86.0 122.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 15:05:49 INFO - PROCESS | 10555 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:05:49 INFO - PROCESS | 10555 | Values: 147.0 146.0 147.0 146.0 146.0 148.0 148.0 147.0 146.0 145.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 15:05:49 INFO - PROCESS | 10555 | Values: 94.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.50 stddev:3.57 (5.5%) stddev-sans-first:3.79 15:05:49 INFO - PROCESS | 10555 | Values: 65.0 63.0 64.0 64.0 75.0 65.0 63.0 64.0 63.0 65.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 15:05:49 INFO - PROCESS | 10555 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:85.50 stddev:9.77 (11.4%) stddev-sans-first:10.13 15:05:49 INFO - PROCESS | 10555 | Values: 83.0 86.0 90.0 88.0 84.0 85.0 84.0 88.0 116.0 85.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:132.00 stddev:4.22 (3.2%) stddev-sans-first:4.47 15:05:49 INFO - PROCESS | 10555 | Values: 132.0 132.0 142.0 129.0 131.0 128.0 131.0 137.0 135.0 130.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.00 stddev:2.99 (1.8%) stddev-sans-first:2.87 15:05:49 INFO - PROCESS | 10555 | Values: 173.0 168.0 167.0 171.0 175.0 166.0 169.0 171.0 167.0 167.0 15:05:49 INFO - PROCESS | 10555 | 15:05:49 INFO - PROCESS | 10555 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.32 15:05:49 INFO - PROCESS | 10555 | Values: 69.0 70.0 67.0 66.0 67.0 68.0 66.0 67.0 66.0 66.0 15:05:49 INFO - PROCESS | 10555 | -------- Summary: end -------- 15:05:49 INFO - PROCESS | 10555 | 15:05:50 INFO - TEST-INFO | 10555: exit 0 15:05:50 INFO - TEST-OK | kraken | took 63826ms 15:05:50 INFO - SUITE-END | took 1182s 15:05:50 INFO - Completed test suite (00:19:43) 15:05:50 INFO - javascript benchmark 15:05:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2633.2890119667686, 2664.160789351353, 2679.4373181631863, 2701.149138021523, 2701.6893057298403, 4588.9770551147285, 4645.3264276679865, 4673.228917228653, 4731.053789242148, 4771.950170962387, 4626.653001024928, 4672.579467847893, 4680.227762419206, 4694.014257006024, 4702.012577358751, 4254.149170165963, 4270.0605866709275, 4274.679399045084, 4324.027093903878, 4399.758013309267, 4317.222899878021, 4350.086481838817, 4415.580519850625, 4444.355568442574, 4444.97777511112, 4206.768627725474, 4348.934765978513, 4367.672424568154, 4393.0994146199955, 4401.427814384126, 4225.852095176654, 4233.745975241495, 4248.383984322287, 4275.679324050678, 4285.657147428198, 4213.536510983789, 4272.5727427257025, 4314.0, 4338.479382474092, 4373.518912919576, 4389.912201755947, 4646.883827904296, 4648.163330600491, 4668.906621867578, 4675.719456832601, 4943.085529177114, 4999.600031997432, 5010.624203184776, 5080.237964305346, 5081.110805609041, 5073.2643766654, 5087.262346959707, 5088.160453525164, 5092.9745351273, 5105.897882042375, 4552.908941821145, 4610.216263235258, 4650.697704649187, 4693.6010439112715, 4709.670323077386, 5052.418971818214, 5121.95000024994, 5160.329157209539, 5166.070107380632, 5177.715225662625, 4947.703137811743, 4953.752312384367, 4955.380577427822, 4956.8760780980765, 4957.950420495821, 4866.075445665383, 4937.432195297587, 4940.950590494121, 4998.02538504988, 5039.042581909499, 4946.629002824802, 4964.205727083649, 4967.453580106186, 4968.0, 5007.674501157413, 4947.727874966839, 4952.752362381866, 4953.554180123734, 4966.726830024383, 4988.72562009093, 4024.0342317844093, 4063.6952228582973, 4127.731697439657, 4129.628333449944, 4201.705880588391, 3644.927101457956, 3667.339878821784, 3689.1146124929824, 3689.6863766579604, 3709.5919448861146, 4387.934180987288, 4393.604575588212, 4394.714343567658, 4397.384366188736, 4437.755923424243, 4930.728809915489, 4981.825636102792, 4989.476105008995, 5027.4469808321055, 5040.6219533534395, 4395.406620106245, 4421.845235416745, 4450.421445212101, 4469.5306992765945, 4469.776511174428, 4514.593686568224, 4515.683902126885, 4525.117602067565, 4527.411436513298, 4568.977155114203, 4538.614217791524, 4752.643551733703, 4764.380630518011, 4774.0, 4806.903861922672, 5105.617078719037, 5126.871828204325, 5128.282040514406, 5129.74351282427, 5162.535371816554, 4855.514448555116, 4856.004519073652, 4856.271559266138, 4856.660033797601, 4886.511348865085, 4798.184308667465, 4822.855314340575, 4855.393075865517, 4874.0, 5045.520675535819, 4925.778339974781, 4944.950550494449, 4948.653594248368, 4950.084234416644, 5001.049800537886, 4787.473377928494, 4794.2089555223, 4799.136155492045, 4842.8619274471175, 4852.199387101089, 4821.397325334333, 4839.758012099311, 4859.611231101433, 4887.3890763654545, 4898.0, 4825.469198388104, 4828.203346447937, 4890.217565189552, 4894.216925291937, 4894.877628059327, 4802.375691160127, 4920.778564964514, 4921.6062714982, 4954.405471343462, 4976.427710813303, 4744.240921452551, 4748.715077095385, 4778.187708089564, 4787.880302992314, 4795.616350692006], "value": 4603.715140194855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.7941541045226, 572.7050568956985, 575.5108158065644, 580.1877371679648, 580.3239226301358, 27793.44413111739, 40202.396964045525, 41665.16669666605, 41735.58264417351, 45105.32342014872, 40955.18089638205, 41275.0, 41303.0, 41329.17341653165, 41368.58631413693, 7784.961075194616, 7936.5238085714755, 7937.126916039231, 7938.1664925182895, 7938.245866642688, 7706.266090129704, 7741.845163096735, 7797.961010194941, 7804.570748608824, 7809.0, 7813.648385822652, 7851.842963140763, 7852.05775306964, 7852.685892564291, 7854.057513098436, 7801.375889928792, 7815.804604884895, 7839.412044096659, 7843.098043724987, 7849.4897831640765, 7713.3443657288635, 7790.104138024143, 7808.297253247179, 7816.49192802466, 7818.648160832776, 38187.42718859219, 38538.22923541541, 38564.421533677014, 38651.61348386508, 38655.42016869749, 3087.8764849405998, 3113.828739419331, 3204.7115759581748, 3586.7309951753464, 3893.0851249956236, 29067.12798616045, 29693.851530742424, 30237.848810756026, 31760.364792704248, 31788.682113179035, 3320.3027364253535, 3557.6661472632336, 3578.928421431583, 3615.6926661233565, 3721.404575267944, 251180.0, 253097.0, 253256.0, 253459.0, 253986.0, 28538.0, 28893.71106288952, 56758.71620641871, 56890.14664780031, 57376.13935790966, 34464.82767586146, 34551.82724086363, 34640.30719385598, 34657.826710866284, 34668.13329666779, 13751.518696845562, 13869.791953120712, 13877.514286999907, 13885.791713124312, 13886.23625700576, 10804.837927431096, 10805.513751881184, 10808.891911080946, 10815.35107893529, 10815.945920270506, 7834.138244793068, 7937.936136604524, 7945.642446089824, 8035.799105022421, 8040.517568945765, 3101.8449077546034, 3125.0, 3130.6869313068964, 3148.496240601493, 3148.8110713357273, 891.1266958380694, 892.4511425473416, 896.7309807057857, 925.5557332480313, 942.8397172480695, 27086.45827083447, 28162.0, 28196.57438757187, 28457.288567785556, 28840.855795720887, 830.3025458614793, 918.9494577798151, 964.8793900762405, 976.0337266106645, 1020.8468729690605, 14885.0, 15180.468683596022, 15230.619234519005, 15305.770413443808, 15365.665896843637, 358212.0, 364083.0, 364363.0, 364692.0, 365543.0, 48743.75628121837, 50124.74937625288, 50230.74884625627, 50308.49691503038, 50332.74833625882, 1052.4264275969615, 1176.9823452648218, 1188.9464974076188, 1207.6920385301692, 1215.9452824622913, 27248.318792029564, 28387.290317742223, 28469.145925622266, 28781.56827647629, 29043.709562904947, 42859.357109642755, 42878.0, 43275.35086973635, 43341.783291084605, 43409.0, 307121.0, 308594.0, 308799.0, 309065.0, 538715.0, 25164.87417562974, 25679.743202567734, 25803.741962580134, 26819.731802681723, 26874.0, 41720.91987028788, 42061.0, 42290.0, 42569.57430425656, 43745.78127109344, 34904.65095349014, 35240.0, 36133.0, 36133.457998129525, 36312.27375452529, 35392.0, 36049.0, 36230.0, 36318.818405907805, 36417.27165456623, 35188.0, 36108.81945590255, 36114.27771444504, 36220.27559448744, 36221.45667814932, 29988.550171747003, 31563.84218078895, 31802.363952720352, 32054.19864503406, 32288.83855580707, 24515.397920436248, 24788.38029049288, 24819.379515511533, 25039.749602503744, 25042.248732538053], "value": 16572.30527178413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.15533951525606, 358.46767550187974, 358.7650089191579, 376.2118362031543, 378.74245513051113, 15619.843801561981, 16569.75145372819, 17574.736378954327, 17575.209115589798, 17591.824081759194, 14867.702645947102, 14919.254037298146, 15306.923465382686, 15370.231488425561, 15391.538253852374, 4401.669874759382, 4702.553257440538, 4714.198586240347, 4777.904441911177, 4786.449558300805, 3463.722902167833, 3650.4159334506485, 4667.7199368037855, 6547.541672082956, 6943.548669336477, 6716.1604799400075, 6924.723011079551, 7029.578225306498, 7057.752978645748, 7080.362767350937, 6947.40947019504, 6975.720971161148, 6979.930200697979, 6980.825479363006, 7018.789436316919, 3821.102041020358, 6112.602680825777, 6443.645599492026, 6452.967735161341, 6763.053172555797, 22946.65580016301, 23144.42138946523, 23148.88425557878, 23368.182113625942, 23368.182113626113, 2015.0629957070032, 2025.574629327843, 2075.6374673029636, 2251.3020963501203, 2267.841251112423, 13590.796138057936, 14074.499139243013, 14208.573742787732, 14235.857641423558, 14747.0, 1866.850651947841, 1890.8487321014286, 1921.4790712021897, 1927.7493925789558, 2005.81947624713, 77780.0, 79620.99999999942, 79911.0, 81017.59491202566, 82030.0, 16068.517944461684, 16241.91879040621, 16452.670946581242, 16490.20725233203, 16603.252853621616, 29500.262493437836, 29545.85227073851, 29719.25701857471, 29787.55318670222, 29832.701672983425, 9119.908800911906, 9431.669891553762, 9441.103095205945, 9572.664956726621, 9647.324687271823, 7834.804129896798, 7867.370610351159, 7875.330596899214, 7963.8805417918775, 7970.242826931432, 8284.378671599654, 8501.702440414556, 8549.487030778173, 8567.914320856711, 8630.870536941951, 2519.91180308692, 3215.347473014211, 3316.6683331667123, 3454.6372630873398, 3535.5022939329074, 777.941654375924, 803.1727320859524, 892.8839250897341, 949.1362859797551, 962.855571664256, 16005.519834404986, 16356.0, 16362.672746545002, 16528.917355413145, 16888.071156086535, 820.5938060660012, 877.7542288159326, 892.7366426904078, 894.1594900793234, 900.9819803603891, 8931.598078086501, 9359.906400936039, 9361.812763744823, 9397.248220142508, 9583.137517623447, 380507.0, 388517.0, 390086.0, 394192.0, 396207.0, 70950.0, 72951.0, 74359.62820185973, 74428.62785686037, 75859.0, 889.8398288308038, 908.8636704494246, 909.4588719711761, 923.630547780893, 925.8009527951523, 14338.211398373189, 14667.0, 15736.159019282015, 16481.505554833373, 16588.336466541205, 35795.284094318486, 36349.0, 36962.344099775626, 37259.44110838394, 37538.24923501569, 46326.0, 51166.74416627893, 51551.742241290056, 51647.741761290956, 51706.74146629243, 6759.425448836904, 6955.539336739139, 7248.420126389981, 7250.60121693312, 7725.845483090195, 5974.940250597612, 8532.488050716976, 11159.944200278947, 11363.829542557034, 12060.396980151132, 10420.739481513023, 10513.421761802869, 10587.20595955291, 10601.946990265, 10666.360018398611, 9766.706998790047, 9855.45794981283, 9914.752131196778, 9945.552450139616, 9950.900490994998, 5469.480399362054, 7200.1719802223415, 8074.540357737824, 9738.659146929824, 9903.405795651996, 6699.899501507579, 6931.653417329214, 7164.713411463692, 7933.880991785243, 8042.67829286822, 10527.157827373945, 10554.050135487536, 10787.352758834495, 10899.891001089887, 11019.669409917715], "value": 9061.718495589383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1184.0764203920944, 1376.4150236149635, 1398.8111604933333, 1460.430432131469, 1730.9048002359873, 6758.729650813968, 7437.367823734982, 7705.499142555737, 7714.575698336589, 7919.326857217129, 7762.184970578092, 7855.25375089367, 7868.960655196716, 7883.80290492738, 7896.289333959942, 1827.369557502666, 2073.8548301618894, 2138.2302371146416, 2149.6345621244427, 2166.11189412341, 2187.223535644847, 2205.8014778669917, 2208.9226877059305, 2210.171185805323, 2210.4473881529616, 2138.7968143026465, 2153.752318483379, 2178.0307763045453, 2180.4875854174334, 2180.8364372672036, 1769.062396929623, 2041.2651445479617, 2078.5011597216635, 2101.9910442987452, 2105.884176370299, 2135.8718476891436, 2147.473868902129, 2150.0754675489534, 2150.6989021536997, 2155.041006751996, 7751.069871615386, 7799.220077992212, 7828.452008359417, 7832.804179895548, 7851.725189618336, 4311.525732169459, 4425.911481770347, 4437.556244375537, 4451.109778044404, 4456.331550267453, 2668.3996100877343, 2827.9293017674518, 2834.829910205374, 2840.247334456371, 2842.616246806696, 813.7111325479428, 831.1563762780783, 845.7166849105557, 846.0735494633367, 849.9362547808877, 10612.0, 10616.734581635521, 10657.893421065768, 10690.946545267223, 10735.677929662123, 4003.459532963013, 4083.2854250506043, 4134.462519872457, 4164.3961625564125, 4182.1008483176265, 9093.681721139728, 9104.908950910538, 9119.042500537347, 9151.405158664666, 9152.130547597968, 4528.705634133771, 4535.863924082283, 4540.02389486262, 4541.0, 4547.681662283609, 3653.1415117447377, 4061.2283666103936, 4125.092479654471, 4169.145325208325, 4234.1108367242605, 3559.341521818472, 3565.4830049642655, 3683.1528748387486, 3703.222323312081, 3712.461693054492, 1122.2424863217295, 1152.6311580294393, 1163.8603367595942, 1167.2996202278734, 1169.771894480568, 693.8785712500293, 827.8096037911314, 828.3125006244923, 859.4155973937658, 861.3066481482467, 5142.0, 5387.023804173605, 5414.07960646691, 5438.728063596884, 5538.280023596906, 398.9880303590897, 403.4472772301965, 408.6016134269123, 408.73636504455055, 412.72759978414103, 3680.5583330000036, 3711.9443208351895, 3743.794091324949, 3769.0, 3817.6945844332386, 9259.120383563686, 9633.662821801203, 9725.319227653996, 9727.562259698188, 9750.90249097514, 9459.432434053979, 9616.567254473566, 9661.082197191256, 9681.225501959827, 9685.951570242245, 7382.114146302478, 7386.3352298294485, 7481.177070522238, 7489.85020299591, 7501.774946751606, 5070.847874563769, 5071.239314102914, 5109.310243117132, 5255.080360936744, 5258.158694608845, 8868.64525418976, 8878.357503861806, 8994.235489983163, 9040.0, 9101.499417532099, 8417.368697347845, 8747.693830715894, 8827.0, 9080.682176123804, 9103.544822758968, 6143.262808463013, 6636.369544893228, 6730.125083739083, 6837.555558888856, 6858.897116543156, 7662.961685191538, 7711.652975615999, 7731.845363092819, 7736.690532378641, 7744.070711514429, 6727.327267273429, 6788.185417749902, 6845.5550389224545, 6880.931190688029, 7140.036095127091, 6641.833954151185, 6662.267150613526, 6674.132362792806, 6773.830654233487, 6889.138857642794, 6223.906641400292, 6254.530910181846, 6276.152719382825, 6362.745490180341, 6378.77674281398, 4741.431028276491, 4749.4063242094735, 4770.499097594703, 4780.450248221499, 4837.588804951619, 4536.455625324982, 4647.65142614312, 4686.882827929329, 4743.905121897612, 4760.619150468024], "value": 4021.1482866929573, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.2376811305137, 282.78508333666406, 283.40020583804437, 285.4020826368757, 290.34092609775803, 4703.965127671911, 4743.549362810528, 4743.691660042099, 4766.571008609225, 4773.711098003537, 4598.793054312556, 4638.165130276549, 4643.605293550044, 4667.973045929898, 4714.834980775673, 3509.227969846636, 3596.029072150518, 3597.118705917041, 3685.281370132812, 3713.814309284525, 3676.1544844685736, 3686.889393318205, 3688.0779805048737, 3704.9259014819686, 3734.4024956007042, 3500.8599656013857, 3685.8709945151927, 3688.336099502102, 3696.20531585709, 3699.167687270356, 3555.448905419651, 3687.0, 3698.556173259199, 3710.239400922804, 3715.386961151407, 3274.2796584751554, 3279.918002049968, 3283.91630761848, 3287.161773747703, 3308.8676452941854, 4496.617787488068, 4509.7970591323465, 4530.728156310632, 4532.070925460305, 4546.976930190714, 3928.921421571581, 4165.97917010413, 4180.456540649727, 4238.491381034265, 4244.129953359585, 4879.389526603286, 4904.779284932151, 4907.656464047518, 4929.22547882762, 4953.6037117030555, 3527.894163175109, 3530.7642325186234, 3532.0, 3532.858685652571, 3538.7699799513207, 4996.000799840047, 5149.407818100929, 5184.326037615124, 5204.334612923866, 5207.739613019372, 3474.1488335358, 3476.11359103427, 3479.9652003480146, 3491.546099007113, 3495.07380544156, 3540.415831387792, 3540.5574303212097, 3547.787132772042, 3551.7391326079387, 3554.7689400188906, 4120.866761640573, 4122.443470131554, 4125.958740412618, 4132.194222126716, 4142.5857414258935, 4689.882752931136, 4873.561379475864, 4887.926681099786, 4896.3389942358035, 4973.502649734997, 1207.7825991321647, 1209.5585111434264, 1213.5327898759042, 1218.4760552962312, 1224.6081253998814, 762.4853224073728, 773.7640019794017, 774.2992591704516, 774.7714424244862, 787.629813987425, 4308.482982042112, 4336.414584031116, 4345.609404990373, 4455.376247325377, 4473.284274516127, 5036.395632524047, 5045.167547354646, 5045.924311135336, 5071.822486213038, 5083.466236045162, 4319.848805291863, 4387.166438376698, 4401.163778882003, 4438.245498265303, 4447.933281000787, 2658.2955516788065, 2667.399835037101, 2676.585129304961, 2680.557707978162, 2689.892404303806, 4776.471529110651, 4778.354922085544, 4779.928301075487, 4805.4233491980485, 4806.951930480651, 4904.337914381585, 5141.460146684619, 5169.172932330809, 5171.017506673795, 5172.741362931838, 4761.928571071506, 4774.785134668949, 4783.378160839069, 4818.614510839195, 4825.431734686241, 5042.235217673785, 5054.74726263678, 5067.746612669278, 5078.441371449064, 5082.872928176826, 4650.465196502446, 4937.530934561211, 4961.677490963076, 4985.651004429655, 4998.3002379667605, 4787.976060119677, 4808.595702148926, 4809.278608208657, 4811.831585894477, 4819.674589487779, 3497.772644778183, 3540.1857572758927, 3541.5750109986966, 3546.255286389887, 3549.272399158218, 4815.133276010351, 5094.108531007133, 5111.983929481624, 5117.15566931467, 5121.8463446096675, 4908.9754551227015, 4916.06594746997, 4921.581665558325, 4929.9014019720125, 4932.062908047459, 4916.778744956557, 4923.704577725348, 4925.433575138762, 4951.183054795918, 4954.5788607968725, 4562.292844609091, 4888.266759986031, 4898.583620392306, 4903.190973489334, 4903.60771138301, 4740.360051393156, 4800.855974320776, 4903.190973489334, 4975.0, 4984.352034235526, 4853.296272040605, 4867.9269810952155, 4888.169011268022, 4901.877453063702, 4909.803607855646], "value": 3692.948341174326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.9562530622858, 625.1685258606054, 640.7533099756594, 733.2594079979219, 747.6261869065465, 11965.042796576265, 12841.0, 12945.676358091052, 12950.093493455463, 13044.347782610856, 12687.809682854764, 13179.802302965463, 13207.603771886836, 13282.601521954357, 13457.461701531927, 786.3984052200071, 794.0868001797921, 798.9440739148262, 799.0890384961149, 799.1768478467159, 633.2243002322142, 768.2240936653964, 792.7304716396424, 800.3477166109602, 802.2779498451382, 825.5542007316042, 828.2545708862042, 828.5318794880903, 829.701307529292, 831.3432388413146, 574.1015311038212, 821.6015232612178, 822.2928281677753, 823.9464434811748, 825.8926339575846, 578.5747475605426, 598.9970050149722, 599.7541008186666, 600.1058422949817, 600.5195843325322, 13021.609351719464, 13032.218066916015, 13416.262105584188, 13456.663583410394, 13458.259795711232, 12419.75160496785, 12831.0, 12872.678183045406, 12877.291748953803, 12958.87041129586, 11887.465064072137, 12023.458944347525, 12105.45525451348, 12128.393580320948, 12430.627081187578, 3961.1879564689457, 4006.1186538961383, 4025.778582177979, 4120.402541631476, 4198.9370159447635, 59388.0, 59472.0, 60235.39764602342, 60482.0, 60492.85810706095, 10152.137068349273, 10300.175985921109, 10319.535620896928, 10473.895261047444, 10760.569577216824, 16539.83460165383, 16576.502704918872, 16606.169691515377, 16613.08628025446, 16649.750253746202, 6575.309592492815, 6627.801165965029, 6666.533342665967, 6681.600762930301, 6870.3473170048765, 3668.1563240454843, 3721.6650501455, 3760.0599850037493, 3780.6597406233573, 3880.010597297671, 2703.45930813838, 2798.888044478198, 2800.383915538578, 2800.957985630217, 2801.8038737288603, 471.9811207551728, 474.962003039756, 479.53964194373094, 487.3858937738475, 488.62131847817517, 494.29069285575315, 497.477648469106, 565.5277843001057, 602.2471910112359, 603.7592746905152, 7667.233276672288, 8281.710140145065, 8293.792655183548, 8664.913350866536, 9054.909450905538, 527.1828665568354, 587.4859497939303, 613.1140501974604, 620.5997131849931, 628.5286035473395, 3947.4078888167005, 4001.2797696414923, 4115.176964607091, 4127.318992366226, 4143.772092534879, 85607.57196213979, 86208.56895715481, 87537.56231218803, 88143.55928220446, 88536.11463885408, 73462.6326868373, 79195.20804791994, 79593.60203198947, 79598.60200698959, 82784.52223009158, 72088.0, 72506.63746681233, 72876.0, 74309.0, 74613.0, 8052.751823467372, 8075.232852878967, 8134.186581341818, 8185.304249138651, 8220.794480138044, 44465.777671111435, 44648.33027504655, 45017.774911125234, 45176.0, 45437.545624544655, 54050.0, 61867.38132618796, 62201.37798621956, 62754.0, 63386.0, 10114.393136411838, 10169.9491502542, 10289.74275643115, 10555.15558755313, 10591.94704026475, 11240.887591123985, 11421.200515964136, 11518.07855371585, 11980.880191198325, 11998.460069297078, 10081.344712593658, 10585.259031867696, 10594.841077383999, 10596.258261921592, 10632.681019569425, 10940.124790016938, 11147.331160130094, 11325.093992480417, 11651.650450486499, 11661.300321980709, 10046.648367307109, 10229.43738094412, 10578.312409693346, 11021.859888902069, 11441.0, 9901.752456188653, 9915.30592858493, 10231.181505479693, 10388.37669739818, 10525.263231573716, 9516.809663806824, 10209.0, 10215.94892025535, 10542.736431588964, 10700.143988480748], "value": 6468.298541693984, "unit": "score"}], "name": "dromaeo_css", "value": 6363.72161561255, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 131.0, 130.0, 186.0, 138.0, 158.0, 164.0, 132.0, 194.0, 129.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 164.0, 160.0, 159.0, 163.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 108.0, 76.0, 76.0, 76.0, 76.0, 100.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 112.0, 86.0, 86.0, 85.0, 125.0, 86.0, 86.0, 122.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 148.0, 147.0, 146.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 75.0, 65.0, 63.0, 64.0, 63.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 90.0, 88.0, 84.0, 85.0, 84.0, 88.0, 116.0, 85.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 142.0, 129.0, 131.0, 128.0, 131.0, 137.0, 135.0, 130.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 168.0, 167.0, 171.0, 175.0, 166.0, 169.0, 171.0, 167.0, 167.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 66.0, 67.0, 68.0, 66.0, 67.0, 66.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1551.6000000000001, "alertThreshold": 2.0}]} 15:05:51 INFO - Return code: 0 15:05:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:05:51 ERROR - # TBPL SUCCESS # 15:05:51 INFO - Running post-action listener: _resource_record_post_action 15:05:51 INFO - ##### 15:05:51 INFO - ##### Finished run-tests step (success) 15:05:51 INFO - ##### 15:05:51 INFO - Running post-run listener: _resource_record_post_run 15:05:51 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 524296192; Read time: 0; Write time: 386236 15:05:51 INFO - TinderboxPrint: CPU usage
13.1% 15:05:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:05:51 INFO - TinderboxPrint: I/O write bytes / time
524,296,192 / 386,236 15:05:51 INFO - TinderboxPrint: CPU idle
8,324.4 (86.9%) 15:05:51 INFO - TinderboxPrint: CPU user
1,211.4 (12.6%) 15:05:51 INFO - TinderboxPrint: Swap in / out
0 / 0 15:05:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237899776; Read time: 0; Write time: 230472 15:05:51 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 286396416; Read time: 0; Write time: 155764 15:05:51 INFO - Running post-run listener: _upload_blobber_files 15:05:51 INFO - Blob upload gear active. 15:05:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:05:51 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 15:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:05:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:05:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:05:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:05:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:56 INFO - (blobuploader) - INFO - Done attempting. 15:05:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:05:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:05:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:57 INFO - (blobuploader) - INFO - Done attempting. 15:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:58 INFO - (blobuploader) - INFO - Done attempting. 15:05:58 INFO - (blobuploader) - INFO - Iteration through files over. 15:05:58 INFO - Return code: 0 15:05:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:05:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:05:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6f42986f0d5fbaf22142c8abed8a1bda96c5acac360f5ffeb6cd878f6a6afdaa0ed0d9d20a3ca450f83aaf282079d6200d1923d3b9d7b8a7a63c06d5e4089359", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1e2909ccf08a3f2c56e6c8627d3a4c68d74e9581128fec0e86f8a3692d6dbdd8a661858bb0e243c0823a46a50689bcb6d002ba4c520ece3604e558b6cc70aeb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0fa0a7c55c0e7686b00b7a3a760645ef8caec419c677278a03437e27127f56bcab0b1bbc6d1f2b9c3df4ae24abf233b66cf9383a32b705a63530ad9f00444cb0"} 15:05:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:05:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:05:58 INFO - Contents: 15:05:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6f42986f0d5fbaf22142c8abed8a1bda96c5acac360f5ffeb6cd878f6a6afdaa0ed0d9d20a3ca450f83aaf282079d6200d1923d3b9d7b8a7a63c06d5e4089359", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1e2909ccf08a3f2c56e6c8627d3a4c68d74e9581128fec0e86f8a3692d6dbdd8a661858bb0e243c0823a46a50689bcb6d002ba4c520ece3604e558b6cc70aeb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0fa0a7c55c0e7686b00b7a3a760645ef8caec419c677278a03437e27127f56bcab0b1bbc6d1f2b9c3df4ae24abf233b66cf9383a32b705a63530ad9f00444cb0"} 15:05:58 INFO - Running post-run listener: copy_logs_to_upload_dir 15:05:58 INFO - Copying logs to upload dir... 15:05:58 INFO - mkdir: /builds/slave/test/build/upload/logs 15:05:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.203258 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-09 15:05:58.123420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 15:05:58.127107) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6f42986f0d5fbaf22142c8abed8a1bda96c5acac360f5ffeb6cd878f6a6afdaa0ed0d9d20a3ca450f83aaf282079d6200d1923d3b9d7b8a7a63c06d5e4089359", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1e2909ccf08a3f2c56e6c8627d3a4c68d74e9581128fec0e86f8a3692d6dbdd8a661858bb0e243c0823a46a50689bcb6d002ba4c520ece3604e558b6cc70aeb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0fa0a7c55c0e7686b00b7a3a760645ef8caec419c677278a03437e27127f56bcab0b1bbc6d1f2b9c3df4ae24abf233b66cf9383a32b705a63530ad9f00444cb0"} build_url:https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6f42986f0d5fbaf22142c8abed8a1bda96c5acac360f5ffeb6cd878f6a6afdaa0ed0d9d20a3ca450f83aaf282079d6200d1923d3b9d7b8a7a63c06d5e4089359", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1e2909ccf08a3f2c56e6c8627d3a4c68d74e9581128fec0e86f8a3692d6dbdd8a661858bb0e243c0823a46a50689bcb6d002ba4c520ece3604e558b6cc70aeb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0fa0a7c55c0e7686b00b7a3a760645ef8caec419c677278a03437e27127f56bcab0b1bbc6d1f2b9c3df4ae24abf233b66cf9383a32b705a63530ad9f00444cb0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 15:05:58.153683) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:05:58.154060) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465508714.192500-1521987782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:05:58.238388) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 15:05:58.238721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 15:05:58.239030) ========= ========= Total master_lag: 0.17 =========