builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1493917649.86 results: success (0) revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:29.855460) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:29.855902) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:29.856176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:29.971375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:29.971677) ========= 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=6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 10:07:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-05-04 10:07:30 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097899 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.090245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.090567) ========= 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=6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021040 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.146148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.146510) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --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=6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 10:07:30,520 truncating revision to first 12 chars 2017-05-04 10:07:30,520 Setting DEBUG logging. 2017-05-04 10:07:30,520 attempt 1/10 2017-05-04 10:07:30,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b255199db9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 10:07:30,869 unpacking tar archive at: mozilla-central-0b255199db9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.905967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.906287) ========= script_repo_revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.906697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.906964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:07:30.924573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-04 10:07:30.924953) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:31 INFO - MultiFileLogger online at 20170504 10:07:31 in /builds/slave/test 10:07:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:07:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:31 INFO - {'append_to_log': False, 10:07:31 INFO - 'base_work_dir': '/builds/slave/test', 10:07:31 INFO - 'blob_upload_branch': 'Firefox', 10:07:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:31 INFO - 'branch': 'Firefox', 10:07:31 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:31 INFO - 'config_files': ('talos/linux_config.py',), 10:07:31 INFO - 'default_actions': ('clobber', 10:07:31 INFO - 'read-buildbot-config', 10:07:31 INFO - 'download-and-extract', 10:07:31 INFO - 'populate-webroot', 10:07:31 INFO - 'create-virtualenv', 10:07:31 INFO - 'install', 10:07:31 INFO - 'run-tests'), 10:07:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:31 INFO - 'download_minidump_stackwalk': True, 10:07:31 INFO - 'download_symbols': 'ondemand', 10:07:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:31 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:31 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:31 INFO - 'gecko_profile': False, 10:07:31 INFO - 'gecko_profile_interval': 0, 10:07:31 INFO - 'installer_path': 'installer.exe', 10:07:31 INFO - 'log_level': 'info', 10:07:31 INFO - 'log_name': 'talos', 10:07:31 INFO - 'log_to_console': True, 10:07:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:31 INFO - 'opt_config_files': (), 10:07:31 INFO - 'pip_index': False, 10:07:31 INFO - 'suite': 'dromaeojs', 10:07:31 INFO - 'system_bits': '32', 10:07:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:31 INFO - 'title': 'talos-linux64-ix-050', 10:07:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:31 INFO - 'use_talos_json': True, 10:07:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:31 INFO - 'work_dir': 'build'} 10:07:31 INFO - [mozharness: 2017-05-04 17:07:31.392084Z] Running clobber step. 10:07:31 INFO - Running pre-action listener: _resource_record_pre_action 10:07:31 INFO - Running main action method: clobber 10:07:31 INFO - rmtree: /builds/slave/test/build 10:07:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:32 INFO - Running post-action listener: _resource_record_post_action 10:07:32 INFO - [mozharness: 2017-05-04 17:07:32.372259Z] Finished clobber step (success) 10:07:32 INFO - [mozharness: 2017-05-04 17:07:32.372360Z] Running read-buildbot-config step. 10:07:32 INFO - Running pre-action listener: _resource_record_pre_action 10:07:32 INFO - Running main action method: read_buildbot_config 10:07:32 INFO - Using buildbot properties: 10:07:32 INFO - { 10:07:32 INFO - "project": "", 10:07:32 INFO - "product": "firefox", 10:07:32 INFO - "who": "archaeopteryx@coole-files.de", 10:07:32 INFO - "installer_path": "public/build/target.tar.bz2", 10:07:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 10:07:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:07:32 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 10:07:32 INFO - "stage_platform": "linux64-stylo", 10:07:32 INFO - "basedir": "/builds/slave/test", 10:07:32 INFO - "buildnumber": 78, 10:07:32 INFO - "platform": "ubuntu64_hw_stylo", 10:07:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:07:32 INFO - "slavebuilddir": "test", 10:07:32 INFO - "taskId": "TLqVLKqqRHit1QgxBErX_w", 10:07:32 INFO - "branch": "mozilla-central", 10:07:32 INFO - "script_repo_revision": "production", 10:07:32 INFO - "revision": "0b255199db9d6a6f189b89b7906f99155bde3726", 10:07:32 INFO - "slavename": "talos-linux64-ix-050", 10:07:32 INFO - "repo_path": "mozilla-central" 10:07:32 INFO - } 10:07:32 INFO - Finding installer, test and symbols from parent task. 10:07:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TLqVLKqqRHit1QgxBErX_w'}, attempt #1 10:07:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TLqVLKqqRHit1QgxBErX_w'}, attempt #1 10:07:33 INFO - Task dependencies: BwNnrf7UQ8Kx7fuYONHxYg 10:07:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg'}, attempt #1 10:07:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.tar.bz2 10:07:33 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/test_packages.json 10:07:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.crashreporter-symbols.zip 10:07:33 INFO - Running post-action listener: _resource_record_post_action 10:07:33 INFO - [mozharness: 2017-05-04 17:07:33.793634Z] Finished read-buildbot-config step (success) 10:07:33 INFO - [mozharness: 2017-05-04 17:07:33.793851Z] Running download-and-extract step. 10:07:33 INFO - Running pre-action listener: _resource_record_pre_action 10:07:33 INFO - Running main action method: download_and_extract 10:07:33 INFO - mkdir: /builds/slave/test/build/tests 10:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:33 INFO - trying https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.test_packages.json 10:07:33 INFO - Downloading https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:07:34 INFO - Downloaded 986 bytes. 10:07:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:07:34 INFO - Using the following test package requirements: 10:07:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:07:34 INFO - u'common': [u'target.common.tests.zip'], 10:07:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:07:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:07:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:07:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:07:34 INFO - u'mozbase': [u'target.common.tests.zip'], 10:07:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:07:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:07:34 INFO - u'web-platform': [u'target.common.tests.zip', 10:07:34 INFO - u'target.web-platform.tests.zip'], 10:07:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:07:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:07:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.common.tests.zip 10:07:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:07:34 INFO - Fetch https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.common.tests.zip into memory 10:07:35 INFO - Content-Length response header: 58441512 10:07:35 INFO - Bytes received: 58441512 10:07:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:07:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.common.tests.zip 10:07:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:07:45 INFO - Fetch https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.common.tests.zip into memory 10:07:46 INFO - Content-Length response header: 58441512 10:07:46 INFO - Bytes received: 58441512 10:07:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.talos.tests.zip 10:07:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:07:57 INFO - Fetch https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.talos.tests.zip into memory 10:07:57 INFO - Content-Length response header: 14408809 10:07:57 INFO - Bytes received: 14408809 10:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:58 INFO - trying https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.tar.bz2 10:07:58 INFO - Downloading https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:07:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:07:59 INFO - Downloaded 59865560 bytes. 10:07:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.tar.bz2 10:07:59 INFO - mkdir: /builds/slave/test/properties 10:07:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:59 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:59 INFO - Contents: 10:07:59 INFO - build_url:https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.tar.bz2 10:07:59 INFO - Running post-action listener: _resource_record_post_action 10:07:59 INFO - Running post-action listener: set_extra_try_arguments 10:07:59 INFO - [mozharness: 2017-05-04 17:07:59.239923Z] Finished download-and-extract step (success) 10:07:59 INFO - [mozharness: 2017-05-04 17:07:59.240020Z] Running populate-webroot step. 10:07:59 INFO - Running pre-action listener: _resource_record_pre_action 10:07:59 INFO - Running main action method: populate_webroot 10:07:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:59 INFO - '--tppagecycles', 10:07:59 INFO - '7'], 10:07:59 INFO - 'tests': ['tsvgm']}}, 10:07:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:07:59 INFO - 'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:07:59 INFO - 'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['damp', 'tps']}, 10:07:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:07:59 INFO - 'tests': ['damp', 'tps']}, 10:07:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['dromaeo_dom']}, 10:07:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:07:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:07:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore', 10:07:59 INFO - 'tabpaint']}, 10:07:59 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore', 10:07:59 INFO - 'tabpaint']}, 10:07:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore', 10:07:59 INFO - 'tabpaint']}, 10:07:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore', 10:07:59 INFO - 'tabpaint']}, 10:07:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore', 10:07:59 INFO - 'tabpaint']}, 10:07:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore', 10:07:59 INFO - 'tabpaint']}, 10:07:59 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:07:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:07:59 INFO - 'bloom_basic_ref']}, 10:07:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['tsvgx', 10:07:59 INFO - 'tsvgr_opacity', 10:07:59 INFO - 'tart', 10:07:59 INFO - 'tscrollx', 10:07:59 INFO - 'cart', 10:07:59 INFO - 'tsvg_static']}, 10:07:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:59 INFO - 'tsvgr_opacity', 10:07:59 INFO - 'tart', 10:07:59 INFO - 'tscrollx', 10:07:59 INFO - 'cart', 10:07:59 INFO - 'tsvg_static']}, 10:07:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:07:59 INFO - 'talos_options': ['--disable-e10s'], 10:07:59 INFO - 'tests': ['tp5o']}, 10:07:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:07:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:07:59 INFO - 'talos_options': ['--disable-e10s', 10:07:59 INFO - '--xperf_path', 10:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:59 INFO - 'tests': ['tp5n']}, 10:07:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:07:59 INFO - 'talos_options': ['--xperf_path', 10:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:59 INFO - 'tests': ['tp5n']}}, 10:07:59 INFO - 'talos.zip': {'path': '', 10:07:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:59 INFO - Running post-action listener: _resource_record_post_action 10:07:59 INFO - [mozharness: 2017-05-04 17:07:59.253648Z] Finished populate-webroot step (success) 10:07:59 INFO - [mozharness: 2017-05-04 17:07:59.253737Z] Running create-virtualenv step. 10:07:59 INFO - Running pre-action listener: _resource_record_pre_action 10:07:59 INFO - Running main action method: create_virtualenv 10:07:59 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:07:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:59 INFO - Using real prefix '/usr' 10:07:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:59 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:01 INFO - Installing pip.................done. 10:08:01 INFO - Return code: 0 10:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:08:02 INFO - Reading from file tmpfile_stdout 10:08:02 INFO - Output received: 10:08:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:08:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:02 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:08:02 INFO - Using env: {'DISPLAY': ':0', 10:08:02 INFO - 'HOME': '/home/cltbld', 10:08:02 INFO - 'LANG': 'en_US.UTF-8', 10:08:02 INFO - 'LANGUAGE': 'en_US:en', 10:08:02 INFO - 'LOGNAME': 'cltbld', 10:08:02 INFO - 'MAIL': '/var/mail/cltbld', 10:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:02 INFO - 'MOZ_NO_REMOTE': '1', 10:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:02 INFO - 'NO_EM_RESTART': '1', 10:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:02 INFO - 'PWD': '/builds/slave/test', 10:08:02 INFO - 'SHELL': '/bin/bash', 10:08:02 INFO - 'SHLVL': '1', 10:08:02 INFO - 'TERM': 'linux', 10:08:02 INFO - 'TMOUT': '86400', 10:08:02 INFO - 'USER': 'cltbld', 10:08:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:02 INFO - '_': '/tools/buildbot/bin/python'} 10:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:08:02 INFO - Cleaning up... 10:08:02 INFO - Return code: 0 10:08:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:02 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:08:02 INFO - Using env: {'DISPLAY': ':0', 10:08:02 INFO - 'HOME': '/home/cltbld', 10:08:02 INFO - 'LANG': 'en_US.UTF-8', 10:08:02 INFO - 'LANGUAGE': 'en_US:en', 10:08:02 INFO - 'LOGNAME': 'cltbld', 10:08:02 INFO - 'MAIL': '/var/mail/cltbld', 10:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:02 INFO - 'MOZ_NO_REMOTE': '1', 10:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:02 INFO - 'NO_EM_RESTART': '1', 10:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:02 INFO - 'PWD': '/builds/slave/test', 10:08:02 INFO - 'SHELL': '/bin/bash', 10:08:02 INFO - 'SHLVL': '1', 10:08:02 INFO - 'TERM': 'linux', 10:08:02 INFO - 'TMOUT': '86400', 10:08:02 INFO - 'USER': 'cltbld', 10:08:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:02 INFO - '_': '/tools/buildbot/bin/python'} 10:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:02 INFO - Downloading/unpacking psutil>=3.1.1 10:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:03 INFO - Installing collected packages: psutil 10:08:03 INFO - Running setup.py install for psutil 10:08:03 INFO - building 'psutil._psutil_linux' extension 10:08:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:08:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:08:03 INFO - building 'psutil._psutil_posix' extension 10:08:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:08:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:04 INFO - Successfully installed psutil 10:08:04 INFO - Cleaning up... 10:08:04 INFO - Return code: 0 10:08:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:04 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:08:04 INFO - Using env: {'DISPLAY': ':0', 10:08:04 INFO - 'HOME': '/home/cltbld', 10:08:04 INFO - 'LANG': 'en_US.UTF-8', 10:08:04 INFO - 'LANGUAGE': 'en_US:en', 10:08:04 INFO - 'LOGNAME': 'cltbld', 10:08:04 INFO - 'MAIL': '/var/mail/cltbld', 10:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:04 INFO - 'MOZ_NO_REMOTE': '1', 10:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:04 INFO - 'NO_EM_RESTART': '1', 10:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:04 INFO - 'PWD': '/builds/slave/test', 10:08:04 INFO - 'SHELL': '/bin/bash', 10:08:04 INFO - 'SHLVL': '1', 10:08:04 INFO - 'TERM': 'linux', 10:08:04 INFO - 'TMOUT': '86400', 10:08:04 INFO - 'USER': 'cltbld', 10:08:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:04 INFO - '_': '/tools/buildbot/bin/python'} 10:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:08:05 INFO - Installing collected packages: mozsystemmonitor 10:08:05 INFO - Running setup.py install for mozsystemmonitor 10:08:05 INFO - Successfully installed mozsystemmonitor 10:08:05 INFO - Cleaning up... 10:08:05 INFO - Return code: 0 10:08:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:08:05 INFO - Using env: {'DISPLAY': ':0', 10:08:05 INFO - 'HOME': '/home/cltbld', 10:08:05 INFO - 'LANG': 'en_US.UTF-8', 10:08:05 INFO - 'LANGUAGE': 'en_US:en', 10:08:05 INFO - 'LOGNAME': 'cltbld', 10:08:05 INFO - 'MAIL': '/var/mail/cltbld', 10:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:05 INFO - 'MOZ_NO_REMOTE': '1', 10:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:05 INFO - 'NO_EM_RESTART': '1', 10:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:05 INFO - 'PWD': '/builds/slave/test', 10:08:05 INFO - 'SHELL': '/bin/bash', 10:08:05 INFO - 'SHLVL': '1', 10:08:05 INFO - 'TERM': 'linux', 10:08:05 INFO - 'TMOUT': '86400', 10:08:05 INFO - 'USER': 'cltbld', 10:08:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:05 INFO - '_': '/tools/buildbot/bin/python'} 10:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:07 INFO - warning: no files found matching '*.txt' 10:08:07 INFO - no previously-included directories found matching 'build' 10:08:07 INFO - no previously-included directories found matching 'dist' 10:08:07 INFO - no previously-included directories found matching '.git*' 10:08:07 INFO - Installing collected packages: jsonschema, functools32 10:08:07 INFO - Running setup.py install for functools32 10:08:07 INFO - warning: no files found matching '*.txt' 10:08:07 INFO - no previously-included directories found matching 'build' 10:08:07 INFO - no previously-included directories found matching 'dist' 10:08:07 INFO - no previously-included directories found matching '.git*' 10:08:07 INFO - Successfully installed jsonschema functools32 10:08:07 INFO - Cleaning up... 10:08:07 INFO - Return code: 0 10:08:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:08:07 INFO - Using env: {'DISPLAY': ':0', 10:08:07 INFO - 'HOME': '/home/cltbld', 10:08:07 INFO - 'LANG': 'en_US.UTF-8', 10:08:07 INFO - 'LANGUAGE': 'en_US:en', 10:08:07 INFO - 'LOGNAME': 'cltbld', 10:08:07 INFO - 'MAIL': '/var/mail/cltbld', 10:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:07 INFO - 'MOZ_NO_REMOTE': '1', 10:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:07 INFO - 'NO_EM_RESTART': '1', 10:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:07 INFO - 'PWD': '/builds/slave/test', 10:08:07 INFO - 'SHELL': '/bin/bash', 10:08:07 INFO - 'SHLVL': '1', 10:08:07 INFO - 'TERM': 'linux', 10:08:07 INFO - 'TMOUT': '86400', 10:08:07 INFO - 'USER': 'cltbld', 10:08:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:07 INFO - '_': '/tools/buildbot/bin/python'} 10:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:08:07 INFO - Cleaning up... 10:08:07 INFO - Return code: 0 10:08:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:08:07 INFO - Using env: {'DISPLAY': ':0', 10:08:07 INFO - 'HOME': '/home/cltbld', 10:08:07 INFO - 'LANG': 'en_US.UTF-8', 10:08:07 INFO - 'LANGUAGE': 'en_US:en', 10:08:07 INFO - 'LOGNAME': 'cltbld', 10:08:07 INFO - 'MAIL': '/var/mail/cltbld', 10:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:07 INFO - 'MOZ_NO_REMOTE': '1', 10:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:07 INFO - 'NO_EM_RESTART': '1', 10:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:07 INFO - 'PWD': '/builds/slave/test', 10:08:07 INFO - 'SHELL': '/bin/bash', 10:08:07 INFO - 'SHLVL': '1', 10:08:07 INFO - 'TERM': 'linux', 10:08:07 INFO - 'TMOUT': '86400', 10:08:07 INFO - 'USER': 'cltbld', 10:08:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:07 INFO - '_': '/tools/buildbot/bin/python'} 10:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:07 INFO - Downloading/unpacking blobuploader==1.2.4 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:08 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:09 INFO - Downloading docopt-0.6.1.tar.gz 10:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:09 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:09 INFO - Running setup.py install for blobuploader 10:08:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:09 INFO - Running setup.py install for requests 10:08:09 INFO - Running setup.py install for docopt 10:08:10 INFO - Successfully installed blobuploader requests docopt 10:08:10 INFO - Cleaning up... 10:08:10 INFO - Return code: 0 10:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:10 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:08:10 INFO - Using env: {'DISPLAY': ':0', 10:08:10 INFO - 'HOME': '/home/cltbld', 10:08:10 INFO - 'LANG': 'en_US.UTF-8', 10:08:10 INFO - 'LANGUAGE': 'en_US:en', 10:08:10 INFO - 'LOGNAME': 'cltbld', 10:08:10 INFO - 'MAIL': '/var/mail/cltbld', 10:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:10 INFO - 'MOZ_NO_REMOTE': '1', 10:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:10 INFO - 'NO_EM_RESTART': '1', 10:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:10 INFO - 'PWD': '/builds/slave/test', 10:08:10 INFO - 'SHELL': '/bin/bash', 10:08:10 INFO - 'SHLVL': '1', 10:08:10 INFO - 'TERM': 'linux', 10:08:10 INFO - 'TMOUT': '86400', 10:08:10 INFO - 'USER': 'cltbld', 10:08:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:10 INFO - '_': '/tools/buildbot/bin/python'} 10:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:10 INFO - Running setup.py (path:/tmp/pip-ZZwXmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:10 INFO - Running setup.py (path:/tmp/pip-ihpnxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:10 INFO - Running setup.py (path:/tmp/pip-t_HzFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:10 INFO - Running setup.py (path:/tmp/pip-DfQt72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:10 INFO - Running setup.py (path:/tmp/pip-8kXlEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:10 INFO - Running setup.py (path:/tmp/pip-AXhP98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:10 INFO - Running setup.py (path:/tmp/pip-O2zzwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:10 INFO - Running setup.py (path:/tmp/pip-vbq6Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:10 INFO - Running setup.py (path:/tmp/pip-ULwZ8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:10 INFO - Running setup.py (path:/tmp/pip-tRfc4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:11 INFO - Running setup.py (path:/tmp/pip-0HWSYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:11 INFO - Running setup.py (path:/tmp/pip-Hfqvmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:11 INFO - Running setup.py (path:/tmp/pip-wMkvFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:11 INFO - Running setup.py (path:/tmp/pip-bO0ufa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:11 INFO - Running setup.py (path:/tmp/pip-bYF28o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:11 INFO - Running setup.py (path:/tmp/pip-bh6cp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:11 INFO - Running setup.py (path:/tmp/pip-gNBNT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:11 INFO - Running setup.py install for manifestparser 10:08:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:11 INFO - Running setup.py install for mozcrash 10:08:11 INFO - Running setup.py install for mozdebug 10:08:11 INFO - Running setup.py install for mozdevice 10:08:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:11 INFO - Running setup.py install for mozfile 10:08:12 INFO - Running setup.py install for mozhttpd 10:08:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:12 INFO - Running setup.py install for mozinfo 10:08:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:12 INFO - Running setup.py install for mozInstall 10:08:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:12 INFO - Running setup.py install for mozleak 10:08:12 INFO - Running setup.py install for mozlog 10:08:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:12 INFO - Running setup.py install for moznetwork 10:08:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:12 INFO - Running setup.py install for mozprocess 10:08:12 INFO - Running setup.py install for mozprofile 10:08:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:13 INFO - Running setup.py install for mozrunner 10:08:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:13 INFO - Running setup.py install for mozscreenshot 10:08:13 INFO - Running setup.py install for moztest 10:08:13 INFO - Running setup.py install for mozversion 10:08:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:13 INFO - Cleaning up... 10:08:13 INFO - Return code: 0 10:08:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:13 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:08:13 INFO - Using env: {'DISPLAY': ':0', 10:08:13 INFO - 'HOME': '/home/cltbld', 10:08:13 INFO - 'LANG': 'en_US.UTF-8', 10:08:13 INFO - 'LANGUAGE': 'en_US:en', 10:08:13 INFO - 'LOGNAME': 'cltbld', 10:08:13 INFO - 'MAIL': '/var/mail/cltbld', 10:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:13 INFO - 'MOZ_NO_REMOTE': '1', 10:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:13 INFO - 'NO_EM_RESTART': '1', 10:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:13 INFO - 'PWD': '/builds/slave/test', 10:08:13 INFO - 'SHELL': '/bin/bash', 10:08:13 INFO - 'SHLVL': '1', 10:08:13 INFO - 'TERM': 'linux', 10:08:13 INFO - 'TMOUT': '86400', 10:08:13 INFO - 'USER': 'cltbld', 10:08:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:13 INFO - '_': '/tools/buildbot/bin/python'} 10:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:13 INFO - Running setup.py (path:/tmp/pip-Mevd4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:13 INFO - Running setup.py (path:/tmp/pip-UZHltb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:13 INFO - Running setup.py (path:/tmp/pip-fDQVv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:13 INFO - Running setup.py (path:/tmp/pip-v9JddW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:13 INFO - Running setup.py (path:/tmp/pip-uUl4nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:14 INFO - Running setup.py (path:/tmp/pip-KRcYAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:14 INFO - Running setup.py (path:/tmp/pip-F9EDNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:14 INFO - Running setup.py (path:/tmp/pip-tr5GnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:14 INFO - Running setup.py (path:/tmp/pip-pxXehd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:14 INFO - Running setup.py (path:/tmp/pip-87HwIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:14 INFO - Running setup.py (path:/tmp/pip-kU4Y7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:14 INFO - Running setup.py (path:/tmp/pip-kD7fSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:14 INFO - Running setup.py (path:/tmp/pip-PuOGDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:14 INFO - Running setup.py (path:/tmp/pip-aTAKju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:14 INFO - Running setup.py (path:/tmp/pip-EXxSym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:14 INFO - Running setup.py (path:/tmp/pip-4Y4CHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:14 INFO - Running setup.py (path:/tmp/pip-6QnFGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:08:14 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:08:14 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:08:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:15 INFO - Downloading blessings-1.6.tar.gz 10:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:16 INFO - Installing collected packages: blessings 10:08:16 INFO - Running setup.py install for blessings 10:08:16 INFO - Successfully installed blessings 10:08:16 INFO - Cleaning up... 10:08:16 INFO - Return code: 0 10:08:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:16 INFO - Reading from file tmpfile_stdout 10:08:16 INFO - Current package versions: 10:08:16 INFO - argparse == 1.2.1 10:08:16 INFO - blessings == 1.6 10:08:16 INFO - blobuploader == 1.2.4 10:08:16 INFO - docopt == 0.6.1 10:08:16 INFO - functools32 == 3.2.3-2 10:08:16 INFO - jsonschema == 2.5.1 10:08:16 INFO - manifestparser == 1.1 10:08:16 INFO - mozInstall == 1.12 10:08:16 INFO - mozcrash == 1.0 10:08:16 INFO - mozdebug == 0.1 10:08:16 INFO - mozdevice == 0.50 10:08:16 INFO - mozfile == 1.2 10:08:16 INFO - mozhttpd == 0.7 10:08:16 INFO - mozinfo == 0.9 10:08:16 INFO - mozleak == 0.1 10:08:16 INFO - mozlog == 3.4 10:08:16 INFO - moznetwork == 0.27 10:08:16 INFO - mozprocess == 0.25 10:08:16 INFO - mozprofile == 0.28 10:08:16 INFO - mozrunner == 6.13 10:08:16 INFO - mozscreenshot == 0.1 10:08:16 INFO - mozsystemmonitor == 0.3 10:08:16 INFO - moztest == 0.8 10:08:16 INFO - mozversion == 1.4 10:08:16 INFO - psutil == 3.1.1 10:08:16 INFO - requests == 1.2.3 10:08:16 INFO - wsgiref == 0.1.2 10:08:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:16 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:08:16 INFO - Using env: {'DISPLAY': ':0', 10:08:16 INFO - 'HOME': '/home/cltbld', 10:08:16 INFO - 'LANG': 'en_US.UTF-8', 10:08:16 INFO - 'LANGUAGE': 'en_US:en', 10:08:16 INFO - 'LOGNAME': 'cltbld', 10:08:16 INFO - 'MAIL': '/var/mail/cltbld', 10:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:16 INFO - 'MOZ_NO_REMOTE': '1', 10:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:16 INFO - 'NO_EM_RESTART': '1', 10:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:16 INFO - 'PWD': '/builds/slave/test', 10:08:16 INFO - 'SHELL': '/bin/bash', 10:08:16 INFO - 'SHLVL': '1', 10:08:16 INFO - 'TERM': 'linux', 10:08:16 INFO - 'TMOUT': '86400', 10:08:16 INFO - 'USER': 'cltbld', 10:08:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:16 INFO - '_': '/tools/buildbot/bin/python'} 10:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:08:16 INFO - Cleaning up... 10:08:16 INFO - Return code: 0 10:08:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:16 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, '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': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:08:16 INFO - Using env: {'DISPLAY': ':0', 10:08:16 INFO - 'HOME': '/home/cltbld', 10:08:16 INFO - 'LANG': 'en_US.UTF-8', 10:08:16 INFO - 'LANGUAGE': 'en_US:en', 10:08:16 INFO - 'LOGNAME': 'cltbld', 10:08:16 INFO - 'MAIL': '/var/mail/cltbld', 10:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:16 INFO - 'MOZ_NO_REMOTE': '1', 10:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:16 INFO - 'NO_EM_RESTART': '1', 10:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:16 INFO - 'PWD': '/builds/slave/test', 10:08:16 INFO - 'SHELL': '/bin/bash', 10:08:16 INFO - 'SHLVL': '1', 10:08:16 INFO - 'TERM': 'linux', 10:08:16 INFO - 'TMOUT': '86400', 10:08:16 INFO - 'USER': 'cltbld', 10:08:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:16 INFO - '_': '/tools/buildbot/bin/python'} 10:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:08:16 INFO - Cleaning up... 10:08:16 INFO - Return code: 0 10:08:16 INFO - Running post-action listener: _resource_record_post_action 10:08:16 INFO - Running post-action listener: _start_resource_monitoring 10:08:16 INFO - Starting resource monitoring. 10:08:16 INFO - [mozharness: 2017-05-04 17:08:16.904273Z] Finished create-virtualenv step (success) 10:08:16 INFO - [mozharness: 2017-05-04 17:08:16.904736Z] Running install step. 10:08:16 INFO - Running pre-action listener: _resource_record_pre_action 10:08:16 INFO - Running main action method: install 10:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:17 INFO - Reading from file tmpfile_stdout 10:08:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:17 INFO - Reading from file tmpfile_stdout 10:08:17 INFO - Output received: 10:08:17 INFO - Usage: mozinstall [options] installer 10:08:17 INFO - Options: 10:08:17 INFO - -h, --help show this help message and exit 10:08:17 INFO - -d DEST, --destination=DEST 10:08:17 INFO - Directory to install application into. [default: 10:08:17 INFO - "/builds/slave/test"] 10:08:17 INFO - --app=APP Application being installed. [default: firefox] 10:08:17 INFO - mkdir: /builds/slave/test/build/application 10:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:08:32 INFO - Reading from file tmpfile_stdout 10:08:32 INFO - Output received: 10:08:32 INFO - /builds/slave/test/build/application/firefox/firefox 10:08:32 INFO - Running post-action listener: _resource_record_post_action 10:08:32 INFO - [mozharness: 2017-05-04 17:08:32.891166Z] Finished install step (success) 10:08:32 INFO - [mozharness: 2017-05-04 17:08:32.891340Z] Running run-tests step. 10:08:32 INFO - Running pre-action listener: _resource_record_pre_action 10:08:32 INFO - Running main action method: run_tests 10:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:32 INFO - Python 2.7.3 10:08:32 INFO - Return code: 0 10:08:32 INFO - grabbing minidump binary from tooltool 10:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:32 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 0x16cf400>, '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 0x16d03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d0840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:08:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:08:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:08:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:32 INFO - Return code: 0 10:08:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:08:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:32 INFO - ENV: RUST_BACKTRACE is now 1 10:08:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:08:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:08:32 INFO - Using env: {'DISPLAY': ':0', 10:08:32 INFO - 'HOME': '/home/cltbld', 10:08:32 INFO - 'LANG': 'en_US.UTF-8', 10:08:32 INFO - 'LANGUAGE': 'en_US:en', 10:08:32 INFO - 'LOGNAME': 'cltbld', 10:08:32 INFO - 'MAIL': '/var/mail/cltbld', 10:08:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:32 INFO - 'MOZ_NO_REMOTE': '1', 10:08:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:32 INFO - 'NO_EM_RESTART': '1', 10:08:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:32 INFO - 'PWD': '/builds/slave/test', 10:08:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:32 INFO - 'RUST_BACKTRACE': '1', 10:08:32 INFO - 'SHELL': '/bin/bash', 10:08:32 INFO - 'SHLVL': '1', 10:08:32 INFO - 'TERM': 'linux', 10:08:32 INFO - 'TMOUT': '86400', 10:08:32 INFO - 'USER': 'cltbld', 10:08:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865', 10:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:32 INFO - '_': '/tools/buildbot/bin/python'} 10:08:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:08:33 INFO - mozversion application_buildid: 20170504161145 10:08:33 INFO - mozversion application_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:08:33 INFO - mozversion application_display_name: Nightly 10:08:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:33 INFO - mozversion application_name: Firefox 10:08:33 INFO - mozversion application_remotingname: firefox 10:08:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:08:33 INFO - mozversion application_vendor: Mozilla 10:08:33 INFO - mozversion application_version: 55.0a1 10:08:33 INFO - mozversion platform_buildid: 20170504161145 10:08:33 INFO - mozversion platform_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:08:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:08:33 INFO - mozversion platform_version: 55.0a1 10:08:33 INFO - using testdate: 1493917713 10:08:33 INFO - actual date: 1493917713 10:08:33 INFO - starting webserver on 'localhost:47044' 10:08:33 INFO - SUITE-START | Running 2 tests 10:08:33 INFO - TEST-START | dromaeo_css 10:08:33 INFO - operating with platform_type : linux_ 10:08:33 INFO - Initialising browser for dromaeo_css test... 10:08:33 INFO - TEST-INFO | started process 19561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprdzeNS/profile http://localhost:47044/getInfo.html) 10:08:37 INFO - PID 19561 | __metrics Screen width/height:1600/1200 10:08:37 INFO - PID 19561 | colorDepth:24 10:08:37 INFO - PID 19561 | Browser inner width/height: 1024/695 10:08:37 INFO - PID 19561 | __metrics 10:08:38 INFO - PID 19561 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:08:38 INFO - PID 19561 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:08:39 INFO - TEST-INFO | 19561: exit 0 10:08:39 INFO - Browser initialized. 10:08:39 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:39 INFO - TEST-INFO | started process 19662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprdzeNS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:51 INFO - PID 19662 | RSS: Main: 167997440 10:08:51 INFO - PID 19662 | 10:11:57 INFO - PID 19662 | Cycle 1(1): loaded http://localhost:47044/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47044/tests/dromaeo/cssquery-ext.html) 10:11:59 INFO - PID 19662 | RSS: Main: 313909248 10:11:59 INFO - PID 19662 | 10:15:01 INFO - PID 19662 | Cycle 1(1): loaded http://localhost:47044/tests/dromaeo/cssquery-ext.html (next: http://localhost:47044/tests/dromaeo/cssquery-jquery.html) 10:15:02 INFO - PID 19662 | RSS: Main: 246255616 10:15:02 INFO - PID 19662 | 10:18:04 INFO - PID 19662 | Cycle 1(1): loaded http://localhost:47044/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47044/tests/dromaeo/cssquery-mootools.html) 10:18:05 INFO - PID 19662 | RSS: Main: 197124096 10:18:05 INFO - PID 19662 | 10:21:07 INFO - PID 19662 | Cycle 1(1): loaded http://localhost:47044/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47044/tests/dromaeo/cssquery-prototype.html) 10:21:07 INFO - PID 19662 | RSS: Main: 236834816 10:21:07 INFO - PID 19662 | 10:24:11 INFO - PID 19662 | Cycle 1(1): loaded http://localhost:47044/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47044/tests/dromaeo/cssquery-yui.html) 10:24:11 INFO - PID 19662 | RSS: Main: 205058048 10:24:11 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | Cycle 1(1): loaded http://localhost:47044/tests/dromaeo/cssquery-yui.html (next: http://localhost:47044/tests/dromaeo/cssquery-dojo.html) 10:27:14 INFO - PID 19662 | RSS: Main: 293756928 10:27:14 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | __start_tp_report 10:27:14 INFO - PID 19662 | _x_x_mozilla_page_load 10:27:14 INFO - PID 19662 | _x_x_mozilla_page_load_details 10:27:14 INFO - PID 19662 | |i|pagename|runs| 10:27:14 INFO - PID 19662 | |0;dojo.html;2721.850298233597;2727.045534063077;2755.2836262571736;2758.048473276719;2770.695223525412;5080.695158290505;5187.3256476658025;5188.844334669957;5199.766010529525;5225.5819534437205;5209.817656382027;5239.711815850127;5252.212168174776;5292;5326.520613144816;4383.868483945471;4605.102005109005;4655.231886738692;4711.15199264134;4752.691075080126;4709.576138147549;4716.787744551503;4737.407824021997;4759.90480190396;4807.711537307773;4535.047639995605;4589.2886602576655;4596.793144308481;4650.558196971282;4694.061187762427;4675.836345727883;4687.835925742583;4690;4737.668363214576;4749.62003039756;4637.049404871993;4642;4673.252279635276;4677.929831052537;4679.110968915929;5054.974725126351;5109.9489005109845;5173.715445650488;5183.507566781187;5214.478552144755;5591.27313449249;5627.127795191711;5731.455511726379;5732.0542110551705;5743.885122297531;5709.685967271798;5709.8287051388525;5710.457506536873;5711.8000869969355;5739;5291.444398338158;5302.045631786315;5304.098303288451;5308.097623404031;5357.785688572413;5731.398203188689;5752.712364381764;5805.36141024487;5810.680412577349;5818.738156782955;5468.835934921959;5515.779368825282;5555.027870122713;5565.3599836019375;5566.944330556724;5605.1872478491205;5610.607257491936;5616.241807356037;5619.831405057855;5640.661560306313;5466;5583.285831123416;5584.776608935597;5586.91619625706;5602.075657516464;5577.888442231133;5647.124695672177;5690.430956904276;5694.145878118233;5704;4736.715797052188;4744.905101897943;4752.95247047532;4757.405324334458;4802.111609352281;4021.6380525752825;4036.737612055207;4053.959460405358;4061.6953728470485;4075.5109386873764;4823.6382271329085;4829.975850120797;4895.094407534618;4896.387951506062;4907.2393778964315;5695.6582605043;5725.570582206351;5732.082866741302;5736.311642602831;5736.569757268222;4792.520747925179;4862.440819305825;4863.902721945612;4866.270059491034;4911.950880491221;4902.436219834764;4952.653314267966;4971.080350135237;5001.549860512571;5016.046951079356;5187.922181167361;5192.039472697563;5194.246834208943;5211.296474975829;5254.9211761822835;5585.888282234251;5592.02139625572;5658.490735833795;5661.716914154358;5662.292213473316;5298.231756395378;5300.867478313073;5313.814016509404;5317.282166907573;5318.388385335736;5533.087040638249;5536.612437129524;5591.133374326986;5592.580556458363;5593.468620481048;5537.36320323168;5611.6352437091455;5665.291838520185;5672.7163641816915;5675.0636145035605;5323.414424413234;5426.375966763872;5432.103702889137;5473.480019398151;5495.807646732345;5512.531434827924;5513.283273174462;5528.115501519737;5548.334199896039;5559.971405290034;5435;5436.864078398072;5447.373552041566;5450.209719590558;5450.809221677222;5377.8117765878005;5437.8368648940595;5508.669479831223;5512.779488820403;5524.33707955048;5345;5366.490183432567;5427.294451721251;5428.185772134211;5448.318960129984 10:27:14 INFO - PID 19662 | |1;ext.html;681.9488538359622;739.2902813299232;759.5025258455712;1072.6889202131388;1092.1590375410929;25873.342798296322;31890.68109318906;32722;32781.5082773758;32782.99999999997;34473.482897756556;34766;34847.12882177947;34879.47680784784;34887;5339.519443250107;6824.556403833747;6980.9650951745425;6989;7004.159500859904;5393.973030134864;6764.222114456827;6932.306769323052;6935.965320173392;6939;6968.059311992892;7008.614526201057;7016;7016.894746578805;7018.403435707945;5245.580353571705;6942.861142777141;6987.091678081868;7007.229204787469;7010.123734533184;5421.593380496479;6702.497312701518;6863.313668633096;6895.138107736533;6898.758543451006;31217.843910780528;31556.36887262265;31568.684313156806;31575.36849263025;31604;3017.8641961111803;3064.7548196144253;3064.9540256896166;3065.2949821540947;3066.785325027249;23776;23832.76167238323;23861.76138238613;23889.52220955571;23894;3132.1856317357424;3142.732867706248;3154.9053528394184;3159.7156255937075;3163.335699503107;148099;148186;148270;148384;148955;42432.575674242864;42450;42545.149097017886;42551.38313243347;42586;43540.78229608832;43643.56356436459;43694.781526092804;43813.56186438095;43864.148830325925;12382.62852114438;12419;12457.75084498305;12459.813102803466;12462.31457269859;9432.198263147571;9656.95171524138;9967.651132210338;9998.700038998843;10002.399856008662;12189.268643881396;12294.692632684255;12351.38243087842;12498.125131240726;12515.186512876633;4704.764761761967;4766.118268120409;4783.880402989953;4846.794708407666;4900.607951363882;923.732117685877;935.3218916285774;936.6628013914985;949.8100379924043;966.6809952715587;20300.79699202989;20896.955152242328;21475;21576.784232157792;21614.675779863315;1013.7313611892854;1018.5721996761378;1019.7909428567126;1023.9590416383261;1035.340072842498;10896.400697961688;11271.49278282463;11372.715682108013;11387.43062846871;11540.365279909685;166769.99070083752;166775.16612417102;167472.16263918602;167535;167850;40509.39235911464;40534.594654053675;40610.390844137364;40624;40685.59314406877;1232.125191114301;1252.8935040521658;1269.5683467621054;1270.7776139175608;1284.4541070045193;19752.40742777719;19848.90075549613;20183.59632807365;21337.146514139262;21486.67769983483;29982.700172998862;30024.24939376533;30054.69945300519;30115.54826677558;30130.69869301279;154561.4543854547;155110;155114;155500;155660;29415.558766618946;29444;29510;30649.40258961174;30880;36579.26841463103;36741.816290918374;37068.814655926544;37146.8142659285;37182;26571.60142597824;27220.863895680395;27582.448351032464;28150.577741334306;28227.43545129127;28030.439391211654;28260.434791303647;29191.7080829189;29196.416071678872;29320.70679293265;30681.386372272875;31078.22304442407;31132;31140.065798026095;31157.221069473446;27115.86442067777;27147.1855844325;27290.317742056606;28200.15399537935;28300;22015.33953981383;22282.220122295643;22685.43286417853;22694.886525567268;22803.429914252276 10:27:14 INFO - PID 19662 | |2;jquery.html;392.4466502231854;406.3944722363678;408.3384916435375;414.51294728693784;439.16777706246666;12047;13712.862871371284;17702.46892593221;18153.546161345974;18444.446666600008;15603.84396156038;16319.51041468755;17210.13949302533;17533.736993945102;17546;5325.920111198326;5496.835094947138;5499.230107784913;5509.862253443656;5509.972450137744;5346.091164502024;5400.270963419927;5532;5558.166275058733;5576.191452239423;5532.031894418481;5532.446755324476;5532.917006244909;5533.08704063829;5541;5352.143657014878;5517.834464966038;5550.111982082847;5558.666480011212;5561.805336813232;4994.150994330937;5013;5013.373328333958;5020.899582008376;5021.774020169101;22137;22425.439364015867;22618.54762904749;23130.88434557833;23325.53348933029;1664.5755332390163;1705.8635309175236;1705.8976461412356;1707.4024091567976;1711.820258872813;13871.861281387159;14343.497977570734;14765.409383624643;14880.032797868103;14918.2540872957;2029.4520479470607;2047.9590408191752;2062.7834077421953;2091.3307741522717;2097.517570958688;70597;87099;88474;89875;90925.54537227271;10673.733156671145;10730.946345268223;10759.139268858473;10774.730631734112;11148.665540033811;15223.238838058052;15235.390584376722;15244.23778811055;15246.923765381101;15251.407260765696;7748.883766743504;7891.960540197262;8081.393895457747;8132.349412047022;8146.7148649798155;7424;7447.925569583097;7476.850462990709;7633.351165150913;7697.923020769833;6886.827829304308;6896.965515172392;6911.861762764716;6996.6851491683;7039.225685174627;1922.9230830766892;1965.9311924082588;1994.3019943019826;2008.7489063867017;2073.931925058596;861.9353548483889;887.0907319996926;892.1212605583495;896.1307531694246;919.8298314811648;16179.595510112105;16368.508944731677;16567.751483727752;16614;17258.482245532654;882.1795729971188;887.7381172554112;888.7333799860016;890.3856339125982;912.9224015958717;8982.910170898338;9020.684276050306;9340.626374945063;9358.485283309483;9489.288303377136;357791;367807;372491;373483;373558;68521.3147868525;70126;71568.64215678888;72077.23984086039;72325.63837180886;1060.867391576053;1071.8231491803765;1087.9619213327496;1089.096050278267;1089.9019088282093;14297.142171469744;14362.569122926328;14387.496437624633;14418.639534011734;14951.925240373728;35574.82212589024;35757.64242357543;36566.817165914;36611.63388366189;36802.8159859199;41699;43480.34779478374;44212.11575768402;44226;44587;7795.610219488889;8150.836983260183;8161.673533058611;8192.75421737349;8487.321014318717;12531.87468125307;12537.686557835763;13185.077044606785;13618.250996195304;14255.857441425453;11013.118950484102;11088.778224435628;11235.382053987109;11262.718432039264;11445.942770286429;10204.846927296245;10289.691309260734;10585.788284234426;11173.162012848907;11306.152038597302;11340.716482088013;11430.657080287605;11795.646130616095;12172.57395991136;12205.267683938991;8109.432339736398;8242.381821363302;8348.540830254395;8456.83086338282;8487.236148746642;10858.45707714627;11585.420728963349;11601.303921764384;11692.649220523397;11718.70703232426 10:27:14 INFO - PID 19662 | |3;mootools.html;1280.7054377493175;1337.451644825621;1348.0900392235244;1353.5397964692004;1360.442218690337;9761.56072976716;10175.13511351535;10199.18406527478;10215.540300686469;10244.897551024487;10017.749556261097;10098.545565449554;10431.634892778755;10438.06057454829;10445.37327760333;2203.680466332381;2242.372135801978;2246.831487638434;2249.7750224977535;2249.8200143988443;1855.6659801235771;2132.1471411435473;2183.366823621148;2211.9557608847813;2213.6347502662043;1859.0983373064053;2040.387883634911;2150.580636775829;2152.9354119376444;2155.407263002679;2148.194427089841;2151.817095546865;2155.6766485027215;2158.6330323844986;2162.156758864044;2107.8208352290076;2124.373309873591;2142.657174852032;2148.666956621726;2151.1825506307505;9875.358101723437;10025.59897604095;10064.194864410829;10069.244806639532;10072.09351158392;5400.945990540123;5530.917036244459;5568.387477377485;5602.271704678406;5604.299462567179;3213.3252017076443;3332.500124981248;3400.4389275769468;3501.159721666807;3511.490833829106;1015.2892974917513;1020.2316281690736;1043.2019505078622;1056.6988408303596;1058.703563002353;14868.62828429287;14877.851221487756;14893.851061489355;15033.473828416063;15042.924785376003;4521.864344069683;4677.32178834074;4785.545373189541;4798.2322828348;4804.06320767447;11053.392063436428;11054.834177487344;11062.944685276683;11065.668029959113;11068.169887258488;5496.422875598085;5504.559635229172;5510.834674959758;5516.393196748354;5615.887682246333;4748.95251047492;4875.1224779540025;4997.725125118153;5029.748512574357;5051.545360917535;3674.3098174839874;3799.568276303168;3811.742125098711;3831.367824308958;3905.1799122184093;1058.528954615189;1067.2262609607972;1077.52050337599;1078.805814953316;1085.7502774361942;697.8988046733195;710.7974227345285;718.4755128756037;721.7546034348346;733.8092096055065;4994.675346102492;5142.460041695568;5151.304573882553;5167.767450464738;5231.450697676765;559.2841163310968;566.5326105962597;568.2073507457075;571.8713289509827;577.249575551781;3243.708066274047;3278.49183376577;3350.5476760637002;3390.2709618094455;3841.654251117413;13329;13377;13632.591022269347;13711.725765484634;13716.931415342859;13485.123466974615;13655.522056727967;13661.726765464635;13662.863371366358;13681.247531385869;7108.680109394986;7269.3094156055095;7354.154272258758;7409.147947985835;7426.9257307427315;5901.734421950937;6001.639901605918;6061.242344706911;6215.471684906834;6223.097650840693;11794.085084622677;11965.282083075042;11996.940015299868;12153.635390938285;12250.693732656755;11979.760404791681;12184.51261949512;12196.908941495516;12299;12394.876051239373;7840.568768717775;7847.568383738949;8037.276645101969;8040.557769322743;8058;9440;9532.761680958032;9643.421394716339;9663.27525435581;9664.516774161404;8181.509109453452;8257.876131857907;8275.420720549504;8327.875081873655;8357.791055223668;8091.06952700447;8179.79550511242;8255.876161857457;8267.751967440987;8291.461055031403;7287.198408174991;7388.852222955404;7440.107187137578;7440.776776696708;7441.404687625085;5118.566801295643;5262.657927234717;5273;5338.54622357104;5347.625666203328;4912.5753531475475;5000.2499625056535;5040.495950405077;5140.4088529818055;5243.8164664236565 10:27:14 INFO - PID 19662 | |4;prototype.html;354.48953506949977;379.8062987876184;386.6520131881307;391.71992025701616;404.04443491143456;5148.150555158399;5239.371275446947;5254.316938797956;5359.919601205985;5369.301990741208;5162.870928226796;5189.455107213745;5303.54152608033;5312.973435132819;5314.415414304433;4173.227952828721;4213.47331583552;4217.198732240864;4238.152369526092;4241.172971270604;4023.1752490739327;4111.52717437494;4153.356229784388;4233.555476674951;4255.234057869582;4182.581741825824;4187.9581204188025;4190.308599081148;4197.895052623679;4215.430916826235;4176.1230141670285;4189.6438802701805;4193.7903104844945;4205.957940420587;4221.7255878367805;3627.4740162676526;3702.5378123547807;3743.7566558173903;3848.3842585186517;3857.1707082977296;5093.210552364352;5104.489551044903;5106.4382917879375;5115.437301896788;5137;4954.133026720346;4956.653034287565;4965.652404331699;4966.056449274626;4977.701337919736;5469.808556700496;5603.495685388294;5631.437695848379;5635;5660.320761508646;4280.785960701953;4283.164782867342;4285.721428107163;4290.678199135077;4300.462442194726;5874.706264686749;5875.735591898375;5893.499052580536;5897.4102589741115;5914.2902851657645;4291.763952982554;4374.015846434527;4382.693211475166;4398.142362239332;4424.867253982386;4210.5157906841105;4343.261645520269;4488.708233964782;4500.9099818004115;4505.932411013838;4773.11697335987;4874.366332376769;4877.975610121926;4895.143349913751;4897.681650692693;5609.719514024282;5609.971950140223;5626.774929002876;5630.831075067755;5651.943480565224;1357.938892749809;1404.7892816077465;1414.073781673006;1549.5661214859858;1573.9606509837117;931.7204838548544;940.3652534539295;957.8850537935492;959.5633986536109;961.7739831139677;4925.408950925912;4934.432540257844;4941.170592790616;4944.357233559686;4952.108620448282;5734.827955161351;5779.803674603624;5782.380933338672;5790.536757059509;5798.478136967693;4747.192977193886;4938.456769755324;4939.703617782944;4946.703197808071;4958.851234462972;3086.537019447101;3097.4734295169874;3103.286244163855;3107.819028769053;3112.9844350778103;5455.263539422127;5466.535344495763;5487.506124448739;5495.477929596682;5513.889722205614;5825.300963884361;5918.911216331759;5966.910496342558;5976.342602313742;6000.249843847595;5428.891422171534;5438.45615438453;5445.36639008296;5461.617686761968;5463.634091477131;5584.385717570983;5809.215755872903;5828.825135245949;5835.183074369506;5846.742950265713;5753.187745860041;5758.395368486416;5762.510186634183;5764.913526297025;5780.624259423124;5457.672539647634;5459.672419654833;5464.371597266207;5469.781208751764;5482.643628164156;3792.50697409335;3929.1945151243353;3991.421243919557;4032.6975476838766;4039.3537034075584;5630.18362337467;5699.8860022800145;5788.507976822018;5791.044477661308;5819.912701309569;5606.635568688185;5606.943930560642;5610.551155907436;5653.123765816305;5653.604247702621;5539.806106786243;5588.497035266845;5620.156976453564;5631.183478395692;5636.2954630671165;5457.317835270591;5536.252605898313;5544.528715059265;5548.472895074961;5560.888782224414;5478.424765399735;5631.155326701028;5694.686792226302;5707.857303567444;5713.771449142154;5437.184422336682;5460.31746031746;5464.426235245242;5473.8272332645265;5496.258005169251 10:27:14 INFO - PID 19662 | |5;yui.html;737.9335859772619;751.6730222353275;756.9432292578058;758.404652347907;769;13213.537526186585;14116.223607701599;14154.575362739108;14155.150690958537;14155.575332740009;13537.593872183825;14374;15868.682626347494;16261.10563918984;16291;890.198821061047;899.2895612466144;905.710172744722;907.2197909797569;909.2680392284209;916.6562539047857;917.4953775423523;918.4948278446861;918.522368368448;918.8897332320098;962.6053318139565;964.6575465709677;964.9662261820803;972.3290929258789;972.9075737804933;953.6852838563258;960.2318145483655;961.1541843178029;966.1063516247478;971.1842052675751;680.146416247611;683.2859661653584;692.155570204355;692.5325405351418;693.8161387232387;14458.27708614565;14577;14586;14597.197154156516;14619.561413157622;15371.846281537153;15402.998805077747;15934.920325398414;15939.123348215844;15944.362225510966;12166.756664866742;12321;12360.876391236063;12453.626391208278;12462.252264864137;2871;2973.9851300743576;2975.880964761407;3001.1296723950027;3003.05403797803;60429.6978515109;62044;69446;71810.64094679545;73909;10994.780104397867;11007.61473348445;11008.39453830031;11050.226484146193;11118.555257789598;19409.126589303516;22470.43823904383;23110.76889231086;23134.42163945915;23229.651555226686;6067.302260240129;6279.686015699197;6281.78013769525;6282.560220784592;6283.7800676976085;2911.5195992660974;2960.8963686270877;2968.8515574221633;2969.1092672198256;2973.940521189564;3396.82809430746;3974.940375894364;4112.835486580503;4132.2561938851295;4149.813258403318;727.6180005497156;745.843372891688;759.525296689569;759.680934007707;761.5811303782897;556.2823957095302;573.486729377205;595.7646729541807;597.5757212379173;602.2802750712943;9270.490123043162;9493.952530237304;9563.713088607354;9881.357711748713;9992.300538962203;577.8642019125502;583.7110630238059;585.3210276079727;585.3268740947859;605.8545948972215;4239.109786944715;4242.469691288589;4244.490661120685;4280.657547396201;4298.591633794785;61061;61459.38540614626;61555;61689;62930.37069629245;54236;55776.72111639416;56555.43444565584;56659.43340566542;56859.43140568624;37253.44119838205;44852.55147448549;45750.54249457463;46919.29621055755;49650.75174624104;9933.950330248592;9986.500674966368;10096.545655445376;10256.589736410759;10344.53449594755;25798;25807;26312.21063368102;26454.603180952687;27073.323166920985;30201.848990754905;30452.390952181275;30729.692703072684;31142.22144446407;31207.219819504695;12937.935310323388;13002.08985371015;13249.337533123498;13285.003624727991;13302.40139193758;14614.707705846036;14797.852021479648;14801.111933283606;14823.110613363233;15014.624634384229;14016.789748153582;14105.083169593943;14449.49426770058;14455.349509272319;14524.854751452773;13254.403551840383;13309.66725831862;13348.93325533366;13501.324933753076;13656.52202172959;11520.769584608428;11534;11697.12271579652;11724.062075033806;11734.70663233426;9484.288678349289;9717.708468745948;9926.503674816375;10082.344647597884;10297.3821570703;9756.17072548813;9874.802503949737;9879.357841740264;9910.30627856043;10205.948970255102 10:27:14 INFO - PID 19662 | __end_tp_report 10:27:14 INFO - PID 19662 | __start_cc_report 10:27:14 INFO - PID 19662 | _x_x_mozilla_cycle_collect,1456 10:27:14 INFO - PID 19662 | __end_cc_report 10:27:14 INFO - PID 19662 | __startTimestamp1493918834340__endTimestamp 10:27:14 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | ------- Summary: start ------- 10:27:14 INFO - PID 19662 | Number of tests: 6 10:27:14 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | [#0] dojo.html Cycles:165 Average:5164.54 Median:5318.39 stddev:601.94 (11.3%) stddev-sans-first:572.47 10:27:14 INFO - PID 19662 | Values: 2721.9 2727.0 2755.3 2758.0 2770.7 5080.7 5187.3 5188.8 5199.8 5225.6 5209.8 5239.7 5252.2 5292.0 5326.5 4383.9 4605.1 4655.2 4711.2 4752.7 4709.6 4716.8 4737.4 4759.9 4807.7 4535.0 4589.3 4596.8 4650.6 4694.1 4675.8 4687.8 4690.0 4737.7 4749.6 4637.0 4642.0 4673.3 4677.9 4679.1 5055.0 5109.9 5173.7 5183.5 5214.5 5591.3 5627.1 5731.5 5732.1 5743.9 5709.7 5709.8 5710.5 5711.8 5739.0 5291.4 5302.0 5304.1 5308.1 5357.8 5731.4 5752.7 5805.4 5810.7 5818.7 5468.8 5515.8 5555.0 5565.4 5566.9 5605.2 5610.6 5616.2 5619.8 5640.7 5466.0 5583.3 5584.8 5586.9 5602.1 5577.9 5647.1 5690.4 5694.1 5704.0 4736.7 4744.9 4753.0 4757.4 4802.1 4021.6 4036.7 4054.0 4061.7 4075.5 4823.6 4830.0 4895.1 4896.4 4907.2 5695.7 5725.6 5732.1 5736.3 5736.6 4792.5 4862.4 4863.9 4866.3 4912.0 4902.4 4952.7 4971.1 5001.5 5016.0 5187.9 5192.0 5194.2 5211.3 5254.9 5585.9 5592.0 5658.5 5661.7 5662.3 5298.2 5300.9 5313.8 5317.3 5318.4 5533.1 5536.6 5591.1 5592.6 5593.5 5537.4 5611.6 5665.3 5672.7 5675.1 5323.4 5426.4 5432.1 5473.5 5495.8 5512.5 5513.3 5528.1 5548.3 5560.0 5435.0 5436.9 5447.4 5450.2 5450.8 5377.8 5437.8 5508.7 5512.8 5524.3 5345.0 5366.5 5427.3 5428.2 5448.3 10:27:14 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | [#1] ext.html Cycles:180 Average:30266.99 Median:16857.35 stddev:40556.23 (240.6%) stddev-sans-first:40609.16 10:27:14 INFO - PID 19662 | Values: 681.9 739.3 759.5 1072.7 1092.2 25873.3 31890.7 32722.0 32781.5 32783.0 34473.5 34766.0 34847.1 34879.5 34887.0 5339.5 6824.6 6981.0 6989.0 7004.2 5394.0 6764.2 6932.3 6936.0 6939.0 6968.1 7008.6 7016.0 7016.9 7018.4 5245.6 6942.9 6987.1 7007.2 7010.1 5421.6 6702.5 6863.3 6895.1 6898.8 31217.8 31556.4 31568.7 31575.4 31604.0 3017.9 3064.8 3065.0 3065.3 3066.8 23776.0 23832.8 23861.8 23889.5 23894.0 3132.2 3142.7 3154.9 3159.7 3163.3 148099.0 148186.0 148270.0 148384.0 148955.0 42432.6 42450.0 42545.1 42551.4 42586.0 43540.8 43643.6 43694.8 43813.6 43864.1 12382.6 12419.0 12457.8 12459.8 12462.3 9432.2 9657.0 9967.7 9998.7 10002.4 12189.3 12294.7 12351.4 12498.1 12515.2 4704.8 4766.1 4783.9 4846.8 4900.6 923.7 935.3 936.7 949.8 966.7 20300.8 20897.0 21475.0 21576.8 21614.7 1013.7 1018.6 1019.8 1024.0 1035.3 10896.4 11271.5 11372.7 11387.4 11540.4 166770.0 166775.2 167472.2 167535.0 167850.0 40509.4 40534.6 40610.4 40624.0 40685.6 1232.1 1252.9 1269.6 1270.8 1284.5 19752.4 19848.9 20183.6 21337.1 21486.7 29982.7 30024.2 30054.7 30115.5 30130.7 154561.5 155110.0 155114.0 155500.0 155660.0 29415.6 29444.0 29510.0 30649.4 30880.0 36579.3 36741.8 37068.8 37146.8 37182.0 26571.6 27220.9 27582.4 28150.6 28227.4 28030.4 28260.4 29191.7 29196.4 29320.7 30681.4 31078.2 31132.0 31140.1 31157.2 27115.9 27147.2 27290.3 28200.2 28300.0 22015.3 22282.2 22685.4 22694.9 22803.4 10:27:14 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | [#2] jquery.html Cycles:180 Average:24311.08 Median:202304.91 stddev:61155.00 (30.2%) stddev-sans-first:61300.19 10:27:14 INFO - PID 19662 | Values: 392.4 406.4 408.3 414.5 439.2 12047.0 13712.9 17702.5 18153.5 18444.4 15603.8 16319.5 17210.1 17533.7 17546.0 5325.9 5496.8 5499.2 5509.9 5510.0 5346.1 5400.3 5532.0 5558.2 5576.2 5532.0 5532.4 5532.9 5533.1 5541.0 5352.1 5517.8 5550.1 5558.7 5561.8 4994.2 5013.0 5013.4 5020.9 5021.8 22137.0 22425.4 22618.5 23130.9 23325.5 1664.6 1705.9 1705.9 1707.4 1711.8 13871.9 14343.5 14765.4 14880.0 14918.3 2029.5 2048.0 2062.8 2091.3 2097.5 70597.0 87099.0 88474.0 89875.0 90925.5 10673.7 10730.9 10759.1 10774.7 11148.7 15223.2 15235.4 15244.2 15246.9 15251.4 7748.9 7892.0 8081.4 8132.3 8146.7 7424.0 7447.9 7476.9 7633.4 7697.9 6886.8 6897.0 6911.9 6996.7 7039.2 1922.9 1965.9 1994.3 2008.7 2073.9 861.9 887.1 892.1 896.1 919.8 16179.6 16368.5 16567.8 16614.0 17258.5 882.2 887.7 888.7 890.4 912.9 8982.9 9020.7 9340.6 9358.5 9489.3 357791.0 367807.0 372491.0 373483.0 373558.0 68521.3 70126.0 71568.6 72077.2 72325.6 1060.9 1071.8 1088.0 1089.1 1089.9 14297.1 14362.6 14387.5 14418.6 14951.9 35574.8 35757.6 36566.8 36611.6 36802.8 41699.0 43480.3 44212.1 44226.0 44587.0 7795.6 8150.8 8161.7 8192.8 8487.3 12531.9 12537.7 13185.1 13618.3 14255.9 11013.1 11088.8 11235.4 11262.7 11445.9 10204.8 10289.7 10585.8 11173.2 11306.2 11340.7 11430.7 11795.6 12172.6 12205.3 8109.4 8242.4 8348.5 8456.8 8487.2 10858.5 11585.4 11601.3 11692.6 11718.7 10:27:14 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | [#3] mootools.html Cycles:180 Average:6249.27 Median:3506.33 stddev:4100.85 (117.0%) stddev-sans-first:4095.36 10:27:14 INFO - PID 19662 | Values: 1280.7 1337.5 1348.1 1353.5 1360.4 9761.6 10175.1 10199.2 10215.5 10244.9 10017.7 10098.5 10431.6 10438.1 10445.4 2203.7 2242.4 2246.8 2249.8 2249.8 1855.7 2132.1 2183.4 2212.0 2213.6 1859.1 2040.4 2150.6 2152.9 2155.4 2148.2 2151.8 2155.7 2158.6 2162.2 2107.8 2124.4 2142.7 2148.7 2151.2 9875.4 10025.6 10064.2 10069.2 10072.1 5400.9 5530.9 5568.4 5602.3 5604.3 3213.3 3332.5 3400.4 3501.2 3511.5 1015.3 1020.2 1043.2 1056.7 1058.7 14868.6 14877.9 14893.9 15033.5 15042.9 4521.9 4677.3 4785.5 4798.2 4804.1 11053.4 11054.8 11062.9 11065.7 11068.2 5496.4 5504.6 5510.8 5516.4 5615.9 4749.0 4875.1 4997.7 5029.7 5051.5 3674.3 3799.6 3811.7 3831.4 3905.2 1058.5 1067.2 1077.5 1078.8 1085.8 697.9 710.8 718.5 721.8 733.8 4994.7 5142.5 5151.3 5167.8 5231.5 559.3 566.5 568.2 571.9 577.2 3243.7 3278.5 3350.5 3390.3 3841.7 13329.0 13377.0 13632.6 13711.7 13716.9 13485.1 13655.5 13661.7 13662.9 13681.2 7108.7 7269.3 7354.2 7409.1 7426.9 5901.7 6001.6 6061.2 6215.5 6223.1 11794.1 11965.3 11996.9 12153.6 12250.7 11979.8 12184.5 12196.9 12299.0 12394.9 7840.6 7847.6 8037.3 8040.6 8058.0 9440.0 9532.8 9643.4 9663.3 9664.5 8181.5 8257.9 8275.4 8327.9 8357.8 8091.1 8179.8 8255.9 8267.8 8291.5 7287.2 7388.9 7440.1 7440.8 7441.4 5118.6 5262.7 5273.0 5338.5 5347.6 4912.6 5000.2 5040.5 5140.4 5243.8 10:27:14 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | [#4] prototype.html Cycles:180 Average:4698.65 Median:5308.26 stddev:1341.97 (25.3%) stddev-sans-first:1305.52 10:27:14 INFO - PID 19662 | Values: 354.5 379.8 386.7 391.7 404.0 5148.2 5239.4 5254.3 5359.9 5369.3 5162.9 5189.5 5303.5 5313.0 5314.4 4173.2 4213.5 4217.2 4238.2 4241.2 4023.2 4111.5 4153.4 4233.6 4255.2 4182.6 4188.0 4190.3 4197.9 4215.4 4176.1 4189.6 4193.8 4206.0 4221.7 3627.5 3702.5 3743.8 3848.4 3857.2 5093.2 5104.5 5106.4 5115.4 5137.0 4954.1 4956.7 4965.7 4966.1 4977.7 5469.8 5603.5 5631.4 5635.0 5660.3 4280.8 4283.2 4285.7 4290.7 4300.5 5874.7 5875.7 5893.5 5897.4 5914.3 4291.8 4374.0 4382.7 4398.1 4424.9 4210.5 4343.3 4488.7 4500.9 4505.9 4773.1 4874.4 4878.0 4895.1 4897.7 5609.7 5610.0 5626.8 5630.8 5651.9 1357.9 1404.8 1414.1 1549.6 1574.0 931.7 940.4 957.9 959.6 961.8 4925.4 4934.4 4941.2 4944.4 4952.1 5734.8 5779.8 5782.4 5790.5 5798.5 4747.2 4938.5 4939.7 4946.7 4958.9 3086.5 3097.5 3103.3 3107.8 3113.0 5455.3 5466.5 5487.5 5495.5 5513.9 5825.3 5918.9 5966.9 5976.3 6000.2 5428.9 5438.5 5445.4 5461.6 5463.6 5584.4 5809.2 5828.8 5835.2 5846.7 5753.2 5758.4 5762.5 5764.9 5780.6 5457.7 5459.7 5464.4 5469.8 5482.6 3792.5 3929.2 3991.4 4032.7 4039.4 5630.2 5699.9 5788.5 5791.0 5819.9 5606.6 5606.9 5610.6 5653.1 5653.6 5539.8 5588.5 5620.2 5631.2 5636.3 5457.3 5536.3 5544.5 5548.5 5560.9 5478.4 5631.2 5694.7 5707.9 5713.8 5437.2 5460.3 5464.4 5473.8 5496.3 10:27:14 INFO - PID 19662 | 10:27:14 INFO - PID 19662 | [#5] yui.html Cycles:180 Average:14633.12 Median:4141.03 stddev:17176.38 (414.8%) stddev-sans-first:17192.87 10:27:14 INFO - PID 19662 | Values: 737.9 751.7 756.9 758.4 769.0 13213.5 14116.2 14154.6 14155.2 14155.6 13537.6 14374.0 15868.7 16261.1 16291.0 890.2 899.3 905.7 907.2 909.3 916.7 917.5 918.5 918.5 918.9 962.6 964.7 965.0 972.3 972.9 953.7 960.2 961.2 966.1 971.2 680.1 683.3 692.2 692.5 693.8 14458.3 14577.0 14586.0 14597.2 14619.6 15371.8 15403.0 15934.9 15939.1 15944.4 12166.8 12321.0 12360.9 12453.6 12462.3 2871.0 2974.0 2975.9 3001.1 3003.1 60429.7 62044.0 69446.0 71810.6 73909.0 10994.8 11007.6 11008.4 11050.2 11118.6 19409.1 22470.4 23110.8 23134.4 23229.7 6067.3 6279.7 6281.8 6282.6 6283.8 2911.5 2960.9 2968.9 2969.1 2973.9 3396.8 3974.9 4112.8 4132.3 4149.8 727.6 745.8 759.5 759.7 761.6 556.3 573.5 595.8 597.6 602.3 9270.5 9494.0 9563.7 9881.4 9992.3 577.9 583.7 585.3 585.3 605.9 4239.1 4242.5 4244.5 4280.7 4298.6 61061.0 61459.4 61555.0 61689.0 62930.4 54236.0 55776.7 56555.4 56659.4 56859.4 37253.4 44852.6 45750.5 46919.3 49650.8 9934.0 9986.5 10096.5 10256.6 10344.5 25798.0 25807.0 26312.2 26454.6 27073.3 30201.8 30452.4 30729.7 31142.2 31207.2 12937.9 13002.1 13249.3 13285.0 13302.4 14614.7 14797.9 14801.1 14823.1 15014.6 14016.8 14105.1 14449.5 14455.3 14524.9 13254.4 13309.7 13348.9 13501.3 13656.5 11520.8 11534.0 11697.1 11724.1 11734.7 9484.3 9717.7 9926.5 10082.3 10297.4 9756.2 9874.8 9879.4 9910.3 10205.9 10:27:14 INFO - PID 19662 | -------- Summary: end -------- 10:27:14 INFO - PID 19662 | 10:27:15 INFO - TEST-INFO | 19662: exit 0 10:27:15 INFO - TEST-OK | dromaeo_css | took 1122007ms 10:27:15 INFO - TEST-START | kraken 10:27:15 INFO - operating with platform_type : linux_ 10:27:15 INFO - Initialising browser for kraken test... 10:27:15 INFO - TEST-INFO | started process 19995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2IyxXX/profile http://localhost:47044/getInfo.html) 10:27:19 INFO - PID 19995 | __metrics Screen width/height:1600/1200 10:27:19 INFO - PID 19995 | colorDepth:24 10:27:19 INFO - PID 19995 | Browser inner width/height: 1024/695 10:27:19 INFO - PID 19995 | __metrics 10:27:20 INFO - PID 19995 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:27:20 INFO - PID 19995 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:27:21 INFO - TEST-INFO | 19995: exit 0 10:27:21 INFO - Browser initialized. 10:27:21 INFO - Running cycle 1/1 for kraken test... 10:27:21 INFO - TEST-INFO | started process 20103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2IyxXX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:33 INFO - PID 20103 | RSS: Main: 168468480 10:27:33 INFO - PID 20103 | 10:27:36 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47044/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:37 INFO - PID 20103 | RSS: Main: 244588544 10:27:37 INFO - PID 20103 | 10:27:39 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47044/tests/kraken/driver.html?testName=audio-dft) 10:27:40 INFO - PID 20103 | RSS: Main: 206041088 10:27:40 INFO - PID 20103 | 10:27:43 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47044/tests/kraken/driver.html?testName=audio-fft) 10:27:44 INFO - PID 20103 | RSS: Main: 289710080 10:27:44 INFO - PID 20103 | 10:27:46 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47044/tests/kraken/driver.html?testName=audio-oscillator) 10:27:46 INFO - PID 20103 | RSS: Main: 200048640 10:27:46 INFO - PID 20103 | 10:27:49 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47044/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:49 INFO - PID 20103 | RSS: Main: 204935168 10:27:49 INFO - PID 20103 | 10:27:52 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47044/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:53 INFO - PID 20103 | RSS: Main: 264171520 10:27:53 INFO - PID 20103 | 10:27:56 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47044/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:57 INFO - PID 20103 | RSS: Main: 264384512 10:27:57 INFO - PID 20103 | 10:28:00 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47044/tests/kraken/driver.html?testName=json-parse-financial) 10:28:01 INFO - PID 20103 | RSS: Main: 262877184 10:28:01 INFO - PID 20103 | 10:28:02 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47044/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:03 INFO - PID 20103 | RSS: Main: 226271232 10:28:03 INFO - PID 20103 | 10:28:05 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47044/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:05 INFO - PID 20103 | RSS: Main: 230699008 10:28:05 INFO - PID 20103 | 10:28:07 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47044/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:08 INFO - PID 20103 | RSS: Main: 241643520 10:28:08 INFO - PID 20103 | 10:28:11 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:11 INFO - PID 20103 | RSS: Main: 250114048 10:28:11 INFO - PID 20103 | 10:28:15 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:15 INFO - PID 20103 | RSS: Main: 227160064 10:28:15 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:47044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47044/tests/kraken/driver.html?testName=ai-astar) 10:28:17 INFO - PID 20103 | RSS: Main: 294326272 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | __start_tp_report 10:28:17 INFO - PID 20103 | _x_x_mozilla_page_load 10:28:17 INFO - PID 20103 | _x_x_mozilla_page_load_details 10:28:17 INFO - PID 20103 | |i|pagename|runs| 10:28:17 INFO - PID 20103 | |0;ai-astar;108;111;110;111;110;111;110;112;110;113 10:28:17 INFO - PID 20103 | |1;audio-beat-detection;152;121;121;169;133;133;122;121;144;127 10:28:17 INFO - PID 20103 | |2;audio-dft;162;163;162;166;165;163;162;164;163;163 10:28:17 INFO - PID 20103 | |3;audio-fft;74;77;74;104;76;75;76;74;93;75 10:28:17 INFO - PID 20103 | |4;audio-oscillator;84;83;111;84;82;85;96;84;83;107 10:28:17 INFO - PID 20103 | |5;imaging-gaussian-blur;113;114;112;113;113;113;113;112;113;115 10:28:17 INFO - PID 20103 | |6;imaging-darkroom;149;149;148;149;148;148;149;152;149;149 10:28:17 INFO - PID 20103 | |7;imaging-desaturate;94;93;95;94;94;93;94;94;94;94 10:28:17 INFO - PID 20103 | |8;json-parse-financial;52;53;53;52;54;54;54;54;52;53 10:28:17 INFO - PID 20103 | |9;json-stringify-tinderbox;56;55;55;55;55;56;56;56;55;56 10:28:17 INFO - PID 20103 | |10;stanford-crypto-aes;81;84;82;81;82;79;80;79;81;81 10:28:17 INFO - PID 20103 | |11;stanford-crypto-ccm;138;128;127;136;128;128;128;136;177;126 10:28:17 INFO - PID 20103 | |12;stanford-crypto-pbkdf2;180;182;185;187;188;185;187;181;185;187 10:28:17 INFO - PID 20103 | |13;stanford-crypto-sha256-iterative;73;77;70;75;74;69;70;69;70;73 10:28:17 INFO - PID 20103 | __end_tp_report 10:28:17 INFO - PID 20103 | __start_cc_report 10:28:17 INFO - PID 20103 | _x_x_mozilla_cycle_collect,1944 10:28:17 INFO - PID 20103 | __end_cc_report 10:28:17 INFO - PID 20103 | __startTimestamp1493918897737__endTimestamp 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | ------- Summary: start ------- 10:28:17 INFO - PID 20103 | Number of tests: 14 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.35 (1.2%) stddev-sans-first:1.05 10:28:17 INFO - PID 20103 | Values: 108.0 111.0 110.0 111.0 110.0 111.0 110.0 112.0 110.0 113.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:133.00 stddev:16.16 (12.1%) stddev-sans-first:15.82 10:28:17 INFO - PID 20103 | Values: 152.0 121.0 121.0 169.0 133.0 133.0 122.0 121.0 144.0 127.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 10:28:17 INFO - PID 20103 | Values: 162.0 163.0 162.0 166.0 165.0 163.0 162.0 164.0 163.0 163.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#3] audio-fft Cycles:10 Average:79.80 Median:75.50 stddev:10.24 (13.6%) stddev-sans-first:10.64 10:28:17 INFO - PID 20103 | Values: 74.0 77.0 74.0 104.0 76.0 75.0 76.0 74.0 93.0 75.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.00 stddev:10.86 (12.9%) stddev-sans-first:11.30 10:28:17 INFO - PID 20103 | Values: 84.0 83.0 111.0 84.0 82.0 85.0 96.0 84.0 83.0 107.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 10:28:17 INFO - PID 20103 | Values: 113.0 114.0 112.0 113.0 113.0 113.0 113.0 112.0 113.0 115.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 10:28:17 INFO - PID 20103 | Values: 149.0 149.0 148.0 149.0 148.0 148.0 149.0 152.0 149.0 149.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:28:17 INFO - PID 20103 | Values: 94.0 93.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.50 stddev:0.88 (1.6%) stddev-sans-first:0.83 10:28:17 INFO - PID 20103 | Values: 52.0 53.0 53.0 52.0 54.0 54.0 54.0 54.0 52.0 53.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 10:28:17 INFO - PID 20103 | Values: 56.0 55.0 55.0 55.0 55.0 56.0 56.0 56.0 55.0 56.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:1.49 (1.8%) stddev-sans-first:1.58 10:28:17 INFO - PID 20103 | Values: 81.0 84.0 82.0 81.0 82.0 79.0 80.0 79.0 81.0 81.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:132.00 stddev:15.33 (11.6%) stddev-sans-first:16.23 10:28:17 INFO - PID 20103 | Values: 138.0 128.0 127.0 136.0 128.0 128.0 128.0 136.0 177.0 126.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:186.00 stddev:2.79 (1.5%) stddev-sans-first:2.39 10:28:17 INFO - PID 20103 | Values: 180.0 182.0 185.0 187.0 188.0 185.0 187.0 181.0 185.0 187.0 10:28:17 INFO - PID 20103 | 10:28:17 INFO - PID 20103 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:73.00 stddev:2.79 (3.8%) stddev-sans-first:2.93 10:28:17 INFO - PID 20103 | Values: 73.0 77.0 70.0 75.0 74.0 69.0 70.0 69.0 70.0 73.0 10:28:17 INFO - PID 20103 | -------- Summary: end -------- 10:28:17 INFO - PID 20103 | 10:28:19 INFO - TEST-INFO | 20103: exit 0 10:28:19 INFO - TEST-OK | kraken | took 64117ms 10:28:19 INFO - SUITE-END | took 1186s 10:28:19 INFO - Completed test suite (00:19:46) 10:28:19 INFO - javascript benchmark 10:28:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6643.664521244471, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2721.850298233597, 2727.045534063077, 2755.2836262571736, 2758.048473276719, 2770.695223525412, 5080.695158290505, 5187.3256476658025, 5188.844334669957, 5199.766010529525, 5225.5819534437205, 5209.817656382027, 5239.711815850127, 5252.212168174776, 5292.0, 5326.520613144816, 4383.868483945471, 4605.102005109005, 4655.231886738692, 4711.15199264134, 4752.691075080126, 4709.576138147549, 4716.787744551503, 4737.407824021997, 4759.90480190396, 4807.711537307773, 4535.047639995605, 4589.2886602576655, 4596.793144308481, 4650.558196971282, 4694.061187762427, 4675.836345727883, 4687.835925742583, 4690.0, 4737.668363214576, 4749.62003039756, 4637.049404871993, 4642.0, 4673.252279635276, 4677.929831052537, 4679.110968915929, 5054.974725126351, 5109.9489005109845, 5173.715445650488, 5183.507566781187, 5214.478552144755, 5591.27313449249, 5627.127795191711, 5731.455511726379, 5732.0542110551705, 5743.885122297531, 5709.685967271798, 5709.8287051388525, 5710.457506536873, 5711.8000869969355, 5739.0, 5291.444398338158, 5302.045631786315, 5304.098303288451, 5308.097623404031, 5357.785688572413, 5731.398203188689, 5752.712364381764, 5805.36141024487, 5810.680412577349, 5818.738156782955, 5468.835934921959, 5515.779368825282, 5555.027870122713, 5565.3599836019375, 5566.944330556724, 5605.1872478491205, 5610.607257491936, 5616.241807356037, 5619.831405057855, 5640.661560306313, 5466.0, 5583.285831123416, 5584.776608935597, 5586.91619625706, 5602.075657516464, 5577.888442231133, 5647.124695672177, 5690.430956904276, 5694.145878118233, 5704.0, 4736.715797052188, 4744.905101897943, 4752.95247047532, 4757.405324334458, 4802.111609352281, 4021.6380525752825, 4036.737612055207, 4053.959460405358, 4061.6953728470485, 4075.5109386873764, 4823.6382271329085, 4829.975850120797, 4895.094407534618, 4896.387951506062, 4907.2393778964315, 5695.6582605043, 5725.570582206351, 5732.082866741302, 5736.311642602831, 5736.569757268222, 4792.520747925179, 4862.440819305825, 4863.902721945612, 4866.270059491034, 4911.950880491221, 4902.436219834764, 4952.653314267966, 4971.080350135237, 5001.549860512571, 5016.046951079356, 5187.922181167361, 5192.039472697563, 5194.246834208943, 5211.296474975829, 5254.9211761822835, 5585.888282234251, 5592.02139625572, 5658.490735833795, 5661.716914154358, 5662.292213473316, 5298.231756395378, 5300.867478313073, 5313.814016509404, 5317.282166907573, 5318.388385335736, 5533.087040638249, 5536.612437129524, 5591.133374326986, 5592.580556458363, 5593.468620481048, 5537.36320323168, 5611.6352437091455, 5665.291838520185, 5672.7163641816915, 5675.0636145035605, 5323.414424413234, 5426.375966763872, 5432.103702889137, 5473.480019398151, 5495.807646732345, 5512.531434827924, 5513.283273174462, 5528.115501519737, 5548.334199896039, 5559.971405290034, 5435.0, 5436.864078398072, 5447.373552041566, 5450.209719590558, 5450.809221677222, 5377.8117765878005, 5437.8368648940595, 5508.669479831223, 5512.779488820403, 5524.33707955048, 5345.0, 5366.490183432567, 5427.294451721251, 5428.185772134211, 5448.318960129984], "value": 5121.23481853174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.9488538359622, 739.2902813299232, 759.5025258455712, 1072.6889202131388, 1092.1590375410929, 25873.342798296322, 31890.68109318906, 32722.0, 32781.5082773758, 32782.99999999997, 34473.482897756556, 34766.0, 34847.12882177947, 34879.47680784784, 34887.0, 5339.519443250107, 6824.556403833747, 6980.9650951745425, 6989.0, 7004.159500859904, 5393.973030134864, 6764.222114456827, 6932.306769323052, 6935.965320173392, 6939.0, 6968.059311992892, 7008.614526201057, 7016.0, 7016.894746578805, 7018.403435707945, 5245.580353571705, 6942.861142777141, 6987.091678081868, 7007.229204787469, 7010.123734533184, 5421.593380496479, 6702.497312701518, 6863.313668633096, 6895.138107736533, 6898.758543451006, 31217.843910780528, 31556.36887262265, 31568.684313156806, 31575.36849263025, 31604.0, 3017.8641961111803, 3064.7548196144253, 3064.9540256896166, 3065.2949821540947, 3066.785325027249, 23776.0, 23832.76167238323, 23861.76138238613, 23889.52220955571, 23894.0, 3132.1856317357424, 3142.732867706248, 3154.9053528394184, 3159.7156255937075, 3163.335699503107, 148099.0, 148186.0, 148270.0, 148384.0, 148955.0, 42432.575674242864, 42450.0, 42545.149097017886, 42551.38313243347, 42586.0, 43540.78229608832, 43643.56356436459, 43694.781526092804, 43813.56186438095, 43864.148830325925, 12382.62852114438, 12419.0, 12457.75084498305, 12459.813102803466, 12462.31457269859, 9432.198263147571, 9656.95171524138, 9967.651132210338, 9998.700038998843, 10002.399856008662, 12189.268643881396, 12294.692632684255, 12351.38243087842, 12498.125131240726, 12515.186512876633, 4704.764761761967, 4766.118268120409, 4783.880402989953, 4846.794708407666, 4900.607951363882, 923.732117685877, 935.3218916285774, 936.6628013914985, 949.8100379924043, 966.6809952715587, 20300.79699202989, 20896.955152242328, 21475.0, 21576.784232157792, 21614.675779863315, 1013.7313611892854, 1018.5721996761378, 1019.7909428567126, 1023.9590416383261, 1035.340072842498, 10896.400697961688, 11271.49278282463, 11372.715682108013, 11387.43062846871, 11540.365279909685, 166769.99070083752, 166775.16612417102, 167472.16263918602, 167535.0, 167850.0, 40509.39235911464, 40534.594654053675, 40610.390844137364, 40624.0, 40685.59314406877, 1232.125191114301, 1252.8935040521658, 1269.5683467621054, 1270.7776139175608, 1284.4541070045193, 19752.40742777719, 19848.90075549613, 20183.59632807365, 21337.146514139262, 21486.67769983483, 29982.700172998862, 30024.24939376533, 30054.69945300519, 30115.54826677558, 30130.69869301279, 154561.4543854547, 155110.0, 155114.0, 155500.0, 155660.0, 29415.558766618946, 29444.0, 29510.0, 30649.40258961174, 30880.0, 36579.26841463103, 36741.816290918374, 37068.814655926544, 37146.8142659285, 37182.0, 26571.60142597824, 27220.863895680395, 27582.448351032464, 28150.577741334306, 28227.43545129127, 28030.439391211654, 28260.434791303647, 29191.7080829189, 29196.416071678872, 29320.70679293265, 30681.386372272875, 31078.22304442407, 31132.0, 31140.065798026095, 31157.221069473446, 27115.86442067777, 27147.1855844325, 27290.317742056606, 28200.15399537935, 28300.0, 22015.33953981383, 22282.220122295643, 22685.43286417853, 22694.886525567268, 22803.429914252276], "value": 14460.288767602187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.4466502231854, 406.3944722363678, 408.3384916435375, 414.51294728693784, 439.16777706246666, 12047.0, 13712.862871371284, 17702.46892593221, 18153.546161345974, 18444.446666600008, 15603.84396156038, 16319.51041468755, 17210.13949302533, 17533.736993945102, 17546.0, 5325.920111198326, 5496.835094947138, 5499.230107784913, 5509.862253443656, 5509.972450137744, 5346.091164502024, 5400.270963419927, 5532.0, 5558.166275058733, 5576.191452239423, 5532.031894418481, 5532.446755324476, 5532.917006244909, 5533.08704063829, 5541.0, 5352.143657014878, 5517.834464966038, 5550.111982082847, 5558.666480011212, 5561.805336813232, 4994.150994330937, 5013.0, 5013.373328333958, 5020.899582008376, 5021.774020169101, 22137.0, 22425.439364015867, 22618.54762904749, 23130.88434557833, 23325.53348933029, 1664.5755332390163, 1705.8635309175236, 1705.8976461412356, 1707.4024091567976, 1711.820258872813, 13871.861281387159, 14343.497977570734, 14765.409383624643, 14880.032797868103, 14918.2540872957, 2029.4520479470607, 2047.9590408191752, 2062.7834077421953, 2091.3307741522717, 2097.517570958688, 70597.0, 87099.0, 88474.0, 89875.0, 90925.54537227271, 10673.733156671145, 10730.946345268223, 10759.139268858473, 10774.730631734112, 11148.665540033811, 15223.238838058052, 15235.390584376722, 15244.23778811055, 15246.923765381101, 15251.407260765696, 7748.883766743504, 7891.960540197262, 8081.393895457747, 8132.349412047022, 8146.7148649798155, 7424.0, 7447.925569583097, 7476.850462990709, 7633.351165150913, 7697.923020769833, 6886.827829304308, 6896.965515172392, 6911.861762764716, 6996.6851491683, 7039.225685174627, 1922.9230830766892, 1965.9311924082588, 1994.3019943019826, 2008.7489063867017, 2073.931925058596, 861.9353548483889, 887.0907319996926, 892.1212605583495, 896.1307531694246, 919.8298314811648, 16179.595510112105, 16368.508944731677, 16567.751483727752, 16614.0, 17258.482245532654, 882.1795729971188, 887.7381172554112, 888.7333799860016, 890.3856339125982, 912.9224015958717, 8982.910170898338, 9020.684276050306, 9340.626374945063, 9358.485283309483, 9489.288303377136, 357791.0, 367807.0, 372491.0, 373483.0, 373558.0, 68521.3147868525, 70126.0, 71568.64215678888, 72077.23984086039, 72325.63837180886, 1060.867391576053, 1071.8231491803765, 1087.9619213327496, 1089.096050278267, 1089.9019088282093, 14297.142171469744, 14362.569122926328, 14387.496437624633, 14418.639534011734, 14951.925240373728, 35574.82212589024, 35757.64242357543, 36566.817165914, 36611.63388366189, 36802.8159859199, 41699.0, 43480.34779478374, 44212.11575768402, 44226.0, 44587.0, 7795.610219488889, 8150.836983260183, 8161.673533058611, 8192.75421737349, 8487.321014318717, 12531.87468125307, 12537.686557835763, 13185.077044606785, 13618.250996195304, 14255.857441425453, 11013.118950484102, 11088.778224435628, 11235.382053987109, 11262.718432039264, 11445.942770286429, 10204.846927296245, 10289.691309260734, 10585.788284234426, 11173.162012848907, 11306.152038597302, 11340.716482088013, 11430.657080287605, 11795.646130616095, 12172.57395991136, 12205.267683938991, 8109.432339736398, 8242.381821363302, 8348.540830254395, 8456.83086338282, 8487.236148746642, 10858.45707714627, 11585.420728963349, 11601.303921764384, 11692.649220523397, 11718.70703232426], "value": 8747.04637449537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.7054377493175, 1337.451644825621, 1348.0900392235244, 1353.5397964692004, 1360.442218690337, 9761.56072976716, 10175.13511351535, 10199.18406527478, 10215.540300686469, 10244.897551024487, 10017.749556261097, 10098.545565449554, 10431.634892778755, 10438.06057454829, 10445.37327760333, 2203.680466332381, 2242.372135801978, 2246.831487638434, 2249.7750224977535, 2249.8200143988443, 1855.6659801235771, 2132.1471411435473, 2183.366823621148, 2211.9557608847813, 2213.6347502662043, 1859.0983373064053, 2040.387883634911, 2150.580636775829, 2152.9354119376444, 2155.407263002679, 2148.194427089841, 2151.817095546865, 2155.6766485027215, 2158.6330323844986, 2162.156758864044, 2107.8208352290076, 2124.373309873591, 2142.657174852032, 2148.666956621726, 2151.1825506307505, 9875.358101723437, 10025.59897604095, 10064.194864410829, 10069.244806639532, 10072.09351158392, 5400.945990540123, 5530.917036244459, 5568.387477377485, 5602.271704678406, 5604.299462567179, 3213.3252017076443, 3332.500124981248, 3400.4389275769468, 3501.159721666807, 3511.490833829106, 1015.2892974917513, 1020.2316281690736, 1043.2019505078622, 1056.6988408303596, 1058.703563002353, 14868.62828429287, 14877.851221487756, 14893.851061489355, 15033.473828416063, 15042.924785376003, 4521.864344069683, 4677.32178834074, 4785.545373189541, 4798.2322828348, 4804.06320767447, 11053.392063436428, 11054.834177487344, 11062.944685276683, 11065.668029959113, 11068.169887258488, 5496.422875598085, 5504.559635229172, 5510.834674959758, 5516.393196748354, 5615.887682246333, 4748.95251047492, 4875.1224779540025, 4997.725125118153, 5029.748512574357, 5051.545360917535, 3674.3098174839874, 3799.568276303168, 3811.742125098711, 3831.367824308958, 3905.1799122184093, 1058.528954615189, 1067.2262609607972, 1077.52050337599, 1078.805814953316, 1085.7502774361942, 697.8988046733195, 710.7974227345285, 718.4755128756037, 721.7546034348346, 733.8092096055065, 4994.675346102492, 5142.460041695568, 5151.304573882553, 5167.767450464738, 5231.450697676765, 559.2841163310968, 566.5326105962597, 568.2073507457075, 571.8713289509827, 577.249575551781, 3243.708066274047, 3278.49183376577, 3350.5476760637002, 3390.2709618094455, 3841.654251117413, 13329.0, 13377.0, 13632.591022269347, 13711.725765484634, 13716.931415342859, 13485.123466974615, 13655.522056727967, 13661.726765464635, 13662.863371366358, 13681.247531385869, 7108.680109394986, 7269.3094156055095, 7354.154272258758, 7409.147947985835, 7426.9257307427315, 5901.734421950937, 6001.639901605918, 6061.242344706911, 6215.471684906834, 6223.097650840693, 11794.085084622677, 11965.282083075042, 11996.940015299868, 12153.635390938285, 12250.693732656755, 11979.760404791681, 12184.51261949512, 12196.908941495516, 12299.0, 12394.876051239373, 7840.568768717775, 7847.568383738949, 8037.276645101969, 8040.557769322743, 8058.0, 9440.0, 9532.761680958032, 9643.421394716339, 9663.27525435581, 9664.516774161404, 8181.509109453452, 8257.876131857907, 8275.420720549504, 8327.875081873655, 8357.791055223668, 8091.06952700447, 8179.79550511242, 8255.876161857457, 8267.751967440987, 8291.461055031403, 7287.198408174991, 7388.852222955404, 7440.107187137578, 7440.776776696708, 7441.404687625085, 5118.566801295643, 5262.657927234717, 5273.0, 5338.54622357104, 5347.625666203328, 4912.5753531475475, 5000.2499625056535, 5040.495950405077, 5140.4088529818055, 5243.8164664236565], "value": 4635.496401767352, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.48953506949977, 379.8062987876184, 386.6520131881307, 391.71992025701616, 404.04443491143456, 5148.150555158399, 5239.371275446947, 5254.316938797956, 5359.919601205985, 5369.301990741208, 5162.870928226796, 5189.455107213745, 5303.54152608033, 5312.973435132819, 5314.415414304433, 4173.227952828721, 4213.47331583552, 4217.198732240864, 4238.152369526092, 4241.172971270604, 4023.1752490739327, 4111.52717437494, 4153.356229784388, 4233.555476674951, 4255.234057869582, 4182.581741825824, 4187.9581204188025, 4190.308599081148, 4197.895052623679, 4215.430916826235, 4176.1230141670285, 4189.6438802701805, 4193.7903104844945, 4205.957940420587, 4221.7255878367805, 3627.4740162676526, 3702.5378123547807, 3743.7566558173903, 3848.3842585186517, 3857.1707082977296, 5093.210552364352, 5104.489551044903, 5106.4382917879375, 5115.437301896788, 5137.0, 4954.133026720346, 4956.653034287565, 4965.652404331699, 4966.056449274626, 4977.701337919736, 5469.808556700496, 5603.495685388294, 5631.437695848379, 5635.0, 5660.320761508646, 4280.785960701953, 4283.164782867342, 4285.721428107163, 4290.678199135077, 4300.462442194726, 5874.706264686749, 5875.735591898375, 5893.499052580536, 5897.4102589741115, 5914.2902851657645, 4291.763952982554, 4374.015846434527, 4382.693211475166, 4398.142362239332, 4424.867253982386, 4210.5157906841105, 4343.261645520269, 4488.708233964782, 4500.9099818004115, 4505.932411013838, 4773.11697335987, 4874.366332376769, 4877.975610121926, 4895.143349913751, 4897.681650692693, 5609.719514024282, 5609.971950140223, 5626.774929002876, 5630.831075067755, 5651.943480565224, 1357.938892749809, 1404.7892816077465, 1414.073781673006, 1549.5661214859858, 1573.9606509837117, 931.7204838548544, 940.3652534539295, 957.8850537935492, 959.5633986536109, 961.7739831139677, 4925.408950925912, 4934.432540257844, 4941.170592790616, 4944.357233559686, 4952.108620448282, 5734.827955161351, 5779.803674603624, 5782.380933338672, 5790.536757059509, 5798.478136967693, 4747.192977193886, 4938.456769755324, 4939.703617782944, 4946.703197808071, 4958.851234462972, 3086.537019447101, 3097.4734295169874, 3103.286244163855, 3107.819028769053, 3112.9844350778103, 5455.263539422127, 5466.535344495763, 5487.506124448739, 5495.477929596682, 5513.889722205614, 5825.300963884361, 5918.911216331759, 5966.910496342558, 5976.342602313742, 6000.249843847595, 5428.891422171534, 5438.45615438453, 5445.36639008296, 5461.617686761968, 5463.634091477131, 5584.385717570983, 5809.215755872903, 5828.825135245949, 5835.183074369506, 5846.742950265713, 5753.187745860041, 5758.395368486416, 5762.510186634183, 5764.913526297025, 5780.624259423124, 5457.672539647634, 5459.672419654833, 5464.371597266207, 5469.781208751764, 5482.643628164156, 3792.50697409335, 3929.1945151243353, 3991.421243919557, 4032.6975476838766, 4039.3537034075584, 5630.18362337467, 5699.8860022800145, 5788.507976822018, 5791.044477661308, 5819.912701309569, 5606.635568688185, 5606.943930560642, 5610.551155907436, 5653.123765816305, 5653.604247702621, 5539.806106786243, 5588.497035266845, 5620.156976453564, 5631.183478395692, 5636.2954630671165, 5457.317835270591, 5536.252605898313, 5544.528715059265, 5548.472895074961, 5560.888782224414, 5478.424765399735, 5631.155326701028, 5694.686792226302, 5707.857303567444, 5713.771449142154, 5437.184422336682, 5460.31746031746, 5464.426235245242, 5473.8272332645265, 5496.258005169251], "value": 4283.79293233958, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.9335859772619, 751.6730222353275, 756.9432292578058, 758.404652347907, 769.0, 13213.537526186585, 14116.223607701599, 14154.575362739108, 14155.150690958537, 14155.575332740009, 13537.593872183825, 14374.0, 15868.682626347494, 16261.10563918984, 16291.0, 890.198821061047, 899.2895612466144, 905.710172744722, 907.2197909797569, 909.2680392284209, 916.6562539047857, 917.4953775423523, 918.4948278446861, 918.522368368448, 918.8897332320098, 962.6053318139565, 964.6575465709677, 964.9662261820803, 972.3290929258789, 972.9075737804933, 953.6852838563258, 960.2318145483655, 961.1541843178029, 966.1063516247478, 971.1842052675751, 680.146416247611, 683.2859661653584, 692.155570204355, 692.5325405351418, 693.8161387232387, 14458.27708614565, 14577.0, 14586.0, 14597.197154156516, 14619.561413157622, 15371.846281537153, 15402.998805077747, 15934.920325398414, 15939.123348215844, 15944.362225510966, 12166.756664866742, 12321.0, 12360.876391236063, 12453.626391208278, 12462.252264864137, 2871.0, 2973.9851300743576, 2975.880964761407, 3001.1296723950027, 3003.05403797803, 60429.6978515109, 62044.0, 69446.0, 71810.64094679545, 73909.0, 10994.780104397867, 11007.61473348445, 11008.39453830031, 11050.226484146193, 11118.555257789598, 19409.126589303516, 22470.43823904383, 23110.76889231086, 23134.42163945915, 23229.651555226686, 6067.302260240129, 6279.686015699197, 6281.78013769525, 6282.560220784592, 6283.7800676976085, 2911.5195992660974, 2960.8963686270877, 2968.8515574221633, 2969.1092672198256, 2973.940521189564, 3396.82809430746, 3974.940375894364, 4112.835486580503, 4132.2561938851295, 4149.813258403318, 727.6180005497156, 745.843372891688, 759.525296689569, 759.680934007707, 761.5811303782897, 556.2823957095302, 573.486729377205, 595.7646729541807, 597.5757212379173, 602.2802750712943, 9270.490123043162, 9493.952530237304, 9563.713088607354, 9881.357711748713, 9992.300538962203, 577.8642019125502, 583.7110630238059, 585.3210276079727, 585.3268740947859, 605.8545948972215, 4239.109786944715, 4242.469691288589, 4244.490661120685, 4280.657547396201, 4298.591633794785, 61061.0, 61459.38540614626, 61555.0, 61689.0, 62930.37069629245, 54236.0, 55776.72111639416, 56555.43444565584, 56659.43340566542, 56859.43140568624, 37253.44119838205, 44852.55147448549, 45750.54249457463, 46919.29621055755, 49650.75174624104, 9933.950330248592, 9986.500674966368, 10096.545655445376, 10256.589736410759, 10344.53449594755, 25798.0, 25807.0, 26312.21063368102, 26454.603180952687, 27073.323166920985, 30201.848990754905, 30452.390952181275, 30729.692703072684, 31142.22144446407, 31207.219819504695, 12937.935310323388, 13002.08985371015, 13249.337533123498, 13285.003624727991, 13302.40139193758, 14614.707705846036, 14797.852021479648, 14801.111933283606, 14823.110613363233, 15014.624634384229, 14016.789748153582, 14105.083169593943, 14449.49426770058, 14455.349509272319, 14524.854751452773, 13254.403551840383, 13309.66725831862, 13348.93325533366, 13501.324933753076, 13656.52202172959, 11520.769584608428, 11534.0, 11697.12271579652, 11724.062075033806, 11734.70663233426, 9484.288678349289, 9717.708468745948, 9926.503674816375, 10082.344647597884, 10297.3821570703, 9756.17072548813, 9874.802503949737, 9879.357841740264, 9910.30627856043, 10205.948970255102], "value": 6684.609848805749, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0, 112.0, 110.0, 113.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 121.0, 169.0, 133.0, 133.0, 122.0, 121.0, 144.0, 127.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 166.0, 165.0, 163.0, 162.0, 164.0, 163.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 104.0, 76.0, 75.0, 76.0, 74.0, 93.0, 75.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 111.0, 84.0, 82.0, 85.0, 96.0, 84.0, 83.0, 107.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 115.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 148.0, 148.0, 149.0, 152.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 54.0, 54.0, 54.0, 54.0, 52.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0, 55.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 82.0, 81.0, 82.0, 79.0, 80.0, 79.0, 81.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 128.0, 127.0, 136.0, 128.0, 128.0, 128.0, 136.0, 177.0, 126.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 182.0, 185.0, 187.0, 188.0, 185.0, 187.0, 181.0, 185.0, 187.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 70.0, 75.0, 74.0, 69.0, 70.0, 69.0, 70.0, 73.0], "value": 72.0, "unit": "score"}]}]} 10:28:19 INFO - Return code: 0 10:28:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:28:19 INFO - # TBPL SUCCESS # 10:28:19 INFO - Running post-action listener: _resource_record_post_action 10:28:19 INFO - [mozharness: 2017-05-04 17:28:19.537764Z] Finished run-tests step (success) 10:28:19 INFO - Running post-run listener: _resource_record_post_run 10:28:19 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355131392; Read time: 20; Write time: 245908 10:28:19 INFO - TinderboxPrint: CPU usage
12.9% 10:28:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 10:28:19 INFO - TinderboxPrint: I/O write bytes / time
355,131,392 / 245,908 10:28:19 INFO - TinderboxPrint: CPU idle
8,353.0 (87.1%) 10:28:19 INFO - TinderboxPrint: CPU user
1,198.3 (12.5%) 10:28:19 INFO - TinderboxPrint: Swap in / out
0 / 0 10:28:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118784; Read time: 0; Write time: 28 10:28:19 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254296064; Read time: 20; Write time: 161988 10:28:20 INFO - Running post-run listener: _upload_blobber_files 10:28:20 INFO - Blob upload gear active. 10:28:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:28:20 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 10:28:20 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:28:20 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:28:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:28:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:28:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:21 INFO - (blobuploader) - INFO - Done attempting. 10:28:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:28:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:28:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:22 INFO - (blobuploader) - INFO - Done attempting. 10:28:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:28:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:28:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:25 INFO - (blobuploader) - INFO - Done attempting. 10:28:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:28:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:26 INFO - (blobuploader) - INFO - Done attempting. 10:28:26 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:26 INFO - Return code: 0 10:28:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd150cd97ee9e7b4a3e96f712c3aff16b2bbea0566ee70c163fe5daaf4ab10a83ffb474024cbb4ed2a91279e7632ffd054c8b28a8c95afafdcf4f795cce439d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1baf180fdb9f37678cf43d7c585ffa155109bc6fdc54c93f9a76d8b41c209aa7408b2ba50b5d929950741ecae8bb67f5759dc29e63d0d43999b6496bc3a4508", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85cb0841fb13235a0b85fc89ef542dc7a6464c985ac4b89487883e9682cc5718cef3a8bfa2733fd4bec3e618b057f0a74d7999e1276f58720810dffcab210c0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/118a4e82e8fe4a8b98fe846d2c3f24ebf4a7ec2b0fe95c14e387207bcad0a7841929431ddd0b4b9f3028934770d309dfed0a763712f1e58bc78d30bd2ccc8530"} 10:28:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:26 INFO - Contents: 10:28:26 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd150cd97ee9e7b4a3e96f712c3aff16b2bbea0566ee70c163fe5daaf4ab10a83ffb474024cbb4ed2a91279e7632ffd054c8b28a8c95afafdcf4f795cce439d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1baf180fdb9f37678cf43d7c585ffa155109bc6fdc54c93f9a76d8b41c209aa7408b2ba50b5d929950741ecae8bb67f5759dc29e63d0d43999b6496bc3a4508", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85cb0841fb13235a0b85fc89ef542dc7a6464c985ac4b89487883e9682cc5718cef3a8bfa2733fd4bec3e618b057f0a74d7999e1276f58720810dffcab210c0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/118a4e82e8fe4a8b98fe846d2c3f24ebf4a7ec2b0fe95c14e387207bcad0a7841929431ddd0b4b9f3028934770d309dfed0a763712f1e58bc78d30bd2ccc8530"} 10:28:26 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:26 INFO - Copying logs to upload dir... 10:28:26 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.259083 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-04 10:28:26.053265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:28:26.060987) ========= 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=6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd150cd97ee9e7b4a3e96f712c3aff16b2bbea0566ee70c163fe5daaf4ab10a83ffb474024cbb4ed2a91279e7632ffd054c8b28a8c95afafdcf4f795cce439d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1baf180fdb9f37678cf43d7c585ffa155109bc6fdc54c93f9a76d8b41c209aa7408b2ba50b5d929950741ecae8bb67f5759dc29e63d0d43999b6496bc3a4508", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85cb0841fb13235a0b85fc89ef542dc7a6464c985ac4b89487883e9682cc5718cef3a8bfa2733fd4bec3e618b057f0a74d7999e1276f58720810dffcab210c0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/118a4e82e8fe4a8b98fe846d2c3f24ebf4a7ec2b0fe95c14e387207bcad0a7841929431ddd0b4b9f3028934770d309dfed0a763712f1e58bc78d30bd2ccc8530"} build_url:https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/BwNnrf7UQ8Kx7fuYONHxYg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd150cd97ee9e7b4a3e96f712c3aff16b2bbea0566ee70c163fe5daaf4ab10a83ffb474024cbb4ed2a91279e7632ffd054c8b28a8c95afafdcf4f795cce439d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1baf180fdb9f37678cf43d7c585ffa155109bc6fdc54c93f9a76d8b41c209aa7408b2ba50b5d929950741ecae8bb67f5759dc29e63d0d43999b6496bc3a4508", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85cb0841fb13235a0b85fc89ef542dc7a6464c985ac4b89487883e9682cc5718cef3a8bfa2733fd4bec3e618b057f0a74d7999e1276f58720810dffcab210c0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/118a4e82e8fe4a8b98fe846d2c3f24ebf4a7ec2b0fe95c14e387207bcad0a7841929431ddd0b4b9f3028934770d309dfed0a763712f1e58bc78d30bd2ccc8530"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:28:26.092197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:28:26.095745) ========= 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=6dbc10da6d83fee962c624be000001a8-1493917648.962239-144087865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:28:26.145564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:28:26.145869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:28:26.146171) ========= ========= Total master_lag: 0.01 =========